builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0074 starttime: 1457357485.77 results: success (0) buildid: 20160307030208 builduid: 2ebdd262f61444c2a007a632327c1612 revision: 68d3781deda0d4d58ec9877862830db89669b3a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.771613) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.772028) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.772329) ========= 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.LeJHRLdyHR/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.ld3iXtfktO/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005178 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.795472) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.795755) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.812865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.813123) ========= 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.LeJHRLdyHR/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.ld3iXtfktO/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005845 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.905126) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.905434) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.905801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:25.906072) ========= 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.LeJHRLdyHR/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.ld3iXtfktO/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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-07 05:31:25-- 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% 15.5M=0.001s 2016-03-07 05:31:26 (15.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167120 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:26.088609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:26.088924) ========= 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.LeJHRLdyHR/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.ld3iXtfktO/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.026146 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:26.138861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 05:31:26.139255) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68d3781deda0d4d58ec9877862830db89669b3a5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 68d3781deda0d4d58ec9877862830db89669b3a5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LeJHRLdyHR/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.ld3iXtfktO/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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-07 05:31:26,217 truncating revision to first 12 chars 2016-03-07 05:31:26,217 Setting DEBUG logging. 2016-03-07 05:31:26,217 attempt 1/10 2016-03-07 05:31:26,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68d3781deda0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 05:31:27,283 unpacking tar archive at: mozilla-central-68d3781deda0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.319986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 05:31:27.476183) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:27.476552) ========= echo 68d3781deda0d4d58ec9877862830db89669b3a5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'68d3781deda0d4d58ec9877862830db89669b3a5'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LeJHRLdyHR/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.ld3iXtfktO/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 68d3781deda0d4d58ec9877862830db89669b3a5 program finished with exit code 0 elapsedTime=0.005927 script_repo_revision: '68d3781deda0d4d58ec9877862830db89669b3a5' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:27.526577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:27.526856) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 05:31:27.540287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-07 05:31:27.540574) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LeJHRLdyHR/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.ld3iXtfktO/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:31:27 INFO - MultiFileLogger online at 20160307 05:31:27 in /builds/slave/test 05:31:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:31:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:27 INFO - {'append_to_log': False, 05:31:27 INFO - 'base_work_dir': '/builds/slave/test', 05:31:27 INFO - 'blob_upload_branch': 'Firefox', 05:31:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:27 INFO - 'branch': 'Firefox', 05:31:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:27 INFO - 'config_files': ('talos/mac_config.py',), 05:31:27 INFO - 'default_actions': ('clobber', 05:31:27 INFO - 'read-buildbot-config', 05:31:27 INFO - 'download-and-extract', 05:31:27 INFO - 'populate-webroot', 05:31:27 INFO - 'create-virtualenv', 05:31:27 INFO - 'install', 05:31:27 INFO - 'run-tests'), 05:31:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:27 INFO - 'download_minidump_stackwalk': True, 05:31:27 INFO - 'download_symbols': 'ondemand', 05:31:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:27 INFO - 'installer_path': 'installer.exe', 05:31:27 INFO - 'log_level': 'info', 05:31:27 INFO - 'log_name': 'talos', 05:31:27 INFO - 'log_to_console': True, 05:31:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:27 INFO - 'opt_config_files': (), 05:31:27 INFO - 'pip_index': False, 05:31:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:27 INFO - 'cmd': ('bash', 05:31:27 INFO - '-c', 05:31:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:27 INFO - 'enabled': True, 05:31:27 INFO - 'halt_on_failure': False, 05:31:27 INFO - 'name': 'check_screen_resolution'},), 05:31:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:27 INFO - 'cmd': ('bash', 05:31:27 INFO - '-c', 05:31:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:27 INFO - 'enabled': True, 05:31:27 INFO - 'halt_on_failure': False, 05:31:27 INFO - 'name': 'check_screen_resolution'},), 05:31:27 INFO - 'run_cmd_checks_enabled': True, 05:31:27 INFO - 'sps_profile': False, 05:31:27 INFO - 'sps_profile_interval': 0, 05:31:27 INFO - 'suite': 'dromaeojs', 05:31:27 INFO - 'system_bits': '32', 05:31:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:27 INFO - 'title': 't-yosemite-r7-0074', 05:31:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:27 INFO - 'use_talos_json': True, 05:31:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:27 INFO - 'work_dir': 'build'} 05:31:27 INFO - ##### 05:31:27 INFO - ##### Running clobber step. 05:31:27 INFO - ##### 05:31:27 INFO - Running pre-action listener: _resource_record_pre_action 05:31:27 INFO - Running main action method: clobber 05:31:27 INFO - rmtree: /builds/slave/test/build 05:31:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:29 INFO - Running post-action listener: _resource_record_post_action 05:31:29 INFO - ##### 05:31:29 INFO - ##### Running read-buildbot-config step. 05:31:29 INFO - ##### 05:31:29 INFO - Running pre-action listener: _resource_record_pre_action 05:31:29 INFO - Running main action method: read_buildbot_config 05:31:29 INFO - Using buildbot properties: 05:31:29 INFO - { 05:31:29 INFO - "project": "", 05:31:29 INFO - "product": "firefox", 05:31:29 INFO - "script_repo_revision": "production", 05:31:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:31:29 INFO - "repository": "", 05:31:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:31:29 INFO - "buildid": "20160307030208", 05:31:29 INFO - "stage_platform": "macosx64", 05:31:29 INFO - "basedir": "/builds/slave/test", 05:31:29 INFO - "nightly_build": "True", 05:31:29 INFO - "buildnumber": 154, 05:31:29 INFO - "slavename": "t-yosemite-r7-0074", 05:31:29 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:31:29 INFO - "platform": "yosemite_r7", 05:31:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:29 INFO - "branch": "mozilla-central", 05:31:29 INFO - "repo_path": "mozilla-central", 05:31:29 INFO - "revision": "68d3781deda0d4d58ec9877862830db89669b3a5", 05:31:29 INFO - "pgo_build": "False", 05:31:29 INFO - "builduid": "2ebdd262f61444c2a007a632327c1612", 05:31:29 INFO - "slavebuilddir": "test" 05:31:29 INFO - } 05:31:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:31:29 INFO - Running post-action listener: _resource_record_post_action 05:31:29 INFO - ##### 05:31:29 INFO - ##### Running download-and-extract step. 05:31:29 INFO - ##### 05:31:29 INFO - Running pre-action listener: _resource_record_pre_action 05:31:29 INFO - Running main action method: download_and_extract 05:31:29 INFO - mkdir: /builds/slave/test/build/tests 05:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:29 INFO - https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 05:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 05:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/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 05:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/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 05:31:30 INFO - Downloaded 1277 bytes. 05:31:30 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 05:31:30 INFO - Using the following test package requirements: 05:31:30 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:31:30 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:31:30 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:30 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:31:30 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:31:30 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:31:30 INFO - u'jsshell-mac.zip'], 05:31:30 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:31:30 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:31:30 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:31:30 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:31:30 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:31:30 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:31:30 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:31:30 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:31:30 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:31:30 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:31:30 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:31:30 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:30 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:30 INFO - https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:31:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:31:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:31:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/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 05:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/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 05:31:31 INFO - Downloaded 17866536 bytes. 05:31:31 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'] 05:31:31 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 05:31:35 INFO - Return code: 0 05:31:35 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 05:31: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')]} 05:31:35 INFO - https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:31:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:31:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:31:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/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 05:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/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 05:31:36 INFO - Downloaded 17866536 bytes. 05:31:36 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'] 05:31:36 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 05:31:39 INFO - Return code: 0 05:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:39 INFO - https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:31:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:31:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:31:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/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 05:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/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 05:31:40 INFO - Downloaded 10845161 bytes. 05:31:40 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'] 05:31:40 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 05:31:41 INFO - Return code: 0 05:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:41 INFO - https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/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 05:31:44 INFO - Downloaded 111117404 bytes. 05:31:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:31:44 INFO - mkdir: /builds/slave/test/properties 05:31:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:44 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:44 INFO - Contents: 05:31:44 INFO - build_url:https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:31:44 INFO - Running post-action listener: _resource_record_post_action 05:31:44 INFO - Running post-action listener: set_extra_try_arguments 05:31:44 INFO - ##### 05:31:44 INFO - ##### Running populate-webroot step. 05:31:44 INFO - ##### 05:31:44 INFO - Running pre-action listener: _resource_record_pre_action 05:31:44 INFO - Running main action method: populate_webroot 05:31:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:44 INFO - '--tppagecycles', 05:31:44 INFO - '7'], 05:31:44 INFO - 'tests': ['tsvgm']}}, 05:31:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:31:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:31:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:31:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:31:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:31:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:44 INFO - 'talos_options': ['--e10s'], 05:31:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:44 INFO - 'tests': ['damp', 'tps']}, 05:31:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:44 INFO - 'talos_options': ['--e10s'], 05:31:44 INFO - 'tests': ['damp', 'tps']}, 05:31:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:31:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:44 INFO - 'other': {'tests': ['a11yr', 05:31:44 INFO - 'ts_paint', 05:31:44 INFO - 'tpaint', 05:31:44 INFO - 'sessionrestore', 05:31:44 INFO - 'sessionrestore_no_auto_restore', 05:31:44 INFO - 'tabpaint']}, 05:31:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:31:44 INFO - 'tests': ['a11yr', 05:31:44 INFO - 'ts_paint', 05:31:44 INFO - 'tpaint', 05:31:44 INFO - 'sessionrestore', 05:31:44 INFO - 'sessionrestore_no_auto_restore', 05:31:44 INFO - 'tabpaint']}, 05:31:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:31:44 INFO - 'tests': ['a11yr', 05:31:44 INFO - 'ts_paint', 05:31:44 INFO - 'tpaint', 05:31:44 INFO - 'sessionrestore', 05:31:44 INFO - 'sessionrestore_no_auto_restore', 05:31:44 INFO - 'tabpaint']}, 05:31:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:31:44 INFO - 'tests': ['a11yr', 05:31:44 INFO - 'ts_paint', 05:31:44 INFO - 'tpaint', 05:31:44 INFO - 'sessionrestore', 05:31:44 INFO - 'sessionrestore_no_auto_restore', 05:31:44 INFO - 'tabpaint']}, 05:31:44 INFO - 'other_l64': {'tests': ['a11yr', 05:31:44 INFO - 'ts_paint', 05:31:44 INFO - 'tpaint', 05:31:44 INFO - 'sessionrestore', 05:31:44 INFO - 'sessionrestore_no_auto_restore', 05:31:44 INFO - 'tabpaint']}, 05:31:44 INFO - 'other_nol64': {'tests': ['a11yr', 05:31:44 INFO - 'ts_paint', 05:31:44 INFO - 'tpaint', 05:31:44 INFO - 'sessionrestore', 05:31:44 INFO - 'sessionrestore_no_auto_restore', 05:31:44 INFO - 'tabpaint']}, 05:31:44 INFO - 'svgr': {'tests': ['tsvgx', 05:31:44 INFO - 'tsvgr_opacity', 05:31:44 INFO - 'tart', 05:31:44 INFO - 'tscrollx', 05:31:44 INFO - 'cart']}, 05:31:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:31:44 INFO - 'tests': ['tsvgx', 05:31:44 INFO - 'tsvgr_opacity', 05:31:44 INFO - 'tart', 05:31:44 INFO - 'tscrollx', 05:31:44 INFO - 'cart']}, 05:31:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:44 INFO - 'tests': ['tp5o']}, 05:31:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:44 INFO - 'talos_options': ['--e10s'], 05:31:44 INFO - 'tests': ['tp5o']}, 05:31:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:44 INFO - 'talos_options': ['--xperf_path', 05:31:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:44 INFO - 'tests': ['tp5n']}, 05:31:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:44 INFO - 'talos_options': ['--e10s', 05:31:44 INFO - '--xperf_path', 05:31:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:44 INFO - 'tests': ['tp5n']}}, 05:31:44 INFO - 'talos.zip': {'path': '', 05:31:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:44 INFO - Running post-action listener: _resource_record_post_action 05:31:44 INFO - ##### 05:31:44 INFO - ##### Running create-virtualenv step. 05:31:44 INFO - ##### 05:31:44 INFO - Running pre-action listener: _resource_record_pre_action 05:31:44 INFO - Running main action method: create_virtualenv 05:31:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:31:44 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 05:31:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:31:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:45 INFO - Using real prefix '/tools/python27' 05:31:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:31:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:31:48 INFO - Installing pip.................done. 05:31:48 INFO - Return code: 0 05:31:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:31: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')]} 05:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31: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')]} 05:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:48 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 0x107b79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7a494ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, '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.LeJHRLdyHR/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.ld3iXtfktO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:31:48 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 05:31:48 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 05:31:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:31:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:48 INFO - 'HOME': '/Users/cltbld', 05:31:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:48 INFO - 'LOGNAME': 'cltbld', 05:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:48 INFO - 'MOZ_NO_REMOTE': '1', 05:31:48 INFO - 'NO_EM_RESTART': '1', 05:31:48 INFO - 'PAGER': '/bin/cat', 05:31:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:48 INFO - 'PWD': '/builds/slave/test', 05:31:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:48 INFO - 'SHELL': '/bin/bash', 05:31:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:31:48 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:31:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:48 INFO - 'USER': 'cltbld', 05:31:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:48 INFO - 'XPC_FLAGS': '0x0', 05:31:48 INFO - 'XPC_SERVICE_NAME': '0', 05:31:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:49 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 05:31:49 INFO - Cleaning up... 05:31:49 INFO - Return code: 0 05:31:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107b79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7a494ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, '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.LeJHRLdyHR/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.ld3iXtfktO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:31:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:31:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:49 INFO - 'HOME': '/Users/cltbld', 05:31:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:49 INFO - 'LOGNAME': 'cltbld', 05:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:49 INFO - 'MOZ_NO_REMOTE': '1', 05:31:49 INFO - 'NO_EM_RESTART': '1', 05:31:49 INFO - 'PAGER': '/bin/cat', 05:31:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:49 INFO - 'PWD': '/builds/slave/test', 05:31:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:49 INFO - 'SHELL': '/bin/bash', 05:31:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:31:49 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:31:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:49 INFO - 'USER': 'cltbld', 05:31:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:49 INFO - 'XPC_FLAGS': '0x0', 05:31:49 INFO - 'XPC_SERVICE_NAME': '0', 05:31:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:49 INFO - Downloading/unpacking psutil>=0.7.1 05:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:31:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:52 INFO - Installing collected packages: psutil 05:31:52 INFO - Running setup.py install for psutil 05:31:52 INFO - building 'psutil._psutil_osx' extension 05:31:52 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 05:31:52 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 05:31:52 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 05:31:53 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 05:31:53 INFO - building 'psutil._psutil_posix' extension 05:31:53 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 05:31:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:31:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:31:53 INFO - ^ 05:31:53 INFO - 1 warning generated. 05:31:53 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 05:31:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:53 INFO - Successfully installed psutil 05:31:53 INFO - Cleaning up... 05:31:53 INFO - Return code: 0 05:31:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:31:53 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')]} 05:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:53 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')]} 05:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:53 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 0x107b79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7a494ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, '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.LeJHRLdyHR/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.ld3iXtfktO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:31:53 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 05:31:53 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 05:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:53 INFO - 'HOME': '/Users/cltbld', 05:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:53 INFO - 'LOGNAME': 'cltbld', 05:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:53 INFO - 'MOZ_NO_REMOTE': '1', 05:31:53 INFO - 'NO_EM_RESTART': '1', 05:31:53 INFO - 'PAGER': '/bin/cat', 05:31:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:53 INFO - 'PWD': '/builds/slave/test', 05:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:53 INFO - 'SHELL': '/bin/bash', 05:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:31:53 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:53 INFO - 'USER': 'cltbld', 05:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:53 INFO - 'XPC_FLAGS': '0x0', 05:31:53 INFO - 'XPC_SERVICE_NAME': '0', 05:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:31:53 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 05:31:53 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 05:31:53 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 05:31:53 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 05:31:53 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 05:31:53 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 05:31:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:31:56 INFO - Installing collected packages: mozsystemmonitor 05:31:56 INFO - Running setup.py install for mozsystemmonitor 05:31:56 INFO - Successfully installed mozsystemmonitor 05:31:56 INFO - Cleaning up... 05:31:56 INFO - Return code: 0 05:31:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:31:56 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')]} 05:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:56 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')]} 05:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:56 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 0x107b79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7a494ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, '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.LeJHRLdyHR/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.ld3iXtfktO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:31:56 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 05:31:56 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 05:31:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:31:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:56 INFO - 'HOME': '/Users/cltbld', 05:31:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:56 INFO - 'LOGNAME': 'cltbld', 05:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:56 INFO - 'MOZ_NO_REMOTE': '1', 05:31:56 INFO - 'NO_EM_RESTART': '1', 05:31:56 INFO - 'PAGER': '/bin/cat', 05:31:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:56 INFO - 'PWD': '/builds/slave/test', 05:31:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:56 INFO - 'SHELL': '/bin/bash', 05:31:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:31:56 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:31:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:56 INFO - 'USER': 'cltbld', 05:31:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:56 INFO - 'XPC_FLAGS': '0x0', 05:31:56 INFO - 'XPC_SERVICE_NAME': '0', 05:31:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:31:56 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 05:31:56 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 05:31:56 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 05:31:56 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 05:31:56 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 05:31:56 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 05:31:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:31:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:31: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 05:31: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 05:31: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 05:31: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 05:31: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 05:31: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 05:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:31:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:31:59 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 05:31:59 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 05:31:59 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 05:31:59 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 05:31:59 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 05:31:59 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 05:31:59 INFO - Downloading docopt-0.6.1.tar.gz 05:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:00 INFO - Running setup.py install for blobuploader 05:32:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:00 INFO - Running setup.py install for requests 05:32:00 INFO - Running setup.py install for docopt 05:32:00 INFO - Successfully installed blobuploader requests docopt 05:32:00 INFO - Cleaning up... 05:32:00 INFO - Return code: 0 05:32:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:00 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 0x107b79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7a494ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, '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.LeJHRLdyHR/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.ld3iXtfktO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:32:00 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 05:32:00 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 05:32:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:32:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:00 INFO - 'HOME': '/Users/cltbld', 05:32:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:00 INFO - 'LOGNAME': 'cltbld', 05:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:00 INFO - 'MOZ_NO_REMOTE': '1', 05:32:00 INFO - 'NO_EM_RESTART': '1', 05:32:00 INFO - 'PAGER': '/bin/cat', 05:32:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:00 INFO - 'PWD': '/builds/slave/test', 05:32:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:00 INFO - 'SHELL': '/bin/bash', 05:32:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:32:00 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:32:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:00 INFO - 'USER': 'cltbld', 05:32:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:00 INFO - 'XPC_FLAGS': '0x0', 05:32:00 INFO - 'XPC_SERVICE_NAME': '0', 05:32:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-6iTrbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-fiRKHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-QanSKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-wiwrFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-sn99yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-sYk5Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-dm918a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-lOuIXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-cszJse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-ziEDkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-DOm2y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Ddtgao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-nQpIND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-QowDMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-fmeRCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-7OwBbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-hY9mjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:02 INFO - Running setup.py install for manifestparser 05:32:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:03 INFO - Running setup.py install for mozcrash 05:32:03 INFO - Running setup.py install for mozdebug 05:32:03 INFO - Running setup.py install for mozdevice 05:32:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:03 INFO - Running setup.py install for mozfile 05:32:03 INFO - Running setup.py install for mozhttpd 05:32:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:03 INFO - Running setup.py install for mozinfo 05:32:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Running setup.py install for mozInstall 05:32:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Running setup.py install for mozleak 05:32:04 INFO - Running setup.py install for mozlog 05:32:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Running setup.py install for moznetwork 05:32:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Running setup.py install for mozprocess 05:32:04 INFO - Running setup.py install for mozprofile 05:32:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:04 INFO - Running setup.py install for mozrunner 05:32:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:05 INFO - Running setup.py install for mozscreenshot 05:32:05 INFO - Running setup.py install for moztest 05:32:05 INFO - Running setup.py install for mozversion 05:32:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:05 INFO - Cleaning up... 05:32:05 INFO - Return code: 0 05:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:05 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 0x107b79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7a494ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, '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.LeJHRLdyHR/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.ld3iXtfktO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:32:05 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 05:32:05 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 05:32:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:32:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:05 INFO - 'HOME': '/Users/cltbld', 05:32:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:05 INFO - 'LOGNAME': 'cltbld', 05:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:05 INFO - 'MOZ_NO_REMOTE': '1', 05:32:05 INFO - 'NO_EM_RESTART': '1', 05:32:05 INFO - 'PAGER': '/bin/cat', 05:32:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:05 INFO - 'PWD': '/builds/slave/test', 05:32:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:05 INFO - 'SHELL': '/bin/bash', 05:32:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:32:05 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:32:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:05 INFO - 'USER': 'cltbld', 05:32:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:05 INFO - 'XPC_FLAGS': '0x0', 05:32:05 INFO - 'XPC_SERVICE_NAME': '0', 05:32:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-3l7gs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:05 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)) 05:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:05 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-S74oCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-QKJI3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:06 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-IiZNZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:06 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-NzeuxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:06 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-kecU1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:06 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-v1HITi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:06 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-K8GozT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:06 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-4tStS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:06 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-EzL3Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:06 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-t8LZwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:06 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)) 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:06 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Gd2EFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:07 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)) 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:07 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-jyBCOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:07 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)) 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:07 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-iWufh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:07 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)) 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:07 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Q4Ylcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:07 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)) 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:07 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-h0qFJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:07 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)) 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:07 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-s8xR6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:07 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)) 05:32:07 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:07 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:07 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)) 05:32:07 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)) 05:32:07 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)) 05:32:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:10 INFO - Downloading blessings-1.6.tar.gz 05:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:10 INFO - Installing collected packages: blessings 05:32:10 INFO - Running setup.py install for blessings 05:32:10 INFO - Successfully installed blessings 05:32:10 INFO - Cleaning up... 05:32:10 INFO - Return code: 0 05:32:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:10 INFO - Reading from file tmpfile_stdout 05:32:10 INFO - Current package versions: 05:32:10 INFO - blessings == 1.6 05:32:10 INFO - blobuploader == 1.2.4 05:32:10 INFO - docopt == 0.6.1 05:32:10 INFO - manifestparser == 1.1 05:32:10 INFO - mozInstall == 1.12 05:32:10 INFO - mozcrash == 0.17 05:32:10 INFO - mozdebug == 0.1 05:32:10 INFO - mozdevice == 0.48 05:32:10 INFO - mozfile == 1.2 05:32:10 INFO - mozhttpd == 0.7 05:32:10 INFO - mozinfo == 0.9 05:32:10 INFO - mozleak == 0.1 05:32:10 INFO - mozlog == 3.1 05:32:10 INFO - moznetwork == 0.27 05:32:10 INFO - mozprocess == 0.22 05:32:10 INFO - mozprofile == 0.28 05:32:10 INFO - mozrunner == 6.11 05:32:10 INFO - mozscreenshot == 0.1 05:32:10 INFO - mozsystemmonitor == 0.0 05:32:10 INFO - moztest == 0.7 05:32:10 INFO - mozversion == 1.4 05:32:10 INFO - psutil == 3.1.1 05:32:10 INFO - requests == 1.2.3 05:32:10 INFO - wsgiref == 0.1.2 05:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:10 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 0x107b79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7a494ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, '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.LeJHRLdyHR/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.ld3iXtfktO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:32:10 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 05:32:10 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 05:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:10 INFO - 'HOME': '/Users/cltbld', 05:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:10 INFO - 'LOGNAME': 'cltbld', 05:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:10 INFO - 'MOZ_NO_REMOTE': '1', 05:32:10 INFO - 'NO_EM_RESTART': '1', 05:32:10 INFO - 'PAGER': '/bin/cat', 05:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:10 INFO - 'PWD': '/builds/slave/test', 05:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:10 INFO - 'SHELL': '/bin/bash', 05:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:32:10 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:10 INFO - 'USER': 'cltbld', 05:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:10 INFO - 'XPC_FLAGS': '0x0', 05:32:10 INFO - 'XPC_SERVICE_NAME': '0', 05:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 INFO - Cleaning up... 05:32:10 INFO - Return code: 0 05:32:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:10 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 0x107b79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7a494ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, '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.LeJHRLdyHR/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.ld3iXtfktO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:32:10 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 05:32:10 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 05:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:10 INFO - 'HOME': '/Users/cltbld', 05:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:10 INFO - 'LOGNAME': 'cltbld', 05:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:10 INFO - 'MOZ_NO_REMOTE': '1', 05:32:10 INFO - 'NO_EM_RESTART': '1', 05:32:10 INFO - 'PAGER': '/bin/cat', 05:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:10 INFO - 'PWD': '/builds/slave/test', 05:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:10 INFO - 'SHELL': '/bin/bash', 05:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:32:10 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:10 INFO - 'USER': 'cltbld', 05:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:10 INFO - 'XPC_FLAGS': '0x0', 05:32:10 INFO - 'XPC_SERVICE_NAME': '0', 05:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:11 INFO - Downloading/unpacking jsonschema 05:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:32:13 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 05:32:13 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 05:32:13 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 05:32:13 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 05:32:13 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 05:32:13 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 05:32:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:14 INFO - warning: no files found matching '*.txt' 05:32:14 INFO - no previously-included directories found matching 'build' 05:32:14 INFO - no previously-included directories found matching 'dist' 05:32:14 INFO - no previously-included directories found matching '.git*' 05:32:14 INFO - Installing collected packages: jsonschema, functools32 05:32:14 INFO - Running setup.py install for functools32 05:32:14 INFO - warning: no files found matching '*.txt' 05:32:14 INFO - no previously-included directories found matching 'build' 05:32:14 INFO - no previously-included directories found matching 'dist' 05:32:14 INFO - no previously-included directories found matching '.git*' 05:32:14 INFO - Successfully installed jsonschema functools32 05:32:14 INFO - Cleaning up... 05:32:14 INFO - Return code: 0 05:32:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:14 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 0x107b79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7a494ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, '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.LeJHRLdyHR/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.ld3iXtfktO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:32:14 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 05:32:14 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 05:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:14 INFO - 'HOME': '/Users/cltbld', 05:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:14 INFO - 'LOGNAME': 'cltbld', 05:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:14 INFO - 'MOZ_NO_REMOTE': '1', 05:32:14 INFO - 'NO_EM_RESTART': '1', 05:32:14 INFO - 'PAGER': '/bin/cat', 05:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:14 INFO - 'PWD': '/builds/slave/test', 05:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:14 INFO - 'SHELL': '/bin/bash', 05:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:32:14 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:14 INFO - 'USER': 'cltbld', 05:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:14 INFO - 'XPC_FLAGS': '0x0', 05:32:14 INFO - 'XPC_SERVICE_NAME': '0', 05:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:14 INFO - Downloading/unpacking flake8 05:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:32:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:32:16 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 05:32:16 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 05:32:16 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 05:32:16 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 05:32:16 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 05:32:16 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 05:32:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:32:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:32:17 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 05:32:17 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 05:32:17 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 05:32:17 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 05:32:17 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 05:32:17 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 05:32:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:32:17 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 05:32:17 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 05:32:17 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 05:32:17 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 05:32:17 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 05:32:17 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 05:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:18 INFO - no previously-included directories found matching 'docs/_build' 05:32:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:32:18 INFO - Running setup.py install for pep8 05:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:18 INFO - no previously-included directories found matching 'docs/_build' 05:32:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:32:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:32:18 INFO - Cleaning up... 05:32:18 INFO - Return code: 0 05:32:18 INFO - Running post-action listener: _resource_record_post_action 05:32:18 INFO - Running post-action listener: _start_resource_monitoring 05:32:18 INFO - Starting resource monitoring. 05:32:18 INFO - ##### 05:32:18 INFO - ##### Running install step. 05:32:18 INFO - ##### 05:32:18 INFO - Running pre-action listener: _resource_record_pre_action 05:32:18 INFO - Running main action method: install 05:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:18 INFO - Reading from file tmpfile_stdout 05:32:18 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:18 INFO - Reading from file tmpfile_stdout 05:32:18 INFO - Output received: 05:32:18 INFO - Usage: mozinstall [options] installer 05:32:18 INFO - Options: 05:32:18 INFO - -h, --help show this help message and exit 05:32:18 INFO - -d DEST, --destination=DEST 05:32:18 INFO - Directory to install application into. [default: 05:32:18 INFO - "/builds/slave/test"] 05:32:18 INFO - --app=APP Application being installed. [default: firefox] 05:32:18 INFO - mkdir: /builds/slave/test/build/application 05:32:18 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'] 05:32:18 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 05:32:52 INFO - Reading from file tmpfile_stdout 05:32:52 INFO - Output received: 05:32:52 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:32:52 INFO - Running post-action listener: _resource_record_post_action 05:32:52 INFO - ##### 05:32:52 INFO - ##### Running run-tests step. 05:32:52 INFO - ##### 05:32:52 INFO - Running pre-action listener: _resource_record_pre_action 05:32:52 INFO - Running main action method: run_tests 05:32:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:32:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:32:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:32:53 INFO - 2016-03-07 05:32:53.005 screenresolution[1641:7561] starting screenresolution argv=screenresolution get 05:32:53 INFO - 2016-03-07 05:32:53.007 screenresolution[1641:7561] Display 0: 1600x1200x32@60 05:32:53 INFO - 2016-03-07 05:32:53.013 screenresolution[1642:7564] starting screenresolution argv=screenresolution list 05:32:53 INFO - Available Modes on Display 0 05:32:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:32:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:32:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:32:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:32:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:32:53 INFO - Intel Iris: 05:32:53 INFO - Chipset Model: Intel Iris 05:32:53 INFO - Type: GPU 05:32:53 INFO - Bus: Built-In 05:32:53 INFO - VRAM (Dynamic, Max): 1536 MB 05:32:53 INFO - Vendor: Intel (0x8086) 05:32:53 INFO - Device ID: 0x0a2e 05:32:53 INFO - Revision ID: 0x0009 05:32:53 INFO - Displays: 05:32:53 INFO - Display: 05:32:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:32:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:32:53 INFO - Display Serial Number: 1600x1200 60 05:32:53 INFO - Main Display: Yes 05:32:53 INFO - Mirror: Off 05:32:53 INFO - Online: Yes 05:32:53 INFO - Rotation: Supported 05:32:53 INFO - Return code: 0 05:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:32:53 INFO - Python 2.7.3 05:32:53 INFO - Return code: 0 05:32:53 INFO - grabbing minidump binary from tooltool 05:32:53 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')]} 05:32:53 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 0x107a1dd30>, '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 0x107841db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a14b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:32:53 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 05:32:53 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 05:32:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:32:53 INFO - Return code: 0 05:32:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:32:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:32:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:32:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:32:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:32:54 INFO - Return code: 0 05:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 05:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0074 --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 05:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LeJHRLdyHR/Render', 05:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:54 INFO - 'HOME': '/Users/cltbld', 05:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:54 INFO - 'LOGNAME': 'cltbld', 05:32:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:32:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:54 INFO - 'MOZ_NO_REMOTE': '1', 05:32:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:32:54 INFO - 'NO_EM_RESTART': '1', 05:32:54 INFO - 'PAGER': '/bin/cat', 05:32:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:54 INFO - 'PWD': '/builds/slave/test', 05:32:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:54 INFO - 'SHELL': '/bin/bash', 05:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld3iXtfktO/Listeners', 05:32:54 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:54 INFO - 'USER': 'cltbld', 05:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:54 INFO - 'XPC_FLAGS': '0x0', 05:32:54 INFO - 'XPC_SERVICE_NAME': '0', 05:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 05:32:54 INFO - mozversion application_buildid: 20160307030208 05:32:54 INFO - mozversion application_changeset: 68d3781deda0d4d58ec9877862830db89669b3a5 05:32:54 INFO - mozversion application_display_name: Nightly 05:32:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:32:54 INFO - mozversion application_name: Firefox 05:32:54 INFO - mozversion application_remotingname: firefox 05:32:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:32:54 INFO - mozversion application_vendor: Mozilla 05:32:54 INFO - mozversion application_version: 47.0a1 05:32:54 INFO - mozversion platform_buildid: 20160307030208 05:32:54 INFO - mozversion platform_changeset: 68d3781deda0d4d58ec9877862830db89669b3a5 05:32:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:32:54 INFO - mozversion platform_version: 47.0a1 05:32:54 INFO - using testdate: 1457357574 05:32:54 INFO - actual date: 1457357574 05:32:54 INFO - starting webserver on 'localhost:49272' 05:32:54 INFO - SUITE-START | Running 2 tests 05:32:54 INFO - TEST-START | dromaeo_css 05:32:54 INFO - operating with platform_type : mac_ 05:32:54 INFO - Initialising browser for dromaeo_css test... 05:32:54 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp4NokGe/profile http://localhost:49272/getInfo.html) 05:32:57 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 05:32:57 INFO - PROCESS | 1660 | colorDepth:24 05:32:57 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 05:32:57 INFO - PROCESS | 1660 | __metrics 05:32:57 INFO - PROCESS | 1660 | 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" 05:32:57 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:57 INFO - TEST-INFO | 1660: exit 0 05:32:57 INFO - Browser initialized. 05:32:57 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:57 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp4NokGe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:09 INFO - PROCESS | 1664 | RSS: Main: 246120448 05:33:09 INFO - PROCESS | 1664 | 05:34:01 INFO - PROCESS | 1664 | 1457357641353 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] 05:36:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 05:36:12 INFO - PROCESS | 1664 | RSS: Main: 364384256 05:36:12 INFO - PROCESS | 1664 | 05:39:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 05:39:15 INFO - PROCESS | 1664 | RSS: Main: 376852480 05:39:15 INFO - PROCESS | 1664 | 05:42:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 05:42:17 INFO - PROCESS | 1664 | RSS: Main: 382734336 05:42:17 INFO - PROCESS | 1664 | 05:45:19 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 05:45:20 INFO - PROCESS | 1664 | RSS: Main: 339849216 05:45:20 INFO - PROCESS | 1664 | 05:48:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 05:48:23 INFO - PROCESS | 1664 | RSS: Main: 336470016 05:48:23 INFO - PROCESS | 1664 | 05:51:26 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 05:51:27 INFO - PROCESS | 1664 | RSS: Main: 384901120 05:51:27 INFO - PROCESS | 1664 | 05:51:27 INFO - PROCESS | 1664 | __start_tp_report 05:51:27 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 05:51:27 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 05:51:27 INFO - PROCESS | 1664 | |i|pagename|runs| 05:51:27 INFO - PROCESS | 1664 | |0;dojo.html;3434.433318502447;3464.982675086624;3501.3697534443822;3510.245297261089;3545.415006523922;5584.050711379065;5625.128105143699;5664.886702265952;5665;5679.488846003859;5663.292088488939;5672.716364181795;5680.3467601225875;5787.565932555065;5821.09772985188;5048.823291184809;5077.974610126954;5094.694318340893;5112.718800465973;5185.248139019859;5150.381954165487;5169.56058735008;5204.739763011853;5209.140491818865;5279.128943724281;5050.797968081272;5106.208537676666;5121.8463446096675;5125.3080834087295;5143.434222235551;5062.721550314731;5106.591472682214;5142.202958541432;5142.871428214287;5174.793008279665;5137.3064636274;5148.433672296044;5166.3800343958965;5184.637075404723;5201.609879259071;5500.064988951888;5550.77796888124;5551.250581171571;5557.999560079184;5563.610547261694;5097.898042039175;6096.085587161917;6194.5973511721595;6229.719662615194;6240.188775459162;6102.96948515259;6154.76904619078;6263.467605253559;6278.905816412757;6298.6535740534255;5666.206731057697;5714.599978001542;5727.198192253088;5738.598298119134;5792.218050563204;6219.844503887439;6226.034964580497;6250.937490625127;6277.937220627735;6292.685365731695;6120.416658368064;6133.785317513865;6141.416565426277;6146.6004709693725;6152.507799376039;6269.46709529686;6270.968645156836;6271.874562508724;6272.6236425814595;6283.120363149163;5119.769610367543;6030.216071910623;6117.918752924011;6124.173236613089;6168.722407491584;6183.536234782409;6199.070139479114;6212.720427580679;6218.502519798405;6239.313675495692;4824.179889418737;4838.250071238964;4867.294242334841;4867.34290870735;4909.729964851896;4168.8124034417915;4278.7860606969525;4369.12617476506;4394.912101757947;4434.046679963759;5669.829905102853;5685.118806584986;5687.40282270364;5699.772009119589;5714.942850571524;6241.095041218998;6248.4688801452385;6250.562460627803;6283.214598175228;6304.3695630437505;5562.471565201299;5652.925944070614;5683.431656834284;5744.597878148489;5796.971015144897;5323.0684630190335;5328.3605967284175;5330.493603107699;5340.359156901197;5350.571954243651;6211.378862113753;6249.156363890907;6267.185265915584;6295.653739044396;6298.622082675054;6025.548083893638;6132.8773424532155;6143.38905964972;6230.06549017651;6251.6561589113035;5534.7786088556;6244.968775156277;6255.843603909939;6259.1550140730415;6263.968680156752;5962.910556341745;6138.1713468681155;6170.228721409824;6170.660613666291;6205.22434695663;6138.081874381997;6234.906476402948;6261.092141639528;6277.403646653561;6279.560430769802;6002.069679199731;6032.426919442646;6038.305594856472;6039.607425517327;6063.939360606338;4395;5945.940540594539;6016.2479690038745;6067.787627433018;6101.969490152521;5910.940890591039;5928.970355148197;5964.5526585505395;5971.104334349709;5999.070144127667;5909.881802364014;5984.042553191469;5995.640261584319;6034.818955431344;6059.575999639993;5933.169356290209;5953.374895635896;5963.403659634002;5974.4324289192455;5984.760609575743 05:51:27 INFO - PROCESS | 1664 | |1;ext.html;475.62425683709847;488.39195201973547;589.713988715473;639.5203597302024;648.9091527186195;30297.394052118943;30337;37983.62016379832;37987.240255194876;39935.80032099835;39172;39519.20961580767;39745;39770.8011459943;39924.600753992454;9256.166944974968;9472.052794720506;9481.43111413314;9481.668141615044;9502.239820814353;9373.203277721403;9677.032296770338;9683.612655493771;9692.321537492378;9692.418454892693;9627.518624068804;9717.90282097177;9721.125098741111;9738.415695058284;9755.073268039525;9651.276154288456;9697.127258546694;9701.66044188457;9705.999999999965;9713.854292185622;9527.571259293349;9616.807663846754;9657.082577155159;9666.468344241064;9671.758206044906;38546.421803672965;38817;38911.22177556461;38942.80528597339;38945.805270973746;3324;3444.8622055117767;3446.3107378524146;3769.3595854100727;3774.5281839770028;22050.558988820132;28964.71035289662;29512.409751804844;29607.851960740274;29654.851725741235;2721.4693134838712;2739.561670132789;2850.5439129739143;2861.227468583492;2868.498012847764;360231;464138;466427;466583;467965;64445.35554644487;64756.35243647597;64852;65044.34955650383;65347.67326163339;69202.65398672974;69458;69474;69531.95702064472;69570.95643565351;16226.594335141715;16390.754138687927;16395.67208655844;16423.507294781175;16429.424970125987;12499.93750531197;12520.81218781719;12575.371231438392;12585.433655485525;12599.92900603459;19375.224991000203;19873.900630496755;19875;19925.900370498053;19934.401967940987;6867.965660171667;8326.625301861432;8381.790455238668;8385.496870187808;8469.74590762278;748.3611186132688;950.8288508068475;988.9851652225223;1011.4740335025746;1031.1591565237723;27269;27394.45211095767;27876.86061569679;28063.01779437751;28752.85623571869;974.7279799861249;988.48104745008;1014.5028935821394;1146.363768108691;1152.8558930133734;12382.938085309515;14316.785248221286;14625.634359141106;14652.780208296885;14693.853061469463;499782;515051;531645;532223;533792.3172688937;59147;59255;59561.404385956455;59582;59651.806963861345;1281.1992504684572;1402.859714028589;1435.2751860310477;1441.8341890682707;1475.8671719545293;28102.2974425641;28297.43405131927;28569.285767855137;28739.425211496073;28848.855755721088;45117.32324015077;45171.644850654535;45414.86462838455;45478;45509.08981820411;278396;279601;279896;280312.57499400404;280387;27989;30156.547651784804;33028.00915972525;33458.33083338368;33479;40725;41242.58757412388;41507.584924150375;41561.58438415698;42587.7870610645;25804.741952580232;35135.45864421694;35949.64050359568;36739.816300918326;37575.624243758306;34678.65321346754;35166.82416587901;35437.29125417529;36057.819710901276;36065.918022459366;35210.295794084486;35817.283654327286;36002;36165;36604;31091.067267981998;31510.424419239862;31631.52552711757;31848.203794905312;31946.041618750543;18893.527661808566;23749.406264843517;24073.879630602434;24341.39146521351;24429.633555497036 05:51:27 INFO - PROCESS | 1664 | |2;jquery.html;361.45600870689617;367.6635878171472;368.543006671727;369.59713911836093;375.391865178411;20205.59588808223;21028.57942841144;21206.89396553015;21324.654288028305;21628.783712162873;20696.861672608;20726.58546829066;21486.57026859462;21489.892550537264;21525.892370538124;5700.344460387047;5921.052631578948;5961.970190149043;5963.55273354498;5964.105384192362;5533.6403133796375;5846;5848.444397782204;5848.707564621774;5852.912206316909;5747.137929310616;5786.363500014995;5792.362840087587;5804.854878628047;5808.157817116516;5503.889922201553;5751.424857514257;5774.364819869811;5782.3350314713925;5804.82585522435;4979.1784355581285;5004.274380214885;5006.299118123429;5007.198848184273;5012.548870601663;23151.189708360296;23318.3004509865;23618.93714782839;23667.171648992204;23674.881625591763;1883.6703576873992;2113.292047164202;2167.7615462299136;2261.8642881427168;2265.184533567914;9826;9913.75215619608;10452.529636166391;11480.311181329063;14704.044237124659;1681.092210206487;1751.4395393474094;1810.384469280451;1835;1847.7043673012254;80433;86770.56614716887;88179.99999999936;88649.22701545933;89852.10147898503;11360.772784544262;11366.147538934612;11440.656780296604;11462.598809041643;11554.76890462186;13712.931435342958;13767.31163441824;13809.309534523234;13814.585562433143;13825.308734563232;8093.352531797442;8211.876821847676;8265.710700125466;8328.458650187718;8359.205875441823;6700.497462690318;8181.468204566684;8209.58952052395;8218.506889586644;8263.586820659064;4453.153900758845;4496.797644106023;4499.325101234841;4506.143832671782;4536.8638940831825;1875.624875024973;1888.2352647177916;1912.407153782332;1914.6457905287566;1957.0508303472805;770.249007217958;832.1719888710651;854.850401179791;880.300161371711;930.1256818590504;17172.22724977379;17534.736978945326;17554;17671.469855904343;18022.549436263937;808.8463191993502;828.825946551231;834.2158371131118;847.4703310430981;850.0819115355401;7882.960585197037;9238.630454781733;9261.30540209487;9292.16370526656;9408.529573521297;626192.869035661;630367;638910;646418;650965;97582.02417975871;111175;118152;120267.59464810655;121875;1014.6499457687086;1029.9588016479406;1031.9071283584512;1051.0277992856577;1052.8420736889527;17440;17611.647767044844;17862;17970.281188752302;18210.36263730763;49453.78550394213;49775.50224497853;50329;51210.48789512057;51803.48196517987;55847;70115;71021.64489177521;73458;74898.50202996019;7868.921310786819;7891.171427000312;7975.481593696391;8047.557384343917;8258.545779982158;12728.554500592434;12842.935785321013;13012;13211.339433028117;13350.866491334962;11380.715482113013;11387.487563059516;11403.486843092247;11413.086953043903;11729.413529323328;9959.203263739028;10216.233782466195;11056.944715276371;11171.608993685182;11457.968782809587;11389.373584452935;11530.077593792645;11603.825942611036;11715.121365897421;11754.942055215071;7846.333061689592;7915.683372665029;7960.243776841191;8257.42198046155;8265.586720664063;10972.067374273276;11182.496787644413;11305.434728263719;11371.943140284246;11507.942460287644 05:51:27 INFO - PROCESS | 1664 | |3;mootools.html;1447.3993292783496;1589.5469791109535;1613.7175994201011;1900.9809901900985;2028.3407892434961;7877.960610196948;8445.451045682034;8629.69796057138;8641.697540586072;8651.567421628924;8365.790855228623;8595.097514760953;8608;8624.698135565257;8632.050474447806;2181.607310684084;2417.8549287042747;2459.9139030133947;2476.1209770531473;2484.776370126688;2482.7641374069435;2490.5267999080115;2492.426741849367;2493.376655836041;2495.887685054177;2186.814120799734;2295.6900818389554;2482.391814005562;2485.092941076503;2485.7762801347876;2344.167820423742;2372.063035101134;2379.6073647848084;2399.7600239975864;2403.567357875582;2435.683361163055;2462.44594966133;2472.2830379190013;2474.5174690935273;2480.9827970531996;8640;8705.956470217672;8714.25928796053;8724.694635687783;8728.825423491558;5330.546903513206;5528.723563821793;5529.778808847641;5532.197831314477;5542.8337149885565;3538.5046093546925;3632.6185750496347;3680.871169509081;3690.833912473945;3708.9814550927344;1038.268021045169;1039.3400190878847;1049.4805071489586;1062.1449732964961;1070.1492313610697;11606.825897611543;11627.534898604046;11657;11666.300021998708;11670.649880503599;4800.087983283165;4860.392450943632;4965.32968049316;4969.801207951714;4973.602111831045;10022.699319020441;10026.64906728261;10039.598416063276;10043.146332561813;10048.69853904384;5501.449855014546;5501.697406642593;5502.174673798962;5502.98194833957;5507.917381239285;4392.165488557164;4547.931781023287;4758.191107511731;4864.197407427735;4890.902181956412;3851.7111216658864;3927.0771368728324;3956.5647778744315;3976.940345894814;3979.462772525672;1299.8960083193322;1308.7578797922415;1316.9078164528582;1317.8945684345422;1328.913620614657;1363.7068030373318;1374.6013656039636;1398.3357904995046;1421.9928900355433;1424.8361438434713;8072.394570407243;8128.9187108129345;8137.023557173059;8149.429539932148;8150.75547733569;504.1807063521777;507.47729838266645;509.8623371689697;1273.7134144817528;1339.2165583133976;6169.96915015422;6248.656323902138;6312.589681670676;6333.081703153017;6344.968275158687;9215.907840921505;10166.745831354276;10188.745281368025;10406.27156099081;10562.735931601617;10200;10226.233032522441;10295.536700848479;10403;10418.479076046167;8051.919480805234;8157.021157461261;8255.587220639065;8302.294304984023;8334.541600212047;7697;7800.531968081933;7846.33306168982;7886.132525422085;7887.092984306878;9356.345055846026;9428.198603118812;9431.151196392357;9453.621855125994;9520.333576649846;7876.40926930494;9364.391314564531;9514.809703805746;9523.761905952406;9827.656032038843;7311.524750891175;7454.1800401956825;7852.254035866584;8146.837063258583;8164.224398682116;8220.301274391744;8221.671133154847;8293.668253269801;8296.958515207385;8314.334853211607;7082.645867706698;7224.74713385029;7251.8187045324285;7354.521956072838;7424.1462231844025;7089.645517724196;7110.0401445804155;7167.283271672791;7223.711051557879;7259.128904531279;7693.576853273124;7789.143194248742;7791.415643826623;7803.531788092732;7811.570363629828;6957.686904089227;6960;7079;7100.147982242164;7106.431485481253;7072.893906591508;7169.605671688108;7171.569705817667;7195.892061618975;7200.71197152108 05:51:27 INFO - PROCESS | 1664 | |4;prototype.html;316.92869104451495;322.17201791396104;330.33272788966275;330.3459150881256;332.8069719562654;5190.9740451297785;6417.839554011146;6490.772822951198;6501.479881609472;6509.967450162754;6374.490040796737;6425.518086143535;6427.839304017402;6433;6445.419912207901;4591.6353078164775;4633.212353899845;4669.439667239936;4748.833790817322;4786.832460863861;4435.88910277244;4553.271476563734;4745.240761478164;4778.761061946906;4788.233882578788;4714.669973101884;4729.385179926622;4730.952690473086;4732.929006064912;4746.098241334153;4510.391097201868;4582.999999999984;4687.179743544866;4690.671652984292;4705.694129881546;4029.435878976946;4039.4748682671066;4045.110075783323;4053.898652533681;4054.6888273684012;6197.752089916398;6207.968960155215;6214;6222.595531290452;6227.439530442237;5591.189277554772;5591.3569939457075;5598.804041858556;5606.775728970877;5607.355154157283;6823;6823.795286141423;6833;6833.3166683331265;6835.111435513351;4298.892527686801;4453.866384008485;4461.397711308997;4464.2633965396;4465.352523884018;7101.502894797366;7280.162781280114;7287.817804554876;7292.0520332356455;7293.7082516699265;4574.08518296342;4575.95424045762;4576.427946506687;4579.656525760582;4585.380973568525;4615.376924115269;4622.745748983771;4626.83806066786;4639;4639.466461356919;4441.400410944481;5492.588055895823;5493.807716729895;5500.092484740053;5504.366997795225;6687.297833727486;6920.619365934922;6923.099997000358;6932.23745388017;6936.271691472322;1584.0891487394795;1587.5792914877566;1607.1241173560438;1609.30799756106;1613.4594910704811;958.8993155718549;990.2820455169945;1013.5287091502487;1018.7198520406947;1041.4063983529315;6356.586821856565;6551.344865513411;6554.115194448784;6557.114789503356;6585.6377899216;7220.566765993952;7224.313690199423;7231.096112985877;7233.27667233283;7252.854942901113;6489;6550.050242714779;6550.2794692583775;6557.147570815859;6570.901436478457;3062.8009179403266;3785.280796648628;3790.507234059555;3792.146766977408;3797.9240415192094;5898.852528686732;6799.640071985623;7225.602591857499;7483.214262502468;7580.54516728998;7429.108506979089;7484.1393239777035;7488.700451981859;7492.363149132276;7502.887456688154;5721.284839395075;7535.13345965221;7585.582792946441;7597.810054748676;7599.428268713696;6989.825254368681;7235.421166306788;7255.238199989136;7263.418926485762;7264.527805692613;5769.624974376652;7093.858122837618;7112.288771122846;7114.430845532242;7140.964295178491;7500.324970752658;7549.396048316012;7553.131389890013;7557.962210189134;7570.470067095251;4518.706284091655;4554.27131658933;4571.222892108283;4574.679772416032;4582.793774280232;5881.794232182307;7115.786526404217;7197.208307086112;7197.496175267681;7217.247031543463;6606;6909.2745261748805;6915.101036865175;6926.168859736864;6939.653017349214;6178.505719542516;6918.481113916376;6924.4114250289285;6924.792256232321;6932.237453879969;6747.122874026345;6754.493412993947;6771.695273712793;6773.390394864289;6781.3896749290825;6675.732970681119;6907.274736152833;6914.585124892523;6917.515773895981;6929.272426395156;6488.286288508166;6629.005649152666;6676.866462670817;6681.064650948774;6747.4264687500145 05:51:27 INFO - PROCESS | 1664 | |5;yui.html;743.4201322968083;754.5208792416817;755.5013690963965;767.6161919040479;810.2262339465809;14863.365029846707;15096.245187740624;15199.772003419943;15202.163880986542;15211.695766084686;14018.509352172676;14237.71524569508;14271.92960527962;14281.571552853431;14296.285185740697;755.9848803023964;767.033537742443;932.7434955387272;940.8494640857464;962.903709629035;943.1228957069957;948.5162567090764;949.6391371278904;950.3964982236295;953.2564599612278;1003.9598416063349;1005.4319309590095;1006.4213077480441;1009.3086235928375;1011.8836333821595;782.1630854985168;977.7066879936062;993.7068564773409;1000.5947591225565;1007.1942446043137;740.3189066059239;743;743.353282644103;743.5427212264473;743.8958545803591;14948.252587370587;15061.945663803539;15069.020513666577;15078.924605376902;15103.848961510465;12377.69055773604;12394.938025309906;12428.192167509173;12477.875221247852;12751.553695620702;9883.456409897453;10071.496425178711;10191.388516688949;10290.07389334956;10773.730656733565;3512.7892326460496;3550.183457804719;3561.8753343632848;3633.4731463937846;3682.650148235913;77317.61341193314;77330.61334693347;77431.83852242221;77547.61226193832;77834.22165778326;9185.265178785681;9536.761580960532;9703.563339649732;9730.708078757649;10156;21616;21865.562688746137;21881.67177492339;21885.562288754136;21932.89033554822;7456.552606843607;7636.274553917369;7648.541087534766;7718;7723.150453450116;3838.6353296436796;3959.9604003960167;4088.8773336799945;4097.426360309559;4098.446709694213;3544.91137721559;3590.3716849551224;3591.048372181374;3592.8742494012586;3597.9280414391565;625.3902445115975;636.5830381100386;636.9649669268234;637.8118455055769;638.0716058135401;536.7665065696434;572.1046562130252;573.0830074918684;594.5659668442062;595.5057302438966;7398.889016664754;7622.466427350143;7662.65518051689;7716.845663086707;8023.237792409828;571.9599628026082;592.9021711417654;594.2037669522861;601.5548494114324;601.6029420582395;3613.95195393333;3625.5830579483168;3667.394879844796;3732.1405393532436;3770.1517158639635;83875;86397.70403443954;86536;86557;86588;75174;76393;76793;77729;77761.61119194482;65941.35146621277;66380.66809665921;66959.99560006603;68022;68417.65791171113;7266.854662906607;7278.063975080978;7442.181360050498;7494.175640679412;7551.056117985252;42532.574674252864;42796.572034279256;44898.551014489436;46925.76537117429;48762.5123748758;61030.38969610247;61516;65625.67187164034;68065;69410.65294673495;10097.19222462216;10252.846207306748;10408.583656653649;10440.216983726099;10485.9475702621;10619.36283822973;10653.9467302663;10691.358518488916;10795;10894.564217431214;9911.504424778876;10166.745831354276;10185.185185185019;10355.585776568852;10534.315269507457;10145.307819887732;10354.275200736178;10414.739631509274;10952;11096.056835169102;8278.296344810758;10051.246156538142;10198.643047493302;10469.214808889212;10487.213458990758;6618.305077966937;8307.792305192419;8503.829923401374;8621.8706719398;8650.956745216234;8221.054578723524;8375.32997360222;8408.495490270603;8618.224359807647;8660.437071590326 05:51:27 INFO - PROCESS | 1664 | __end_tp_report 05:51:27 INFO - PROCESS | 1664 | __start_cc_report 05:51:27 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1479 05:51:27 INFO - PROCESS | 1664 | __end_cc_report 05:51:27 INFO - PROCESS | 1664 | __startTimestamp1457358687139__endTimestamp 05:51:27 INFO - PROCESS | 1664 | 05:51:27 INFO - PROCESS | 1664 | ------- Summary: start ------- 05:51:27 INFO - PROCESS | 1664 | Number of tests: 6 05:51:27 INFO - PROCESS | 1664 | 05:51:27 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5683.25 Median:5933.17 stddev:639.44 (10.8%) stddev-sans-first:616.59 05:51:27 INFO - PROCESS | 1664 | Values: 3434.4 3465.0 3501.4 3510.2 3545.4 5584.1 5625.1 5664.9 5665.0 5679.5 5663.3 5672.7 5680.3 5787.6 5821.1 5048.8 5078.0 5094.7 5112.7 5185.2 5150.4 5169.6 5204.7 5209.1 5279.1 5050.8 5106.2 5121.8 5125.3 5143.4 5062.7 5106.6 5142.2 5142.9 5174.8 5137.3 5148.4 5166.4 5184.6 5201.6 5500.1 5550.8 5551.3 5558.0 5563.6 5097.9 6096.1 6194.6 6229.7 6240.2 6103.0 6154.8 6263.5 6278.9 6298.7 5666.2 5714.6 5727.2 5738.6 5792.2 6219.8 6226.0 6250.9 6277.9 6292.7 6120.4 6133.8 6141.4 6146.6 6152.5 6269.5 6271.0 6271.9 6272.6 6283.1 5119.8 6030.2 6117.9 6124.2 6168.7 6183.5 6199.1 6212.7 6218.5 6239.3 4824.2 4838.3 4867.3 4867.3 4909.7 4168.8 4278.8 4369.1 4394.9 4434.0 5669.8 5685.1 5687.4 5699.8 5714.9 6241.1 6248.5 6250.6 6283.2 6304.4 5562.5 5652.9 5683.4 5744.6 5797.0 5323.1 5328.4 5330.5 5340.4 5350.6 6211.4 6249.2 6267.2 6295.7 6298.6 6025.5 6132.9 6143.4 6230.1 6251.7 5534.8 6245.0 6255.8 6259.2 6264.0 5962.9 6138.2 6170.2 6170.7 6205.2 6138.1 6234.9 6261.1 6277.4 6279.6 6002.1 6032.4 6038.3 6039.6 6063.9 4395.0 5945.9 6016.2 6067.8 6102.0 5910.9 5929.0 5964.6 5971.1 5999.1 5909.9 5984.0 5995.6 6034.8 6059.6 5933.2 5953.4 5963.4 5974.4 5984.8 05:51:27 INFO - PROCESS | 1664 | 05:51:27 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:56872.81 Median:20672.49 stddev:114065.82 (551.8%) stddev-sans-first:114307.21 05:51:27 INFO - PROCESS | 1664 | Values: 475.6 488.4 589.7 639.5 648.9 30297.4 30337.0 37983.6 37987.2 39935.8 39172.0 39519.2 39745.0 39770.8 39924.6 9256.2 9472.1 9481.4 9481.7 9502.2 9373.2 9677.0 9683.6 9692.3 9692.4 9627.5 9717.9 9721.1 9738.4 9755.1 9651.3 9697.1 9701.7 9706.0 9713.9 9527.6 9616.8 9657.1 9666.5 9671.8 38546.4 38817.0 38911.2 38942.8 38945.8 3324.0 3444.9 3446.3 3769.4 3774.5 22050.6 28964.7 29512.4 29607.9 29654.9 2721.5 2739.6 2850.5 2861.2 2868.5 360231.0 464138.0 466427.0 466583.0 467965.0 64445.4 64756.4 64852.0 65044.3 65347.7 69202.7 69458.0 69474.0 69532.0 69571.0 16226.6 16390.8 16395.7 16423.5 16429.4 12499.9 12520.8 12575.4 12585.4 12599.9 19375.2 19873.9 19875.0 19925.9 19934.4 6868.0 8326.6 8381.8 8385.5 8469.7 748.4 950.8 989.0 1011.5 1031.2 27269.0 27394.5 27876.9 28063.0 28752.9 974.7 988.5 1014.5 1146.4 1152.9 12382.9 14316.8 14625.6 14652.8 14693.9 499782.0 515051.0 531645.0 532223.0 533792.3 59147.0 59255.0 59561.4 59582.0 59651.8 1281.2 1402.9 1435.3 1441.8 1475.9 28102.3 28297.4 28569.3 28739.4 28848.9 45117.3 45171.6 45414.9 45478.0 45509.1 278396.0 279601.0 279896.0 280312.6 280387.0 27989.0 30156.5 33028.0 33458.3 33479.0 40725.0 41242.6 41507.6 41561.6 42587.8 25804.7 35135.5 35949.6 36739.8 37575.6 34678.7 35166.8 35437.3 36057.8 36065.9 35210.3 35817.3 36002.0 36165.0 36604.0 31091.1 31510.4 31631.5 31848.2 31946.0 18893.5 23749.4 24073.9 24341.4 24429.6 05:51:27 INFO - PROCESS | 1664 | 05:51:27 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34372.08 Median:2414.27 stddev:105307.31 (4361.9%) stddev-sans-first:105571.76 05:51:27 INFO - PROCESS | 1664 | Values: 361.5 367.7 368.5 369.6 375.4 20205.6 21028.6 21206.9 21324.7 21628.8 20696.9 20726.6 21486.6 21489.9 21525.9 5700.3 5921.1 5962.0 5963.6 5964.1 5533.6 5846.0 5848.4 5848.7 5852.9 5747.1 5786.4 5792.4 5804.9 5808.2 5503.9 5751.4 5774.4 5782.3 5804.8 4979.2 5004.3 5006.3 5007.2 5012.5 23151.2 23318.3 23618.9 23667.2 23674.9 1883.7 2113.3 2167.8 2261.9 2265.2 9826.0 9913.8 10452.5 11480.3 14704.0 1681.1 1751.4 1810.4 1835.0 1847.7 80433.0 86770.6 88180.0 88649.2 89852.1 11360.8 11366.1 11440.7 11462.6 11554.8 13712.9 13767.3 13809.3 13814.6 13825.3 8093.4 8211.9 8265.7 8328.5 8359.2 6700.5 8181.5 8209.6 8218.5 8263.6 4453.2 4496.8 4499.3 4506.1 4536.9 1875.6 1888.2 1912.4 1914.6 1957.1 770.2 832.2 854.9 880.3 930.1 17172.2 17534.7 17554.0 17671.5 18022.5 808.8 828.8 834.2 847.5 850.1 7883.0 9238.6 9261.3 9292.2 9408.5 626192.9 630367.0 638910.0 646418.0 650965.0 97582.0 111175.0 118152.0 120267.6 121875.0 1014.6 1030.0 1031.9 1051.0 1052.8 17440.0 17611.6 17862.0 17970.3 18210.4 49453.8 49775.5 50329.0 51210.5 51803.5 55847.0 70115.0 71021.6 73458.0 74898.5 7868.9 7891.2 7975.5 8047.6 8258.5 12728.6 12842.9 13012.0 13211.3 13350.9 11380.7 11387.5 11403.5 11413.1 11729.4 9959.2 10216.2 11056.9 11171.6 11458.0 11389.4 11530.1 11603.8 11715.1 11754.9 7846.3 7915.7 7960.2 8257.4 8265.6 10972.1 11182.5 11305.4 11371.9 11507.9 05:51:27 INFO - PROCESS | 1664 | 05:51:27 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6000.67 Median:5501.57 stddev:3111.18 (56.6%) stddev-sans-first:3101.08 05:51:27 INFO - PROCESS | 1664 | Values: 1447.4 1589.5 1613.7 1901.0 2028.3 7878.0 8445.5 8629.7 8641.7 8651.6 8365.8 8595.1 8608.0 8624.7 8632.1 2181.6 2417.9 2459.9 2476.1 2484.8 2482.8 2490.5 2492.4 2493.4 2495.9 2186.8 2295.7 2482.4 2485.1 2485.8 2344.2 2372.1 2379.6 2399.8 2403.6 2435.7 2462.4 2472.3 2474.5 2481.0 8640.0 8706.0 8714.3 8724.7 8728.8 5330.5 5528.7 5529.8 5532.2 5542.8 3538.5 3632.6 3680.9 3690.8 3709.0 1038.3 1039.3 1049.5 1062.1 1070.1 11606.8 11627.5 11657.0 11666.3 11670.6 4800.1 4860.4 4965.3 4969.8 4973.6 10022.7 10026.6 10039.6 10043.1 10048.7 5501.4 5501.7 5502.2 5503.0 5507.9 4392.2 4547.9 4758.2 4864.2 4890.9 3851.7 3927.1 3956.6 3976.9 3979.5 1299.9 1308.8 1316.9 1317.9 1328.9 1363.7 1374.6 1398.3 1422.0 1424.8 8072.4 8128.9 8137.0 8149.4 8150.8 504.2 507.5 509.9 1273.7 1339.2 6170.0 6248.7 6312.6 6333.1 6345.0 9215.9 10166.7 10188.7 10406.3 10562.7 10200.0 10226.2 10295.5 10403.0 10418.5 8051.9 8157.0 8255.6 8302.3 8334.5 7697.0 7800.5 7846.3 7886.1 7887.1 9356.3 9428.2 9431.2 9453.6 9520.3 7876.4 9364.4 9514.8 9523.8 9827.7 7311.5 7454.2 7852.3 8146.8 8164.2 8220.3 8221.7 8293.7 8297.0 8314.3 7082.6 7224.7 7251.8 7354.5 7424.1 7089.6 7110.0 7167.3 7223.7 7259.1 7693.6 7789.1 7791.4 7803.5 7811.6 6957.7 6960.0 7079.0 7100.1 7106.4 7072.9 7169.6 7171.6 7195.9 7200.7 05:51:27 INFO - PROCESS | 1664 | 05:51:27 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5629.04 Median:6466.85 stddev:1813.68 (28.0%) stddev-sans-first:1774.40 05:51:27 INFO - PROCESS | 1664 | Values: 316.9 322.2 330.3 330.3 332.8 5191.0 6417.8 6490.8 6501.5 6510.0 6374.5 6425.5 6427.8 6433.0 6445.4 4591.6 4633.2 4669.4 4748.8 4786.8 4435.9 4553.3 4745.2 4778.8 4788.2 4714.7 4729.4 4731.0 4732.9 4746.1 4510.4 4583.0 4687.2 4690.7 4705.7 4029.4 4039.5 4045.1 4053.9 4054.7 6197.8 6208.0 6214.0 6222.6 6227.4 5591.2 5591.4 5598.8 5606.8 5607.4 6823.0 6823.8 6833.0 6833.3 6835.1 4298.9 4453.9 4461.4 4464.3 4465.4 7101.5 7280.2 7287.8 7292.1 7293.7 4574.1 4576.0 4576.4 4579.7 4585.4 4615.4 4622.7 4626.8 4639.0 4639.5 4441.4 5492.6 5493.8 5500.1 5504.4 6687.3 6920.6 6923.1 6932.2 6936.3 1584.1 1587.6 1607.1 1609.3 1613.5 958.9 990.3 1013.5 1018.7 1041.4 6356.6 6551.3 6554.1 6557.1 6585.6 7220.6 7224.3 7231.1 7233.3 7252.9 6489.0 6550.1 6550.3 6557.1 6570.9 3062.8 3785.3 3790.5 3792.1 3797.9 5898.9 6799.6 7225.6 7483.2 7580.5 7429.1 7484.1 7488.7 7492.4 7502.9 5721.3 7535.1 7585.6 7597.8 7599.4 6989.8 7235.4 7255.2 7263.4 7264.5 5769.6 7093.9 7112.3 7114.4 7141.0 7500.3 7549.4 7553.1 7558.0 7570.5 4518.7 4554.3 4571.2 4574.7 4582.8 5881.8 7115.8 7197.2 7197.5 7217.2 6606.0 6909.3 6915.1 6926.2 6939.7 6178.5 6918.5 6924.4 6924.8 6932.2 6747.1 6754.5 6771.7 6773.4 6781.4 6675.7 6907.3 6914.6 6917.5 6929.3 6488.3 6629.0 6676.9 6681.1 6747.4 05:51:27 INFO - PROCESS | 1664 | 05:51:27 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17483.33 Median:594.38 stddev:24505.80 (4122.9%) stddev-sans-first:24542.31 05:51:27 INFO - PROCESS | 1664 | Values: 743.4 754.5 755.5 767.6 810.2 14863.4 15096.2 15199.8 15202.2 15211.7 14018.5 14237.7 14271.9 14281.6 14296.3 756.0 767.0 932.7 940.8 962.9 943.1 948.5 949.6 950.4 953.3 1004.0 1005.4 1006.4 1009.3 1011.9 782.2 977.7 993.7 1000.6 1007.2 740.3 743.0 743.4 743.5 743.9 14948.3 15061.9 15069.0 15078.9 15103.8 12377.7 12394.9 12428.2 12477.9 12751.6 9883.5 10071.5 10191.4 10290.1 10773.7 3512.8 3550.2 3561.9 3633.5 3682.7 77317.6 77330.6 77431.8 77547.6 77834.2 9185.3 9536.8 9703.6 9730.7 10156.0 21616.0 21865.6 21881.7 21885.6 21932.9 7456.6 7636.3 7648.5 7718.0 7723.2 3838.6 3960.0 4088.9 4097.4 4098.4 3544.9 3590.4 3591.0 3592.9 3597.9 625.4 636.6 637.0 637.8 638.1 536.8 572.1 573.1 594.6 595.5 7398.9 7622.5 7662.7 7716.8 8023.2 572.0 592.9 594.2 601.6 601.6 3614.0 3625.6 3667.4 3732.1 3770.2 83875.0 86397.7 86536.0 86557.0 86588.0 75174.0 76393.0 76793.0 77729.0 77761.6 65941.4 66380.7 66960.0 68022.0 68417.7 7266.9 7278.1 7442.2 7494.2 7551.1 42532.6 42796.6 44898.6 46925.8 48762.5 61030.4 61516.0 65625.7 68065.0 69410.7 10097.2 10252.8 10408.6 10440.2 10485.9 10619.4 10653.9 10691.4 10795.0 10894.6 9911.5 10166.7 10185.2 10355.6 10534.3 10145.3 10354.3 10414.7 10952.0 11096.1 8278.3 10051.2 10198.6 10469.2 10487.2 6618.3 8307.8 8503.8 8621.9 8651.0 8221.1 8375.3 8408.5 8618.2 8660.4 05:51:27 INFO - PROCESS | 1664 | -------- Summary: end -------- 05:51:27 INFO - PROCESS | 1664 | 05:51:27 INFO - TEST-INFO | 1664: exit 0 05:51:27 INFO - TEST-OK | dromaeo_css | took 1112992ms 05:51:27 INFO - TEST-START | kraken 05:51:27 INFO - operating with platform_type : mac_ 05:51:27 INFO - Initialising browser for kraken test... 05:51:27 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpkbboUD/profile http://localhost:49272/getInfo.html) 05:51:29 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 05:51:29 INFO - PROCESS | 1671 | colorDepth:24 05:51:29 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 05:51:29 INFO - PROCESS | 1671 | __metrics 05:51:30 INFO - PROCESS | 1671 | 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" 05:51:30 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:30 INFO - TEST-INFO | 1671: exit 0 05:51:30 INFO - Browser initialized. 05:51:30 INFO - Running cycle 1/1 for kraken test... 05:51:30 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpkbboUD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:42 INFO - PROCESS | 1674 | RSS: Main: 245682176 05:51:42 INFO - PROCESS | 1674 | 05:51:45 INFO - PROCESS | 1674 | 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) 05:51:45 INFO - PROCESS | 1674 | RSS: Main: 290574336 05:51:45 INFO - PROCESS | 1674 | 05:51:48 INFO - PROCESS | 1674 | 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) 05:51:49 INFO - PROCESS | 1674 | RSS: Main: 301142016 05:51:49 INFO - PROCESS | 1674 | 05:51:52 INFO - PROCESS | 1674 | 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) 05:51:52 INFO - PROCESS | 1674 | RSS: Main: 286052352 05:51:52 INFO - PROCESS | 1674 | 05:51:54 INFO - PROCESS | 1674 | 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) 05:51:55 INFO - PROCESS | 1674 | RSS: Main: 288190464 05:51:55 INFO - PROCESS | 1674 | 05:51:57 INFO - PROCESS | 1674 | 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) 05:51:58 INFO - PROCESS | 1674 | RSS: Main: 289202176 05:51:58 INFO - PROCESS | 1674 | 05:52:00 INFO - PROCESS | 1674 | 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) 05:52:01 INFO - PROCESS | 1674 | RSS: Main: 290992128 05:52:01 INFO - PROCESS | 1674 | 05:52:04 INFO - PROCESS | 1674 | 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) 05:52:04 INFO - PROCESS | 1674 | RSS: Main: 290779136 05:52:04 INFO - PROCESS | 1674 | 05:52:07 INFO - PROCESS | 1674 | 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) 05:52:08 INFO - PROCESS | 1674 | RSS: Main: 289906688 05:52:08 INFO - PROCESS | 1674 | 05:52:09 INFO - PROCESS | 1674 | 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) 05:52:10 INFO - PROCESS | 1674 | RSS: Main: 325263360 05:52:10 INFO - PROCESS | 1674 | 05:52:12 INFO - PROCESS | 1674 | 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) 05:52:12 INFO - PROCESS | 1674 | RSS: Main: 326819840 05:52:12 INFO - PROCESS | 1674 | 05:52:15 INFO - PROCESS | 1674 | 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) 05:52:15 INFO - PROCESS | 1674 | RSS: Main: 331845632 05:52:15 INFO - PROCESS | 1674 | 05:52:18 INFO - PROCESS | 1674 | 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) 05:52:18 INFO - PROCESS | 1674 | RSS: Main: 334094336 05:52:18 INFO - PROCESS | 1674 | 05:52:21 INFO - PROCESS | 1674 | 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) 05:52:21 INFO - PROCESS | 1674 | RSS: Main: 334561280 05:52:21 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | 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) 05:52:23 INFO - PROCESS | 1674 | RSS: Main: 394293248 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | __start_tp_report 05:52:23 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 05:52:23 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 05:52:23 INFO - PROCESS | 1674 | |i|pagename|runs| 05:52:23 INFO - PROCESS | 1674 | |0;ai-astar;112;108;110;110;110;111;115;111;110;108 05:52:23 INFO - PROCESS | 1674 | |1;audio-beat-detection;158;132;179;189;116;140;137;117;161;114 05:52:23 INFO - PROCESS | 1674 | |2;audio-dft;185;188;188;186;186;183;183;181;183;183 05:52:23 INFO - PROCESS | 1674 | |3;audio-fft;70;78;86;77;57;57;59;77;75;55 05:52:23 INFO - PROCESS | 1674 | |4;audio-oscillator;98;92;131;79;77;86;110;77;82;107 05:52:23 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;88;85;90;87;88;87;91;87;91;86 05:52:23 INFO - PROCESS | 1674 | |6;imaging-darkroom;94;95;113;149;112;94;94;103;94;95 05:52:23 INFO - PROCESS | 1674 | |7;imaging-desaturate;103;147;140;88;85;88;87;88;85;85 05:52:23 INFO - PROCESS | 1674 | |8;json-parse-financial;56;56;55;54;53;54;54;63;56;54 05:52:23 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;64;66;73;75;71;68;68;68;68;70 05:52:23 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;84;81;82;83;83;83;83;82;85;83 05:52:23 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;132;125;114;118;130;132;124;127;124;106 05:52:23 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;144;125;137;137;135;126;137;136;135;138 05:52:23 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;66;66;67;68;66;66;67;65;70 05:52:23 INFO - PROCESS | 1674 | __end_tp_report 05:52:23 INFO - PROCESS | 1674 | __start_cc_report 05:52:23 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1246 05:52:23 INFO - PROCESS | 1674 | __end_cc_report 05:52:23 INFO - PROCESS | 1674 | __startTimestamp1457358743778__endTimestamp 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | ------- Summary: start ------- 05:52:23 INFO - PROCESS | 1674 | Number of tests: 14 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:2.01 (1.8%) stddev-sans-first:2.06 05:52:23 INFO - PROCESS | 1674 | Values: 112.0 108.0 110.0 110.0 110.0 111.0 115.0 111.0 110.0 108.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:149.00 stddev:26.58 (17.8%) stddev-sans-first:27.72 05:52:23 INFO - PROCESS | 1674 | Values: 158.0 132.0 179.0 189.0 116.0 140.0 137.0 117.0 161.0 114.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.50 stddev:2.37 (1.3%) stddev-sans-first:2.51 05:52:23 INFO - PROCESS | 1674 | Values: 185.0 188.0 188.0 186.0 186.0 183.0 183.0 181.0 183.0 183.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:69.10 Median:76.00 stddev:11.15 (14.7%) stddev-sans-first:11.82 05:52:23 INFO - PROCESS | 1674 | Values: 70.0 78.0 86.0 77.0 57.0 57.0 59.0 77.0 75.0 55.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:80.50 stddev:17.72 (22.0%) stddev-sans-first:18.73 05:52:23 INFO - PROCESS | 1674 | Values: 98.0 92.0 131.0 79.0 77.0 86.0 110.0 77.0 82.0 107.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.00 stddev:2.05 (2.3%) stddev-sans-first:2.18 05:52:23 INFO - PROCESS | 1674 | Values: 88.0 85.0 90.0 87.0 88.0 87.0 91.0 87.0 91.0 86.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:94.00 stddev:17.42 (18.5%) stddev-sans-first:18.08 05:52:23 INFO - PROCESS | 1674 | Values: 94.0 95.0 113.0 149.0 112.0 94.0 94.0 103.0 94.0 95.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:99.60 Median:86.00 stddev:23.79 (27.7%) stddev-sans-first:25.20 05:52:23 INFO - PROCESS | 1674 | Values: 103.0 147.0 140.0 88.0 85.0 88.0 87.0 88.0 85.0 85.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:2.84 (5.1%) stddev-sans-first:3.00 05:52:23 INFO - PROCESS | 1674 | Values: 56.0 56.0 55.0 54.0 53.0 54.0 54.0 63.0 56.0 54.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:3.25 (4.7%) stddev-sans-first:2.87 05:52:23 INFO - PROCESS | 1674 | Values: 64.0 66.0 73.0 75.0 71.0 68.0 68.0 68.0 68.0 70.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.10 (1.3%) stddev-sans-first:1.09 05:52:23 INFO - PROCESS | 1674 | Values: 84.0 81.0 82.0 83.0 83.0 83.0 83.0 82.0 85.0 83.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:126.00 stddev:8.35 (6.6%) stddev-sans-first:8.23 05:52:23 INFO - PROCESS | 1674 | Values: 132.0 125.0 114.0 118.0 130.0 132.0 124.0 127.0 124.0 106.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.00 Median:137.00 stddev:5.62 (4.1%) stddev-sans-first:4.92 05:52:23 INFO - PROCESS | 1674 | Values: 144.0 125.0 137.0 137.0 135.0 126.0 137.0 136.0 135.0 138.0 05:52:23 INFO - PROCESS | 1674 | 05:52:23 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 05:52:23 INFO - PROCESS | 1674 | Values: 67.0 66.0 66.0 67.0 68.0 66.0 66.0 67.0 65.0 70.0 05:52:23 INFO - PROCESS | 1674 | -------- Summary: end -------- 05:52:23 INFO - PROCESS | 1674 | 05:52:24 INFO - TEST-INFO | 1674: exit 0 05:52:24 INFO - TEST-OK | kraken | took 56919ms 05:52:24 INFO - SUITE-END | took 1169s 05:52:24 INFO - Completed test suite (00:19:30) 05:52:24 INFO - javascript benchmark 05:52:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3434.433318502447, 3464.982675086624, 3501.3697534443822, 3510.245297261089, 3545.415006523922, 5584.050711379065, 5625.128105143699, 5664.886702265952, 5665.0, 5679.488846003859, 5663.292088488939, 5672.716364181795, 5680.3467601225875, 5787.565932555065, 5821.09772985188, 5048.823291184809, 5077.974610126954, 5094.694318340893, 5112.718800465973, 5185.248139019859, 5150.381954165487, 5169.56058735008, 5204.739763011853, 5209.140491818865, 5279.128943724281, 5050.797968081272, 5106.208537676666, 5121.8463446096675, 5125.3080834087295, 5143.434222235551, 5062.721550314731, 5106.591472682214, 5142.202958541432, 5142.871428214287, 5174.793008279665, 5137.3064636274, 5148.433672296044, 5166.3800343958965, 5184.637075404723, 5201.609879259071, 5500.064988951888, 5550.77796888124, 5551.250581171571, 5557.999560079184, 5563.610547261694, 5097.898042039175, 6096.085587161917, 6194.5973511721595, 6229.719662615194, 6240.188775459162, 6102.96948515259, 6154.76904619078, 6263.467605253559, 6278.905816412757, 6298.6535740534255, 5666.206731057697, 5714.599978001542, 5727.198192253088, 5738.598298119134, 5792.218050563204, 6219.844503887439, 6226.034964580497, 6250.937490625127, 6277.937220627735, 6292.685365731695, 6120.416658368064, 6133.785317513865, 6141.416565426277, 6146.6004709693725, 6152.507799376039, 6269.46709529686, 6270.968645156836, 6271.874562508724, 6272.6236425814595, 6283.120363149163, 5119.769610367543, 6030.216071910623, 6117.918752924011, 6124.173236613089, 6168.722407491584, 6183.536234782409, 6199.070139479114, 6212.720427580679, 6218.502519798405, 6239.313675495692, 4824.179889418737, 4838.250071238964, 4867.294242334841, 4867.34290870735, 4909.729964851896, 4168.8124034417915, 4278.7860606969525, 4369.12617476506, 4394.912101757947, 4434.046679963759, 5669.829905102853, 5685.118806584986, 5687.40282270364, 5699.772009119589, 5714.942850571524, 6241.095041218998, 6248.4688801452385, 6250.562460627803, 6283.214598175228, 6304.3695630437505, 5562.471565201299, 5652.925944070614, 5683.431656834284, 5744.597878148489, 5796.971015144897, 5323.0684630190335, 5328.3605967284175, 5330.493603107699, 5340.359156901197, 5350.571954243651, 6211.378862113753, 6249.156363890907, 6267.185265915584, 6295.653739044396, 6298.622082675054, 6025.548083893638, 6132.8773424532155, 6143.38905964972, 6230.06549017651, 6251.6561589113035, 5534.7786088556, 6244.968775156277, 6255.843603909939, 6259.1550140730415, 6263.968680156752, 5962.910556341745, 6138.1713468681155, 6170.228721409824, 6170.660613666291, 6205.22434695663, 6138.081874381997, 6234.906476402948, 6261.092141639528, 6277.403646653561, 6279.560430769802, 6002.069679199731, 6032.426919442646, 6038.305594856472, 6039.607425517327, 6063.939360606338, 4395.0, 5945.940540594539, 6016.2479690038745, 6067.787627433018, 6101.969490152521, 5910.940890591039, 5928.970355148197, 5964.5526585505395, 5971.104334349709, 5999.070144127667, 5909.881802364014, 5984.042553191469, 5995.640261584319, 6034.818955431344, 6059.575999639993, 5933.169356290209, 5953.374895635896, 5963.403659634002, 5974.4324289192455, 5984.760609575743], "unit": "score", "name": "dojo.html", "value": 5644.521047131099}, {"lowerIsBetter": false, "replicates": [475.62425683709847, 488.39195201973547, 589.713988715473, 639.5203597302024, 648.9091527186195, 30297.394052118943, 30337.0, 37983.62016379832, 37987.240255194876, 39935.80032099835, 39172.0, 39519.20961580767, 39745.0, 39770.8011459943, 39924.600753992454, 9256.166944974968, 9472.052794720506, 9481.43111413314, 9481.668141615044, 9502.239820814353, 9373.203277721403, 9677.032296770338, 9683.612655493771, 9692.321537492378, 9692.418454892693, 9627.518624068804, 9717.90282097177, 9721.125098741111, 9738.415695058284, 9755.073268039525, 9651.276154288456, 9697.127258546694, 9701.66044188457, 9705.999999999965, 9713.854292185622, 9527.571259293349, 9616.807663846754, 9657.082577155159, 9666.468344241064, 9671.758206044906, 38546.421803672965, 38817.0, 38911.22177556461, 38942.80528597339, 38945.805270973746, 3324.0, 3444.8622055117767, 3446.3107378524146, 3769.3595854100727, 3774.5281839770028, 22050.558988820132, 28964.71035289662, 29512.409751804844, 29607.851960740274, 29654.851725741235, 2721.4693134838712, 2739.561670132789, 2850.5439129739143, 2861.227468583492, 2868.498012847764, 360231.0, 464138.0, 466427.0, 466583.0, 467965.0, 64445.35554644487, 64756.35243647597, 64852.0, 65044.34955650383, 65347.67326163339, 69202.65398672974, 69458.0, 69474.0, 69531.95702064472, 69570.95643565351, 16226.594335141715, 16390.754138687927, 16395.67208655844, 16423.507294781175, 16429.424970125987, 12499.93750531197, 12520.81218781719, 12575.371231438392, 12585.433655485525, 12599.92900603459, 19375.224991000203, 19873.900630496755, 19875.0, 19925.900370498053, 19934.401967940987, 6867.965660171667, 8326.625301861432, 8381.790455238668, 8385.496870187808, 8469.74590762278, 748.3611186132688, 950.8288508068475, 988.9851652225223, 1011.4740335025746, 1031.1591565237723, 27269.0, 27394.45211095767, 27876.86061569679, 28063.01779437751, 28752.85623571869, 974.7279799861249, 988.48104745008, 1014.5028935821394, 1146.363768108691, 1152.8558930133734, 12382.938085309515, 14316.785248221286, 14625.634359141106, 14652.780208296885, 14693.853061469463, 499782.0, 515051.0, 531645.0, 532223.0, 533792.3172688937, 59147.0, 59255.0, 59561.404385956455, 59582.0, 59651.806963861345, 1281.1992504684572, 1402.859714028589, 1435.2751860310477, 1441.8341890682707, 1475.8671719545293, 28102.2974425641, 28297.43405131927, 28569.285767855137, 28739.425211496073, 28848.855755721088, 45117.32324015077, 45171.644850654535, 45414.86462838455, 45478.0, 45509.08981820411, 278396.0, 279601.0, 279896.0, 280312.57499400404, 280387.0, 27989.0, 30156.547651784804, 33028.00915972525, 33458.33083338368, 33479.0, 40725.0, 41242.58757412388, 41507.584924150375, 41561.58438415698, 42587.7870610645, 25804.741952580232, 35135.45864421694, 35949.64050359568, 36739.816300918326, 37575.624243758306, 34678.65321346754, 35166.82416587901, 35437.29125417529, 36057.819710901276, 36065.918022459366, 35210.295794084486, 35817.283654327286, 36002.0, 36165.0, 36604.0, 31091.067267981998, 31510.424419239862, 31631.52552711757, 31848.203794905312, 31946.041618750543, 18893.527661808566, 23749.406264843517, 24073.879630602434, 24341.39146521351, 24429.633555497036], "unit": "score", "name": "ext.html", "value": 19064.255640957977}, {"lowerIsBetter": false, "replicates": [361.45600870689617, 367.6635878171472, 368.543006671727, 369.59713911836093, 375.391865178411, 20205.59588808223, 21028.57942841144, 21206.89396553015, 21324.654288028305, 21628.783712162873, 20696.861672608, 20726.58546829066, 21486.57026859462, 21489.892550537264, 21525.892370538124, 5700.344460387047, 5921.052631578948, 5961.970190149043, 5963.55273354498, 5964.105384192362, 5533.6403133796375, 5846.0, 5848.444397782204, 5848.707564621774, 5852.912206316909, 5747.137929310616, 5786.363500014995, 5792.362840087587, 5804.854878628047, 5808.157817116516, 5503.889922201553, 5751.424857514257, 5774.364819869811, 5782.3350314713925, 5804.82585522435, 4979.1784355581285, 5004.274380214885, 5006.299118123429, 5007.198848184273, 5012.548870601663, 23151.189708360296, 23318.3004509865, 23618.93714782839, 23667.171648992204, 23674.881625591763, 1883.6703576873992, 2113.292047164202, 2167.7615462299136, 2261.8642881427168, 2265.184533567914, 9826.0, 9913.75215619608, 10452.529636166391, 11480.311181329063, 14704.044237124659, 1681.092210206487, 1751.4395393474094, 1810.384469280451, 1835.0, 1847.7043673012254, 80433.0, 86770.56614716887, 88179.99999999936, 88649.22701545933, 89852.10147898503, 11360.772784544262, 11366.147538934612, 11440.656780296604, 11462.598809041643, 11554.76890462186, 13712.931435342958, 13767.31163441824, 13809.309534523234, 13814.585562433143, 13825.308734563232, 8093.352531797442, 8211.876821847676, 8265.710700125466, 8328.458650187718, 8359.205875441823, 6700.497462690318, 8181.468204566684, 8209.58952052395, 8218.506889586644, 8263.586820659064, 4453.153900758845, 4496.797644106023, 4499.325101234841, 4506.143832671782, 4536.8638940831825, 1875.624875024973, 1888.2352647177916, 1912.407153782332, 1914.6457905287566, 1957.0508303472805, 770.249007217958, 832.1719888710651, 854.850401179791, 880.300161371711, 930.1256818590504, 17172.22724977379, 17534.736978945326, 17554.0, 17671.469855904343, 18022.549436263937, 808.8463191993502, 828.825946551231, 834.2158371131118, 847.4703310430981, 850.0819115355401, 7882.960585197037, 9238.630454781733, 9261.30540209487, 9292.16370526656, 9408.529573521297, 626192.869035661, 630367.0, 638910.0, 646418.0, 650965.0, 97582.02417975871, 111175.0, 118152.0, 120267.59464810655, 121875.0, 1014.6499457687086, 1029.9588016479406, 1031.9071283584512, 1051.0277992856577, 1052.8420736889527, 17440.0, 17611.647767044844, 17862.0, 17970.281188752302, 18210.36263730763, 49453.78550394213, 49775.50224497853, 50329.0, 51210.48789512057, 51803.48196517987, 55847.0, 70115.0, 71021.64489177521, 73458.0, 74898.50202996019, 7868.921310786819, 7891.171427000312, 7975.481593696391, 8047.557384343917, 8258.545779982158, 12728.554500592434, 12842.935785321013, 13012.0, 13211.339433028117, 13350.866491334962, 11380.715482113013, 11387.487563059516, 11403.486843092247, 11413.086953043903, 11729.413529323328, 9959.203263739028, 10216.233782466195, 11056.944715276371, 11171.608993685182, 11457.968782809587, 11389.373584452935, 11530.077593792645, 11603.825942611036, 11715.121365897421, 11754.942055215071, 7846.333061689592, 7915.683372665029, 7960.243776841191, 8257.42198046155, 8265.586720664063, 10972.067374273276, 11182.496787644413, 11305.434728263719, 11371.943140284246, 11507.942460287644], "unit": "score", "name": "jquery.html", "value": 9211.991499434134}, {"lowerIsBetter": false, "replicates": [1447.3993292783496, 1589.5469791109535, 1613.7175994201011, 1900.9809901900985, 2028.3407892434961, 7877.960610196948, 8445.451045682034, 8629.69796057138, 8641.697540586072, 8651.567421628924, 8365.790855228623, 8595.097514760953, 8608.0, 8624.698135565257, 8632.050474447806, 2181.607310684084, 2417.8549287042747, 2459.9139030133947, 2476.1209770531473, 2484.776370126688, 2482.7641374069435, 2490.5267999080115, 2492.426741849367, 2493.376655836041, 2495.887685054177, 2186.814120799734, 2295.6900818389554, 2482.391814005562, 2485.092941076503, 2485.7762801347876, 2344.167820423742, 2372.063035101134, 2379.6073647848084, 2399.7600239975864, 2403.567357875582, 2435.683361163055, 2462.44594966133, 2472.2830379190013, 2474.5174690935273, 2480.9827970531996, 8640.0, 8705.956470217672, 8714.25928796053, 8724.694635687783, 8728.825423491558, 5330.546903513206, 5528.723563821793, 5529.778808847641, 5532.197831314477, 5542.8337149885565, 3538.5046093546925, 3632.6185750496347, 3680.871169509081, 3690.833912473945, 3708.9814550927344, 1038.268021045169, 1039.3400190878847, 1049.4805071489586, 1062.1449732964961, 1070.1492313610697, 11606.825897611543, 11627.534898604046, 11657.0, 11666.300021998708, 11670.649880503599, 4800.087983283165, 4860.392450943632, 4965.32968049316, 4969.801207951714, 4973.602111831045, 10022.699319020441, 10026.64906728261, 10039.598416063276, 10043.146332561813, 10048.69853904384, 5501.449855014546, 5501.697406642593, 5502.174673798962, 5502.98194833957, 5507.917381239285, 4392.165488557164, 4547.931781023287, 4758.191107511731, 4864.197407427735, 4890.902181956412, 3851.7111216658864, 3927.0771368728324, 3956.5647778744315, 3976.940345894814, 3979.462772525672, 1299.8960083193322, 1308.7578797922415, 1316.9078164528582, 1317.8945684345422, 1328.913620614657, 1363.7068030373318, 1374.6013656039636, 1398.3357904995046, 1421.9928900355433, 1424.8361438434713, 8072.394570407243, 8128.9187108129345, 8137.023557173059, 8149.429539932148, 8150.75547733569, 504.1807063521777, 507.47729838266645, 509.8623371689697, 1273.7134144817528, 1339.2165583133976, 6169.96915015422, 6248.656323902138, 6312.589681670676, 6333.081703153017, 6344.968275158687, 9215.907840921505, 10166.745831354276, 10188.745281368025, 10406.27156099081, 10562.735931601617, 10200.0, 10226.233032522441, 10295.536700848479, 10403.0, 10418.479076046167, 8051.919480805234, 8157.021157461261, 8255.587220639065, 8302.294304984023, 8334.541600212047, 7697.0, 7800.531968081933, 7846.33306168982, 7886.132525422085, 7887.092984306878, 9356.345055846026, 9428.198603118812, 9431.151196392357, 9453.621855125994, 9520.333576649846, 7876.40926930494, 9364.391314564531, 9514.809703805746, 9523.761905952406, 9827.656032038843, 7311.524750891175, 7454.1800401956825, 7852.254035866584, 8146.837063258583, 8164.224398682116, 8220.301274391744, 8221.671133154847, 8293.668253269801, 8296.958515207385, 8314.334853211607, 7082.645867706698, 7224.74713385029, 7251.8187045324285, 7354.521956072838, 7424.1462231844025, 7089.645517724196, 7110.0401445804155, 7167.283271672791, 7223.711051557879, 7259.128904531279, 7693.576853273124, 7789.143194248742, 7791.415643826623, 7803.531788092732, 7811.570363629828, 6957.686904089227, 6960.0, 7079.0, 7100.147982242164, 7106.431485481253, 7072.893906591508, 7169.605671688108, 7171.569705817667, 7195.892061618975, 7200.71197152108], "unit": "score", "name": "mootools.html", "value": 4892.549274638073}, {"lowerIsBetter": false, "replicates": [316.92869104451495, 322.17201791396104, 330.33272788966275, 330.3459150881256, 332.8069719562654, 5190.9740451297785, 6417.839554011146, 6490.772822951198, 6501.479881609472, 6509.967450162754, 6374.490040796737, 6425.518086143535, 6427.839304017402, 6433.0, 6445.419912207901, 4591.6353078164775, 4633.212353899845, 4669.439667239936, 4748.833790817322, 4786.832460863861, 4435.88910277244, 4553.271476563734, 4745.240761478164, 4778.761061946906, 4788.233882578788, 4714.669973101884, 4729.385179926622, 4730.952690473086, 4732.929006064912, 4746.098241334153, 4510.391097201868, 4582.999999999984, 4687.179743544866, 4690.671652984292, 4705.694129881546, 4029.435878976946, 4039.4748682671066, 4045.110075783323, 4053.898652533681, 4054.6888273684012, 6197.752089916398, 6207.968960155215, 6214.0, 6222.595531290452, 6227.439530442237, 5591.189277554772, 5591.3569939457075, 5598.804041858556, 5606.775728970877, 5607.355154157283, 6823.0, 6823.795286141423, 6833.0, 6833.3166683331265, 6835.111435513351, 4298.892527686801, 4453.866384008485, 4461.397711308997, 4464.2633965396, 4465.352523884018, 7101.502894797366, 7280.162781280114, 7287.817804554876, 7292.0520332356455, 7293.7082516699265, 4574.08518296342, 4575.95424045762, 4576.427946506687, 4579.656525760582, 4585.380973568525, 4615.376924115269, 4622.745748983771, 4626.83806066786, 4639.0, 4639.466461356919, 4441.400410944481, 5492.588055895823, 5493.807716729895, 5500.092484740053, 5504.366997795225, 6687.297833727486, 6920.619365934922, 6923.099997000358, 6932.23745388017, 6936.271691472322, 1584.0891487394795, 1587.5792914877566, 1607.1241173560438, 1609.30799756106, 1613.4594910704811, 958.8993155718549, 990.2820455169945, 1013.5287091502487, 1018.7198520406947, 1041.4063983529315, 6356.586821856565, 6551.344865513411, 6554.115194448784, 6557.114789503356, 6585.6377899216, 7220.566765993952, 7224.313690199423, 7231.096112985877, 7233.27667233283, 7252.854942901113, 6489.0, 6550.050242714779, 6550.2794692583775, 6557.147570815859, 6570.901436478457, 3062.8009179403266, 3785.280796648628, 3790.507234059555, 3792.146766977408, 3797.9240415192094, 5898.852528686732, 6799.640071985623, 7225.602591857499, 7483.214262502468, 7580.54516728998, 7429.108506979089, 7484.1393239777035, 7488.700451981859, 7492.363149132276, 7502.887456688154, 5721.284839395075, 7535.13345965221, 7585.582792946441, 7597.810054748676, 7599.428268713696, 6989.825254368681, 7235.421166306788, 7255.238199989136, 7263.418926485762, 7264.527805692613, 5769.624974376652, 7093.858122837618, 7112.288771122846, 7114.430845532242, 7140.964295178491, 7500.324970752658, 7549.396048316012, 7553.131389890013, 7557.962210189134, 7570.470067095251, 4518.706284091655, 4554.27131658933, 4571.222892108283, 4574.679772416032, 4582.793774280232, 5881.794232182307, 7115.786526404217, 7197.208307086112, 7197.496175267681, 7217.247031543463, 6606.0, 6909.2745261748805, 6915.101036865175, 6926.168859736864, 6939.653017349214, 6178.505719542516, 6918.481113916376, 6924.4114250289285, 6924.792256232321, 6932.237453879969, 6747.122874026345, 6754.493412993947, 6771.695273712793, 6773.390394864289, 6781.3896749290825, 6675.732970681119, 6907.274736152833, 6914.585124892523, 6917.515773895981, 6929.272426395156, 6488.286288508166, 6629.005649152666, 6676.866462670817, 6681.064650948774, 6747.4264687500145], "unit": "score", "name": "prototype.html", "value": 5022.834065099862}, {"lowerIsBetter": false, "replicates": [743.4201322968083, 754.5208792416817, 755.5013690963965, 767.6161919040479, 810.2262339465809, 14863.365029846707, 15096.245187740624, 15199.772003419943, 15202.163880986542, 15211.695766084686, 14018.509352172676, 14237.71524569508, 14271.92960527962, 14281.571552853431, 14296.285185740697, 755.9848803023964, 767.033537742443, 932.7434955387272, 940.8494640857464, 962.903709629035, 943.1228957069957, 948.5162567090764, 949.6391371278904, 950.3964982236295, 953.2564599612278, 1003.9598416063349, 1005.4319309590095, 1006.4213077480441, 1009.3086235928375, 1011.8836333821595, 782.1630854985168, 977.7066879936062, 993.7068564773409, 1000.5947591225565, 1007.1942446043137, 740.3189066059239, 743.0, 743.353282644103, 743.5427212264473, 743.8958545803591, 14948.252587370587, 15061.945663803539, 15069.020513666577, 15078.924605376902, 15103.848961510465, 12377.69055773604, 12394.938025309906, 12428.192167509173, 12477.875221247852, 12751.553695620702, 9883.456409897453, 10071.496425178711, 10191.388516688949, 10290.07389334956, 10773.730656733565, 3512.7892326460496, 3550.183457804719, 3561.8753343632848, 3633.4731463937846, 3682.650148235913, 77317.61341193314, 77330.61334693347, 77431.83852242221, 77547.61226193832, 77834.22165778326, 9185.265178785681, 9536.761580960532, 9703.563339649732, 9730.708078757649, 10156.0, 21616.0, 21865.562688746137, 21881.67177492339, 21885.562288754136, 21932.89033554822, 7456.552606843607, 7636.274553917369, 7648.541087534766, 7718.0, 7723.150453450116, 3838.6353296436796, 3959.9604003960167, 4088.8773336799945, 4097.426360309559, 4098.446709694213, 3544.91137721559, 3590.3716849551224, 3591.048372181374, 3592.8742494012586, 3597.9280414391565, 625.3902445115975, 636.5830381100386, 636.9649669268234, 637.8118455055769, 638.0716058135401, 536.7665065696434, 572.1046562130252, 573.0830074918684, 594.5659668442062, 595.5057302438966, 7398.889016664754, 7622.466427350143, 7662.65518051689, 7716.845663086707, 8023.237792409828, 571.9599628026082, 592.9021711417654, 594.2037669522861, 601.5548494114324, 601.6029420582395, 3613.95195393333, 3625.5830579483168, 3667.394879844796, 3732.1405393532436, 3770.1517158639635, 83875.0, 86397.70403443954, 86536.0, 86557.0, 86588.0, 75174.0, 76393.0, 76793.0, 77729.0, 77761.61119194482, 65941.35146621277, 66380.66809665921, 66959.99560006603, 68022.0, 68417.65791171113, 7266.854662906607, 7278.063975080978, 7442.181360050498, 7494.175640679412, 7551.056117985252, 42532.574674252864, 42796.572034279256, 44898.551014489436, 46925.76537117429, 48762.5123748758, 61030.38969610247, 61516.0, 65625.67187164034, 68065.0, 69410.65294673495, 10097.19222462216, 10252.846207306748, 10408.583656653649, 10440.216983726099, 10485.9475702621, 10619.36283822973, 10653.9467302663, 10691.358518488916, 10795.0, 10894.564217431214, 9911.504424778876, 10166.745831354276, 10185.185185185019, 10355.585776568852, 10534.315269507457, 10145.307819887732, 10354.275200736178, 10414.739631509274, 10952.0, 11096.056835169102, 8278.296344810758, 10051.246156538142, 10198.643047493302, 10469.214808889212, 10487.213458990758, 6618.305077966937, 8307.792305192419, 8503.829923401374, 8621.8706719398, 8650.956745216234, 8221.054578723524, 8375.32997360222, 8408.495490270603, 8618.224359807647, 8660.437071590326], "unit": "score", "name": "yui.html", "value": 6713.361229704333}], "name": "dromaeo_css", "value": 7395.08479215244}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 110.0, 110.0, 110.0, 111.0, 115.0, 111.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [158.0, 132.0, 179.0, 189.0, 116.0, 140.0, 137.0, 117.0, 161.0, 114.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [185.0, 188.0, 188.0, 186.0, 186.0, 183.0, 183.0, 181.0, 183.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.6}, {"lowerIsBetter": true, "replicates": [70.0, 78.0, 86.0, 77.0, 57.0, 57.0, 59.0, 77.0, 75.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.1}, {"lowerIsBetter": true, "replicates": [98.0, 92.0, 131.0, 79.0, 77.0, 86.0, 110.0, 77.0, 82.0, 107.0], "unit": "score", "name": "audio-oscillator", "value": 93.9}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 90.0, 87.0, 88.0, 87.0, 91.0, 87.0, 91.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 113.0, 149.0, 112.0, 94.0, 94.0, 103.0, 94.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 104.3}, {"lowerIsBetter": true, "replicates": [103.0, 147.0, 140.0, 88.0, 85.0, 88.0, 87.0, 88.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 99.6}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 54.0, 53.0, 54.0, 54.0, 63.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 73.0, 75.0, 71.0, 68.0, 68.0, 68.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 82.0, 83.0, 83.0, 83.0, 83.0, 82.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [132.0, 125.0, 114.0, 118.0, 130.0, 132.0, 124.0, 127.0, 124.0, 106.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [144.0, 125.0, 137.0, 137.0, 135.0, 126.0, 137.0, 136.0, 135.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 68.0, 66.0, 66.0, 67.0, 65.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1426.8}]} 05:52:25 INFO - Return code: 0 05:52:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:52:25 INFO - # TBPL SUCCESS # 05:52:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:25 INFO - 2016-03-07 05:52:25.103 screenresolution[1684:9949] starting screenresolution argv=screenresolution get 05:52:25 INFO - 2016-03-07 05:52:25.106 screenresolution[1684:9949] Display 0: 1600x1200x32@60 05:52:25 INFO - 2016-03-07 05:52:25.112 screenresolution[1685:9951] starting screenresolution argv=screenresolution list 05:52:25 INFO - Available Modes on Display 0 05:52:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:25 INFO - Intel Iris: 05:52:25 INFO - Chipset Model: Intel Iris 05:52:25 INFO - Type: GPU 05:52:25 INFO - Bus: Built-In 05:52:25 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:25 INFO - Vendor: Intel (0x8086) 05:52:25 INFO - Device ID: 0x0a2e 05:52:25 INFO - Revision ID: 0x0009 05:52:25 INFO - Displays: 05:52:25 INFO - Display: 05:52:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:25 INFO - Display Serial Number: 1600x1200 60 05:52:25 INFO - Main Display: Yes 05:52:25 INFO - Mirror: Off 05:52:25 INFO - Online: Yes 05:52:25 INFO - Rotation: Supported 05:52:25 INFO - Return code: 0 05:52:25 INFO - Running post-action listener: _resource_record_post_action 05:52:25 INFO - Running post-run listener: _resource_record_post_run 05:52:26 INFO - Total resource usage - Wall time: 1206s; CPU: 52.0%; Read bytes: 39716352; Write bytes: 706726912; Read time: 438; Write time: 1946 05:52:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 394963456; Write bytes: 390127104; Read time: 29971; Write time: 682 05:52:26 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 37885440; Write bytes: 300711424; Read time: 418; Write time: 1223 05:52:26 INFO - Running post-run listener: _upload_blobber_files 05:52:26 INFO - Blob upload gear active. 05:52:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:26 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 05:52:26 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:26 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:52:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:27 INFO - (blobuploader) - INFO - Done attempting. 05:52:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:52:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:52:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:28 INFO - (blobuploader) - INFO - Done attempting. 05:52:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:28 INFO - Return code: 0 05:52:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49175e7e61c3cba7a262bea5814936e2f09d322f9b231b6020472c726cfa3aff57ec1911f44a98614dbfa4dacd17040f333a578989661d8a223f6bb731de32a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7be20a24bdfb5f1051bb012e140ba0c0c2f9edbb9c5fd22687b905b0dd5395922569b741c0010d133790883f479d42c2a8d4cc924902f087fddec2eb146fa94"} 05:52:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:28 INFO - Contents: 05:52:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49175e7e61c3cba7a262bea5814936e2f09d322f9b231b6020472c726cfa3aff57ec1911f44a98614dbfa4dacd17040f333a578989661d8a223f6bb731de32a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7be20a24bdfb5f1051bb012e140ba0c0c2f9edbb9c5fd22687b905b0dd5395922569b741c0010d133790883f479d42c2a8d4cc924902f087fddec2eb146fa94"} 05:52:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:28 INFO - Copying logs to upload dir... 05:52:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.305928 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-07 05:52:28.891556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 05:52:28.900593) ========= 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.LeJHRLdyHR/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.ld3iXtfktO/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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/Firefox/sha512/49175e7e61c3cba7a262bea5814936e2f09d322f9b231b6020472c726cfa3aff57ec1911f44a98614dbfa4dacd17040f333a578989661d8a223f6bb731de32a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7be20a24bdfb5f1051bb012e140ba0c0c2f9edbb9c5fd22687b905b0dd5395922569b741c0010d133790883f479d42c2a8d4cc924902f087fddec2eb146fa94"} build_url:https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010348 build_url: 'https://queue.taskcluster.net/v1/task/LNfOzH9bQHO0Pmxh_9FMZA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49175e7e61c3cba7a262bea5814936e2f09d322f9b231b6020472c726cfa3aff57ec1911f44a98614dbfa4dacd17040f333a578989661d8a223f6bb731de32a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7be20a24bdfb5f1051bb012e140ba0c0c2f9edbb9c5fd22687b905b0dd5395922569b741c0010d133790883f479d42c2a8d4cc924902f087fddec2eb146fa94"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 05:52:28.929495) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:52:28.929798) ========= 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.LeJHRLdyHR/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.ld3iXtfktO/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005198 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 05:52:28.978012) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 05:52:28.978335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 05:52:28.978713) ========= ========= Total master_lag: 0.31 =========