builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0080 starttime: 1457205415.43 results: success (0) buildid: 20160305102518 builduid: 16be7c43898448f68b14aff72f71d532 revision: b29add2c129122e4af8582cac68259c0cc96baec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.432211) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.432606) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.432886) ========= 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.qV0ypB7orT/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.Ej99AEMpaz/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.005387 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.459183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.459463) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.539915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.540158) ========= 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.qV0ypB7orT/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.Ej99AEMpaz/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.005450 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.599640) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.599918) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.600273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:55.600544) ========= 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.qV0ypB7orT/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.Ej99AEMpaz/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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-03-05 11:16:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-03-05 11:16:56 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.518422 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:56.139479) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:56.139788) ========= 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.qV0ypB7orT/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.Ej99AEMpaz/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.027537 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:56.188111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-05 11:16:56.188493) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b29add2c129122e4af8582cac68259c0cc96baec --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 b29add2c129122e4af8582cac68259c0cc96baec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qV0ypB7orT/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.Ej99AEMpaz/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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-03-05 11:16:56,265 truncating revision to first 12 chars 2016-03-05 11:16:56,265 Setting DEBUG logging. 2016-03-05 11:16:56,266 attempt 1/10 2016-03-05 11:16:56,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b29add2c1291?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-05 11:16:57,688 unpacking tar archive at: fx-team-b29add2c1291/testing/mozharness/ program finished with exit code 0 elapsedTime=1.683270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-05 11:16:57.887866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:57.888214) ========= echo b29add2c129122e4af8582cac68259c0cc96baec in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b29add2c129122e4af8582cac68259c0cc96baec'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qV0ypB7orT/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.Ej99AEMpaz/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 b29add2c129122e4af8582cac68259c0cc96baec program finished with exit code 0 elapsedTime=0.005439 script_repo_revision: 'b29add2c129122e4af8582cac68259c0cc96baec' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:57.938737) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:57.939044) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-05 11:16:57.956150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-03-05 11:16:57.956466) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.qV0ypB7orT/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.Ej99AEMpaz/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:16:58 INFO - MultiFileLogger online at 20160305 11:16:58 in /builds/slave/test 11:16:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:16:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:58 INFO - {'append_to_log': False, 11:16:58 INFO - 'base_work_dir': '/builds/slave/test', 11:16:58 INFO - 'blob_upload_branch': 'Fx-Team', 11:16:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:58 INFO - 'branch': 'Fx-Team', 11:16:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:58 INFO - 'config_files': ('talos/mac_config.py',), 11:16:58 INFO - 'default_actions': ('clobber', 11:16:58 INFO - 'read-buildbot-config', 11:16:58 INFO - 'download-and-extract', 11:16:58 INFO - 'populate-webroot', 11:16:58 INFO - 'create-virtualenv', 11:16:58 INFO - 'install', 11:16:58 INFO - 'run-tests'), 11:16:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:58 INFO - 'download_minidump_stackwalk': True, 11:16:58 INFO - 'download_symbols': 'ondemand', 11:16:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:58 INFO - 'installer_path': 'installer.exe', 11:16:58 INFO - 'log_level': 'info', 11:16:58 INFO - 'log_name': 'talos', 11:16:58 INFO - 'log_to_console': True, 11:16:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:16:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:16:58 INFO - 'opt_config_files': (), 11:16:58 INFO - 'pip_index': False, 11:16:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:16:58 INFO - 'cmd': ('bash', 11:16:58 INFO - '-c', 11:16:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:16:58 INFO - 'enabled': True, 11:16:58 INFO - 'halt_on_failure': False, 11:16:58 INFO - 'name': 'check_screen_resolution'},), 11:16:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:16:58 INFO - 'cmd': ('bash', 11:16:58 INFO - '-c', 11:16:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:16:58 INFO - 'enabled': True, 11:16:58 INFO - 'halt_on_failure': False, 11:16:58 INFO - 'name': 'check_screen_resolution'},), 11:16:58 INFO - 'run_cmd_checks_enabled': True, 11:16:58 INFO - 'sps_profile': False, 11:16:58 INFO - 'sps_profile_interval': 0, 11:16:58 INFO - 'suite': 'dromaeojs', 11:16:58 INFO - 'system_bits': '32', 11:16:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:58 INFO - 'title': 't-yosemite-r7-0080', 11:16:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:58 INFO - 'use_talos_json': True, 11:16:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:58 INFO - 'work_dir': 'build'} 11:16:58 INFO - ##### 11:16:58 INFO - ##### Running clobber step. 11:16:58 INFO - ##### 11:16:58 INFO - Running pre-action listener: _resource_record_pre_action 11:16:58 INFO - Running main action method: clobber 11:16:58 INFO - rmtree: /builds/slave/test/build 11:16:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:00 INFO - Running post-action listener: _resource_record_post_action 11:17:00 INFO - ##### 11:17:00 INFO - ##### Running read-buildbot-config step. 11:17:00 INFO - ##### 11:17:00 INFO - Running pre-action listener: _resource_record_pre_action 11:17:00 INFO - Running main action method: read_buildbot_config 11:17:00 INFO - Using buildbot properties: 11:17:00 INFO - { 11:17:00 INFO - "project": "", 11:17:00 INFO - "product": "firefox", 11:17:00 INFO - "script_repo_revision": "production", 11:17:00 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:17:00 INFO - "repository": "", 11:17:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:17:00 INFO - "buildid": "20160305102518", 11:17:00 INFO - "pgo_build": "False", 11:17:00 INFO - "basedir": "/builds/slave/test", 11:17:00 INFO - "buildnumber": 493, 11:17:00 INFO - "slavename": "t-yosemite-r7-0080", 11:17:00 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:17:00 INFO - "platform": "yosemite_r7", 11:17:00 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:17:00 INFO - "branch": "fx-team", 11:17:00 INFO - "repo_path": "integration/fx-team", 11:17:00 INFO - "revision": "b29add2c129122e4af8582cac68259c0cc96baec", 11:17:00 INFO - "stage_platform": "macosx64", 11:17:00 INFO - "builduid": "16be7c43898448f68b14aff72f71d532", 11:17:00 INFO - "slavebuilddir": "test" 11:17:00 INFO - } 11:17:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 11:17:00 INFO - Running post-action listener: _resource_record_post_action 11:17:00 INFO - ##### 11:17:00 INFO - ##### Running download-and-extract step. 11:17:00 INFO - ##### 11:17:00 INFO - Running pre-action listener: _resource_record_pre_action 11:17:00 INFO - Running main action method: download_and_extract 11:17:00 INFO - mkdir: /builds/slave/test/build/tests 11:17:00 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')]} 11:17:00 INFO - https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:17:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 11:17:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 11:17:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 11:17:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 11:17:02 INFO - Downloaded 1277 bytes. 11:17:02 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 11:17:02 INFO - Using the following test package requirements: 11:17:02 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:17:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:17:02 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 11:17:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:17:02 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 11:17:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:17:02 INFO - u'jsshell-mac.zip'], 11:17:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:17:02 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 11:17:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:17:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:17:02 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 11:17:02 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:17:02 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 11:17:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:17:02 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 11:17:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:17:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:17:02 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 11:17:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:02 INFO - https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/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 11:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/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 11:17:04 INFO - Downloaded 17860932 bytes. 11:17:04 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'] 11:17:04 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 11:17:07 INFO - Return code: 0 11:17:07 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 11:17:07 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')]} 11:17:07 INFO - https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:17:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:17:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:17:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/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 11:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/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 11:17:22 INFO - Downloaded 17860932 bytes. 11:17:22 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'] 11:17:22 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 11:17:25 INFO - Return code: 0 11:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:25 INFO - https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:17:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:17:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:17:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/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 11:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/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 11:17:26 INFO - Downloaded 10803659 bytes. 11:17:26 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'] 11:17:26 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 11:17:27 INFO - Return code: 0 11:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:27 INFO - https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:17:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:17:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:17:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 11:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XG-qFvTfRVmp6uXpT0vT7g/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 11:17:30 INFO - Downloaded 110928212 bytes. 11:17:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:17:30 INFO - mkdir: /builds/slave/test/properties 11:17:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:17:30 INFO - Writing to file /builds/slave/test/properties/build_url 11:17:30 INFO - Contents: 11:17:30 INFO - build_url:https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:17:32 INFO - Running post-action listener: _resource_record_post_action 11:17:32 INFO - Running post-action listener: set_extra_try_arguments 11:17:32 INFO - ##### 11:17:32 INFO - ##### Running populate-webroot step. 11:17:32 INFO - ##### 11:17:32 INFO - Running pre-action listener: _resource_record_pre_action 11:17:32 INFO - Running main action method: populate_webroot 11:17:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:17:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:17:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:17:32 INFO - '--tppagecycles', 11:17:32 INFO - '7'], 11:17:32 INFO - 'tests': ['tsvgm']}}, 11:17:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:17:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:17:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:17:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:17:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:17:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:32 INFO - 'talos_options': ['--e10s'], 11:17:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:32 INFO - 'tests': ['damp', 'tps']}, 11:17:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:32 INFO - 'talos_options': ['--e10s'], 11:17:32 INFO - 'tests': ['damp', 'tps']}, 11:17:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:17:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:32 INFO - 'other': {'tests': ['a11yr', 11:17:32 INFO - 'ts_paint', 11:17:32 INFO - 'tpaint', 11:17:32 INFO - 'sessionrestore', 11:17:32 INFO - 'sessionrestore_no_auto_restore']}, 11:17:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:17:32 INFO - 'tests': ['a11yr', 11:17:32 INFO - 'ts_paint', 11:17:32 INFO - 'tpaint', 11:17:32 INFO - 'sessionrestore', 11:17:32 INFO - 'sessionrestore_no_auto_restore']}, 11:17:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:17:32 INFO - 'tests': ['a11yr', 11:17:32 INFO - 'ts_paint', 11:17:32 INFO - 'tpaint', 11:17:32 INFO - 'sessionrestore', 11:17:32 INFO - 'sessionrestore_no_auto_restore']}, 11:17:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:17:32 INFO - 'tests': ['a11yr', 11:17:32 INFO - 'ts_paint', 11:17:32 INFO - 'tpaint', 11:17:32 INFO - 'sessionrestore', 11:17:32 INFO - 'sessionrestore_no_auto_restore']}, 11:17:32 INFO - 'other_l64': {'tests': ['a11yr', 11:17:32 INFO - 'ts_paint', 11:17:32 INFO - 'tpaint', 11:17:32 INFO - 'sessionrestore', 11:17:32 INFO - 'sessionrestore_no_auto_restore']}, 11:17:32 INFO - 'other_nol64': {'tests': ['a11yr', 11:17:32 INFO - 'ts_paint', 11:17:32 INFO - 'tpaint', 11:17:32 INFO - 'sessionrestore', 11:17:32 INFO - 'sessionrestore_no_auto_restore']}, 11:17:32 INFO - 'svgr': {'tests': ['tsvgx', 11:17:32 INFO - 'tsvgr_opacity', 11:17:32 INFO - 'tart', 11:17:32 INFO - 'tscrollx', 11:17:32 INFO - 'cart']}, 11:17:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:17:32 INFO - 'tests': ['tsvgx', 11:17:32 INFO - 'tsvgr_opacity', 11:17:32 INFO - 'tart', 11:17:32 INFO - 'tscrollx', 11:17:32 INFO - 'cart']}, 11:17:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:32 INFO - 'tests': ['tp5o']}, 11:17:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:32 INFO - 'talos_options': ['--e10s'], 11:17:32 INFO - 'tests': ['tp5o']}, 11:17:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:32 INFO - 'talos_options': ['--xperf_path', 11:17:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:32 INFO - 'tests': ['tp5n']}, 11:17:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:32 INFO - 'talos_options': ['--e10s', 11:17:32 INFO - '--xperf_path', 11:17:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:32 INFO - 'tests': ['tp5n']}}, 11:17:32 INFO - 'talos.zip': {'path': '', 11:17:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:17:32 INFO - Running post-action listener: _resource_record_post_action 11:17:32 INFO - ##### 11:17:32 INFO - ##### Running create-virtualenv step. 11:17:32 INFO - ##### 11:17:32 INFO - Running pre-action listener: _resource_record_pre_action 11:17:32 INFO - Running main action method: create_virtualenv 11:17:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:17:32 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 11:17:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:17:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:32 INFO - Using real prefix '/tools/python27' 11:17:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:17:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:35 INFO - Installing pip.................done. 11:17:35 INFO - Return code: 0 11:17:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17:35 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')]} 11:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:35 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')]} 11:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:35 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 0x10cbcba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d88d645d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, '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.qV0ypB7orT/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.Ej99AEMpaz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:17:35 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 11:17:35 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 11:17:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:17:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:35 INFO - 'HOME': '/Users/cltbld', 11:17:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:35 INFO - 'LOGNAME': 'cltbld', 11:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:35 INFO - 'MOZ_NO_REMOTE': '1', 11:17:35 INFO - 'NO_EM_RESTART': '1', 11:17:35 INFO - 'PAGER': '/bin/cat', 11:17:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:35 INFO - 'PWD': '/builds/slave/test', 11:17:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:35 INFO - 'SHELL': '/bin/bash', 11:17:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:17:35 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:17:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:35 INFO - 'USER': 'cltbld', 11:17:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:35 INFO - 'XPC_FLAGS': '0x0', 11:17:35 INFO - 'XPC_SERVICE_NAME': '0', 11:17:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:36 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 11:17:36 INFO - Cleaning up... 11:17:36 INFO - Return code: 0 11:17:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:17:36 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')]} 11:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:36 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')]} 11:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:36 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 0x10cbcba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d88d645d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, '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.qV0ypB7orT/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.Ej99AEMpaz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:17:36 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 11:17:36 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 11:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:36 INFO - 'HOME': '/Users/cltbld', 11:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:36 INFO - 'LOGNAME': 'cltbld', 11:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:36 INFO - 'MOZ_NO_REMOTE': '1', 11:17:36 INFO - 'NO_EM_RESTART': '1', 11:17:36 INFO - 'PAGER': '/bin/cat', 11:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:36 INFO - 'PWD': '/builds/slave/test', 11:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:36 INFO - 'SHELL': '/bin/bash', 11:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:17:36 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:36 INFO - 'USER': 'cltbld', 11:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:36 INFO - 'XPC_FLAGS': '0x0', 11:17:36 INFO - 'XPC_SERVICE_NAME': '0', 11:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:36 INFO - Downloading/unpacking psutil>=0.7.1 11:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:39 INFO - Installing collected packages: psutil 11:17:39 INFO - Running setup.py install for psutil 11:17:39 INFO - building 'psutil._psutil_osx' extension 11:17:39 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 11:17:40 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 11:17:40 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 11:17:40 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 11:17:40 INFO - building 'psutil._psutil_posix' extension 11:17:40 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 11:17:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:17:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:17:40 INFO - ^ 11:17:40 INFO - 1 warning generated. 11:17:40 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 11:17:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:40 INFO - Successfully installed psutil 11:17:40 INFO - Cleaning up... 11:17:40 INFO - Return code: 0 11:17:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:40 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 0x10cbcba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d88d645d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, '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.qV0ypB7orT/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.Ej99AEMpaz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:17:40 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 11:17:40 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 11:17:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:17:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:40 INFO - 'HOME': '/Users/cltbld', 11:17:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:40 INFO - 'LOGNAME': 'cltbld', 11:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:40 INFO - 'MOZ_NO_REMOTE': '1', 11:17:40 INFO - 'NO_EM_RESTART': '1', 11:17:40 INFO - 'PAGER': '/bin/cat', 11:17:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:40 INFO - 'PWD': '/builds/slave/test', 11:17:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:40 INFO - 'SHELL': '/bin/bash', 11:17:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:17:40 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:17:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:40 INFO - 'USER': 'cltbld', 11:17:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:40 INFO - 'XPC_FLAGS': '0x0', 11:17:40 INFO - 'XPC_SERVICE_NAME': '0', 11:17:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:17:40 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 11:17:40 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 11:17:40 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 11:17:40 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 11:17:40 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 11:17:40 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 11:17:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:17:43 INFO - Installing collected packages: mozsystemmonitor 11:17:43 INFO - Running setup.py install for mozsystemmonitor 11:17:43 INFO - Successfully installed mozsystemmonitor 11:17:43 INFO - Cleaning up... 11:17:43 INFO - Return code: 0 11:17:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:43 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 0x10cbcba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d88d645d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, '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.qV0ypB7orT/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.Ej99AEMpaz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:17:43 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 11:17:43 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 11:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:43 INFO - 'HOME': '/Users/cltbld', 11:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:43 INFO - 'LOGNAME': 'cltbld', 11:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:43 INFO - 'MOZ_NO_REMOTE': '1', 11:17:43 INFO - 'NO_EM_RESTART': '1', 11:17:43 INFO - 'PAGER': '/bin/cat', 11:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:43 INFO - 'PWD': '/builds/slave/test', 11:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:43 INFO - 'SHELL': '/bin/bash', 11:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:17:43 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:43 INFO - 'USER': 'cltbld', 11:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:43 INFO - 'XPC_FLAGS': '0x0', 11:17:43 INFO - 'XPC_SERVICE_NAME': '0', 11:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:43 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 11:17:43 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 11:17:43 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 11:17:43 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 11:17:43 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 11:17:43 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 11:17:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:47 INFO - Downloading docopt-0.6.1.tar.gz 11:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:47 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:47 INFO - Running setup.py install for blobuploader 11:17:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:47 INFO - Running setup.py install for requests 11:17:48 INFO - Running setup.py install for docopt 11:17:48 INFO - Successfully installed blobuploader requests docopt 11:17:48 INFO - Cleaning up... 11:17:48 INFO - Return code: 0 11:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:48 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')]} 11:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:48 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')]} 11:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:48 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 0x10cbcba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d88d645d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, '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.qV0ypB7orT/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.Ej99AEMpaz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:17:48 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 11:17:48 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 11:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:48 INFO - 'HOME': '/Users/cltbld', 11:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:48 INFO - 'LOGNAME': 'cltbld', 11:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:48 INFO - 'MOZ_NO_REMOTE': '1', 11:17:48 INFO - 'NO_EM_RESTART': '1', 11:17:48 INFO - 'PAGER': '/bin/cat', 11:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:48 INFO - 'PWD': '/builds/slave/test', 11:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:48 INFO - 'SHELL': '/bin/bash', 11:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:17:48 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:48 INFO - 'USER': 'cltbld', 11:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:48 INFO - 'XPC_FLAGS': '0x0', 11:17:48 INFO - 'XPC_SERVICE_NAME': '0', 11:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-53WPZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-FlJQrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ySa09o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-awqnIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:48 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Ih9wV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Kw2QHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-JGOj78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-MOEKb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-de_Wqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-bQT_Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Y2A7ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-EhfsNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-7NpkPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-NPVLQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:49 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-IRjjK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:50 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-nLSkGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:50 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-UIkF9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:50 INFO - Running setup.py install for manifestparser 11:17:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:50 INFO - Running setup.py install for mozcrash 11:17:50 INFO - Running setup.py install for mozdebug 11:17:50 INFO - Running setup.py install for mozdevice 11:17:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:50 INFO - Running setup.py install for mozfile 11:17:51 INFO - Running setup.py install for mozhttpd 11:17:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:51 INFO - Running setup.py install for mozinfo 11:17:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:51 INFO - Running setup.py install for mozInstall 11:17:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:51 INFO - Running setup.py install for mozleak 11:17:51 INFO - Running setup.py install for mozlog 11:17:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:51 INFO - Running setup.py install for moznetwork 11:17:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:51 INFO - Running setup.py install for mozprocess 11:17:52 INFO - Running setup.py install for mozprofile 11:17:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:52 INFO - Running setup.py install for mozrunner 11:17:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:52 INFO - Running setup.py install for mozscreenshot 11:17:52 INFO - Running setup.py install for moztest 11:17:52 INFO - Running setup.py install for mozversion 11:17:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:52 INFO - Cleaning up... 11:17:52 INFO - Return code: 0 11:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:52 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 0x10cbcba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d88d645d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, '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.qV0ypB7orT/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.Ej99AEMpaz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:17:52 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 11:17:52 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 11:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:52 INFO - 'HOME': '/Users/cltbld', 11:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:52 INFO - 'LOGNAME': 'cltbld', 11:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:52 INFO - 'MOZ_NO_REMOTE': '1', 11:17:52 INFO - 'NO_EM_RESTART': '1', 11:17:52 INFO - 'PAGER': '/bin/cat', 11:17:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:52 INFO - 'PWD': '/builds/slave/test', 11:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:52 INFO - 'SHELL': '/bin/bash', 11:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:17:52 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:52 INFO - 'USER': 'cltbld', 11:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:52 INFO - 'XPC_FLAGS': '0x0', 11:17:52 INFO - 'XPC_SERVICE_NAME': '0', 11:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-fgpoEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:53 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)) 11:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-E6K6iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:53 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)) 11:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-OXwZGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:53 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)) 11:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-9GG7vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:53 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)) 11:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Ns_TLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:53 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)) 11:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-b2DoBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:53 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)) 11:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-awbAe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:53 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)) 11:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-75164s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:53 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)) 11:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-fgNr2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:54 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)) 11:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:54 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-6vcV3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:54 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)) 11:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:54 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-AVGFna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:54 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)) 11:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:54 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-d96q51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:54 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)) 11:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:54 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-2GPNWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:54 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)) 11:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:54 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-iL0gN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:54 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)) 11:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:54 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-KGXO0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:54 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)) 11:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:54 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-JfimeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:54 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)) 11:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:54 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-p7FM4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:54 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)) 11:17:54 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)) 11:17:54 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)) 11:17:54 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)) 11:17:54 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)) 11:17:54 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)) 11:17:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:54 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 11:17:54 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 11:17:54 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 11:17:54 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 11:17:54 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 11:17:54 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 11:17:57 INFO - Downloading blessings-1.6.tar.gz 11:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:57 INFO - Installing collected packages: blessings 11:17:57 INFO - Running setup.py install for blessings 11:17:57 INFO - Successfully installed blessings 11:17:57 INFO - Cleaning up... 11:17:57 INFO - Return code: 0 11:17:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:57 INFO - Reading from file tmpfile_stdout 11:17:57 INFO - Current package versions: 11:17:57 INFO - blessings == 1.6 11:17:57 INFO - blobuploader == 1.2.4 11:17:57 INFO - docopt == 0.6.1 11:17:57 INFO - manifestparser == 1.1 11:17:57 INFO - mozInstall == 1.12 11:17:57 INFO - mozcrash == 0.16 11:17:57 INFO - mozdebug == 0.1 11:17:57 INFO - mozdevice == 0.48 11:17:57 INFO - mozfile == 1.2 11:17:57 INFO - mozhttpd == 0.7 11:17:57 INFO - mozinfo == 0.9 11:17:57 INFO - mozleak == 0.1 11:17:57 INFO - mozlog == 3.1 11:17:57 INFO - moznetwork == 0.27 11:17:57 INFO - mozprocess == 0.22 11:17:57 INFO - mozprofile == 0.28 11:17:57 INFO - mozrunner == 6.11 11:17:57 INFO - mozscreenshot == 0.1 11:17:57 INFO - mozsystemmonitor == 0.0 11:17:57 INFO - moztest == 0.7 11:17:57 INFO - mozversion == 1.4 11:17:57 INFO - psutil == 3.1.1 11:17:57 INFO - requests == 1.2.3 11:17:57 INFO - wsgiref == 0.1.2 11:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:57 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 0x10cbcba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d88d645d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, '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.qV0ypB7orT/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.Ej99AEMpaz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:17:57 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 11:17:57 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 11:17:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:17:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:57 INFO - 'HOME': '/Users/cltbld', 11:17:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:57 INFO - 'LOGNAME': 'cltbld', 11:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:57 INFO - 'MOZ_NO_REMOTE': '1', 11:17:57 INFO - 'NO_EM_RESTART': '1', 11:17:57 INFO - 'PAGER': '/bin/cat', 11:17:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:57 INFO - 'PWD': '/builds/slave/test', 11:17:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:57 INFO - 'SHELL': '/bin/bash', 11:17:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:17:57 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:17:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:57 INFO - 'USER': 'cltbld', 11:17:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:57 INFO - 'XPC_FLAGS': '0x0', 11:17:57 INFO - 'XPC_SERVICE_NAME': '0', 11:17:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:58 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)) 11:17:58 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)) 11:17:58 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)) 11:17:58 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)) 11:17:58 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)) 11:17:58 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)) 11:17:58 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)) 11:17:58 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)) 11:17:58 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)) 11:17:58 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)) 11:17:58 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)) 11:17:58 INFO - Cleaning up... 11:17:58 INFO - Return code: 0 11:17:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:58 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 0x10cbcba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d88d645d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, '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.qV0ypB7orT/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.Ej99AEMpaz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:17:58 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 11:17:58 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 11:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:58 INFO - 'HOME': '/Users/cltbld', 11:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:58 INFO - 'LOGNAME': 'cltbld', 11:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:58 INFO - 'MOZ_NO_REMOTE': '1', 11:17:58 INFO - 'NO_EM_RESTART': '1', 11:17:58 INFO - 'PAGER': '/bin/cat', 11:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:58 INFO - 'PWD': '/builds/slave/test', 11:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:58 INFO - 'SHELL': '/bin/bash', 11:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:17:58 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:58 INFO - 'USER': 'cltbld', 11:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:58 INFO - 'XPC_FLAGS': '0x0', 11:17:58 INFO - 'XPC_SERVICE_NAME': '0', 11:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:58 INFO - Downloading/unpacking jsonschema 11:17:58 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 11:17:58 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 11:17:58 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 11:17:58 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 11:17:58 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 11:17:58 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 11:18:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:00 INFO - Downloading/unpacking functools32 (from jsonschema) 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:01 INFO - warning: no files found matching '*.txt' 11:18:01 INFO - no previously-included directories found matching 'build' 11:18:01 INFO - no previously-included directories found matching 'dist' 11:18:01 INFO - no previously-included directories found matching '.git*' 11:18:01 INFO - Installing collected packages: jsonschema, functools32 11:18:01 INFO - Running setup.py install for functools32 11:18:01 INFO - warning: no files found matching '*.txt' 11:18:01 INFO - no previously-included directories found matching 'build' 11:18:01 INFO - no previously-included directories found matching 'dist' 11:18:01 INFO - no previously-included directories found matching '.git*' 11:18:01 INFO - Successfully installed jsonschema functools32 11:18:01 INFO - Cleaning up... 11:18:01 INFO - Return code: 0 11:18:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:01 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 0x10cbcba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d88d645d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, '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.qV0ypB7orT/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.Ej99AEMpaz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 11:18:01 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 11:18:01 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 11:18:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:18:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:01 INFO - 'HOME': '/Users/cltbld', 11:18:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:01 INFO - 'LOGNAME': 'cltbld', 11:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:01 INFO - 'MOZ_NO_REMOTE': '1', 11:18:01 INFO - 'NO_EM_RESTART': '1', 11:18:01 INFO - 'PAGER': '/bin/cat', 11:18:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:01 INFO - 'PWD': '/builds/slave/test', 11:18:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:01 INFO - 'SHELL': '/bin/bash', 11:18:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:18:01 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:18:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:01 INFO - 'USER': 'cltbld', 11:18:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:01 INFO - 'XPC_FLAGS': '0x0', 11:18:01 INFO - 'XPC_SERVICE_NAME': '0', 11:18:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:01 INFO - Downloading/unpacking flake8 11:18:01 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 11:18:01 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 11:18:01 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 11:18:01 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 11:18:01 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 11:18:01 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 11:18:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:18:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:18:04 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 11:18:04 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 11:18:04 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 11:18:04 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 11:18:04 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 11:18:04 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 11:18:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:18:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:18:04 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 11:18:04 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 11:18:04 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 11:18:04 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 11:18:04 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 11:18:04 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 11:18:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:18:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:05 INFO - no previously-included directories found matching 'docs/_build' 11:18:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:18:05 INFO - Running setup.py install for pep8 11:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:06 INFO - no previously-included directories found matching 'docs/_build' 11:18:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:18:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:18:06 INFO - Cleaning up... 11:18:06 INFO - Return code: 0 11:18:06 INFO - Running post-action listener: _resource_record_post_action 11:18:06 INFO - Running post-action listener: _start_resource_monitoring 11:18:06 INFO - Starting resource monitoring. 11:18:06 INFO - ##### 11:18:06 INFO - ##### Running install step. 11:18:06 INFO - ##### 11:18:06 INFO - Running pre-action listener: _resource_record_pre_action 11:18:06 INFO - Running main action method: install 11:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:06 INFO - Reading from file tmpfile_stdout 11:18:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:06 INFO - Reading from file tmpfile_stdout 11:18:06 INFO - Output received: 11:18:06 INFO - Usage: mozinstall [options] installer 11:18:06 INFO - Options: 11:18:06 INFO - -h, --help show this help message and exit 11:18:06 INFO - -d DEST, --destination=DEST 11:18:06 INFO - Directory to install application into. [default: 11:18:06 INFO - "/builds/slave/test"] 11:18:06 INFO - --app=APP Application being installed. [default: firefox] 11:18:06 INFO - mkdir: /builds/slave/test/build/application 11:18:06 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'] 11:18:06 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 11:18:40 INFO - Reading from file tmpfile_stdout 11:18:40 INFO - Output received: 11:18:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:18:40 INFO - Running post-action listener: _resource_record_post_action 11:18:40 INFO - ##### 11:18:40 INFO - ##### Running run-tests step. 11:18:40 INFO - ##### 11:18:40 INFO - Running pre-action listener: _resource_record_pre_action 11:18:40 INFO - Running main action method: run_tests 11:18:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:18:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:18:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:18:40 INFO - 2016-03-05 11:18:40.664 screenresolution[1642:7654] starting screenresolution argv=screenresolution get 11:18:40 INFO - 2016-03-05 11:18:40.666 screenresolution[1642:7654] Display 0: 1600x1200x32@60 11:18:40 INFO - 2016-03-05 11:18:40.673 screenresolution[1643:7656] starting screenresolution argv=screenresolution list 11:18:40 INFO - Available Modes on Display 0 11:18:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:18:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:18:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:18:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:18:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:18:40 INFO - Intel Iris: 11:18:40 INFO - Chipset Model: Intel Iris 11:18:40 INFO - Type: GPU 11:18:40 INFO - Bus: Built-In 11:18:40 INFO - VRAM (Dynamic, Max): 1536 MB 11:18:40 INFO - Vendor: Intel (0x8086) 11:18:40 INFO - Device ID: 0x0a2e 11:18:40 INFO - Revision ID: 0x0009 11:18:40 INFO - Displays: 11:18:40 INFO - Display: 11:18:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:18:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:18:40 INFO - Display Serial Number: 1600x1200 60 11:18:40 INFO - Main Display: Yes 11:18:40 INFO - Mirror: Off 11:18:40 INFO - Online: Yes 11:18:40 INFO - Rotation: Supported 11:18:40 INFO - Return code: 0 11:18:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:18:40 INFO - Python 2.7.3 11:18:40 INFO - Return code: 0 11:18:40 INFO - grabbing minidump binary from tooltool 11:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:40 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 0x10ca6fd30>, '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 0x10c893db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:18:40 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 11:18:40 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 11:18:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:18:40 INFO - Return code: 0 11:18:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:18:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:18:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:18:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:18:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:18:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:18:42 INFO - Return code: 0 11:18:42 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:18:42 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qV0ypB7orT/Render', 11:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:42 INFO - 'HOME': '/Users/cltbld', 11:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:42 INFO - 'LOGNAME': 'cltbld', 11:18:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:18:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:42 INFO - 'MOZ_NO_REMOTE': '1', 11:18:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:18:42 INFO - 'NO_EM_RESTART': '1', 11:18:42 INFO - 'PAGER': '/bin/cat', 11:18:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:42 INFO - 'PWD': '/builds/slave/test', 11:18:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:42 INFO - 'SHELL': '/bin/bash', 11:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej99AEMpaz/Listeners', 11:18:42 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 11:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:42 INFO - 'USER': 'cltbld', 11:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:42 INFO - 'XPC_FLAGS': '0x0', 11:18:42 INFO - 'XPC_SERVICE_NAME': '0', 11:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:18:42 INFO - mozversion application_buildid: 20160305102518 11:18:42 INFO - mozversion application_changeset: b29add2c129122e4af8582cac68259c0cc96baec 11:18:42 INFO - mozversion application_display_name: Nightly 11:18:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:18:42 INFO - mozversion application_name: Firefox 11:18:42 INFO - mozversion application_remotingname: firefox 11:18:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:18:42 INFO - mozversion application_vendor: Mozilla 11:18:42 INFO - mozversion application_version: 47.0a1 11:18:42 INFO - mozversion platform_buildid: 20160305102518 11:18:42 INFO - mozversion platform_changeset: b29add2c129122e4af8582cac68259c0cc96baec 11:18:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:18:42 INFO - mozversion platform_version: 47.0a1 11:18:42 INFO - using testdate: 1457205522 11:18:42 INFO - actual date: 1457205522 11:18:42 INFO - starting webserver on 'localhost:49272' 11:18:42 INFO - SUITE-START | Running 2 tests 11:18:42 INFO - TEST-START | dromaeo_css 11:18:42 INFO - operating with platform_type : mac_ 11:18:42 INFO - Initialising browser for dromaeo_css test... 11:18:42 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpzDCwqs/profile http://localhost:49272/getInfo.html) 11:18:44 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 11:18:44 INFO - PROCESS | 1661 | colorDepth:24 11:18:44 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 11:18:44 INFO - PROCESS | 1661 | __metrics 11:18:44 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:18:44 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:18:45 INFO - TEST-INFO | 1661: exit 0 11:18:45 INFO - Browser initialized. 11:18:45 INFO - Running cycle 1/1 for dromaeo_css test... 11:18:45 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpzDCwqs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:57 INFO - PROCESS | 1664 | RSS: Main: 245960704 11:18:57 INFO - PROCESS | 1664 | 11:19:48 INFO - PROCESS | 1664 | 1457205588636 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] 11:21:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 11:22:01 INFO - PROCESS | 1664 | RSS: Main: 337403904 11:22:01 INFO - PROCESS | 1664 | 11:25:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 11:25:04 INFO - PROCESS | 1664 | RSS: Main: 375267328 11:25:04 INFO - PROCESS | 1664 | 11:28:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 11:28:06 INFO - PROCESS | 1664 | RSS: Main: 374259712 11:28:06 INFO - PROCESS | 1664 | 11:31:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 11:31:09 INFO - PROCESS | 1664 | RSS: Main: 332464128 11:31:09 INFO - PROCESS | 1664 | 11:34:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 11:34:13 INFO - PROCESS | 1664 | RSS: Main: 333991936 11:34:13 INFO - PROCESS | 1664 | 11:37:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 11:37:16 INFO - PROCESS | 1664 | RSS: Main: 391368704 11:37:16 INFO - PROCESS | 1664 | 11:37:16 INFO - PROCESS | 1664 | __start_tp_report 11:37:16 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 11:37:16 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 11:37:16 INFO - PROCESS | 1664 | |i|pagename|runs| 11:37:16 INFO - PROCESS | 1664 | |0;dojo.html;3326.4843949187875;3406.642302558231;3441.913952151196;3454.4990976308422;3484.1986343141075;5424.593155513342;5518.641288316257;5543.805966791163;5572.6377785443965;5577.637453565515;5527.060399732045;5578.888422231553;5581.302337207849;5677.574181936361;5693.715314234292;5011.473795251501;5039.370078740158;5072.619553533481;5097.49025097491;5203.089459344599;5156.664816786897;5166.405863325709;5204.505571970676;5208.427073021964;5220.765065572039;4989.9750501247445;5031.698098114125;5082.923756143679;5134.4095429025765;5137.255098010767;5161.303224064741;5163.302954101186;5172.353455818023;5175.146100893348;5190.506901844319;5093.872653183663;5143.665661731976;5147.613928955306;5151.356080489939;5157.149070403379;5365.007473617393;5468.9726551367385;5480.534154596864;5587.9941610510095;5597.496225339739;6123.969380153071;6133.969330153365;6138.416850399205;6159.568830181889;6173.290071641729;5386.461353864622;6158.6612736299485;6207.534434917354;6215.28524219716;6218.440340369389;5549.19536667181;5648.689322087324;5659.179418984266;5751.568632352507;5765.538756899438;6273.12176295319;6287.874242515124;6292.307846136921;6293.716782744787;6326.335734747785;5958.225430693982;5969.492593129546;6023.006203976295;6034.758609655564;6041.124037014608;6040.667763272974;6109.495762817221;6127.816165515042;6179.938200618026;6188.938110618927;6117.393215327435;6127.509799216052;6132.294322189902;6143;6145.692715364304;6115.088229002436;6124.136831511461;6134.141220229171;6142.665787001;6177.1969643945995;4703.835365762182;4791.233402655558;4811.206150985118;4818.903621927542;4822.397200349957;4274.995376086617;4356.9128617428105;4361.433013708261;4362.062156636339;4368.235558777201;5450.454954504517;5513.117901135799;5536.833894983157;5540.556755459635;5546.140348246028;6115.088229002346;6146.371211628922;6209.844753881099;6236.844078897973;6241.095041218998;5527.695976721238;5531.004419204502;5531.529819965348;5540;5549.223108764695;5124.92312615311;5217.582593392595;5229.738513074331;5236.790528378822;5245.055889939771;6187.752489900354;6291.276503202007;6299.4645455135;6322.49420046386;6322.557420980579;6171.691415429301;6193.318734939063;6193.597416167935;6207.286162091236;6214.8135555933395;6164.260288765377;6221.129041934042;6286.088517165077;6286.277078136073;6330.778422755181;5296.629235953446;5748.310202775694;6038.607490513103;6042.3655516170165;6092.543059270483;6127.234095738033;6140.048292514667;6146.692665366803;6158.445739883432;6160.10678451631;5734.741936612779;5888.381719919518;5910.7340169693325;5938.287405511366;5994.610350327215;5893.351731309467;5940.316863560746;5955.612885162451;5957.4042595740075;5959.195508606283;5760.654360738369;5792.391798861059;5804.361520232856;5807.535397168301;5808.535317174531;5594.328680558359;5973.223480947449;6031.215941927521;6048.667323297261;6083.057126145454;5815.331236907809;5818.44724751148;5830.970845145916;5841.240638716939;5846.503047241032 11:37:16 INFO - PROCESS | 1664 | |1;ext.html;491.0522691205971;581.5057201378828;590.5275779376498;637.4486069549839;639.0861068671799;26805.59791603125;29188.854055729716;30977.225569360777;30986;31060.534091988637;31685.841570792112;39559.011024724394;40808.59191408085;40887.38668919969;40910.79544602273;9598.664046758366;9772.560234789451;9773.21463382936;9783.972682868267;9797.216222702167;9552.283578731589;9687.031296870291;9693.612255509772;9695.563699633498;9723.12491875731;9654.613815447374;9721.902780972207;9725.51372431379;9728.221742260603;9732.854007189897;9607.375520591175;9832.213422926148;9834.213262938947;9852.211823054211;9880.456574888414;9765.169960553361;9886.604535818558;9891.30760846741;9891.30760846741;9913.405195688281;40340.991475213064;40672.59327406747;40681.79659101715;40697.593024069676;40709.389359159635;3314.436545787222;3410.3520331137006;3411.113110591264;3508.333416650854;3925.2738243425056;27042.45915081707;27813.443731125266;27969.300767480774;28059.035867489285;28284.717152828413;2748.69764325924;2762.5718013707906;2850.315924178203;2869.4548035873117;2894.7539459145996;287325.5633721839;383481;390334;393403;393731.99999999715;45711.771441142584;46154;68175;69320.6533967337;69448.6527567369;47158.528414715416;47170.76414617905;47264.291035634495;47360.7631961838;47435.76282118567;15622.843771562366;15775.447859324868;15795.842041579437;15812.130332831575;15865;12619.495220191273;12694.238345699288;12694.555690550786;12728.872711272768;12745.872541274653;14737.11577305365;14753.77869331961;14766.92616536932;14780.482683106255;14903.435139310433;6473.676316184172;6587.374199451045;6620.304867988792;6642.468602511787;6645.900311495331;971.3880255439169;971.7133445633414;987.6345752071636;1036.6216331039116;1076.838474228872;28957.986470473432;29084.27289317784;29606.555901661493;29644.851775741416;29663.110106696833;1040.7095201949528;1066.4987455895716;1124.668222874254;1137.6302701622005;1269.8730126987227;14775.70448591022;14777.926110369594;14836.92581537107;15243.3902643893;15484.458043968407;517930;522949;526738;526991;528457;58694.82610347769;59276.70361648164;59315.70342148262;59326.81346373048;59535;1346.8316460442445;1390.478570536049;1464.2751837840337;1484.2059498168212;1494.305148106136;28346.574801378407;28762.06743278892;28853.557322134227;29135.562966555943;29461.26346841346;47869.5213047879;48288;48288.758556206994;48416.75791621019;48728;361175;363557;363977;364141;364311;28479.718412671064;28923.42153156883;32678.673213267564;33231;33514.83242583772;42586;43533.564664352954;43820.78089609532;44111.77944110259;44248.55751442444;35192;36234.637653623126;36273.81863090667;36789;36825.81587092047;30240;35384.46923296204;35813.46279805857;36361.45457818082;36551.26897462089;35100.64899350974;35457.46813797847;35484.29031419306;36368.27263454663;36386.8180659095;31307.84346078255;31677.891273805308;31760.407605318753;31838.36323273568;31908;23744.762552374254;23982.60637007022;23999.52000960006;24299.63550546708;24331.51336973286 11:37:16 INFO - PROCESS | 1664 | |2;jquery.html;359.9640035996401;362.351391010092;364.1933118143312;369.8243334416153;373.80935722781373;19435.611287774253;19723.5069123272;20514.48713782156;20961.790382096173;21069.683954740653;20938.476538086517;21422.00091987123;21430.357089287347;22155.778442215575;22158.556828863413;6210.627362358262;6381.712822922979;6434.034894765776;6438.066480360345;6468.611883287018;4586.334981427691;4783.976080119594;4786.1145688047645;4786.21027530457;7161.570305781644;4782.354382158399;4794.544518270776;7417.925820741804;7565.167831538526;7566.356859666907;7346.63266836656;7422.480426370156;7534.773956781305;7542.35889949355;7550.320471157567;7108.0404145440225;7181.245969173266;7193.3166349196745;7193.964030179868;7204;26649.73350266492;27161.72838271612;27511.31221719453;28762.280942976384;28806.423871522453;2285.7714228577174;2318.0959425823944;2321.883905804703;2374.8218883583627;2399.8920048597856;15286.923565382102;15574.844251557453;15809.762853557206;16051.518454446385;16214.837851621569;1811.2392795026121;1861.3392245752834;1866.4960460675677;1896.2509808625653;1957.5986922680815;112300;113733;115597;117025;118730;9270.860937085949;10957.780844383067;11460.541578336773;11490.310581365145;11752.58865939688;13634.727305453835;13802.723945521033;13916.791248131287;13946;13985.3706583204;8569.700060497853;8581.013183483854;8589.613467393981;8683.739487815375;8685.08806575313;8730.17063378978;8747.650093996295;8751.956240218758;8819.91180088191;8832.205101540892;3557.6086630470627;4504.729716217037;4521.570450807168;4556.476005259437;4561.680682352204;1506.7287888180012;1551.2476448922264;1766.3596610965003;1798.1458807066538;1890.9905450472659;902.1970446302796;984.3650845204803;1002.9197664186847;1004.6182450668845;1046.1108058150512;19896.60206795856;19910.60178796416;19946.10242539089;20133.798662013192;20313.74980003222;808.6644042722322;906.7305771919234;949.9572519236651;953.2469349214043;955.345588272022;10187.439690816927;10825.78348433027;10978.945105274423;11013.449327533592;11051.226414151093;540961;619215;631373;636691;648325;120949;120983;125383.0786135244;126737.29682164325;130001.69998300086;1020.285799940045;1049.732318258839;1065.03082195202;1066.317556763672;1068.1027936533349;18289.90260584369;18641.627167456303;18724.344647937258;18734.812651873308;18812.596182100035;52138.95722085461;52714.73642631762;52800.20799687931;52921.470785291654;54077;77455.61272193604;77912;78889;81121;81640.59179704063;7857.253560911704;7996.480228785111;8013.799655008672;8033.517988920684;8137.62020127634;7997.280244777998;12385.814212786636;12914.35428228566;12929;13303.06878518533;11012.063974561932;11340.773184536098;11521.423928803359;11602.129840261845;11636.12729045342;10970.780584388109;11099.778004440028;11354.94322528415;11434.085273178292;11655.708607284885;11405.030572401107;11536.480858361561;11573.942130289295;11735.061195104201;11749.00133488663;7785.377169826287;7933.246341597539;7963.6814527418255;8058.83882322362;8122.918770812453;11721.413929303671;11801.023370770712;11957.940210298893;11960.461779219782;11983.400829958642 11:37:16 INFO - PROCESS | 1664 | |3;mootools.html;1417.2134465371714;1541.1369633005513;1569.2938177819983;1571.4028669105737;2044.2538473457184;7896.644650990705;8526.147385261478;8654.048054713976;8654.870176947335;8675.566221688914;8394.076651568323;8597.742067737978;8618.784530386743;8620.956895215515;8635.266002389804;2185.650295952648;2380.3216083416187;2413.8793060347;2484.5403600334;2495.70051593809;2497.3382053755677;2506.373406648338;2509.0214816221687;2510.159096702607;2512.258883629334;2422.685050943384;2473.2209354053507;2489.7759201671847;2490.3525083478244;2493.551160791057;2412.0572901060677;2455;2474.34429876083;2479.801615870744;2479.962800557993;2434.9878250608813;2464.149868295435;2476.5170791695627;2485.5401750676183;2485.7074321352975;8626.309895208367;8682.86975695365;8696.739097827076;8707.956460217722;8713.520756358397;5372.140457526816;5461.617686761928;5515.034868897927;5521.199426083235;5525.751341189656;2831.773458123366;3620.2940426616556;3671.706263498914;3682.907927301812;3691.9261614767825;1031.8710161229847;1037.870266216723;1040.0743338428729;1046.9390885296891;1057.989619912989;9662;11728.413579321;11772.470238839272;11782.823257651142;11783.999999999915;4794.9280760788615;4836.12949669063;4924.852254432372;4936.160852655057;4936.703797772073;10095.848562271573;10118.898811011943;10120.898791012143;10125.291229614004;10126.645567405105;5426.375966763794;5466.125419932871;5467.507924286833;5470.72646367688;5476.397596264408;4417.911641767211;4487.730736155841;4504.324351347324;4544.931826022612;4751.904961900743;3532.2405682778326;3809.3333666608787;3878.612138786099;3964.345882929342;4025.77858217795;1294.210531575738;1314.0867097367238;1318.1497933832625;1326.7280207557428;1327.2633688303085;1352.4184600621631;1365.1467832604621;1392.4639013979488;1396.6368744126396;1402.5161319344809;7871;8123.147069557729;8131.674733010614;8136.674533018613;8137.95931020353;503.8060346766448;513.6070905757099;519.8492437193172;520.6719766547051;521.6609204017343;6153.323134455206;6175.44421002112;6236.812895613139;6238.220222472191;6243.8126856194385;10247.231457640706;10726.302790318761;10733.409662468639;10741.194410419093;10751.78496430067;10373.429461379546;10482.266241363031;10516.526756295985;10518.703241895262;10586.894131058745;7118.216996130525;8179.509229446371;8214;8357.164283571716;8387.119352468026;7771;7829.021372328459;7870.488418252795;7875.976123104189;7897.091834439113;7713.884291735516;9227.953860230657;9514.143727064597;9519.857202141835;9664.806703866025;9575.760605984906;9915.058069483388;9955.900440995498;10042.297039207186;10050.09549140581;6685.966570167118;6879.415249703831;7458.067741532309;7500.099988001475;7532.133804612539;8097.190280971856;8219.342452603658;8233.300169485661;8237.670493180445;8246.134155913544;7204.4956853019785;7294.708211671474;7304.4156467483535;7431.962840185764;7443.776686699408;7127.964360178374;7153.85692286141;7260.891086633599;7276.308750668678;7313.744018959311;7426.777196684108;7606.277403646644;7640.465167438226;7649.808754781175;7652.846943060997;6895.310468953065;6903.275156108536;6929.237783843874;6941.895871561829;6977.092977912839;6911.032455456139;7016.473764467583;7016.964915175391;7031.43748500129;7038.859222815618 11:37:16 INFO - PROCESS | 1664 | |4;prototype.html;321.2530865737161;324.5310526289511;331.8622771549807;333.13052931847875;335.6090154969461;6448.580842245251;6515.133341329817;6576.342365763421;6586.506012049092;6595.604263744179;5644.617068818135;6424.293327733945;6479.384458476437;6494.5453818232745;6502.08970744095;3955.7626542407547;4351.325544540593;4703.43558772946;4741.075490279397;4845.418549774032;4296.334068219431;4497.842575509858;4802.807887684488;4806;4825.806967721287;4790.616750659939;4793.233082706767;4793.8667293054605;4799.13615549201;4802.375691160162;4587.541245875419;4679.672422930396;4782.904341913177;4812.518748125194;4813.78337974792;4101.507819061701;4121.464209652726;4123.670106391482;4124.13393187431;4132.73137246081;6121.510279177655;6147.323794382614;6177.135201071808;6256.906146407808;6262.718177682015;5668.546516278729;5711.114777209539;5718.399568045378;5727.198192253088;5731.369549349568;6722.663866806689;6954.3393377629045;6960.164780226354;6960.512764106515;6974.755883544051;3925.234579257046;4666.323383109464;4703.459102203256;4712.575868171881;4716.764161791931;7147.785566433015;7332.743353982638;7340.192578816326;7342.302481264272;7342.559446433231;4738.265568836767;4760.357351757469;4760.571548560646;4767.261074533453;4770.236762118045;4827.903441931212;4835.129676658235;4841.757912104381;4847.3698419205275;4853.12643724126;5718.8848174605555;5722.713864306768;5726.713664316851;5727.341355744059;5742.48317651405;6696.531242813054;6976.162860456778;6999.020137180799;7016.894746578805;7036.6481675916;1668.0658831054648;1677.9916100419664;1690.3999080326307;1694.872884533665;1697.5756060984754;835.6615570693879;1043.7703705184847;1049.816282150636;1055.0082922053246;1096.276457538037;5297.443768404262;6427.196600424947;6486.2216534016225;6537.542372033912;6541.378569035934;7259.092613423322;7272.672729727175;7280.0535930328715;7289.635518224068;7302.525335853153;5471.8084867029465;6347.174867267318;6481.935180648227;6495.415412612888;6509.153810004764;3798.430235464647;3841.9231615368094;3847.5382954045695;3849.0377405648587;3852.3836186210633;7146.857062858714;7550.735724249625;7571.053618297713;7573.394128469709;7598.772036838904;7482.139553951257;7501.962490187623;7525.0969883613225;7530.849383012309;7546.698132074655;5618.578606604439;7548.056492938383;7559.659815308324;7559.886601700979;7563.886541701769;6978.860422791618;7271.818204544928;7283.126024877049;7289.052423185164;7289.088863892013;7136.857262854817;7172.605506696973;7192.280771922975;7195.640217988975;7208.135023796968;7451.962740186481;7529.774106776806;7534.434917381328;7544.509606875536;7544.735934242275;4793.496682848251;4794.232922732346;4794.808207671654;4799.904001920012;4805.447373551947;6965.79102626922;7212.963935180291;7224.7471338505;7231.059962204879;7237.927620723725;6976.7558135465015;7025.297470253138;7025.613591252531;7025.964870175821;7033.29667033313;6912.585244885323;7005.914083317094;7014.824629384306;7021.43828493709;7024.297570242935;5235.65968212065;6836.282190370139;6847.691853866688;6848.3494068063455;6859.279775623488;6771.62756048422;6991.300869912968;7006.614636195059;7008.684609192701;7013.4038606719005;6477.546571739933;6647.335266473314;6657.267700553032;6703.095082163845;6857.382835544825 11:37:16 INFO - PROCESS | 1664 | |5;yui.html;700.4361489001353;764.1288930619095;765.8927750114989;778.8559116563432;826.566052822268;14871.925640371783;14904.403823847048;15052.473163439281;15123.168225747579;15128.848711512896;14170.93717971151;14275.643108922282;14277.143371397724;14278.2860856957;14289.356978935946;688.2738710660251;693.9930600693979;740.8814589665654;937.0676177203658;955.9569819358111;958.942463452195;963.3930623707055;963.9421634701905;964.2527041542791;965.0494263150791;997.1872923567306;1003.6487229469664;1006.521902096502;1007.6271779441616;1015.5633077776553;806.1575653442196;813.6013353456823;818.7257268814894;993.991099034477;998.6904059741504;606.6723969056704;692.5290802254465;758.215247219131;761.0372878308943;764.3503022430945;14861.702765944621;14942.402303907831;14949.476768313165;14957.925210373987;14965.551033469013;10542.578296868116;12591.811122833165;12687.682807929783;12826;13067.86932130676;9341.859872101924;9541.904580954171;9561.474118923456;9637.710868673881;9785.168260697848;3524;3547;3547.0245682437535;3576.338377400189;3614.8192590370377;76933;77205;77727.83408248881;79471.20528794696;82424.58787706083;8041.155678653774;8494.108118647453;9078.137576930181;9542.198260283962;9558.713238602853;22280;22436.439089022904;22488.550228995657;22505.32484025482;22513.549729005328;7394;7402.703891844266;7414.332710056121;7436.553806771611;7480.925190748132;4038.5759495252573;4078.062045729499;4091.4272001919753;4099.139180772071;4122.319817230184;3567.928641427157;3605.6574625410544;3615.240799432149;3616.240589476187;3620.7508409598645;644.3009334871623;645.7546132469631;666.2637785247329;675.4022689919457;713.0409599089216;488.5114885114885;503.88662550926483;586.4428792647002;623.3672822085587;634.4797266241729;7939;8348.248657620721;8372.162783721578;8379.958100209582;8415.074341822394;585.9267591551056;602.5631417222567;608.8325710429579;646.198713595148;657.8059472455542;3041.8593027614643;3775.6979441644603;3871.477350557695;3928.3714605663527;3931.5085614298214;93835.96230282757;94795.10409791766;94898.5255073734;96376.51811740897;96781.06437871204;80320;80967.19032809715;81175.18824811795;81232;81374;72084;72222.27777722155;72252.63873680598;72840;73009.6349518249;7561.621918904143;7595.696172153052;7793.454458187873;7988.760337189894;8167.305779008613;44012.559874402126;46985.76507117443;48366;48974;48976;62228;64277.67861160664;65045.02432463422;65297;65973.67013165096;8350.498970061815;9971.60113595477;10145.594176232868;10218.948905255425;10619;10774;10878.78242435131;11130.554777808797;11346.829797553208;11558.826617600911;8202.712905048294;10330.431826249629;10417.531211095367;10681.57273709043;10702.197335199735;10364.637237696645;10392.168626510012;10483.056524912794;10665.733356666145;10884.238103332691;8519.95740021296;10103.7474063149;10104.242181836538;10496.317739346918;10525.9473702631;8590;9017.2786177107;9047;9127.178553930178;9165.266778657558;7509.211532788979;8763.3427492937;8814.250788683034;8923.15230053144;8930.240929521064 11:37:16 INFO - PROCESS | 1664 | __end_tp_report 11:37:16 INFO - PROCESS | 1664 | __start_cc_report 11:37:16 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1111 11:37:16 INFO - PROCESS | 1664 | __end_cc_report 11:37:16 INFO - PROCESS | 1664 | __startTimestamp1457206636345__endTimestamp 11:37:16 INFO - PROCESS | 1664 | 11:37:16 INFO - PROCESS | 1664 | ------- Summary: start ------- 11:37:16 INFO - PROCESS | 1664 | Number of tests: 6 11:37:16 INFO - PROCESS | 1664 | 11:37:16 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5636.56 Median:5804.36 stddev:626.45 (10.8%) stddev-sans-first:601.59 11:37:16 INFO - PROCESS | 1664 | Values: 3326.5 3406.6 3441.9 3454.5 3484.2 5424.6 5518.6 5543.8 5572.6 5577.6 5527.1 5578.9 5581.3 5677.6 5693.7 5011.5 5039.4 5072.6 5097.5 5203.1 5156.7 5166.4 5204.5 5208.4 5220.8 4990.0 5031.7 5082.9 5134.4 5137.3 5161.3 5163.3 5172.4 5175.1 5190.5 5093.9 5143.7 5147.6 5151.4 5157.1 5365.0 5469.0 5480.5 5588.0 5597.5 6124.0 6134.0 6138.4 6159.6 6173.3 5386.5 6158.7 6207.5 6215.3 6218.4 5549.2 5648.7 5659.2 5751.6 5765.5 6273.1 6287.9 6292.3 6293.7 6326.3 5958.2 5969.5 6023.0 6034.8 6041.1 6040.7 6109.5 6127.8 6179.9 6188.9 6117.4 6127.5 6132.3 6143.0 6145.7 6115.1 6124.1 6134.1 6142.7 6177.2 4703.8 4791.2 4811.2 4818.9 4822.4 4275.0 4356.9 4361.4 4362.1 4368.2 5450.5 5513.1 5536.8 5540.6 5546.1 6115.1 6146.4 6209.8 6236.8 6241.1 5527.7 5531.0 5531.5 5540.0 5549.2 5124.9 5217.6 5229.7 5236.8 5245.1 6187.8 6291.3 6299.5 6322.5 6322.6 6171.7 6193.3 6193.6 6207.3 6214.8 6164.3 6221.1 6286.1 6286.3 6330.8 5296.6 5748.3 6038.6 6042.4 6092.5 6127.2 6140.0 6146.7 6158.4 6160.1 5734.7 5888.4 5910.7 5938.3 5994.6 5893.4 5940.3 5955.6 5957.4 5959.2 5760.7 5792.4 5804.4 5807.5 5808.5 5594.3 5973.2 6031.2 6048.7 6083.1 5815.3 5818.4 5831.0 5841.2 5846.5 11:37:16 INFO - PROCESS | 1664 | 11:37:16 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:56374.55 Median:36377.55 stddev:113263.35 (311.4%) stddev-sans-first:113503.37 11:37:16 INFO - PROCESS | 1664 | Values: 491.1 581.5 590.5 637.4 639.1 26805.6 29188.9 30977.2 30986.0 31060.5 31685.8 39559.0 40808.6 40887.4 40910.8 9598.7 9772.6 9773.2 9784.0 9797.2 9552.3 9687.0 9693.6 9695.6 9723.1 9654.6 9721.9 9725.5 9728.2 9732.9 9607.4 9832.2 9834.2 9852.2 9880.5 9765.2 9886.6 9891.3 9891.3 9913.4 40341.0 40672.6 40681.8 40697.6 40709.4 3314.4 3410.4 3411.1 3508.3 3925.3 27042.5 27813.4 27969.3 28059.0 28284.7 2748.7 2762.6 2850.3 2869.5 2894.8 287325.6 383481.0 390334.0 393403.0 393732.0 45711.8 46154.0 68175.0 69320.7 69448.7 47158.5 47170.8 47264.3 47360.8 47435.8 15622.8 15775.4 15795.8 15812.1 15865.0 12619.5 12694.2 12694.6 12728.9 12745.9 14737.1 14753.8 14766.9 14780.5 14903.4 6473.7 6587.4 6620.3 6642.5 6645.9 971.4 971.7 987.6 1036.6 1076.8 28958.0 29084.3 29606.6 29644.9 29663.1 1040.7 1066.5 1124.7 1137.6 1269.9 14775.7 14777.9 14836.9 15243.4 15484.5 517930.0 522949.0 526738.0 526991.0 528457.0 58694.8 59276.7 59315.7 59326.8 59535.0 1346.8 1390.5 1464.3 1484.2 1494.3 28346.6 28762.1 28853.6 29135.6 29461.3 47869.5 48288.0 48288.8 48416.8 48728.0 361175.0 363557.0 363977.0 364141.0 364311.0 28479.7 28923.4 32678.7 33231.0 33514.8 42586.0 43533.6 43820.8 44111.8 44248.6 35192.0 36234.6 36273.8 36789.0 36825.8 30240.0 35384.5 35813.5 36361.5 36551.3 35100.6 35457.5 35484.3 36368.3 36386.8 31307.8 31677.9 31760.4 31838.4 31908.0 23744.8 23982.6 23999.5 24299.6 24331.5 11:37:16 INFO - PROCESS | 1664 | 11:37:16 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35710.17 Median:12222.16 stddev:102552.27 (839.1%) stddev-sans-first:102805.61 11:37:16 INFO - PROCESS | 1664 | Values: 360.0 362.4 364.2 369.8 373.8 19435.6 19723.5 20514.5 20961.8 21069.7 20938.5 21422.0 21430.4 22155.8 22158.6 6210.6 6381.7 6434.0 6438.1 6468.6 4586.3 4784.0 4786.1 4786.2 7161.6 4782.4 4794.5 7417.9 7565.2 7566.4 7346.6 7422.5 7534.8 7542.4 7550.3 7108.0 7181.2 7193.3 7194.0 7204.0 26649.7 27161.7 27511.3 28762.3 28806.4 2285.8 2318.1 2321.9 2374.8 2399.9 15286.9 15574.8 15809.8 16051.5 16214.8 1811.2 1861.3 1866.5 1896.3 1957.6 112300.0 113733.0 115597.0 117025.0 118730.0 9270.9 10957.8 11460.5 11490.3 11752.6 13634.7 13802.7 13916.8 13946.0 13985.4 8569.7 8581.0 8589.6 8683.7 8685.1 8730.2 8747.7 8752.0 8819.9 8832.2 3557.6 4504.7 4521.6 4556.5 4561.7 1506.7 1551.2 1766.4 1798.1 1891.0 902.2 984.4 1002.9 1004.6 1046.1 19896.6 19910.6 19946.1 20133.8 20313.7 808.7 906.7 950.0 953.2 955.3 10187.4 10825.8 10978.9 11013.4 11051.2 540961.0 619215.0 631373.0 636691.0 648325.0 120949.0 120983.0 125383.1 126737.3 130001.7 1020.3 1049.7 1065.0 1066.3 1068.1 18289.9 18641.6 18724.3 18734.8 18812.6 52139.0 52714.7 52800.2 52921.5 54077.0 77455.6 77912.0 78889.0 81121.0 81640.6 7857.3 7996.5 8013.8 8033.5 8137.6 7997.3 12385.8 12914.4 12929.0 13303.1 11012.1 11340.8 11521.4 11602.1 11636.1 10970.8 11099.8 11354.9 11434.1 11655.7 11405.0 11536.5 11573.9 11735.1 11749.0 7785.4 7933.2 7963.7 8058.8 8122.9 11721.4 11801.0 11957.9 11960.5 11983.4 11:37:16 INFO - PROCESS | 1664 | 11:37:16 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5971.39 Median:2946.90 stddev:3148.34 (106.8%) stddev-sans-first:3138.56 11:37:16 INFO - PROCESS | 1664 | Values: 1417.2 1541.1 1569.3 1571.4 2044.3 7896.6 8526.1 8654.0 8654.9 8675.6 8394.1 8597.7 8618.8 8621.0 8635.3 2185.7 2380.3 2413.9 2484.5 2495.7 2497.3 2506.4 2509.0 2510.2 2512.3 2422.7 2473.2 2489.8 2490.4 2493.6 2412.1 2455.0 2474.3 2479.8 2480.0 2435.0 2464.1 2476.5 2485.5 2485.7 8626.3 8682.9 8696.7 8708.0 8713.5 5372.1 5461.6 5515.0 5521.2 5525.8 2831.8 3620.3 3671.7 3682.9 3691.9 1031.9 1037.9 1040.1 1046.9 1058.0 9662.0 11728.4 11772.5 11782.8 11784.0 4794.9 4836.1 4924.9 4936.2 4936.7 10095.8 10118.9 10120.9 10125.3 10126.6 5426.4 5466.1 5467.5 5470.7 5476.4 4417.9 4487.7 4504.3 4544.9 4751.9 3532.2 3809.3 3878.6 3964.3 4025.8 1294.2 1314.1 1318.1 1326.7 1327.3 1352.4 1365.1 1392.5 1396.6 1402.5 7871.0 8123.1 8131.7 8136.7 8138.0 503.8 513.6 519.8 520.7 521.7 6153.3 6175.4 6236.8 6238.2 6243.8 10247.2 10726.3 10733.4 10741.2 10751.8 10373.4 10482.3 10516.5 10518.7 10586.9 7118.2 8179.5 8214.0 8357.2 8387.1 7771.0 7829.0 7870.5 7876.0 7897.1 7713.9 9228.0 9514.1 9519.9 9664.8 9575.8 9915.1 9955.9 10042.3 10050.1 6686.0 6879.4 7458.1 7500.1 7532.1 8097.2 8219.3 8233.3 8237.7 8246.1 7204.5 7294.7 7304.4 7432.0 7443.8 7128.0 7153.9 7260.9 7276.3 7313.7 7426.8 7606.3 7640.5 7649.8 7652.8 6895.3 6903.3 6929.2 6941.9 6977.1 6911.0 7016.5 7017.0 7031.4 7038.9 11:37:16 INFO - PROCESS | 1664 | 11:37:16 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5708.75 Median:6484.08 stddev:1816.37 (28.0%) stddev-sans-first:1775.88 11:37:16 INFO - PROCESS | 1664 | Values: 321.3 324.5 331.9 333.1 335.6 6448.6 6515.1 6576.3 6586.5 6595.6 5644.6 6424.3 6479.4 6494.5 6502.1 3955.8 4351.3 4703.4 4741.1 4845.4 4296.3 4497.8 4802.8 4806.0 4825.8 4790.6 4793.2 4793.9 4799.1 4802.4 4587.5 4679.7 4782.9 4812.5 4813.8 4101.5 4121.5 4123.7 4124.1 4132.7 6121.5 6147.3 6177.1 6256.9 6262.7 5668.5 5711.1 5718.4 5727.2 5731.4 6722.7 6954.3 6960.2 6960.5 6974.8 3925.2 4666.3 4703.5 4712.6 4716.8 7147.8 7332.7 7340.2 7342.3 7342.6 4738.3 4760.4 4760.6 4767.3 4770.2 4827.9 4835.1 4841.8 4847.4 4853.1 5718.9 5722.7 5726.7 5727.3 5742.5 6696.5 6976.2 6999.0 7016.9 7036.6 1668.1 1678.0 1690.4 1694.9 1697.6 835.7 1043.8 1049.8 1055.0 1096.3 5297.4 6427.2 6486.2 6537.5 6541.4 7259.1 7272.7 7280.1 7289.6 7302.5 5471.8 6347.2 6481.9 6495.4 6509.2 3798.4 3841.9 3847.5 3849.0 3852.4 7146.9 7550.7 7571.1 7573.4 7598.8 7482.1 7502.0 7525.1 7530.8 7546.7 5618.6 7548.1 7559.7 7559.9 7563.9 6978.9 7271.8 7283.1 7289.1 7289.1 7136.9 7172.6 7192.3 7195.6 7208.1 7452.0 7529.8 7534.4 7544.5 7544.7 4793.5 4794.2 4794.8 4799.9 4805.4 6965.8 7213.0 7224.7 7231.1 7237.9 6976.8 7025.3 7025.6 7026.0 7033.3 6912.6 7005.9 7014.8 7021.4 7024.3 5235.7 6836.3 6847.7 6848.3 6859.3 6771.6 6991.3 7006.6 7008.7 7013.4 6477.5 6647.3 6657.3 6703.1 6857.4 11:37:16 INFO - PROCESS | 1664 | 11:37:16 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18104.93 Median:32977.40 stddev:25976.84 (78.8%) stddev-sans-first:26016.83 11:37:16 INFO - PROCESS | 1664 | Values: 700.4 764.1 765.9 778.9 826.6 14871.9 14904.4 15052.5 15123.2 15128.8 14170.9 14275.6 14277.1 14278.3 14289.4 688.3 694.0 740.9 937.1 956.0 958.9 963.4 963.9 964.3 965.0 997.2 1003.6 1006.5 1007.6 1015.6 806.2 813.6 818.7 994.0 998.7 606.7 692.5 758.2 761.0 764.4 14861.7 14942.4 14949.5 14957.9 14965.6 10542.6 12591.8 12687.7 12826.0 13067.9 9341.9 9541.9 9561.5 9637.7 9785.2 3524.0 3547.0 3547.0 3576.3 3614.8 76933.0 77205.0 77727.8 79471.2 82424.6 8041.2 8494.1 9078.1 9542.2 9558.7 22280.0 22436.4 22488.6 22505.3 22513.5 7394.0 7402.7 7414.3 7436.6 7480.9 4038.6 4078.1 4091.4 4099.1 4122.3 3567.9 3605.7 3615.2 3616.2 3620.8 644.3 645.8 666.3 675.4 713.0 488.5 503.9 586.4 623.4 634.5 7939.0 8348.2 8372.2 8380.0 8415.1 585.9 602.6 608.8 646.2 657.8 3041.9 3775.7 3871.5 3928.4 3931.5 93836.0 94795.1 94898.5 96376.5 96781.1 80320.0 80967.2 81175.2 81232.0 81374.0 72084.0 72222.3 72252.6 72840.0 73009.6 7561.6 7595.7 7793.5 7988.8 8167.3 44012.6 46985.8 48366.0 48974.0 48976.0 62228.0 64277.7 65045.0 65297.0 65973.7 8350.5 9971.6 10145.6 10218.9 10619.0 10774.0 10878.8 11130.6 11346.8 11558.8 8202.7 10330.4 10417.5 10681.6 10702.2 10364.6 10392.2 10483.1 10665.7 10884.2 8520.0 10103.7 10104.2 10496.3 10525.9 8590.0 9017.3 9047.0 9127.2 9165.3 7509.2 8763.3 8814.3 8923.2 8930.2 11:37:16 INFO - PROCESS | 1664 | -------- Summary: end -------- 11:37:16 INFO - PROCESS | 1664 | 11:37:16 INFO - TEST-INFO | 1664: exit 0 11:37:16 INFO - TEST-OK | dromaeo_css | took 1114448ms 11:37:16 INFO - TEST-START | kraken 11:37:16 INFO - operating with platform_type : mac_ 11:37:16 INFO - Initialising browser for kraken test... 11:37:16 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpagyN7A/profile http://localhost:49272/getInfo.html) 11:37:19 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 11:37:19 INFO - PROCESS | 1674 | colorDepth:24 11:37:19 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 11:37:19 INFO - PROCESS | 1674 | __metrics 11:37:19 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:37:19 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:19 INFO - TEST-INFO | 1674: exit 0 11:37:19 INFO - Browser initialized. 11:37:19 INFO - Running cycle 1/1 for kraken test... 11:37:19 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpagyN7A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:31 INFO - PROCESS | 1676 | RSS: Main: 246067200 11:37:31 INFO - PROCESS | 1676 | 11:37:34 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 11:37:35 INFO - PROCESS | 1676 | RSS: Main: 291229696 11:37:35 INFO - PROCESS | 1676 | 11:37:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 11:37:38 INFO - PROCESS | 1676 | RSS: Main: 301166592 11:37:38 INFO - PROCESS | 1676 | 11:37:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 11:37:42 INFO - PROCESS | 1676 | RSS: Main: 286789632 11:37:42 INFO - PROCESS | 1676 | 11:37:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 11:37:44 INFO - PROCESS | 1676 | RSS: Main: 289816576 11:37:44 INFO - PROCESS | 1676 | 11:37:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:37:47 INFO - PROCESS | 1676 | RSS: Main: 289947648 11:37:47 INFO - PROCESS | 1676 | 11:37:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:50 INFO - PROCESS | 1676 | RSS: Main: 291713024 11:37:50 INFO - PROCESS | 1676 | 11:37:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:54 INFO - PROCESS | 1676 | RSS: Main: 290930688 11:37:54 INFO - PROCESS | 1676 | 11:37:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 11:37:57 INFO - PROCESS | 1676 | RSS: Main: 292585472 11:37:57 INFO - PROCESS | 1676 | 11:37:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:37:59 INFO - PROCESS | 1676 | RSS: Main: 325308416 11:37:59 INFO - PROCESS | 1676 | 11:38:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:02 INFO - PROCESS | 1676 | RSS: Main: 324542464 11:38:02 INFO - PROCESS | 1676 | 11:38:04 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:04 INFO - PROCESS | 1676 | RSS: Main: 332996608 11:38:04 INFO - PROCESS | 1676 | 11:38:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:08 INFO - PROCESS | 1676 | RSS: Main: 334835712 11:38:08 INFO - PROCESS | 1676 | 11:38:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:11 INFO - PROCESS | 1676 | RSS: Main: 334659584 11:38:11 INFO - PROCESS | 1676 | 11:38:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 11:38:13 INFO - PROCESS | 1676 | RSS: Main: 394989568 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | __start_tp_report 11:38:13 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 11:38:13 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 11:38:13 INFO - PROCESS | 1676 | |i|pagename|runs| 11:38:13 INFO - PROCESS | 1676 | |0;ai-astar;110;108;111;111;112;112;158;145;111;113 11:38:13 INFO - PROCESS | 1676 | |1;audio-beat-detection;156;124;142;164;99;127;152;150;195;118 11:38:13 INFO - PROCESS | 1676 | |2;audio-dft;185;182;187;190;186;187;184;184;182;183 11:38:13 INFO - PROCESS | 1676 | |3;audio-fft;75;76;84;79;57;57;58;79;77;56 11:38:13 INFO - PROCESS | 1676 | |4;audio-oscillator;92;105;170;120;116;97;117;77;79;118 11:38:13 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;88;85;89;86;87;85;88;86;88;89 11:38:13 INFO - PROCESS | 1676 | |6;imaging-darkroom;94;93;96;93;93;131;145;94;96;93 11:38:13 INFO - PROCESS | 1676 | |7;imaging-desaturate;87;85;88;88;86;87;89;85;85;85 11:38:13 INFO - PROCESS | 1676 | |8;json-parse-financial;56;55;52;51;44;44;59;75;91;83 11:38:13 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;64;71;67;75;72;67;65;67;67;69 11:38:13 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;83;83;83;81;83;83;83;82;84;83 11:38:13 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;126;130;123;131;119;121;129;111;129;129 11:38:13 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;140;138;138;136;138;120;137;138;136;138 11:38:13 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;68;67;70;66;66;67;67;67;67;67 11:38:13 INFO - PROCESS | 1676 | __end_tp_report 11:38:13 INFO - PROCESS | 1676 | __start_cc_report 11:38:13 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1210 11:38:13 INFO - PROCESS | 1676 | __end_cc_report 11:38:13 INFO - PROCESS | 1676 | __startTimestamp1457206693126__endTimestamp 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | ------- Summary: start ------- 11:38:13 INFO - PROCESS | 1676 | Number of tests: 14 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:119.10 Median:112.00 stddev:17.40 (15.5%) stddev-sans-first:18.14 11:38:13 INFO - PROCESS | 1676 | Values: 110.0 108.0 111.0 111.0 112.0 112.0 158.0 145.0 111.0 113.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:154.00 stddev:27.13 (17.6%) stddev-sans-first:28.34 11:38:13 INFO - PROCESS | 1676 | Values: 156.0 124.0 142.0 164.0 99.0 127.0 152.0 150.0 195.0 118.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.50 stddev:2.54 (1.4%) stddev-sans-first:2.69 11:38:13 INFO - PROCESS | 1676 | Values: 185.0 182.0 187.0 190.0 186.0 187.0 184.0 184.0 182.0 183.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:69.80 Median:76.50 stddev:11.28 (14.7%) stddev-sans-first:11.81 11:38:13 INFO - PROCESS | 1676 | Values: 75.0 76.0 84.0 79.0 57.0 57.0 58.0 79.0 77.0 56.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:123.50 stddev:26.69 (21.6%) stddev-sans-first:27.58 11:38:13 INFO - PROCESS | 1676 | Values: 92.0 105.0 170.0 120.0 116.0 97.0 117.0 77.0 79.0 118.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:1.52 (1.7%) stddev-sans-first:1.58 11:38:13 INFO - PROCESS | 1676 | Values: 88.0 85.0 89.0 86.0 87.0 85.0 88.0 86.0 88.0 89.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:102.80 Median:93.50 stddev:18.88 (20.2%) stddev-sans-first:19.75 11:38:13 INFO - PROCESS | 1676 | Values: 94.0 93.0 96.0 93.0 93.0 131.0 145.0 94.0 96.0 93.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:1.51 (1.7%) stddev-sans-first:1.59 11:38:13 INFO - PROCESS | 1676 | Values: 87.0 85.0 88.0 88.0 86.0 87.0 89.0 85.0 85.0 85.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:57.50 stddev:16.34 (28.4%) stddev-sans-first:17.23 11:38:13 INFO - PROCESS | 1676 | Values: 56.0 55.0 52.0 51.0 44.0 44.0 59.0 75.0 91.0 83.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:3.37 (5.0%) stddev-sans-first:3.18 11:38:13 INFO - PROCESS | 1676 | Values: 64.0 71.0 67.0 75.0 72.0 67.0 65.0 67.0 67.0 69.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.79 (1.0%) stddev-sans-first:0.83 11:38:13 INFO - PROCESS | 1676 | Values: 83.0 83.0 83.0 81.0 83.0 83.0 83.0 82.0 84.0 83.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:129.00 stddev:6.34 (4.9%) stddev-sans-first:6.71 11:38:13 INFO - PROCESS | 1676 | Values: 126.0 130.0 123.0 131.0 119.0 121.0 129.0 111.0 129.0 129.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:138.00 stddev:5.70 (4.1%) stddev-sans-first:5.85 11:38:13 INFO - PROCESS | 1676 | Values: 140.0 138.0 138.0 136.0 138.0 120.0 137.0 138.0 136.0 138.0 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.17 11:38:13 INFO - PROCESS | 1676 | Values: 68.0 67.0 70.0 66.0 66.0 67.0 67.0 67.0 67.0 67.0 11:38:13 INFO - PROCESS | 1676 | -------- Summary: end -------- 11:38:13 INFO - PROCESS | 1676 | 11:38:13 INFO - TEST-INFO | 1676: exit 0 11:38:13 INFO - TEST-OK | kraken | took 57005ms 11:38:13 INFO - SUITE-END | took 1171s 11:38:14 INFO - Completed test suite (00:19:31) 11:38:14 INFO - javascript benchmark 11:38:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3326.4843949187875, 3406.642302558231, 3441.913952151196, 3454.4990976308422, 3484.1986343141075, 5424.593155513342, 5518.641288316257, 5543.805966791163, 5572.6377785443965, 5577.637453565515, 5527.060399732045, 5578.888422231553, 5581.302337207849, 5677.574181936361, 5693.715314234292, 5011.473795251501, 5039.370078740158, 5072.619553533481, 5097.49025097491, 5203.089459344599, 5156.664816786897, 5166.405863325709, 5204.505571970676, 5208.427073021964, 5220.765065572039, 4989.9750501247445, 5031.698098114125, 5082.923756143679, 5134.4095429025765, 5137.255098010767, 5161.303224064741, 5163.302954101186, 5172.353455818023, 5175.146100893348, 5190.506901844319, 5093.872653183663, 5143.665661731976, 5147.613928955306, 5151.356080489939, 5157.149070403379, 5365.007473617393, 5468.9726551367385, 5480.534154596864, 5587.9941610510095, 5597.496225339739, 6123.969380153071, 6133.969330153365, 6138.416850399205, 6159.568830181889, 6173.290071641729, 5386.461353864622, 6158.6612736299485, 6207.534434917354, 6215.28524219716, 6218.440340369389, 5549.19536667181, 5648.689322087324, 5659.179418984266, 5751.568632352507, 5765.538756899438, 6273.12176295319, 6287.874242515124, 6292.307846136921, 6293.716782744787, 6326.335734747785, 5958.225430693982, 5969.492593129546, 6023.006203976295, 6034.758609655564, 6041.124037014608, 6040.667763272974, 6109.495762817221, 6127.816165515042, 6179.938200618026, 6188.938110618927, 6117.393215327435, 6127.509799216052, 6132.294322189902, 6143.0, 6145.692715364304, 6115.088229002436, 6124.136831511461, 6134.141220229171, 6142.665787001, 6177.1969643945995, 4703.835365762182, 4791.233402655558, 4811.206150985118, 4818.903621927542, 4822.397200349957, 4274.995376086617, 4356.9128617428105, 4361.433013708261, 4362.062156636339, 4368.235558777201, 5450.454954504517, 5513.117901135799, 5536.833894983157, 5540.556755459635, 5546.140348246028, 6115.088229002346, 6146.371211628922, 6209.844753881099, 6236.844078897973, 6241.095041218998, 5527.695976721238, 5531.004419204502, 5531.529819965348, 5540.0, 5549.223108764695, 5124.92312615311, 5217.582593392595, 5229.738513074331, 5236.790528378822, 5245.055889939771, 6187.752489900354, 6291.276503202007, 6299.4645455135, 6322.49420046386, 6322.557420980579, 6171.691415429301, 6193.318734939063, 6193.597416167935, 6207.286162091236, 6214.8135555933395, 6164.260288765377, 6221.129041934042, 6286.088517165077, 6286.277078136073, 6330.778422755181, 5296.629235953446, 5748.310202775694, 6038.607490513103, 6042.3655516170165, 6092.543059270483, 6127.234095738033, 6140.048292514667, 6146.692665366803, 6158.445739883432, 6160.10678451631, 5734.741936612779, 5888.381719919518, 5910.7340169693325, 5938.287405511366, 5994.610350327215, 5893.351731309467, 5940.316863560746, 5955.612885162451, 5957.4042595740075, 5959.195508606283, 5760.654360738369, 5792.391798861059, 5804.361520232856, 5807.535397168301, 5808.535317174531, 5594.328680558359, 5973.223480947449, 6031.215941927521, 6048.667323297261, 6083.057126145454, 5815.331236907809, 5818.44724751148, 5830.970845145916, 5841.240638716939, 5846.503047241032], "unit": "score", "name": "dojo.html", "value": 5597.230111526463}, {"lowerIsBetter": false, "replicates": [491.0522691205971, 581.5057201378828, 590.5275779376498, 637.4486069549839, 639.0861068671799, 26805.59791603125, 29188.854055729716, 30977.225569360777, 30986.0, 31060.534091988637, 31685.841570792112, 39559.011024724394, 40808.59191408085, 40887.38668919969, 40910.79544602273, 9598.664046758366, 9772.560234789451, 9773.21463382936, 9783.972682868267, 9797.216222702167, 9552.283578731589, 9687.031296870291, 9693.612255509772, 9695.563699633498, 9723.12491875731, 9654.613815447374, 9721.902780972207, 9725.51372431379, 9728.221742260603, 9732.854007189897, 9607.375520591175, 9832.213422926148, 9834.213262938947, 9852.211823054211, 9880.456574888414, 9765.169960553361, 9886.604535818558, 9891.30760846741, 9891.30760846741, 9913.405195688281, 40340.991475213064, 40672.59327406747, 40681.79659101715, 40697.593024069676, 40709.389359159635, 3314.436545787222, 3410.3520331137006, 3411.113110591264, 3508.333416650854, 3925.2738243425056, 27042.45915081707, 27813.443731125266, 27969.300767480774, 28059.035867489285, 28284.717152828413, 2748.69764325924, 2762.5718013707906, 2850.315924178203, 2869.4548035873117, 2894.7539459145996, 287325.5633721839, 383481.0, 390334.0, 393403.0, 393731.99999999715, 45711.771441142584, 46154.0, 68175.0, 69320.6533967337, 69448.6527567369, 47158.528414715416, 47170.76414617905, 47264.291035634495, 47360.7631961838, 47435.76282118567, 15622.843771562366, 15775.447859324868, 15795.842041579437, 15812.130332831575, 15865.0, 12619.495220191273, 12694.238345699288, 12694.555690550786, 12728.872711272768, 12745.872541274653, 14737.11577305365, 14753.77869331961, 14766.92616536932, 14780.482683106255, 14903.435139310433, 6473.676316184172, 6587.374199451045, 6620.304867988792, 6642.468602511787, 6645.900311495331, 971.3880255439169, 971.7133445633414, 987.6345752071636, 1036.6216331039116, 1076.838474228872, 28957.986470473432, 29084.27289317784, 29606.555901661493, 29644.851775741416, 29663.110106696833, 1040.7095201949528, 1066.4987455895716, 1124.668222874254, 1137.6302701622005, 1269.8730126987227, 14775.70448591022, 14777.926110369594, 14836.92581537107, 15243.3902643893, 15484.458043968407, 517930.0, 522949.0, 526738.0, 526991.0, 528457.0, 58694.82610347769, 59276.70361648164, 59315.70342148262, 59326.81346373048, 59535.0, 1346.8316460442445, 1390.478570536049, 1464.2751837840337, 1484.2059498168212, 1494.305148106136, 28346.574801378407, 28762.06743278892, 28853.557322134227, 29135.562966555943, 29461.26346841346, 47869.5213047879, 48288.0, 48288.758556206994, 48416.75791621019, 48728.0, 361175.0, 363557.0, 363977.0, 364141.0, 364311.0, 28479.718412671064, 28923.42153156883, 32678.673213267564, 33231.0, 33514.83242583772, 42586.0, 43533.564664352954, 43820.78089609532, 44111.77944110259, 44248.55751442444, 35192.0, 36234.637653623126, 36273.81863090667, 36789.0, 36825.81587092047, 30240.0, 35384.46923296204, 35813.46279805857, 36361.45457818082, 36551.26897462089, 35100.64899350974, 35457.46813797847, 35484.29031419306, 36368.27263454663, 36386.8180659095, 31307.84346078255, 31677.891273805308, 31760.407605318753, 31838.36323273568, 31908.0, 23744.762552374254, 23982.60637007022, 23999.52000960006, 24299.63550546708, 24331.51336973286], "unit": "score", "name": "ext.html", "value": 18802.194485922777}, {"lowerIsBetter": false, "replicates": [359.9640035996401, 362.351391010092, 364.1933118143312, 369.8243334416153, 373.80935722781373, 19435.611287774253, 19723.5069123272, 20514.48713782156, 20961.790382096173, 21069.683954740653, 20938.476538086517, 21422.00091987123, 21430.357089287347, 22155.778442215575, 22158.556828863413, 6210.627362358262, 6381.712822922979, 6434.034894765776, 6438.066480360345, 6468.611883287018, 4586.334981427691, 4783.976080119594, 4786.1145688047645, 4786.21027530457, 7161.570305781644, 4782.354382158399, 4794.544518270776, 7417.925820741804, 7565.167831538526, 7566.356859666907, 7346.63266836656, 7422.480426370156, 7534.773956781305, 7542.35889949355, 7550.320471157567, 7108.0404145440225, 7181.245969173266, 7193.3166349196745, 7193.964030179868, 7204.0, 26649.73350266492, 27161.72838271612, 27511.31221719453, 28762.280942976384, 28806.423871522453, 2285.7714228577174, 2318.0959425823944, 2321.883905804703, 2374.8218883583627, 2399.8920048597856, 15286.923565382102, 15574.844251557453, 15809.762853557206, 16051.518454446385, 16214.837851621569, 1811.2392795026121, 1861.3392245752834, 1866.4960460675677, 1896.2509808625653, 1957.5986922680815, 112300.0, 113733.0, 115597.0, 117025.0, 118730.0, 9270.860937085949, 10957.780844383067, 11460.541578336773, 11490.310581365145, 11752.58865939688, 13634.727305453835, 13802.723945521033, 13916.791248131287, 13946.0, 13985.3706583204, 8569.700060497853, 8581.013183483854, 8589.613467393981, 8683.739487815375, 8685.08806575313, 8730.17063378978, 8747.650093996295, 8751.956240218758, 8819.91180088191, 8832.205101540892, 3557.6086630470627, 4504.729716217037, 4521.570450807168, 4556.476005259437, 4561.680682352204, 1506.7287888180012, 1551.2476448922264, 1766.3596610965003, 1798.1458807066538, 1890.9905450472659, 902.1970446302796, 984.3650845204803, 1002.9197664186847, 1004.6182450668845, 1046.1108058150512, 19896.60206795856, 19910.60178796416, 19946.10242539089, 20133.798662013192, 20313.74980003222, 808.6644042722322, 906.7305771919234, 949.9572519236651, 953.2469349214043, 955.345588272022, 10187.439690816927, 10825.78348433027, 10978.945105274423, 11013.449327533592, 11051.226414151093, 540961.0, 619215.0, 631373.0, 636691.0, 648325.0, 120949.0, 120983.0, 125383.0786135244, 126737.29682164325, 130001.69998300086, 1020.285799940045, 1049.732318258839, 1065.03082195202, 1066.317556763672, 1068.1027936533349, 18289.90260584369, 18641.627167456303, 18724.344647937258, 18734.812651873308, 18812.596182100035, 52138.95722085461, 52714.73642631762, 52800.20799687931, 52921.470785291654, 54077.0, 77455.61272193604, 77912.0, 78889.0, 81121.0, 81640.59179704063, 7857.253560911704, 7996.480228785111, 8013.799655008672, 8033.517988920684, 8137.62020127634, 7997.280244777998, 12385.814212786636, 12914.35428228566, 12929.0, 13303.06878518533, 11012.063974561932, 11340.773184536098, 11521.423928803359, 11602.129840261845, 11636.12729045342, 10970.780584388109, 11099.778004440028, 11354.94322528415, 11434.085273178292, 11655.708607284885, 11405.030572401107, 11536.480858361561, 11573.942130289295, 11735.061195104201, 11749.00133488663, 7785.377169826287, 7933.246341597539, 7963.6814527418255, 8058.83882322362, 8122.918770812453, 11721.413929303671, 11801.023370770712, 11957.940210298893, 11960.461779219782, 11983.400829958642], "unit": "score", "name": "jquery.html", "value": 9855.934188198777}, {"lowerIsBetter": false, "replicates": [1417.2134465371714, 1541.1369633005513, 1569.2938177819983, 1571.4028669105737, 2044.2538473457184, 7896.644650990705, 8526.147385261478, 8654.048054713976, 8654.870176947335, 8675.566221688914, 8394.076651568323, 8597.742067737978, 8618.784530386743, 8620.956895215515, 8635.266002389804, 2185.650295952648, 2380.3216083416187, 2413.8793060347, 2484.5403600334, 2495.70051593809, 2497.3382053755677, 2506.373406648338, 2509.0214816221687, 2510.159096702607, 2512.258883629334, 2422.685050943384, 2473.2209354053507, 2489.7759201671847, 2490.3525083478244, 2493.551160791057, 2412.0572901060677, 2455.0, 2474.34429876083, 2479.801615870744, 2479.962800557993, 2434.9878250608813, 2464.149868295435, 2476.5170791695627, 2485.5401750676183, 2485.7074321352975, 8626.309895208367, 8682.86975695365, 8696.739097827076, 8707.956460217722, 8713.520756358397, 5372.140457526816, 5461.617686761928, 5515.034868897927, 5521.199426083235, 5525.751341189656, 2831.773458123366, 3620.2940426616556, 3671.706263498914, 3682.907927301812, 3691.9261614767825, 1031.8710161229847, 1037.870266216723, 1040.0743338428729, 1046.9390885296891, 1057.989619912989, 9662.0, 11728.413579321, 11772.470238839272, 11782.823257651142, 11783.999999999915, 4794.9280760788615, 4836.12949669063, 4924.852254432372, 4936.160852655057, 4936.703797772073, 10095.848562271573, 10118.898811011943, 10120.898791012143, 10125.291229614004, 10126.645567405105, 5426.375966763794, 5466.125419932871, 5467.507924286833, 5470.72646367688, 5476.397596264408, 4417.911641767211, 4487.730736155841, 4504.324351347324, 4544.931826022612, 4751.904961900743, 3532.2405682778326, 3809.3333666608787, 3878.612138786099, 3964.345882929342, 4025.77858217795, 1294.210531575738, 1314.0867097367238, 1318.1497933832625, 1326.7280207557428, 1327.2633688303085, 1352.4184600621631, 1365.1467832604621, 1392.4639013979488, 1396.6368744126396, 1402.5161319344809, 7871.0, 8123.147069557729, 8131.674733010614, 8136.674533018613, 8137.95931020353, 503.8060346766448, 513.6070905757099, 519.8492437193172, 520.6719766547051, 521.6609204017343, 6153.323134455206, 6175.44421002112, 6236.812895613139, 6238.220222472191, 6243.8126856194385, 10247.231457640706, 10726.302790318761, 10733.409662468639, 10741.194410419093, 10751.78496430067, 10373.429461379546, 10482.266241363031, 10516.526756295985, 10518.703241895262, 10586.894131058745, 7118.216996130525, 8179.509229446371, 8214.0, 8357.164283571716, 8387.119352468026, 7771.0, 7829.021372328459, 7870.488418252795, 7875.976123104189, 7897.091834439113, 7713.884291735516, 9227.953860230657, 9514.143727064597, 9519.857202141835, 9664.806703866025, 9575.760605984906, 9915.058069483388, 9955.900440995498, 10042.297039207186, 10050.09549140581, 6685.966570167118, 6879.415249703831, 7458.067741532309, 7500.099988001475, 7532.133804612539, 8097.190280971856, 8219.342452603658, 8233.300169485661, 8237.670493180445, 8246.134155913544, 7204.4956853019785, 7294.708211671474, 7304.4156467483535, 7431.962840185764, 7443.776686699408, 7127.964360178374, 7153.85692286141, 7260.891086633599, 7276.308750668678, 7313.744018959311, 7426.777196684108, 7606.277403646644, 7640.465167438226, 7649.808754781175, 7652.846943060997, 6895.310468953065, 6903.275156108536, 6929.237783843874, 6941.895871561829, 6977.092977912839, 6911.032455456139, 7016.473764467583, 7016.964915175391, 7031.43748500129, 7038.859222815618], "unit": "score", "name": "mootools.html", "value": 4804.181391659154}, {"lowerIsBetter": false, "replicates": [321.2530865737161, 324.5310526289511, 331.8622771549807, 333.13052931847875, 335.6090154969461, 6448.580842245251, 6515.133341329817, 6576.342365763421, 6586.506012049092, 6595.604263744179, 5644.617068818135, 6424.293327733945, 6479.384458476437, 6494.5453818232745, 6502.08970744095, 3955.7626542407547, 4351.325544540593, 4703.43558772946, 4741.075490279397, 4845.418549774032, 4296.334068219431, 4497.842575509858, 4802.807887684488, 4806.0, 4825.806967721287, 4790.616750659939, 4793.233082706767, 4793.8667293054605, 4799.13615549201, 4802.375691160162, 4587.541245875419, 4679.672422930396, 4782.904341913177, 4812.518748125194, 4813.78337974792, 4101.507819061701, 4121.464209652726, 4123.670106391482, 4124.13393187431, 4132.73137246081, 6121.510279177655, 6147.323794382614, 6177.135201071808, 6256.906146407808, 6262.718177682015, 5668.546516278729, 5711.114777209539, 5718.399568045378, 5727.198192253088, 5731.369549349568, 6722.663866806689, 6954.3393377629045, 6960.164780226354, 6960.512764106515, 6974.755883544051, 3925.234579257046, 4666.323383109464, 4703.459102203256, 4712.575868171881, 4716.764161791931, 7147.785566433015, 7332.743353982638, 7340.192578816326, 7342.302481264272, 7342.559446433231, 4738.265568836767, 4760.357351757469, 4760.571548560646, 4767.261074533453, 4770.236762118045, 4827.903441931212, 4835.129676658235, 4841.757912104381, 4847.3698419205275, 4853.12643724126, 5718.8848174605555, 5722.713864306768, 5726.713664316851, 5727.341355744059, 5742.48317651405, 6696.531242813054, 6976.162860456778, 6999.020137180799, 7016.894746578805, 7036.6481675916, 1668.0658831054648, 1677.9916100419664, 1690.3999080326307, 1694.872884533665, 1697.5756060984754, 835.6615570693879, 1043.7703705184847, 1049.816282150636, 1055.0082922053246, 1096.276457538037, 5297.443768404262, 6427.196600424947, 6486.2216534016225, 6537.542372033912, 6541.378569035934, 7259.092613423322, 7272.672729727175, 7280.0535930328715, 7289.635518224068, 7302.525335853153, 5471.8084867029465, 6347.174867267318, 6481.935180648227, 6495.415412612888, 6509.153810004764, 3798.430235464647, 3841.9231615368094, 3847.5382954045695, 3849.0377405648587, 3852.3836186210633, 7146.857062858714, 7550.735724249625, 7571.053618297713, 7573.394128469709, 7598.772036838904, 7482.139553951257, 7501.962490187623, 7525.0969883613225, 7530.849383012309, 7546.698132074655, 5618.578606604439, 7548.056492938383, 7559.659815308324, 7559.886601700979, 7563.886541701769, 6978.860422791618, 7271.818204544928, 7283.126024877049, 7289.052423185164, 7289.088863892013, 7136.857262854817, 7172.605506696973, 7192.280771922975, 7195.640217988975, 7208.135023796968, 7451.962740186481, 7529.774106776806, 7534.434917381328, 7544.509606875536, 7544.735934242275, 4793.496682848251, 4794.232922732346, 4794.808207671654, 4799.904001920012, 4805.447373551947, 6965.79102626922, 7212.963935180291, 7224.7471338505, 7231.059962204879, 7237.927620723725, 6976.7558135465015, 7025.297470253138, 7025.613591252531, 7025.964870175821, 7033.29667033313, 6912.585244885323, 7005.914083317094, 7014.824629384306, 7021.43828493709, 7024.297570242935, 5235.65968212065, 6836.282190370139, 6847.691853866688, 6848.3494068063455, 6859.279775623488, 6771.62756048422, 6991.300869912968, 7006.614636195059, 7008.684609192701, 7013.4038606719005, 6477.546571739933, 6647.335266473314, 6657.267700553032, 6703.095082163845, 6857.382835544825], "unit": "score", "name": "prototype.html", "value": 5102.018380240741}, {"lowerIsBetter": false, "replicates": [700.4361489001353, 764.1288930619095, 765.8927750114989, 778.8559116563432, 826.566052822268, 14871.925640371783, 14904.403823847048, 15052.473163439281, 15123.168225747579, 15128.848711512896, 14170.93717971151, 14275.643108922282, 14277.143371397724, 14278.2860856957, 14289.356978935946, 688.2738710660251, 693.9930600693979, 740.8814589665654, 937.0676177203658, 955.9569819358111, 958.942463452195, 963.3930623707055, 963.9421634701905, 964.2527041542791, 965.0494263150791, 997.1872923567306, 1003.6487229469664, 1006.521902096502, 1007.6271779441616, 1015.5633077776553, 806.1575653442196, 813.6013353456823, 818.7257268814894, 993.991099034477, 998.6904059741504, 606.6723969056704, 692.5290802254465, 758.215247219131, 761.0372878308943, 764.3503022430945, 14861.702765944621, 14942.402303907831, 14949.476768313165, 14957.925210373987, 14965.551033469013, 10542.578296868116, 12591.811122833165, 12687.682807929783, 12826.0, 13067.86932130676, 9341.859872101924, 9541.904580954171, 9561.474118923456, 9637.710868673881, 9785.168260697848, 3524.0, 3547.0, 3547.0245682437535, 3576.338377400189, 3614.8192590370377, 76933.0, 77205.0, 77727.83408248881, 79471.20528794696, 82424.58787706083, 8041.155678653774, 8494.108118647453, 9078.137576930181, 9542.198260283962, 9558.713238602853, 22280.0, 22436.439089022904, 22488.550228995657, 22505.32484025482, 22513.549729005328, 7394.0, 7402.703891844266, 7414.332710056121, 7436.553806771611, 7480.925190748132, 4038.5759495252573, 4078.062045729499, 4091.4272001919753, 4099.139180772071, 4122.319817230184, 3567.928641427157, 3605.6574625410544, 3615.240799432149, 3616.240589476187, 3620.7508409598645, 644.3009334871623, 645.7546132469631, 666.2637785247329, 675.4022689919457, 713.0409599089216, 488.5114885114885, 503.88662550926483, 586.4428792647002, 623.3672822085587, 634.4797266241729, 7939.0, 8348.248657620721, 8372.162783721578, 8379.958100209582, 8415.074341822394, 585.9267591551056, 602.5631417222567, 608.8325710429579, 646.198713595148, 657.8059472455542, 3041.8593027614643, 3775.6979441644603, 3871.477350557695, 3928.3714605663527, 3931.5085614298214, 93835.96230282757, 94795.10409791766, 94898.5255073734, 96376.51811740897, 96781.06437871204, 80320.0, 80967.19032809715, 81175.18824811795, 81232.0, 81374.0, 72084.0, 72222.27777722155, 72252.63873680598, 72840.0, 73009.6349518249, 7561.621918904143, 7595.696172153052, 7793.454458187873, 7988.760337189894, 8167.305779008613, 44012.559874402126, 46985.76507117443, 48366.0, 48974.0, 48976.0, 62228.0, 64277.67861160664, 65045.02432463422, 65297.0, 65973.67013165096, 8350.498970061815, 9971.60113595477, 10145.594176232868, 10218.948905255425, 10619.0, 10774.0, 10878.78242435131, 11130.554777808797, 11346.829797553208, 11558.826617600911, 8202.712905048294, 10330.431826249629, 10417.531211095367, 10681.57273709043, 10702.197335199735, 10364.637237696645, 10392.168626510012, 10483.056524912794, 10665.733356666145, 10884.238103332691, 8519.95740021296, 10103.7474063149, 10104.242181836538, 10496.317739346918, 10525.9473702631, 8590.0, 9017.2786177107, 9047.0, 9127.178553930178, 9165.266778657558, 7509.211532788979, 8763.3427492937, 8814.250788683034, 8923.15230053144, 8930.240929521064], "unit": "score", "name": "yui.html", "value": 6765.104768608569}], "name": "dromaeo_css", "value": 7457.473992905155}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 111.0, 111.0, 112.0, 112.0, 158.0, 145.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 119.1}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 142.0, 164.0, 99.0, 127.0, 152.0, 150.0, 195.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 142.7}, {"lowerIsBetter": true, "replicates": [185.0, 182.0, 187.0, 190.0, 186.0, 187.0, 184.0, 184.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 185.0}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 84.0, 79.0, 57.0, 57.0, 58.0, 79.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.8}, {"lowerIsBetter": true, "replicates": [92.0, 105.0, 170.0, 120.0, 116.0, 97.0, 117.0, 77.0, 79.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 89.0, 86.0, 87.0, 85.0, 88.0, 86.0, 88.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 96.0, 93.0, 93.0, 131.0, 145.0, 94.0, 96.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 102.8}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 88.0, 86.0, 87.0, 89.0, 85.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.5}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 52.0, 51.0, 44.0, 44.0, 59.0, 75.0, 91.0, 83.0], "unit": "score", "name": "json-parse-financial", "value": 61.0}, {"lowerIsBetter": true, "replicates": [64.0, 71.0, 67.0, 75.0, 72.0, 67.0, 65.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 81.0, 83.0, 83.0, 83.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [126.0, 130.0, 123.0, 131.0, 119.0, 121.0, 129.0, 111.0, 129.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [140.0, 138.0, 138.0, 136.0, 138.0, 120.0, 137.0, 138.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1442.2}]} 11:38:14 INFO - Return code: 0 11:38:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:38:14 INFO - # TBPL SUCCESS # 11:38:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:38:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:38:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:38:14 INFO - 2016-03-05 11:38:14.467 screenresolution[1680:10033] starting screenresolution argv=screenresolution get 11:38:14 INFO - 2016-03-05 11:38:14.470 screenresolution[1680:10033] Display 0: 1600x1200x32@60 11:38:14 INFO - 2016-03-05 11:38:14.476 screenresolution[1681:10036] starting screenresolution argv=screenresolution list 11:38:14 INFO - Available Modes on Display 0 11:38:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:38:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:38:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:38:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:38:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:38:14 INFO - Intel Iris: 11:38:14 INFO - Chipset Model: Intel Iris 11:38:14 INFO - Type: GPU 11:38:14 INFO - Bus: Built-In 11:38:14 INFO - VRAM (Dynamic, Max): 1536 MB 11:38:14 INFO - Vendor: Intel (0x8086) 11:38:14 INFO - Device ID: 0x0a2e 11:38:14 INFO - Revision ID: 0x0009 11:38:14 INFO - Displays: 11:38:14 INFO - Display: 11:38:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:38:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:38:14 INFO - Display Serial Number: 1600x1200 60 11:38:14 INFO - Main Display: Yes 11:38:14 INFO - Mirror: Off 11:38:14 INFO - Online: Yes 11:38:14 INFO - Rotation: Supported 11:38:14 INFO - Return code: 0 11:38:14 INFO - Running post-action listener: _resource_record_post_action 11:38:14 INFO - Running post-run listener: _resource_record_post_run 11:38:15 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39478784; Write bytes: 703862272; Read time: 419; Write time: 2112 11:38:15 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 394439168; Write bytes: 387581440; Read time: 30003; Write time: 890 11:38:15 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37688832; Write bytes: 299419648; Read time: 401; Write time: 1158 11:38:15 INFO - Running post-run listener: _upload_blobber_files 11:38:15 INFO - Blob upload gear active. 11:38:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:15 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 11:38:15 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'] 11:38:15 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 11:38:16 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:38:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:17 INFO - (blobuploader) - INFO - Done attempting. 11:38:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:38:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:38:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:18 INFO - (blobuploader) - INFO - Done attempting. 11:38:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:38:18 INFO - Return code: 0 11:38:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbbced7884ae05f9c80bdd59cfbebed8b4112de3b0fe1d2c8cccaebce1b124a9861b9b3b9567208216f5aa98c359617e8b1995f6e7828be40e0f09d64913b594", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ddc151700542f624eb8338a345152e57e06375ba0af2ef2a9a5940eb9775f2409a58c0178eaca0413470dd100761308670b8c1b79d30715df7d20e151b47e6f"} 11:38:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:18 INFO - Contents: 11:38:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbbced7884ae05f9c80bdd59cfbebed8b4112de3b0fe1d2c8cccaebce1b124a9861b9b3b9567208216f5aa98c359617e8b1995f6e7828be40e0f09d64913b594", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ddc151700542f624eb8338a345152e57e06375ba0af2ef2a9a5940eb9775f2409a58c0178eaca0413470dd100761308670b8c1b79d30715df7d20e151b47e6f"} 11:38:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:18 INFO - Copying logs to upload dir... 11:38:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.378809 ========= master_lag: 2.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-03-05 11:38:20.989090) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-05 11:38:20.992592) ========= 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.qV0ypB7orT/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.Ej99AEMpaz/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbbced7884ae05f9c80bdd59cfbebed8b4112de3b0fe1d2c8cccaebce1b124a9861b9b3b9567208216f5aa98c359617e8b1995f6e7828be40e0f09d64913b594", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ddc151700542f624eb8338a345152e57e06375ba0af2ef2a9a5940eb9775f2409a58c0178eaca0413470dd100761308670b8c1b79d30715df7d20e151b47e6f"} build_url:https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011043 build_url: 'https://queue.taskcluster.net/v1/task/XG-qFvTfRVmp6uXpT0vT7g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbbced7884ae05f9c80bdd59cfbebed8b4112de3b0fe1d2c8cccaebce1b124a9861b9b3b9567208216f5aa98c359617e8b1995f6e7828be40e0f09d64913b594", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ddc151700542f624eb8338a345152e57e06375ba0af2ef2a9a5940eb9775f2409a58c0178eaca0413470dd100761308670b8c1b79d30715df7d20e151b47e6f"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-05 11:38:21.050428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 11:38:21.050749) ========= 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.qV0ypB7orT/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.Ej99AEMpaz/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.005028 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 11:38:21.099009) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-05 11:38:21.099325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-05 11:38:21.099741) ========= ========= Total master_lag: 2.92 =========