builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0212 starttime: 1484051216.14 results: success (0) buildid: 20170110030221 builduid: 5e8c5c5d2f284239ae48b38251ffd097 revision: 8f3b24109e3412b36f97277e31ad66856dc609d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:56.136464) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:56.136944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:56.143226) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:56.172588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:56.173503) ========= 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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 --2017-01-10 04:26:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.1M=0s 2017-01-10 04:26:56 (29.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.526336 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:56.726602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:56.726948) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UduyAnpa1Z/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.HSpWR0bWSW/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.031537 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:56.781397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 04:26:56.781826) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f3b24109e3412b36f97277e31ad66856dc609d6 --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 8f3b24109e3412b36f97277e31ad66856dc609d6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UduyAnpa1Z/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.HSpWR0bWSW/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 2017-01-10 04:26:56,880 truncating revision to first 12 chars 2017-01-10 04:26:56,880 Setting DEBUG logging. 2017-01-10 04:26:56,880 attempt 1/10 2017-01-10 04:26:56,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f3b24109e34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 04:26:58,137 unpacking tar archive at: mozilla-central-8f3b24109e34/testing/mozharness/ program finished with exit code 0 elapsedTime=1.516962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 04:26:58.322881) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:58.323220) ========= script_repo_revision: 8f3b24109e3412b36f97277e31ad66856dc609d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:58.323644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:58.323960) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 04:26:58.348546) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-10 04:26:58.349014) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:26:58 INFO - MultiFileLogger online at 20170110 04:26:58 in /builds/slave/test 04:26:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:26:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:58 INFO - {'append_to_log': False, 04:26:58 INFO - 'base_work_dir': '/builds/slave/test', 04:26:58 INFO - 'blob_upload_branch': 'Firefox', 04:26:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:58 INFO - 'branch': 'Firefox', 04:26:58 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:58 INFO - 'config_files': ('talos/mac_config.py',), 04:26:58 INFO - 'default_actions': ('clobber', 04:26:58 INFO - 'read-buildbot-config', 04:26:58 INFO - 'download-and-extract', 04:26:58 INFO - 'populate-webroot', 04:26:58 INFO - 'create-virtualenv', 04:26:58 INFO - 'install', 04:26:58 INFO - 'run-tests'), 04:26:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:58 INFO - 'download_minidump_stackwalk': True, 04:26:58 INFO - 'download_symbols': 'ondemand', 04:26:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:58 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:58 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:58 INFO - 'installer_path': 'installer.exe', 04:26:58 INFO - 'log_level': 'info', 04:26:58 INFO - 'log_name': 'talos', 04:26:58 INFO - 'log_to_console': True, 04:26:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:26:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:26:58 INFO - 'opt_config_files': (), 04:26:58 INFO - 'pip_index': False, 04:26:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:58 INFO - 'cmd': ('bash', 04:26:58 INFO - '-c', 04:26:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:58 INFO - 'enabled': True, 04:26:58 INFO - 'halt_on_failure': False, 04:26:58 INFO - 'name': 'check_screen_resolution'},), 04:26:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:58 INFO - 'cmd': ('bash', 04:26:58 INFO - '-c', 04:26:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:58 INFO - 'enabled': True, 04:26:58 INFO - 'halt_on_failure': False, 04:26:58 INFO - 'name': 'check_screen_resolution'},), 04:26:58 INFO - 'run_cmd_checks_enabled': True, 04:26:58 INFO - 'sps_profile': False, 04:26:58 INFO - 'sps_profile_interval': 0, 04:26:58 INFO - 'suite': 'dromaeojs-e10s', 04:26:58 INFO - 'system_bits': '32', 04:26:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:58 INFO - 'title': 't-yosemite-r7-0212', 04:26:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:58 INFO - 'use_talos_json': True, 04:26:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:58 INFO - 'work_dir': 'build'} 04:26:58 INFO - [mozharness: 2017-01-10 12:26:58.550523Z] Running clobber step. 04:26:58 INFO - Running pre-action listener: _resource_record_pre_action 04:26:58 INFO - Running main action method: clobber 04:26:58 INFO - rmtree: /builds/slave/test/build 04:26:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:01 INFO - Running post-action listener: _resource_record_post_action 04:27:01 INFO - [mozharness: 2017-01-10 12:27:01.452072Z] Finished clobber step (success) 04:27:01 INFO - [mozharness: 2017-01-10 12:27:01.452208Z] Running read-buildbot-config step. 04:27:01 INFO - Running pre-action listener: _resource_record_pre_action 04:27:01 INFO - Running main action method: read_buildbot_config 04:27:01 INFO - Using buildbot properties: 04:27:01 INFO - { 04:27:01 INFO - "project": "", 04:27:01 INFO - "product": "firefox", 04:27:01 INFO - "script_repo_revision": "production", 04:27:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:27:01 INFO - "repository": "", 04:27:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:27:01 INFO - "buildid": "20170110030221", 04:27:01 INFO - "stage_platform": "macosx64", 04:27:01 INFO - "basedir": "/builds/slave/test", 04:27:01 INFO - "nightly_build": "True", 04:27:01 INFO - "buildnumber": 42, 04:27:01 INFO - "slavename": "t-yosemite-r7-0212", 04:27:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:27:01 INFO - "platform": "yosemite_r7", 04:27:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:27:01 INFO - "branch": "mozilla-central", 04:27:01 INFO - "repo_path": "mozilla-central", 04:27:01 INFO - "revision": "8f3b24109e3412b36f97277e31ad66856dc609d6", 04:27:01 INFO - "pgo_build": "False", 04:27:01 INFO - "builduid": "5e8c5c5d2f284239ae48b38251ffd097", 04:27:01 INFO - "slavebuilddir": "test" 04:27:01 INFO - } 04:27:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:27:01 INFO - Running post-action listener: _resource_record_post_action 04:27:01 INFO - [mozharness: 2017-01-10 12:27:01.455470Z] Finished read-buildbot-config step (success) 04:27:01 INFO - [mozharness: 2017-01-10 12:27:01.455608Z] Running download-and-extract step. 04:27:01 INFO - Running pre-action listener: _resource_record_pre_action 04:27:01 INFO - Running main action method: download_and_extract 04:27:01 INFO - mkdir: /builds/slave/test/build/tests 04:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:01 INFO - trying https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:27:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:27:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:27:03 INFO - Downloaded 1199 bytes. 04:27:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:27:03 INFO - Using the following test package requirements: 04:27:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:27:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:27:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:27:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:27:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:27:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:27:03 INFO - u'jsshell-mac.zip'], 04:27:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:27:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:27:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:27:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:27:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:27:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:27:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:27:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:27:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:27:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:27:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:27:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:27:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:27:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:27:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:27:03 INFO - Expected file size: 16306283 04:27:03 INFO - Obtained file size: 16306283 04:27:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:27:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:27:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:27:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:27:11 INFO - Expected file size: 16306283 04:27:11 INFO - Obtained file size: 16306283 04:27:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:27:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:27:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:27:19 INFO - Expected file size: 14403537 04:27:19 INFO - Obtained file size: 14403537 04:27:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:19 INFO - trying https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:27:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:27:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:27:22 INFO - Downloaded 69843522 bytes. 04:27:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:27:22 INFO - mkdir: /builds/slave/test/properties 04:27:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:22 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:22 INFO - Contents: 04:27:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:27:23 INFO - Running post-action listener: _resource_record_post_action 04:27:23 INFO - Running post-action listener: set_extra_try_arguments 04:27:23 INFO - [mozharness: 2017-01-10 12:27:23.739391Z] Finished download-and-extract step (success) 04:27:23 INFO - [mozharness: 2017-01-10 12:27:23.739531Z] Running populate-webroot step. 04:27:23 INFO - Running pre-action listener: _resource_record_pre_action 04:27:23 INFO - Running main action method: populate_webroot 04:27:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:23 INFO - '--tppagecycles', 04:27:23 INFO - '7'], 04:27:23 INFO - 'tests': ['tsvgm']}}, 04:27:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:27:23 INFO - 'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:27:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:27:23 INFO - 'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['damp', 'tps']}, 04:27:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:27:23 INFO - 'tests': ['damp', 'tps']}, 04:27:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['dromaeo_dom']}, 04:27:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['basic_compositor_video']}, 04:27:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:27:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['a11yr', 04:27:23 INFO - 'ts_paint', 04:27:23 INFO - 'tpaint', 04:27:23 INFO - 'sessionrestore', 04:27:23 INFO - 'sessionrestore_no_auto_restore', 04:27:23 INFO - 'tabpaint']}, 04:27:23 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:23 INFO - 'ts_paint', 04:27:23 INFO - 'tpaint', 04:27:23 INFO - 'sessionrestore', 04:27:23 INFO - 'sessionrestore_no_auto_restore', 04:27:23 INFO - 'tabpaint']}, 04:27:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:23 INFO - 'ts_paint', 04:27:23 INFO - 'tpaint', 04:27:23 INFO - 'sessionrestore', 04:27:23 INFO - 'sessionrestore_no_auto_restore', 04:27:23 INFO - 'tabpaint']}, 04:27:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:23 INFO - 'ts_paint', 04:27:23 INFO - 'tpaint', 04:27:23 INFO - 'sessionrestore', 04:27:23 INFO - 'sessionrestore_no_auto_restore', 04:27:23 INFO - 'tabpaint']}, 04:27:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['a11yr', 04:27:23 INFO - 'ts_paint', 04:27:23 INFO - 'tpaint', 04:27:23 INFO - 'sessionrestore', 04:27:23 INFO - 'sessionrestore_no_auto_restore', 04:27:23 INFO - 'tabpaint']}, 04:27:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['a11yr', 04:27:23 INFO - 'ts_paint', 04:27:23 INFO - 'tpaint', 04:27:23 INFO - 'sessionrestore', 04:27:23 INFO - 'sessionrestore_no_auto_restore', 04:27:23 INFO - 'tabpaint']}, 04:27:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['tsvgx', 04:27:23 INFO - 'tsvgr_opacity', 04:27:23 INFO - 'tart', 04:27:23 INFO - 'tscrollx', 04:27:23 INFO - 'cart', 04:27:23 INFO - 'tsvg_static']}, 04:27:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:23 INFO - 'tsvgr_opacity', 04:27:23 INFO - 'tart', 04:27:23 INFO - 'tscrollx', 04:27:23 INFO - 'cart', 04:27:23 INFO - 'tsvg_static']}, 04:27:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:27:23 INFO - 'talos_options': ['--disable-e10s'], 04:27:23 INFO - 'tests': ['tp5o']}, 04:27:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:27:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:27:23 INFO - 'talos_options': ['--disable-e10s', 04:27:23 INFO - '--xperf_path', 04:27:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:23 INFO - 'tests': ['tp5n']}, 04:27:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:27:23 INFO - 'talos_options': ['--xperf_path', 04:27:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:23 INFO - 'tests': ['tp5n']}}, 04:27:23 INFO - 'talos.zip': {'path': '', 04:27:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:23 INFO - Running post-action listener: _resource_record_post_action 04:27:23 INFO - [mozharness: 2017-01-10 12:27:23.757613Z] Finished populate-webroot step (success) 04:27:23 INFO - [mozharness: 2017-01-10 12:27:23.757746Z] Running create-virtualenv step. 04:27:23 INFO - Running pre-action listener: _resource_record_pre_action 04:27:23 INFO - Running main action method: create_virtualenv 04:27:23 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:27:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:23 INFO - Using real prefix '/tools/python27' 04:27:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:24 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:27 INFO - Installing pip.................done. 04:27:27 INFO - Return code: 0 04:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:27:27 INFO - Reading from file tmpfile_stdout 04:27:27 INFO - Output received: 04:27:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:27:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:27 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 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:27 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 04:27:27 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 04:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:27 INFO - 'HOME': '/Users/cltbld', 04:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:27 INFO - 'LOGNAME': 'cltbld', 04:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:27 INFO - 'MOZ_NO_REMOTE': '1', 04:27:27 INFO - 'NO_EM_RESTART': '1', 04:27:27 INFO - 'PAGER': '/bin/cat', 04:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:27 INFO - 'PWD': '/builds/slave/test', 04:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:27 INFO - 'SHELL': '/bin/bash', 04:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:27 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:27 INFO - 'USER': 'cltbld', 04:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:27 INFO - 'XPC_FLAGS': '0x0', 04:27:27 INFO - 'XPC_SERVICE_NAME': '0', 04:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:27:27 INFO - Cleaning up... 04:27:27 INFO - Return code: 0 04:27:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:28 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:28 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>=3.1.1'] in /builds/slave/test/build 04:27:28 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>=3.1.1 04:27:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:28 INFO - 'HOME': '/Users/cltbld', 04:27:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:28 INFO - 'LOGNAME': 'cltbld', 04:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:28 INFO - 'MOZ_NO_REMOTE': '1', 04:27:28 INFO - 'NO_EM_RESTART': '1', 04:27:28 INFO - 'PAGER': '/bin/cat', 04:27:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:28 INFO - 'PWD': '/builds/slave/test', 04:27:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:28 INFO - 'SHELL': '/bin/bash', 04:27:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:28 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:28 INFO - 'USER': 'cltbld', 04:27:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:28 INFO - 'XPC_FLAGS': '0x0', 04:27:28 INFO - 'XPC_SERVICE_NAME': '0', 04:27:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:28 INFO - Downloading/unpacking psutil>=3.1.1 04:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:32 INFO - Installing collected packages: psutil 04:27:32 INFO - Running setup.py install for psutil 04:27:32 INFO - building 'psutil._psutil_osx' extension 04:27:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:27:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:27:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:27:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:27:33 INFO - building 'psutil._psutil_posix' extension 04:27:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:27:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:27:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:27:33 INFO - ^ 04:27:33 INFO - 1 warning generated. 04:27:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:27:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:33 INFO - Successfully installed psutil 04:27:33 INFO - Cleaning up... 04:27:33 INFO - Return code: 0 04:27:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:33 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:33 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.3'] in /builds/slave/test/build 04:27:33 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.3 04:27:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:33 INFO - 'HOME': '/Users/cltbld', 04:27:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:33 INFO - 'LOGNAME': 'cltbld', 04:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:33 INFO - 'MOZ_NO_REMOTE': '1', 04:27:33 INFO - 'NO_EM_RESTART': '1', 04:27:33 INFO - 'PAGER': '/bin/cat', 04:27:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:33 INFO - 'PWD': '/builds/slave/test', 04:27:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:33 INFO - 'SHELL': '/bin/bash', 04:27:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:33 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:33 INFO - 'USER': 'cltbld', 04:27:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:33 INFO - 'XPC_FLAGS': '0x0', 04:27:33 INFO - 'XPC_SERVICE_NAME': '0', 04:27:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:36 INFO - Installing collected packages: mozsystemmonitor 04:27:36 INFO - Running setup.py install for mozsystemmonitor 04:27:36 INFO - Successfully installed mozsystemmonitor 04:27:36 INFO - Cleaning up... 04:27:36 INFO - Return code: 0 04:27:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:27:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:36 INFO - 'HOME': '/Users/cltbld', 04:27:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:36 INFO - 'LOGNAME': 'cltbld', 04:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:36 INFO - 'MOZ_NO_REMOTE': '1', 04:27:36 INFO - 'NO_EM_RESTART': '1', 04:27:36 INFO - 'PAGER': '/bin/cat', 04:27:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:36 INFO - 'PWD': '/builds/slave/test', 04:27:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:36 INFO - 'SHELL': '/bin/bash', 04:27:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:36 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:36 INFO - 'USER': 'cltbld', 04:27:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:36 INFO - 'XPC_FLAGS': '0x0', 04:27:36 INFO - 'XPC_SERVICE_NAME': '0', 04:27:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:39 INFO - warning: no files found matching '*.txt' 04:27:39 INFO - no previously-included directories found matching 'build' 04:27:39 INFO - no previously-included directories found matching 'dist' 04:27:39 INFO - no previously-included directories found matching '.git*' 04:27:39 INFO - Installing collected packages: jsonschema, functools32 04:27:40 INFO - Running setup.py install for functools32 04:27:40 INFO - warning: no files found matching '*.txt' 04:27:40 INFO - no previously-included directories found matching 'build' 04:27:40 INFO - no previously-included directories found matching 'dist' 04:27:40 INFO - no previously-included directories found matching '.git*' 04:27:40 INFO - Successfully installed jsonschema functools32 04:27:40 INFO - Cleaning up... 04:27:40 INFO - Return code: 0 04:27:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:27:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:40 INFO - 'HOME': '/Users/cltbld', 04:27:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:40 INFO - 'LOGNAME': 'cltbld', 04:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:40 INFO - 'MOZ_NO_REMOTE': '1', 04:27:40 INFO - 'NO_EM_RESTART': '1', 04:27:40 INFO - 'PAGER': '/bin/cat', 04:27:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:40 INFO - 'PWD': '/builds/slave/test', 04:27:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:40 INFO - 'SHELL': '/bin/bash', 04:27:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:40 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:40 INFO - 'USER': 'cltbld', 04:27:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:40 INFO - 'XPC_FLAGS': '0x0', 04:27:40 INFO - 'XPC_SERVICE_NAME': '0', 04:27:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:27:40 INFO - Cleaning up... 04:27:40 INFO - Return code: 0 04:27:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:27:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:40 INFO - 'HOME': '/Users/cltbld', 04:27:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:40 INFO - 'LOGNAME': 'cltbld', 04:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:40 INFO - 'MOZ_NO_REMOTE': '1', 04:27:40 INFO - 'NO_EM_RESTART': '1', 04:27:40 INFO - 'PAGER': '/bin/cat', 04:27:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:40 INFO - 'PWD': '/builds/slave/test', 04:27:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:40 INFO - 'SHELL': '/bin/bash', 04:27:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:40 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:40 INFO - 'USER': 'cltbld', 04:27:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:40 INFO - 'XPC_FLAGS': '0x0', 04:27:40 INFO - 'XPC_SERVICE_NAME': '0', 04:27:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:40 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:44 INFO - Downloading docopt-0.6.1.tar.gz 04:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:44 INFO - Running setup.py install for blobuploader 04:27:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:44 INFO - Running setup.py install for requests 04:27:45 INFO - Running setup.py install for docopt 04:27:45 INFO - Successfully installed blobuploader requests docopt 04:27:45 INFO - Cleaning up... 04:27:45 INFO - Return code: 0 04:27:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:45 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 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:45 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 04:27:45 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 04:27:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:45 INFO - 'HOME': '/Users/cltbld', 04:27:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:45 INFO - 'LOGNAME': 'cltbld', 04:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:45 INFO - 'MOZ_NO_REMOTE': '1', 04:27:45 INFO - 'NO_EM_RESTART': '1', 04:27:45 INFO - 'PAGER': '/bin/cat', 04:27:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:45 INFO - 'PWD': '/builds/slave/test', 04:27:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:45 INFO - 'SHELL': '/bin/bash', 04:27:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:45 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:45 INFO - 'USER': 'cltbld', 04:27:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:45 INFO - 'XPC_FLAGS': '0x0', 04:27:45 INFO - 'XPC_SERVICE_NAME': '0', 04:27:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Szm2YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-vYyDnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-AQ1nF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-tXfrvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-dQCgaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-3FAusI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-t1Pv_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Dotnbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-3vVgkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-36Bv1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-ltZlJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-_kIXGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-sU7WyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-wu9_Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-7QNEPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-PTMBk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:47 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-KTne1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:47 INFO - Running setup.py install for manifestparser 04:27:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:47 INFO - Running setup.py install for mozcrash 04:27:47 INFO - Running setup.py install for mozdebug 04:27:48 INFO - Running setup.py install for mozdevice 04:27:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Running setup.py install for mozfile 04:27:48 INFO - Running setup.py install for mozhttpd 04:27:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Running setup.py install for mozinfo 04:27:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Running setup.py install for mozInstall 04:27:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Running setup.py install for mozleak 04:27:48 INFO - Running setup.py install for mozlog 04:27:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Running setup.py install for moznetwork 04:27:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Running setup.py install for mozprocess 04:27:49 INFO - Running setup.py install for mozprofile 04:27:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Running setup.py install for mozrunner 04:27:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Running setup.py install for mozscreenshot 04:27:49 INFO - Running setup.py install for moztest 04:27:50 INFO - Running setup.py install for mozversion 04:27:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:50 INFO - Cleaning up... 04:27:50 INFO - Return code: 0 04:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:50 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 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:50 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 04:27:50 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 04:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:50 INFO - 'HOME': '/Users/cltbld', 04:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:50 INFO - 'LOGNAME': 'cltbld', 04:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:50 INFO - 'MOZ_NO_REMOTE': '1', 04:27:50 INFO - 'NO_EM_RESTART': '1', 04:27:50 INFO - 'PAGER': '/bin/cat', 04:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:50 INFO - 'PWD': '/builds/slave/test', 04:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:50 INFO - 'SHELL': '/bin/bash', 04:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:50 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:50 INFO - 'USER': 'cltbld', 04:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:50 INFO - 'XPC_FLAGS': '0x0', 04:27:50 INFO - 'XPC_SERVICE_NAME': '0', 04:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:50 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-JdVAPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:50 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-xhO24A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:50 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-fFSv2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:50 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-_oiXt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:50 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-tpDvMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:51 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-M8jXQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:51 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-RpALT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:51 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)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:51 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-B3gG1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:51 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-oDtE08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:51 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-wtf62L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:51 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-w9mygz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:51 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-8ARpGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:51 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-smPKG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:51 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)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:51 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-doyiCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:52 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-u_Hu7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:52 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-VGtQkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:52 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-YeF1Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:27:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:27:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:27:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:54 INFO - Downloading blessings-1.6.tar.gz 04:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:55 INFO - Installing collected packages: blessings 04:27:55 INFO - Running setup.py install for blessings 04:27:55 INFO - Successfully installed blessings 04:27:55 INFO - Cleaning up... 04:27:55 INFO - Return code: 0 04:27:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:55 INFO - Reading from file tmpfile_stdout 04:27:55 INFO - Current package versions: 04:27:55 INFO - blessings == 1.6 04:27:55 INFO - blobuploader == 1.2.4 04:27:55 INFO - docopt == 0.6.1 04:27:55 INFO - functools32 == 3.2.3-2 04:27:55 INFO - jsonschema == 2.5.1 04:27:55 INFO - manifestparser == 1.1 04:27:55 INFO - mozInstall == 1.12 04:27:55 INFO - mozcrash == 1.0 04:27:55 INFO - mozdebug == 0.1 04:27:55 INFO - mozdevice == 0.49 04:27:55 INFO - mozfile == 1.2 04:27:55 INFO - mozhttpd == 0.7 04:27:55 INFO - mozinfo == 0.9 04:27:55 INFO - mozleak == 0.1 04:27:55 INFO - mozlog == 3.4 04:27:55 INFO - moznetwork == 0.27 04:27:55 INFO - mozprocess == 0.24 04:27:55 INFO - mozprofile == 0.28 04:27:55 INFO - mozrunner == 6.13 04:27:55 INFO - mozscreenshot == 0.1 04:27:55 INFO - mozsystemmonitor == 0.3 04:27:55 INFO - moztest == 0.8 04:27:55 INFO - mozversion == 1.4 04:27:55 INFO - psutil == 3.1.1 04:27:55 INFO - requests == 1.2.3 04:27:55 INFO - wsgiref == 0.1.2 04:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:55 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 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:55 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 04:27:55 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 04:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:55 INFO - 'HOME': '/Users/cltbld', 04:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:55 INFO - 'LOGNAME': 'cltbld', 04:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:55 INFO - 'MOZ_NO_REMOTE': '1', 04:27:55 INFO - 'NO_EM_RESTART': '1', 04:27:55 INFO - 'PAGER': '/bin/cat', 04:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:55 INFO - 'PWD': '/builds/slave/test', 04:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:55 INFO - 'SHELL': '/bin/bash', 04:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:55 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:55 INFO - 'USER': 'cltbld', 04:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:55 INFO - 'XPC_FLAGS': '0x0', 04:27:55 INFO - 'XPC_SERVICE_NAME': '0', 04:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 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)) 04:27:55 INFO - Cleaning up... 04:27:55 INFO - Return code: 0 04:27:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:55 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 0x10df8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84c0d8f4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, '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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:27:55 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 04:27:55 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 04:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:55 INFO - 'HOME': '/Users/cltbld', 04:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:55 INFO - 'LOGNAME': 'cltbld', 04:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:55 INFO - 'MOZ_NO_REMOTE': '1', 04:27:55 INFO - 'NO_EM_RESTART': '1', 04:27:55 INFO - 'PAGER': '/bin/cat', 04:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:55 INFO - 'PWD': '/builds/slave/test', 04:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:55 INFO - 'SHELL': '/bin/bash', 04:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:27:55 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:55 INFO - 'USER': 'cltbld', 04:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:55 INFO - 'XPC_FLAGS': '0x0', 04:27:55 INFO - 'XPC_SERVICE_NAME': '0', 04:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:27:56 INFO - Cleaning up... 04:27:56 INFO - Return code: 0 04:27:56 INFO - Running post-action listener: _resource_record_post_action 04:27:56 INFO - Running post-action listener: _start_resource_monitoring 04:27:56 INFO - Starting resource monitoring. 04:27:56 INFO - [mozharness: 2017-01-10 12:27:56.193068Z] Finished create-virtualenv step (success) 04:27:56 INFO - [mozharness: 2017-01-10 12:27:56.194079Z] Running install step. 04:27:56 INFO - Running pre-action listener: _resource_record_pre_action 04:27:56 INFO - Running main action method: install 04:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:56 INFO - Reading from file tmpfile_stdout 04:27:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:56 INFO - Reading from file tmpfile_stdout 04:27:56 INFO - Output received: 04:27:56 INFO - Usage: mozinstall [options] installer 04:27:56 INFO - Options: 04:27:56 INFO - -h, --help show this help message and exit 04:27:56 INFO - -d DEST, --destination=DEST 04:27:56 INFO - Directory to install application into. [default: 04:27:56 INFO - "/builds/slave/test"] 04:27:56 INFO - --app=APP Application being installed. [default: firefox] 04:27:56 INFO - mkdir: /builds/slave/test/build/application 04:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:28:18 INFO - Reading from file tmpfile_stdout 04:28:18 INFO - Output received: 04:28:18 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:28:18 INFO - Running post-action listener: _resource_record_post_action 04:28:18 INFO - [mozharness: 2017-01-10 12:28:18.126101Z] Finished install step (success) 04:28:18 INFO - [mozharness: 2017-01-10 12:28:18.126237Z] Running run-tests step. 04:28:18 INFO - Running pre-action listener: _resource_record_pre_action 04:28:18 INFO - Running main action method: run_tests 04:28:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:18 INFO - 2017-01-10 04:28:18.140 screenresolution[1635:8201] starting screenresolution argv=screenresolution get 04:28:18 INFO - 2017-01-10 04:28:18.143 screenresolution[1635:8201] Display 0: 1600x1200x32@60 04:28:18 INFO - 2017-01-10 04:28:18.149 screenresolution[1636:8203] starting screenresolution argv=screenresolution list 04:28:18 INFO - Available Modes on Display 0 04:28:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:18 INFO - Intel Iris: 04:28:18 INFO - Chipset Model: Intel Iris 04:28:18 INFO - Type: GPU 04:28:18 INFO - Bus: Built-In 04:28:18 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:18 INFO - Vendor: Intel (0x8086) 04:28:18 INFO - Device ID: 0x0a2e 04:28:18 INFO - Revision ID: 0x0009 04:28:18 INFO - Displays: 04:28:18 INFO - Display: 04:28:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:18 INFO - Display Serial Number: 1600x1200 60 04:28:18 INFO - Main Display: Yes 04:28:18 INFO - Mirror: Off 04:28:18 INFO - Online: Yes 04:28:18 INFO - Rotation: Supported 04:28:18 INFO - Return code: 0 04:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:18 INFO - Python 2.7.3 04:28:18 INFO - Return code: 0 04:28:18 INFO - grabbing minidump binary from tooltool 04:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:18 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6dd30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd62be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:28:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:28:18 INFO - Calling ['/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'] with output_timeout 600 04:28:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:18 INFO - Return code: 0 04:28:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:28:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:28:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0212 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UduyAnpa1Z/Render', 04:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:18 INFO - 'HOME': '/Users/cltbld', 04:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:18 INFO - 'LOGNAME': 'cltbld', 04:28:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:18 INFO - 'MOZ_NO_REMOTE': '1', 04:28:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:18 INFO - 'NO_EM_RESTART': '1', 04:28:18 INFO - 'PAGER': '/bin/cat', 04:28:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:18 INFO - 'PWD': '/builds/slave/test', 04:28:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:18 INFO - 'SHELL': '/bin/bash', 04:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HSpWR0bWSW/Listeners', 04:28:18 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:18 INFO - 'USER': 'cltbld', 04:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:18 INFO - 'XPC_FLAGS': '0x0', 04:28:18 INFO - 'XPC_SERVICE_NAME': '0', 04:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:28:18 INFO - mozversion application_buildid: 20170110030221 04:28:18 INFO - mozversion application_changeset: 8f3b24109e3412b36f97277e31ad66856dc609d6 04:28:18 INFO - mozversion application_display_name: Nightly 04:28:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:18 INFO - mozversion application_name: Firefox 04:28:18 INFO - mozversion application_remotingname: firefox 04:28:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:28:18 INFO - mozversion application_vendor: Mozilla 04:28:18 INFO - mozversion application_version: 53.0a1 04:28:18 INFO - mozversion platform_buildid: 20170110030221 04:28:18 INFO - mozversion platform_changeset: 8f3b24109e3412b36f97277e31ad66856dc609d6 04:28:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:28:18 INFO - mozversion platform_version: 53.0a1 04:28:18 INFO - using testdate: 1484051298 04:28:18 INFO - actual date: 1484051298 04:28:18 INFO - starting webserver on 'localhost:49242' 04:28:18 INFO - SUITE-START | Running 2 tests 04:28:18 INFO - TEST-START | dromaeo_css 04:28:18 INFO - operating with platform_type : mac_ 04:28:18 INFO - Initialising browser for dromaeo_css test... 04:28:18 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpte7CaJ/profile http://localhost:49242/getInfo.html) 04:28:19 INFO - PROCESS | 1646 | 1484051299406 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 04:28:21 INFO - PROCESS | 1646 | 2017-01-10 04:28:21.902 plugin-container[1649:8372] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 04:28:21 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:28:21 INFO - PROCESS | 1646 | 2017-01-10 04:28:21.904 plugin-container[1649:8372] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 04:28:21 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:28:21 INFO - PROCESS | 1646 | 2017-01-10 04:28:21.904 plugin-container[1649:8372] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:28:21 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 04:28:21 INFO - PROCESS | 1646 | colorDepth:24 04:28:21 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 04:28:21 INFO - PROCESS | 1646 | __metrics 04:28:22 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 04:28:22 INFO - TEST-INFO | 1646: exit 0 04:28:22 INFO - Browser initialized. 04:28:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:22 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpte7CaJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:25 INFO - PROCESS | 1651 | 2017-01-10 04:28:25.088 plugin-container[1652:8505] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 04:28:25 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:28:25 INFO - PROCESS | 1651 | 2017-01-10 04:28:25.088 plugin-container[1652:8505] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 04:28:25 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:28:25 INFO - PROCESS | 1651 | 2017-01-10 04:28:25.089 plugin-container[1652:8505] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:28:34 INFO - PROCESS | 1651 | RSS: Main: 233050112 04:28:34 INFO - PROCESS | 1651 | 04:31:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 04:31:39 INFO - PROCESS | 1651 | RSS: Main: 255234048 04:31:39 INFO - PROCESS | 1651 | 04:33:23 INFO - PROCESS | 1651 | ************************* 04:33:23 INFO - PROCESS | 1651 | A coding exception was thrown and uncaught in a Task. 04:33:23 INFO - PROCESS | 1651 | 04:33:23 INFO - PROCESS | 1651 | Full message: ReferenceError: fetch is not defined 04:33:23 INFO - PROCESS | 1651 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 04:33:23 INFO - PROCESS | 1651 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 04:33:23 INFO - PROCESS | 1651 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 04:33:23 INFO - PROCESS | 1651 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 04:33:23 INFO - PROCESS | 1651 | TaskImpl@resource://gre/modules/Task.jsm:277:3 04:33:23 INFO - PROCESS | 1651 | asyncFunction@resource://gre/modules/Task.jsm:252:14 04:33:23 INFO - PROCESS | 1651 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 04:33:23 INFO - PROCESS | 1651 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 04:33:23 INFO - PROCESS | 1651 | TaskImpl@resource://gre/modules/Task.jsm:277:3 04:33:23 INFO - PROCESS | 1651 | asyncFunction@resource://gre/modules/Task.jsm:252:14 04:33:23 INFO - PROCESS | 1651 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 04:33:23 INFO - PROCESS | 1651 | 04:33:23 INFO - PROCESS | 1651 | ************************* 04:34:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 04:34:42 INFO - PROCESS | 1651 | RSS: Main: 264933376 04:34:42 INFO - PROCESS | 1651 | 04:37:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 04:37:44 INFO - PROCESS | 1651 | RSS: Main: 273227776 04:37:44 INFO - PROCESS | 1651 | 04:40:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 04:40:47 INFO - PROCESS | 1651 | RSS: Main: 269549568 04:40:47 INFO - PROCESS | 1651 | 04:43:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 04:43:50 INFO - PROCESS | 1651 | RSS: Main: 274149376 04:43:50 INFO - PROCESS | 1651 | 04:46:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 04:46:53 INFO - PROCESS | 1651 | RSS: Main: 276078592 04:46:53 INFO - PROCESS | 1651 | 04:46:53 INFO - PROCESS | 1651 | __start_tp_report 04:46:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 04:46:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 04:46:53 INFO - PROCESS | 1651 | |i|pagename|runs| 04:46:53 INFO - PROCESS | 1651 | |0;dojo.html;3309.2554175310556;3323.335332933414;3327.4509705898527;3337.7830441021338;3342.699157075863;5414.972925135378;5509.146082357231;5510.72446377681;5520.9171862422045;5540.2243685883905;5418.9458105418935;5435.157550579656;5510.531604813596;5542.334919809628;5582;4784.736839473845;4962.702237865721;4972.105021096192;5093.083245015896;5100.464451232623;4985.102681517325;5149.150390185634;5156.432792392834;5189.481051894818;5198.9480105198845;4992.550670439678;4993.925091123636;5004.224345226496;5026.2209357549455;5047.899042019139;4954.9752251238515;5043.218301163325;5058.140116180258;5060.721660308718;5067.417247016567;4993.900121997576;5023.196288593807;5073.974630126826;5077.111505486525;5086.262491938685;4560.612347950429;5475.260839786618;5521.696306703129;5539.113741801292;5554.638948468337;5822.737976791054;5870.354261031283;5901.704914754245;6054.788082417138;6066.332703402622;6100.664463454508;6106.786262480836;6112.297085835142;6113.816585502442;6142.385761423867;5507.862303442406;5574.804881829157;5601.467860553282;5615.466530679579;5616.550675945915;5306.726385667412;5741.339745929188;6109.419605137505;6195.287541932736;6209.9379006210265;5839.9124013139835;5989.221401217901;5993.400659933972;6025.367336429699;6030.879382412327;6112.266528016667;6123.632582045091;6128.417800308964;6156.569040167235;6176.7838125665385;4981.153203955264;5856.385079566669;5930.851728706817;5942.8811423771285;6033.095035744585;4743;5208.557272631793;5839.474447299764;6074.210352654215;6080.14877917092;4427.092446048552;4718.4809670936165;4751.121042607128;4781.593564546983;4785.401824771903;4187.099773548702;4253.574642535722;4255.127698821734;4257.91484170321;4268.2530557152995;5698.059820129715;5729.799457018984;5731.77072917087;5734.483896449339;5764.798232061941;5215.58275337972;6156.199694039746;6173.382661733791;6189.442950134509;6193.84515387119;5539.473749993744;5566.2207290979295;5594.720263986785;5660.122680984454;5706.543476521868;5218.530332270114;5219.164933610604;5219.791208351623;5257.710825904535;5287.603429742785;6224.595401298901;6225.159603453476;6228.688565571703;6230.59501132434;6253.312135665074;6104.664243466652;6158.969205153946;6163.753449862134;6181.690915454299;6214.098955651496;6116.092308610985;6121.300552271563;6136.825445958321;6157.507399408126;6186.257649082139;5958.076498142795;5968.552358573038;5994.07091900756;5996.1005849122985;6000.339962604197;6066.211392519121;6089.391060893875;6098.0852872069545;6108.17539632144;6108.511319094373;5752.0509115997065;5794.971025145016;5803.680797556175;5816.418358164319;5897.174395584536;5825.970870145792;5830.271216097988;5836.766529338779;5850.882982340244;5938.228030356199;5525.419830917856;5530.281063461885;5705.686187259741;5750.712464376848;5771.480566749013;5845.152452894392;5880.911786323294;5963.13534537481;5986.790462333797;5994.55040871945;5624.268845050117;5791.391903850035;5807.883842323215;5810.593258471867;5822.417758224144 04:46:53 INFO - PROCESS | 1651 | |1;ext.html;450.6529971921623;459.67363172147776;513.4788189987163;514.5909002343137;519.903817793708;37968;40405.19189616206;40469.79765101178;41704;42462.93842653935;41586.79206603971;41993.79003104988;42050.94872628186;42101.15797684045;42132;8410.158984101572;8619.870701939475;9138.999999999984;9362.391444556082;9390.060993900624;11024.173187010967;11266.549338026469;11306.265092768985;11428.085753139729;11448.885511144865;11232.831507527393;11258.605948791794;11321.490532925996;11346.829797553044;11355.886441135566;11146.996770290672;11177.66467005987;11192.944035279772;11219.943900280528;11221.326720396803;9173.44959302444;11104.722381940435;11108.16688748347;11112.833307500394;11122.332660040343;38595.8421247363;38784.612153878385;38828;38945;39027.41458878119;3068.6624471308137;3544.220271540257;3991;4018.2566225248424;4208.473940757405;25044.624330635055;27812.30469238285;29923.70076299253;30311.848440757876;30456.695433045606;3133.2010337364054;3192.2657788708493;3229.289556297611;3326.667333266654;3341.214814518586;433722.99999999686;449068;449464;452064;457152;61720.45698857564;62273.68863155655;62729.05906411407;62736.37263627397;63820.36179638237;49444.50555494399;51165.74417127965;61617.38382616117;62057.68971155115;62346;14823.925880370745;15294.311755970786;15373.154476503676;15381.461648842236;15381.923090384476;9982.750431239278;10774.569017239222;10978.066864316463;11494.712632184095;11893.989010933994;16296.837031629531;16298.348066077224;16325.26536305869;16348.673026539402;16363.936344137594;7396.297351751575;7431.739889103964;7432.9256707433315;7460.477766556289;7486.139094004259;854.410456784829;860.1828263150032;864.9682861570157;870.3515880668942;875.5490922175085;29157.41685166285;29330.867098258146;30379.544306835414;30438.54342184869;30513.847430763148;860.5482121885934;1035.9896401036044;1046.4663021858755;1069.49199130414;1202.6873013016505;15464.226788660522;15517.258564494266;15546.300416481285;15559.45541906028;15593.766093508606;577793;583262;583373;584644;585064;60065.69967150136;60709.69645151746;61022.694886525285;61070;61175.69412152911;1372.19726460022;1410.2525661399475;1426.108682073704;1426.472205284031;1430.6780974280703;28999.56500652534;29188.854055729586;29215;29732;30067.69932300649;51366.459006229874;51627.74186129045;51656;51799;52187.73906130445;497055;498052;499768;500153;501042;33648.49527257142;40246.79876600715;40322.39516407315;40910.79544602258;41197.79401102975;45809;46210.306845398016;46857.297140543604;47320.52679473299;48088.03823923572;38391.04022399463;38501.6149838498;38927;39686.60313396829;40205;32170.195745105622;37572.812135939144;37712.43431348477;39080;39171.80414097911;30813.537796932615;33622.83188584042;34397.48403773995;37627.05932351713;38269.80865095768;31716;33666.49500257449;34560;34765.82617086898;34794;22257.44356391103;22691.319260422213;23048;25117.74882251154;25630.615540767278 04:46:53 INFO - PROCESS | 1651 | |2;jquery.html;296.9806962547436;328.7649330728529;356.98081975958627;380.6459992207248;409.7275311917575;19621.50946226345;19964.600707985832;20040.89979550102;20442.284520041783;20680.37958861233;19883.502912427197;20365.796342036574;20431.18275268991;20466.079026443807;20572.868492232923;5180.974095129519;5535.474129957658;5772.769089236446;5778.4799368056865;5797.826065218051;6329.36706329368;6535.24844642865;6538.313477084909;6544.607323560578;6549.93450065498;6207.937920620781;6308.684565771693;6373.362663733613;6482.384173503509;6492.123563318963;6305.842353941142;6338.778142764981;6352.205974253218;6361.9045714314325;6366.904496432558;5142.125838607446;5426.8914621707345;5445.782168713246;5472.835814925519;5480.534154596864;12784.936075319656;13120;13267.933660331733;18091.643126765546;24892.751072489405;2206.3491270075365;2602.4534847682007;2610.4909542639193;2613.4773045391;2615.071649564415;9825;9825.606975720963;9981.201503879673;10431.956804319583;14397.064190827667;1707.4621494229277;1803.567143885471;1810.809864964186;1816.0828781465275;1848.9630207395776;106383.46808265909;121154;127085;127261;127903;11454.599089031844;11533.250338727956;11615.30308181495;11836.763264734656;11962.222455540363;14986.250687465583;15169.938104332812;15179.544613661608;15180.089194648357;15184.848151518565;8232.217939295757;8481.618327175293;8488.490690558463;8581.699640512552;8607.18231767981;7410.703571857173;8099.311558517474;8137.430379873471;8150.633221504928;8264.462809917337;4330.372096046056;4340.76125813077;4773;4783.378160839069;4813.927791083137;1884.4817675139445;2041.2345370486069;2053.917843286252;2056.9177232910815;2065.5972085443195;871.111466304366;986.4229425785995;993.9453330066916;1009.2783659683362;1051.4269723000982;15881;19223.231070757294;19878.801211987986;20176.495587610134;20275.695864562043;860.9969385665754;966.9854952175723;1006.758377989292;1022.9386236825666;1059.586761163147;9246.815063698688;10157.492125393848;10372.377657340432;10416.010479004482;10457.581696732197;573161;576382;580539;582305;701512;115674;151090.24454877657;154648.2267588655;160369.1981540108;162846;1055.773008803111;1077.2513103393067;1095.901368876805;1099.7305660113163;1106.6956586938657;18805.90597047006;19476.4157075288;19581.216751330358;19664.803351966297;19691.80308196957;39053.80473097616;50241.24638130358;56750;57512;58000.70999644975;83659;87748;89005;89876;90637;8028.759137225892;8256.587170641324;8369.748907532783;8370.748877533684;8514.126892083732;11637.59268425635;12455.688607784516;12763.21315015917;13087.214767114003;13133.212007279593;9534.475603841855;11143.275687080313;11288.492017859051;11430.028447582048;11487.425628718698;9265.212456941235;11075.335479871233;11143.33140011602;11246.100311974858;11254.606088786853;9442.85835712451;11222.382768947786;11524.59663911759;11577.768444630892;11699.941500292443;7246.7101315946775;8099.112793458724;8174.223448772357;8446.28206602421;8514.531700756517;9478.620855165716;10777.407242601732;11187.32876027441;11414.08687304997;11657.318816672383 04:46:53 INFO - PROCESS | 1651 | |3;mootools.html;1380.4823191303262;1446.7829825526169;1459.489178787424;1463.2756785391227;1489.7169537787822;7129.50093493455;7612.50518716283;7877.133515313311;7953.483023603469;8579.91420085799;8112.985876765404;8382.03606585243;8392.160783921605;8456.408051436387;8470.957645211765;2299.5630830142263;2306.169778879602;2328.045501344449;2329.452578644026;2340.3797993531643;2318.3740390094663;2349.6710460535537;2351.412146963259;2361.49227915998;2362.9291121266388;2297.3337732057685;2298.7011688480475;2312.6762253284555;2316.3977365884907;2319.8724070176136;2261.061659411342;2270.1146552844402;2286.965695514569;2291.4958709083976;2293.805026572735;2297.9195728149602;2315.6410756332625;2327.0459111764267;2328.161861729776;2331.603627383349;8390.160983901622;8395.454295470774;8443.324534037323;8495.490270583785;8511.914880851236;4995.700257984497;5153.6907785532985;5162.793488260465;5168.3281173447585;5176.611754118456;3315.668433156689;3316.4859446785786;3550.2012047289413;3558.484019817138;3574.8927532174075;1146.455433669009;1182.6156499137815;1245.8538144906709;1245.8567264764577;1273.3696820074122;10863.967923047298;10903.29128606638;10918.727031824188;10995;11006.394648294341;4397.648188144941;4611.169989401873;4670.089332580114;4717.103750287434;4752.287156926489;9507.904920950701;9599.712008639752;9607.903920960702;9611.375260608178;9615.471149086867;4485.798139083749;5041.117804384218;5224.764885580158;5280.128778751463;5291.074062039128;3622.601513833476;4343.370211319341;4348.565143485689;4681.976590117028;4788.808447662054;3077;3806.9428958565645;3851.017990412427;3876.573576906538;3899.7465164764767;1127.1208457403238;1283.8202651628778;1288.091895213872;1288.4781663426327;1297.4031945305076;919.4988731141544;931.38993958957;934.2339281788868;946.0464141547682;960.9087136722001;4611.423572053493;5569.275994120739;5626.409227031185;5792.9710351447975;5873.970630146822;590.1236663554618;890.098279608481;1006.5369929832359;1028.6605420211313;1063.9361638301727;3803;3903.4144878268485;3911.1799023693115;3943.940840887389;4002.9599704002585;9805.852912206323;10011.64959226438;10064.194864410829;10068.647597334058;10085.092341689284;10026.348287361445;10052.346597471142;10067.993200679874;10072.798544029078;10099.242556808269;7842.803929901684;7872.212778722196;7912.367010639135;7922.564258965812;8021.719239826578;4871.8294859681155;5552.305961754781;5589.077802162597;5660.37735849048;5799.898019376305;9298.907010930076;9322.161005509537;9355.625774968925;9396.53017349116;9400.717978460658;6593.80218593443;9250.72247832566;9273.21177699876;9341.766455838386;9363.110504502061;6659.433948114271;6846.486513511606;7023.22744498115;7214.96392518034;7378.114626244885;7869.3311068559815;8073.717419890276;8091.716789912325;8103.959480202561;8121.269085782308;6992.615406152507;7159.463040272105;7270.491065625355;7359.080114985627;7407.148177959388;5453.590980676386;6864.798660234539;7012.1935977363255;7094.361507464353;7105.82235444118;6313.116163736989;6367.395097465734;6445.452136568444;6458.38645328693;6471.2234531856475;4988.927380613186;5012.348394708664;5025.949740502694;5060.645754797129;5105.566026887756;4940.036692844861;4992.775325110306;5079.5428411443145;5160.761417259906;5170.069387510284 04:46:53 INFO - PROCESS | 1651 | |4;prototype.html;304.50213900273076;317.6712102973422;342.9742769292302;348.28253797177797;362.3333067156432;5100;5131;5251.2385704072985;5252.212168174776;5303.814366497173;4782;5169.974150129254;5200.50595193457;5206.843794686156;5211.973940130303;4127.596617150169;4129.855455059073;4130.731502452346;4131.772752498611;4153.6677065834665;3760.4735337052834;3938.8818335449982;4105.158442519291;4148.460700108997;4180.707350485467;3197.7601679873987;3248.832388421294;3642.8724994625195;3935.2129574085156;3938.4683067785913;3724.832382542792;3921.8627348042683;3932.960670393288;3940.4286378475103;4000.1199136621585;3244.6755324467363;3360.815155166465;3430.3482338355634;3450.2236996675797;3466.2201004773974;4395.12097580482;4476.462824461053;4828.758562071883;4935.298526105421;5207.09940871583;3883.728139030269;3994.6404823565726;4466.642668586505;4513.255312873372;4517.909641807179;4735.502772208937;5232.761463214808;5557.360903496109;5559.332880054379;5561.416051314594;3644.4168932970597;3739.775613463201;3794.827775504299;3810.485584446092;3819.427085937104;5081.8475445736685;5664.490195882349;5751.22358481608;5789.797357092523;5812.6114783338735;3698.7965661888857;3797.5442946846;3824.464574959508;3842.540773904703;3849.5188101487315;3196.002498438476;3833.9808300958316;3853.9614603854166;3875.689944804465;3881.049142959993;4438.800253988514;4485.932711009337;4507.3689683444345;4524.0047189618235;4533.977330113395;4513.638908887281;4673.088747694235;5235.345581802275;5486.862828429321;5545.334559852843;1136.931784092957;1160.9941950290195;1183.7869183547043;1236.6290112966253;1262.135437225485;718.7017387784116;723.2333726250191;829.8423299573062;859.9312055035582;861.9828602249406;4361.738295702268;4375.6280716138845;4868.488808675109;4964.429090654621;4991.053489139239;4582.770861456914;5346.278252435949;5347.224652425377;5374.462553744673;5402.324709411324;4410.42664453619;4532.750698711602;4885.802978270346;4901.803927842846;4927.526094103649;2505.4613258149584;2632.2498088044817;2641.1944356971308;2715.4026114254834;2857.7856660750526;4539.455265368177;4935.777889994959;5062.7468626568525;5207.0366982108435;5248.475152484721;4565.246734288805;4590.67865249436;5206.323177986913;5496.5053145217125;5556.72216389187;4763.523647635278;5506.697131657717;5569.944300557024;5607.971960140255;5641.912492377846;4696.632132117027;4816.760206503993;5206.843794686166;5300.224424817729;5389.56883449331;3970.0273433009097;4474.977625111854;4892.266160075875;4941;5271.710055946806;4350.39035556846;5131.666441681279;5520.227168196536;5642.178910544728;5672.149177623224;3766.604506526885;3788.507494025759;3791.563970143469;3800.7909564974193;3820.3066837878673;4774.928376074292;5642.294713160855;5680.7443665036;5681.573881958952;5691.804721008469;4464.419625448671;4633.72197668141;4671.388371011995;4958.256261560795;5182.989317083133;5046.798128074836;5065.290859279778;5255.054090263637;5292.3649162099255;5444.972775136099;4918.803247870045;5222.6083043771105;5342.504098852328;5350.438203988525;5358.97320513395;5250;5360.383555891122;5373.731313434391;5580.274564306615;5583.525400341016;5203.869903252449;5393.516782884738;5432.402435731988;5495.258140151188;5496.4503549646315 04:46:53 INFO - PROCESS | 1651 | |5;yui.html;595.5949954031257;663.3101574362663;679.6839469646613;706.6996526476246;736.2012216744831;11329.773404531905;12302.81545776814;14347.21090340031;15105;15250;13727.45090196391;13909.443622255123;13996.930015349935;14005.439782408717;14040.368183431745;786.4180506425233;842.0400743152795;869.7955980344614;871.0810095349403;873.7073080518003;688.3495097133211;714.6069661686078;845.3406343052429;882.0165515450291;882.7528292078197;897.9640814367417;919.5540163020929;920.6271460058687;921.7879887625817;925.051821882569;915.3409545127497;917.1745429113785;917.9495127767971;918.6646873891049;922.492629054021;682.6552590941592;685.4002747595854;686.6532401137443;690.6615758278458;691.1222747111141;14584.052036617586;14752.55742327732;14989.175595342253;15082.170480623561;15208.543743687707;13988;14314.42742290307;14347.641308967359;14531.854681453156;14533.200673962929;11510.42447877611;11705.239159454693;11781.646550603497;12004.459799309052;12059.21615095016;3232.9030129096163;3737.925241495182;3746.868859589901;3747.7376583639157;3926.8429262829454;105745;106492;107393.92606073918;107535;109006;10921.672349829518;11026.338419694845;11043.944780276048;11065.114790816715;11262.267952583055;23877;23884.40288992789;23919.282421527383;23929.923153458138;24311.756882431302;7205.351518363373;7269.63651817407;7399.556026638419;7409.184989651134;7475.962620186864;4174.31123864559;4197.580241975778;4260.914781704349;4342.6742994275555;4362.8036738346855;3061.6479104902774;3390.7454241930645;3521.29574085184;3527.3650742866016;3530.3645343838357;635.9745610175634;643.6910283064155;647.2879832184653;648.0538413915642;665.5341261117237;618.7617767159586;619.1981384107592;631.8072987738692;638.4273900197386;653.738504598155;9221.262299016063;9508.572114254875;9673.951630241803;9867.396253544794;9898.7030389087;604.9788257410969;661.3948237362855;663.4393937123124;666.0109737040491;669.0900375489331;3976.562578116405;4729.716217026989;4810.278458231293;4818.469968303484;4831.444383895897;62034;102101;106140;107553.38669919957;113504;91056.54471727599;91524;93190.53404732933;93925.53037234907;94809.52595237117;66353.6729265412;80121.59939200267;87045.56477217573;87123.56438217769;87746.12253877507;8071.4753541019645;8493.32053435736;8670.869936951078;9161.221296189899;9218.492982886006;57521.42478575161;57857.26428207161;57889;58660;59674.70162649159;58890.11664824945;65022.67488662527;67144;71867.92198117137;71950;13274.203547787163;13328;13437.664058398619;13514;13920.164790112625;14142.858571414154;14881.255937203314;15092.849071509583;15191.620209494851;15327;13641;13960.860391395956;14039.368228429541;14042.648933776329;14590.781138283146;13967.511137110152;14090;14193.716125677634;14227.430902764188;14302.213378264296;12228.205166664495;13374.622281048107;13487.39306731219;13729.862701372858;13847.930760346133;11237.269577477438;11397.772044559228;11446.484908178985;11706.473208705798;11830.940845295718;9707.66023189185;11221.88778112241;11335.206535542433;11460;11513.53945842157 04:46:53 INFO - PROCESS | 1651 | __end_tp_report 04:46:53 INFO - PROCESS | 1651 | __start_cc_report 04:46:53 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,385 04:46:53 INFO - PROCESS | 1651 | __end_cc_report 04:46:53 INFO - PROCESS | 1651 | __startTimestamp1484052413796__endTimestamp 04:46:53 INFO - PROCESS | 1651 | 04:46:53 INFO - PROCESS | 1651 | ------- Summary: start ------- 04:46:53 INFO - PROCESS | 1651 | Number of tests: 6 04:46:53 INFO - PROCESS | 1651 | 04:46:53 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5546.67 Median:5734.48 stddev:634.84 (11.1%) stddev-sans-first:612.04 04:46:53 INFO - PROCESS | 1651 | Values: 3309.3 3323.3 3327.5 3337.8 3342.7 5415.0 5509.1 5510.7 5520.9 5540.2 5418.9 5435.2 5510.5 5542.3 5582.0 4784.7 4962.7 4972.1 5093.1 5100.5 4985.1 5149.2 5156.4 5189.5 5198.9 4992.6 4993.9 5004.2 5026.2 5047.9 4955.0 5043.2 5058.1 5060.7 5067.4 4993.9 5023.2 5074.0 5077.1 5086.3 4560.6 5475.3 5521.7 5539.1 5554.6 5822.7 5870.4 5901.7 6054.8 6066.3 6100.7 6106.8 6112.3 6113.8 6142.4 5507.9 5574.8 5601.5 5615.5 5616.6 5306.7 5741.3 6109.4 6195.3 6209.9 5839.9 5989.2 5993.4 6025.4 6030.9 6112.3 6123.6 6128.4 6156.6 6176.8 4981.2 5856.4 5930.9 5942.9 6033.1 4743.0 5208.6 5839.5 6074.2 6080.1 4427.1 4718.5 4751.1 4781.6 4785.4 4187.1 4253.6 4255.1 4257.9 4268.3 5698.1 5729.8 5731.8 5734.5 5764.8 5215.6 6156.2 6173.4 6189.4 6193.8 5539.5 5566.2 5594.7 5660.1 5706.5 5218.5 5219.2 5219.8 5257.7 5287.6 6224.6 6225.2 6228.7 6230.6 6253.3 6104.7 6159.0 6163.8 6181.7 6214.1 6116.1 6121.3 6136.8 6157.5 6186.3 5958.1 5968.6 5994.1 5996.1 6000.3 6066.2 6089.4 6098.1 6108.2 6108.5 5752.1 5795.0 5803.7 5816.4 5897.2 5826.0 5830.3 5836.8 5850.9 5938.2 5525.4 5530.3 5705.7 5750.7 5771.5 5845.2 5880.9 5963.1 5986.8 5994.6 5624.3 5791.4 5807.9 5810.6 5822.4 04:46:53 INFO - PROCESS | 1651 | 04:46:53 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:65480.08 Median:38548.73 stddev:136583.71 (354.3%) stddev-sans-first:136879.60 04:46:53 INFO - PROCESS | 1651 | Values: 450.7 459.7 513.5 514.6 519.9 37968.0 40405.2 40469.8 41704.0 42462.9 41586.8 41993.8 42050.9 42101.2 42132.0 8410.2 8619.9 9139.0 9362.4 9390.1 11024.2 11266.5 11306.3 11428.1 11448.9 11232.8 11258.6 11321.5 11346.8 11355.9 11147.0 11177.7 11192.9 11219.9 11221.3 9173.4 11104.7 11108.2 11112.8 11122.3 38595.8 38784.6 38828.0 38945.0 39027.4 3068.7 3544.2 3991.0 4018.3 4208.5 25044.6 27812.3 29923.7 30311.8 30456.7 3133.2 3192.3 3229.3 3326.7 3341.2 433723.0 449068.0 449464.0 452064.0 457152.0 61720.5 62273.7 62729.1 62736.4 63820.4 49444.5 51165.7 61617.4 62057.7 62346.0 14823.9 15294.3 15373.2 15381.5 15381.9 9982.8 10774.6 10978.1 11494.7 11894.0 16296.8 16298.3 16325.3 16348.7 16363.9 7396.3 7431.7 7432.9 7460.5 7486.1 854.4 860.2 865.0 870.4 875.5 29157.4 29330.9 30379.5 30438.5 30513.8 860.5 1036.0 1046.5 1069.5 1202.7 15464.2 15517.3 15546.3 15559.5 15593.8 577793.0 583262.0 583373.0 584644.0 585064.0 60065.7 60709.7 61022.7 61070.0 61175.7 1372.2 1410.3 1426.1 1426.5 1430.7 28999.6 29188.9 29215.0 29732.0 30067.7 51366.5 51627.7 51656.0 51799.0 52187.7 497055.0 498052.0 499768.0 500153.0 501042.0 33648.5 40246.8 40322.4 40910.8 41197.8 45809.0 46210.3 46857.3 47320.5 48088.0 38391.0 38501.6 38927.0 39686.6 40205.0 32170.2 37572.8 37712.4 39080.0 39171.8 30813.5 33622.8 34397.5 37627.1 38269.8 31716.0 33666.5 34560.0 34765.8 34794.0 22257.4 22691.3 23048.0 25117.7 25630.6 04:46:53 INFO - PROCESS | 1651 | 04:46:53 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:35870.17 Median:11443.36 stddev:101804.30 (889.6%) stddev-sans-first:102054.85 04:46:53 INFO - PROCESS | 1651 | Values: 297.0 328.8 357.0 380.6 409.7 19621.5 19964.6 20040.9 20442.3 20680.4 19883.5 20365.8 20431.2 20466.1 20572.9 5181.0 5535.5 5772.8 5778.5 5797.8 6329.4 6535.2 6538.3 6544.6 6549.9 6207.9 6308.7 6373.4 6482.4 6492.1 6305.8 6338.8 6352.2 6361.9 6366.9 5142.1 5426.9 5445.8 5472.8 5480.5 12784.9 13120.0 13267.9 18091.6 24892.8 2206.3 2602.5 2610.5 2613.5 2615.1 9825.0 9825.6 9981.2 10432.0 14397.1 1707.5 1803.6 1810.8 1816.1 1849.0 106383.5 121154.0 127085.0 127261.0 127903.0 11454.6 11533.3 11615.3 11836.8 11962.2 14986.3 15169.9 15179.5 15180.1 15184.8 8232.2 8481.6 8488.5 8581.7 8607.2 7410.7 8099.3 8137.4 8150.6 8264.5 4330.4 4340.8 4773.0 4783.4 4813.9 1884.5 2041.2 2053.9 2056.9 2065.6 871.1 986.4 993.9 1009.3 1051.4 15881.0 19223.2 19878.8 20176.5 20275.7 861.0 967.0 1006.8 1022.9 1059.6 9246.8 10157.5 10372.4 10416.0 10457.6 573161.0 576382.0 580539.0 582305.0 701512.0 115674.0 151090.2 154648.2 160369.2 162846.0 1055.8 1077.3 1095.9 1099.7 1106.7 18805.9 19476.4 19581.2 19664.8 19691.8 39053.8 50241.2 56750.0 57512.0 58000.7 83659.0 87748.0 89005.0 89876.0 90637.0 8028.8 8256.6 8369.7 8370.7 8514.1 11637.6 12455.7 12763.2 13087.2 13133.2 9534.5 11143.3 11288.5 11430.0 11487.4 9265.2 11075.3 11143.3 11246.1 11254.6 9442.9 11222.4 11524.6 11577.8 11699.9 7246.7 8099.1 8174.2 8446.3 8514.5 9478.6 10777.4 11187.3 11414.1 11657.3 04:46:53 INFO - PROCESS | 1651 | 04:46:53 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5428.27 Median:5033.53 stddev:2969.56 (59.0%) stddev-sans-first:2962.31 04:46:53 INFO - PROCESS | 1651 | Values: 1380.5 1446.8 1459.5 1463.3 1489.7 7129.5 7612.5 7877.1 7953.5 8579.9 8113.0 8382.0 8392.2 8456.4 8471.0 2299.6 2306.2 2328.0 2329.5 2340.4 2318.4 2349.7 2351.4 2361.5 2362.9 2297.3 2298.7 2312.7 2316.4 2319.9 2261.1 2270.1 2287.0 2291.5 2293.8 2297.9 2315.6 2327.0 2328.2 2331.6 8390.2 8395.5 8443.3 8495.5 8511.9 4995.7 5153.7 5162.8 5168.3 5176.6 3315.7 3316.5 3550.2 3558.5 3574.9 1146.5 1182.6 1245.9 1245.9 1273.4 10864.0 10903.3 10918.7 10995.0 11006.4 4397.6 4611.2 4670.1 4717.1 4752.3 9507.9 9599.7 9607.9 9611.4 9615.5 4485.8 5041.1 5224.8 5280.1 5291.1 3622.6 4343.4 4348.6 4682.0 4788.8 3077.0 3806.9 3851.0 3876.6 3899.7 1127.1 1283.8 1288.1 1288.5 1297.4 919.5 931.4 934.2 946.0 960.9 4611.4 5569.3 5626.4 5793.0 5874.0 590.1 890.1 1006.5 1028.7 1063.9 3803.0 3903.4 3911.2 3943.9 4003.0 9805.9 10011.6 10064.2 10068.6 10085.1 10026.3 10052.3 10068.0 10072.8 10099.2 7842.8 7872.2 7912.4 7922.6 8021.7 4871.8 5552.3 5589.1 5660.4 5799.9 9298.9 9322.2 9355.6 9396.5 9400.7 6593.8 9250.7 9273.2 9341.8 9363.1 6659.4 6846.5 7023.2 7215.0 7378.1 7869.3 8073.7 8091.7 8104.0 8121.3 6992.6 7159.5 7270.5 7359.1 7407.1 5453.6 6864.8 7012.2 7094.4 7105.8 6313.1 6367.4 6445.5 6458.4 6471.2 4988.9 5012.3 5025.9 5060.6 5105.6 4940.0 4992.8 5079.5 5160.8 5170.1 04:46:53 INFO - PROCESS | 1651 | 04:46:53 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4328.29 Median:4769.23 stddev:1309.92 (27.5%) stddev-sans-first:1278.31 04:46:53 INFO - PROCESS | 1651 | Values: 304.5 317.7 343.0 348.3 362.3 5100.0 5131.0 5251.2 5252.2 5303.8 4782.0 5170.0 5200.5 5206.8 5212.0 4127.6 4129.9 4130.7 4131.8 4153.7 3760.5 3938.9 4105.2 4148.5 4180.7 3197.8 3248.8 3642.9 3935.2 3938.5 3724.8 3921.9 3933.0 3940.4 4000.1 3244.7 3360.8 3430.3 3450.2 3466.2 4395.1 4476.5 4828.8 4935.3 5207.1 3883.7 3994.6 4466.6 4513.3 4517.9 4735.5 5232.8 5557.4 5559.3 5561.4 3644.4 3739.8 3794.8 3810.5 3819.4 5081.8 5664.5 5751.2 5789.8 5812.6 3698.8 3797.5 3824.5 3842.5 3849.5 3196.0 3834.0 3854.0 3875.7 3881.0 4438.8 4485.9 4507.4 4524.0 4534.0 4513.6 4673.1 5235.3 5486.9 5545.3 1136.9 1161.0 1183.8 1236.6 1262.1 718.7 723.2 829.8 859.9 862.0 4361.7 4375.6 4868.5 4964.4 4991.1 4582.8 5346.3 5347.2 5374.5 5402.3 4410.4 4532.8 4885.8 4901.8 4927.5 2505.5 2632.2 2641.2 2715.4 2857.8 4539.5 4935.8 5062.7 5207.0 5248.5 4565.2 4590.7 5206.3 5496.5 5556.7 4763.5 5506.7 5569.9 5608.0 5641.9 4696.6 4816.8 5206.8 5300.2 5389.6 3970.0 4475.0 4892.3 4941.0 5271.7 4350.4 5131.7 5520.2 5642.2 5672.1 3766.6 3788.5 3791.6 3800.8 3820.3 4774.9 5642.3 5680.7 5681.6 5691.8 4464.4 4633.7 4671.4 4958.3 5183.0 5046.8 5065.3 5255.1 5292.4 5445.0 4918.8 5222.6 5342.5 5350.4 5359.0 5250.0 5360.4 5373.7 5580.3 5583.5 5203.9 5393.5 5432.4 5495.3 5496.5 04:46:53 INFO - PROCESS | 1651 | 04:46:53 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20836.72 Median:4229.25 stddev:30050.80 (710.5%) stddev-sans-first:30096.67 04:46:53 INFO - PROCESS | 1651 | Values: 595.6 663.3 679.7 706.7 736.2 11329.8 12302.8 14347.2 15105.0 15250.0 13727.5 13909.4 13996.9 14005.4 14040.4 786.4 842.0 869.8 871.1 873.7 688.3 714.6 845.3 882.0 882.8 898.0 919.6 920.6 921.8 925.1 915.3 917.2 917.9 918.7 922.5 682.7 685.4 686.7 690.7 691.1 14584.1 14752.6 14989.2 15082.2 15208.5 13988.0 14314.4 14347.6 14531.9 14533.2 11510.4 11705.2 11781.6 12004.5 12059.2 3232.9 3737.9 3746.9 3747.7 3926.8 105745.0 106492.0 107393.9 107535.0 109006.0 10921.7 11026.3 11043.9 11065.1 11262.3 23877.0 23884.4 23919.3 23929.9 24311.8 7205.4 7269.6 7399.6 7409.2 7476.0 4174.3 4197.6 4260.9 4342.7 4362.8 3061.6 3390.7 3521.3 3527.4 3530.4 636.0 643.7 647.3 648.1 665.5 618.8 619.2 631.8 638.4 653.7 9221.3 9508.6 9674.0 9867.4 9898.7 605.0 661.4 663.4 666.0 669.1 3976.6 4729.7 4810.3 4818.5 4831.4 62034.0 102101.0 106140.0 107553.4 113504.0 91056.5 91524.0 93190.5 93925.5 94809.5 66353.7 80121.6 87045.6 87123.6 87746.1 8071.5 8493.3 8670.9 9161.2 9218.5 57521.4 57857.3 57889.0 58660.0 59674.7 58890.1 65022.7 67144.0 71867.9 71950.0 13274.2 13328.0 13437.7 13514.0 13920.2 14142.9 14881.3 15092.8 15191.6 15327.0 13641.0 13960.9 14039.4 14042.6 14590.8 13967.5 14090.0 14193.7 14227.4 14302.2 12228.2 13374.6 13487.4 13729.9 13847.9 11237.3 11397.8 11446.5 11706.5 11830.9 9707.7 11221.9 11335.2 11460.0 11513.5 04:46:53 INFO - PROCESS | 1651 | -------- Summary: end -------- 04:46:53 INFO - PROCESS | 1651 | 04:46:54 INFO - TEST-INFO | 1651: exit 0 04:46:54 INFO - TEST-OK | dromaeo_css | took 1115702ms 04:46:54 INFO - TEST-START | kraken 04:46:54 INFO - operating with platform_type : mac_ 04:46:54 INFO - Initialising browser for kraken test... 04:46:54 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp3on2bK/profile http://localhost:49242/getInfo.html) 04:46:54 INFO - PROCESS | 1659 | 1484052414959 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 04:46:57 INFO - PROCESS | 1659 | 2017-01-10 04:46:57.189 plugin-container[1661:10864] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x892f, name = 'com.apple.tsm.portname' 04:46:57 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:57 INFO - PROCESS | 1659 | 2017-01-10 04:46:57.190 plugin-container[1661:10864] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9013, name = 'com.apple.CFPasteboardClient' 04:46:57 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:57 INFO - PROCESS | 1659 | 2017-01-10 04:46:57.190 plugin-container[1661:10864] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:46:57 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 04:46:57 INFO - PROCESS | 1659 | colorDepth:24 04:46:57 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 04:46:57 INFO - PROCESS | 1659 | __metrics 04:46:57 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 04:46:57 INFO - TEST-INFO | 1659: exit 0 04:46:57 INFO - Browser initialized. 04:46:57 INFO - Running cycle 1/1 for kraken test... 04:46:57 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp3on2bK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:00 INFO - PROCESS | 1662 | 2017-01-10 04:47:00.447 plugin-container[1663:10977] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:47:00 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:47:00 INFO - PROCESS | 1662 | 2017-01-10 04:47:00.447 plugin-container[1663:10977] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 04:47:00 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:47:00 INFO - PROCESS | 1662 | 2017-01-10 04:47:00.447 plugin-container[1663:10977] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:47:10 INFO - PROCESS | 1662 | RSS: Main: 233136128 04:47:10 INFO - PROCESS | 1662 | 04:47:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:14 INFO - PROCESS | 1662 | RSS: Main: 246067200 04:47:14 INFO - PROCESS | 1662 | 04:47:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 04:47:17 INFO - PROCESS | 1662 | RSS: Main: 253624320 04:47:17 INFO - PROCESS | 1662 | 04:47:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 04:47:21 INFO - PROCESS | 1662 | RSS: Main: 256180224 04:47:21 INFO - PROCESS | 1662 | 04:47:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 04:47:24 INFO - PROCESS | 1662 | RSS: Main: 258396160 04:47:24 INFO - PROCESS | 1662 | 04:47:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:26 INFO - PROCESS | 1662 | RSS: Main: 259272704 04:47:26 INFO - PROCESS | 1662 | 04:47:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:30 INFO - PROCESS | 1662 | RSS: Main: 264544256 04:47:30 INFO - PROCESS | 1662 | 04:47:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:34 INFO - PROCESS | 1662 | RSS: Main: 264224768 04:47:34 INFO - PROCESS | 1662 | 04:47:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 04:47:37 INFO - PROCESS | 1662 | RSS: Main: 264073216 04:47:37 INFO - PROCESS | 1662 | 04:47:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:40 INFO - PROCESS | 1662 | RSS: Main: 263012352 04:47:40 INFO - PROCESS | 1662 | 04:47:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:42 INFO - PROCESS | 1662 | RSS: Main: 263016448 04:47:42 INFO - PROCESS | 1662 | 04:47:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:45 INFO - PROCESS | 1662 | RSS: Main: 263069696 04:47:45 INFO - PROCESS | 1662 | 04:47:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:49 INFO - PROCESS | 1662 | RSS: Main: 263340032 04:47:49 INFO - PROCESS | 1662 | 04:47:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:52 INFO - PROCESS | 1662 | RSS: Main: 263184384 04:47:52 INFO - PROCESS | 1662 | 04:47:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 04:47:55 INFO - PROCESS | 1662 | RSS: Main: 265023488 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | __start_tp_report 04:47:55 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 04:47:55 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 04:47:55 INFO - PROCESS | 1662 | |i|pagename|runs| 04:47:55 INFO - PROCESS | 1662 | |0;ai-astar;105;132;176;156;117;118;117;117;118;116 04:47:55 INFO - PROCESS | 1662 | |1;audio-beat-detection;145;111;110;153;140;140;112;111;144;140 04:47:55 INFO - PROCESS | 1662 | |2;audio-dft;209;242;278;194;260;276;200;197;195;194 04:47:55 INFO - PROCESS | 1662 | |3;audio-fft;83;62;62;83;60;60;60;61;70;64 04:47:55 INFO - PROCESS | 1662 | |4;audio-oscillator;89;70;86;72;71;72;83;70;73;102 04:47:55 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;124;133;136;116;89;119;78;132;137;86 04:47:55 INFO - PROCESS | 1662 | |6;imaging-darkroom;107;111;95;95;111;153;124;95;98;98 04:47:55 INFO - PROCESS | 1662 | |7;imaging-desaturate;137;139;76;142;148;101;93;92;79;148 04:47:55 INFO - PROCESS | 1662 | |8;json-parse-financial;59;62;66;90;102;99;86;62;53;51 04:47:55 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;67;77;76;71;70;68;68;72;76;72 04:47:55 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;89;90;89;90;88;90;92;92;89;88 04:47:55 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;177;164;160;155;159;143;140;143;193;168 04:47:55 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;170;175;175;176;175;174;171;175;174;171 04:47:55 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;68;73;80;86;87;89;88;67;67;66 04:47:55 INFO - PROCESS | 1662 | __end_tp_report 04:47:55 INFO - PROCESS | 1662 | __start_cc_report 04:47:55 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,936 04:47:55 INFO - PROCESS | 1662 | __end_cc_report 04:47:55 INFO - PROCESS | 1662 | __startTimestamp1484052475062__endTimestamp 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | ------- Summary: start ------- 04:47:55 INFO - PROCESS | 1662 | Number of tests: 14 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:127.20 Median:118.00 stddev:21.94 (18.6%) stddev-sans-first:21.75 04:47:55 INFO - PROCESS | 1662 | Values: 105.0 132.0 176.0 156.0 117.0 118.0 117.0 117.0 118.0 116.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:140.00 stddev:17.30 (12.4%) stddev-sans-first:17.54 04:47:55 INFO - PROCESS | 1662 | Values: 145.0 111.0 110.0 153.0 140.0 140.0 112.0 111.0 144.0 140.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:224.50 Median:225.50 stddev:35.60 (15.8%) stddev-sans-first:37.32 04:47:55 INFO - PROCESS | 1662 | Values: 209.0 242.0 278.0 194.0 260.0 276.0 200.0 197.0 195.0 194.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:66.50 Median:63.00 stddev:9.19 (14.6%) stddev-sans-first:7.57 04:47:55 INFO - PROCESS | 1662 | Values: 83.0 62.0 62.0 83.0 60.0 60.0 60.0 61.0 70.0 64.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:72.50 stddev:10.82 (14.9%) stddev-sans-first:10.83 04:47:55 INFO - PROCESS | 1662 | Values: 89.0 70.0 86.0 72.0 71.0 72.0 83.0 70.0 73.0 102.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:136.50 stddev:22.42 (16.4%) stddev-sans-first:23.54 04:47:55 INFO - PROCESS | 1662 | Values: 124.0 133.0 136.0 116.0 89.0 119.0 78.0 132.0 137.0 86.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:108.70 Median:95.00 stddev:18.26 (19.2%) stddev-sans-first:19.36 04:47:55 INFO - PROCESS | 1662 | Values: 107.0 111.0 95.0 95.0 111.0 153.0 124.0 95.0 98.0 98.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:115.50 Median:112.00 stddev:29.80 (26.6%) stddev-sans-first:30.57 04:47:55 INFO - PROCESS | 1662 | Values: 137.0 139.0 76.0 142.0 148.0 101.0 93.0 92.0 79.0 148.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:73.00 Median:64.00 stddev:19.28 (30.1%) stddev-sans-first:19.77 04:47:55 INFO - PROCESS | 1662 | Values: 59.0 62.0 66.0 90.0 102.0 99.0 86.0 62.0 53.0 51.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:3.62 (5.0%) stddev-sans-first:3.42 04:47:55 INFO - PROCESS | 1662 | Values: 67.0 77.0 76.0 71.0 70.0 68.0 68.0 72.0 76.0 72.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:90.00 stddev:1.42 (1.6%) stddev-sans-first:1.48 04:47:55 INFO - PROCESS | 1662 | Values: 89.0 90.0 89.0 90.0 88.0 90.0 92.0 92.0 89.0 88.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:160.20 Median:162.00 stddev:16.54 (10.2%) stddev-sans-first:16.39 04:47:55 INFO - PROCESS | 1662 | Values: 177.0 164.0 160.0 155.0 159.0 143.0 140.0 143.0 193.0 168.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:175.00 stddev:2.12 (1.2%) stddev-sans-first:1.80 04:47:55 INFO - PROCESS | 1662 | Values: 170.0 175.0 175.0 176.0 175.0 174.0 171.0 175.0 174.0 171.0 04:47:55 INFO - PROCESS | 1662 | 04:47:55 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:83.00 stddev:9.85 (11.9%) stddev-sans-first:9.88 04:47:55 INFO - PROCESS | 1662 | Values: 68.0 73.0 80.0 86.0 87.0 89.0 88.0 67.0 67.0 66.0 04:47:55 INFO - PROCESS | 1662 | -------- Summary: end -------- 04:47:55 INFO - PROCESS | 1662 | 04:47:56 INFO - TEST-INFO | 1662: exit 0 04:47:56 INFO - TEST-OK | kraken | took 61658ms 04:47:56 INFO - SUITE-END | took 1177s 04:47:56 INFO - Completed test suite (00:19:37) 04:47:56 INFO - javascript benchmark 04:47:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7180.652435556156, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.2554175310556, 3323.335332933414, 3327.4509705898527, 3337.7830441021338, 3342.699157075863, 5414.972925135378, 5509.146082357231, 5510.72446377681, 5520.9171862422045, 5540.2243685883905, 5418.9458105418935, 5435.157550579656, 5510.531604813596, 5542.334919809628, 5582.0, 4784.736839473845, 4962.702237865721, 4972.105021096192, 5093.083245015896, 5100.464451232623, 4985.102681517325, 5149.150390185634, 5156.432792392834, 5189.481051894818, 5198.9480105198845, 4992.550670439678, 4993.925091123636, 5004.224345226496, 5026.2209357549455, 5047.899042019139, 4954.9752251238515, 5043.218301163325, 5058.140116180258, 5060.721660308718, 5067.417247016567, 4993.900121997576, 5023.196288593807, 5073.974630126826, 5077.111505486525, 5086.262491938685, 4560.612347950429, 5475.260839786618, 5521.696306703129, 5539.113741801292, 5554.638948468337, 5822.737976791054, 5870.354261031283, 5901.704914754245, 6054.788082417138, 6066.332703402622, 6100.664463454508, 6106.786262480836, 6112.297085835142, 6113.816585502442, 6142.385761423867, 5507.862303442406, 5574.804881829157, 5601.467860553282, 5615.466530679579, 5616.550675945915, 5306.726385667412, 5741.339745929188, 6109.419605137505, 6195.287541932736, 6209.9379006210265, 5839.9124013139835, 5989.221401217901, 5993.400659933972, 6025.367336429699, 6030.879382412327, 6112.266528016667, 6123.632582045091, 6128.417800308964, 6156.569040167235, 6176.7838125665385, 4981.153203955264, 5856.385079566669, 5930.851728706817, 5942.8811423771285, 6033.095035744585, 4743.0, 5208.557272631793, 5839.474447299764, 6074.210352654215, 6080.14877917092, 4427.092446048552, 4718.4809670936165, 4751.121042607128, 4781.593564546983, 4785.401824771903, 4187.099773548702, 4253.574642535722, 4255.127698821734, 4257.91484170321, 4268.2530557152995, 5698.059820129715, 5729.799457018984, 5731.77072917087, 5734.483896449339, 5764.798232061941, 5215.58275337972, 6156.199694039746, 6173.382661733791, 6189.442950134509, 6193.84515387119, 5539.473749993744, 5566.2207290979295, 5594.720263986785, 5660.122680984454, 5706.543476521868, 5218.530332270114, 5219.164933610604, 5219.791208351623, 5257.710825904535, 5287.603429742785, 6224.595401298901, 6225.159603453476, 6228.688565571703, 6230.59501132434, 6253.312135665074, 6104.664243466652, 6158.969205153946, 6163.753449862134, 6181.690915454299, 6214.098955651496, 6116.092308610985, 6121.300552271563, 6136.825445958321, 6157.507399408126, 6186.257649082139, 5958.076498142795, 5968.552358573038, 5994.07091900756, 5996.1005849122985, 6000.339962604197, 6066.211392519121, 6089.391060893875, 6098.0852872069545, 6108.17539632144, 6108.511319094373, 5752.0509115997065, 5794.971025145016, 5803.680797556175, 5816.418358164319, 5897.174395584536, 5825.970870145792, 5830.271216097988, 5836.766529338779, 5850.882982340244, 5938.228030356199, 5525.419830917856, 5530.281063461885, 5705.686187259741, 5750.712464376848, 5771.480566749013, 5845.152452894392, 5880.911786323294, 5963.13534537481, 5986.790462333797, 5994.55040871945, 5624.268845050117, 5791.391903850035, 5807.883842323215, 5810.593258471867, 5822.417758224144], "value": 5507.310124158844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.6529971921623, 459.67363172147776, 513.4788189987163, 514.5909002343137, 519.903817793708, 37968.0, 40405.19189616206, 40469.79765101178, 41704.0, 42462.93842653935, 41586.79206603971, 41993.79003104988, 42050.94872628186, 42101.15797684045, 42132.0, 8410.158984101572, 8619.870701939475, 9138.999999999984, 9362.391444556082, 9390.060993900624, 11024.173187010967, 11266.549338026469, 11306.265092768985, 11428.085753139729, 11448.885511144865, 11232.831507527393, 11258.605948791794, 11321.490532925996, 11346.829797553044, 11355.886441135566, 11146.996770290672, 11177.66467005987, 11192.944035279772, 11219.943900280528, 11221.326720396803, 9173.44959302444, 11104.722381940435, 11108.16688748347, 11112.833307500394, 11122.332660040343, 38595.8421247363, 38784.612153878385, 38828.0, 38945.0, 39027.41458878119, 3068.6624471308137, 3544.220271540257, 3991.0, 4018.2566225248424, 4208.473940757405, 25044.624330635055, 27812.30469238285, 29923.70076299253, 30311.848440757876, 30456.695433045606, 3133.2010337364054, 3192.2657788708493, 3229.289556297611, 3326.667333266654, 3341.214814518586, 433722.99999999686, 449068.0, 449464.0, 452064.0, 457152.0, 61720.45698857564, 62273.68863155655, 62729.05906411407, 62736.37263627397, 63820.36179638237, 49444.50555494399, 51165.74417127965, 61617.38382616117, 62057.68971155115, 62346.0, 14823.925880370745, 15294.311755970786, 15373.154476503676, 15381.461648842236, 15381.923090384476, 9982.750431239278, 10774.569017239222, 10978.066864316463, 11494.712632184095, 11893.989010933994, 16296.837031629531, 16298.348066077224, 16325.26536305869, 16348.673026539402, 16363.936344137594, 7396.297351751575, 7431.739889103964, 7432.9256707433315, 7460.477766556289, 7486.139094004259, 854.410456784829, 860.1828263150032, 864.9682861570157, 870.3515880668942, 875.5490922175085, 29157.41685166285, 29330.867098258146, 30379.544306835414, 30438.54342184869, 30513.847430763148, 860.5482121885934, 1035.9896401036044, 1046.4663021858755, 1069.49199130414, 1202.6873013016505, 15464.226788660522, 15517.258564494266, 15546.300416481285, 15559.45541906028, 15593.766093508606, 577793.0, 583262.0, 583373.0, 584644.0, 585064.0, 60065.69967150136, 60709.69645151746, 61022.694886525285, 61070.0, 61175.69412152911, 1372.19726460022, 1410.2525661399475, 1426.108682073704, 1426.472205284031, 1430.6780974280703, 28999.56500652534, 29188.854055729586, 29215.0, 29732.0, 30067.69932300649, 51366.459006229874, 51627.74186129045, 51656.0, 51799.0, 52187.73906130445, 497055.0, 498052.0, 499768.0, 500153.0, 501042.0, 33648.49527257142, 40246.79876600715, 40322.39516407315, 40910.79544602258, 41197.79401102975, 45809.0, 46210.306845398016, 46857.297140543604, 47320.52679473299, 48088.03823923572, 38391.04022399463, 38501.6149838498, 38927.0, 39686.60313396829, 40205.0, 32170.195745105622, 37572.812135939144, 37712.43431348477, 39080.0, 39171.80414097911, 30813.537796932615, 33622.83188584042, 34397.48403773995, 37627.05932351713, 38269.80865095768, 31716.0, 33666.49500257449, 34560.0, 34765.82617086898, 34794.0, 22257.44356391103, 22691.319260422213, 23048.0, 25117.74882251154, 25630.615540767278], "value": 19947.61459327429, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.9806962547436, 328.7649330728529, 356.98081975958627, 380.6459992207248, 409.7275311917575, 19621.50946226345, 19964.600707985832, 20040.89979550102, 20442.284520041783, 20680.37958861233, 19883.502912427197, 20365.796342036574, 20431.18275268991, 20466.079026443807, 20572.868492232923, 5180.974095129519, 5535.474129957658, 5772.769089236446, 5778.4799368056865, 5797.826065218051, 6329.36706329368, 6535.24844642865, 6538.313477084909, 6544.607323560578, 6549.93450065498, 6207.937920620781, 6308.684565771693, 6373.362663733613, 6482.384173503509, 6492.123563318963, 6305.842353941142, 6338.778142764981, 6352.205974253218, 6361.9045714314325, 6366.904496432558, 5142.125838607446, 5426.8914621707345, 5445.782168713246, 5472.835814925519, 5480.534154596864, 12784.936075319656, 13120.0, 13267.933660331733, 18091.643126765546, 24892.751072489405, 2206.3491270075365, 2602.4534847682007, 2610.4909542639193, 2613.4773045391, 2615.071649564415, 9825.0, 9825.606975720963, 9981.201503879673, 10431.956804319583, 14397.064190827667, 1707.4621494229277, 1803.567143885471, 1810.809864964186, 1816.0828781465275, 1848.9630207395776, 106383.46808265909, 121154.0, 127085.0, 127261.0, 127903.0, 11454.599089031844, 11533.250338727956, 11615.30308181495, 11836.763264734656, 11962.222455540363, 14986.250687465583, 15169.938104332812, 15179.544613661608, 15180.089194648357, 15184.848151518565, 8232.217939295757, 8481.618327175293, 8488.490690558463, 8581.699640512552, 8607.18231767981, 7410.703571857173, 8099.311558517474, 8137.430379873471, 8150.633221504928, 8264.462809917337, 4330.372096046056, 4340.76125813077, 4773.0, 4783.378160839069, 4813.927791083137, 1884.4817675139445, 2041.2345370486069, 2053.917843286252, 2056.9177232910815, 2065.5972085443195, 871.111466304366, 986.4229425785995, 993.9453330066916, 1009.2783659683362, 1051.4269723000982, 15881.0, 19223.231070757294, 19878.801211987986, 20176.495587610134, 20275.695864562043, 860.9969385665754, 966.9854952175723, 1006.758377989292, 1022.9386236825666, 1059.586761163147, 9246.815063698688, 10157.492125393848, 10372.377657340432, 10416.010479004482, 10457.581696732197, 573161.0, 576382.0, 580539.0, 582305.0, 701512.0, 115674.0, 151090.24454877657, 154648.2267588655, 160369.1981540108, 162846.0, 1055.773008803111, 1077.2513103393067, 1095.901368876805, 1099.7305660113163, 1106.6956586938657, 18805.90597047006, 19476.4157075288, 19581.216751330358, 19664.803351966297, 19691.80308196957, 39053.80473097616, 50241.24638130358, 56750.0, 57512.0, 58000.70999644975, 83659.0, 87748.0, 89005.0, 89876.0, 90637.0, 8028.759137225892, 8256.587170641324, 8369.748907532783, 8370.748877533684, 8514.126892083732, 11637.59268425635, 12455.688607784516, 12763.21315015917, 13087.214767114003, 13133.212007279593, 9534.475603841855, 11143.275687080313, 11288.492017859051, 11430.028447582048, 11487.425628718698, 9265.212456941235, 11075.335479871233, 11143.33140011602, 11246.100311974858, 11254.606088786853, 9442.85835712451, 11222.382768947786, 11524.59663911759, 11577.768444630892, 11699.941500292443, 7246.7101315946775, 8099.112793458724, 8174.223448772357, 8446.28206602421, 8514.531700756517, 9478.620855165716, 10777.407242601732, 11187.32876027441, 11414.08687304997, 11657.318816672383], "value": 9629.55953691051, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.4823191303262, 1446.7829825526169, 1459.489178787424, 1463.2756785391227, 1489.7169537787822, 7129.50093493455, 7612.50518716283, 7877.133515313311, 7953.483023603469, 8579.91420085799, 8112.985876765404, 8382.03606585243, 8392.160783921605, 8456.408051436387, 8470.957645211765, 2299.5630830142263, 2306.169778879602, 2328.045501344449, 2329.452578644026, 2340.3797993531643, 2318.3740390094663, 2349.6710460535537, 2351.412146963259, 2361.49227915998, 2362.9291121266388, 2297.3337732057685, 2298.7011688480475, 2312.6762253284555, 2316.3977365884907, 2319.8724070176136, 2261.061659411342, 2270.1146552844402, 2286.965695514569, 2291.4958709083976, 2293.805026572735, 2297.9195728149602, 2315.6410756332625, 2327.0459111764267, 2328.161861729776, 2331.603627383349, 8390.160983901622, 8395.454295470774, 8443.324534037323, 8495.490270583785, 8511.914880851236, 4995.700257984497, 5153.6907785532985, 5162.793488260465, 5168.3281173447585, 5176.611754118456, 3315.668433156689, 3316.4859446785786, 3550.2012047289413, 3558.484019817138, 3574.8927532174075, 1146.455433669009, 1182.6156499137815, 1245.8538144906709, 1245.8567264764577, 1273.3696820074122, 10863.967923047298, 10903.29128606638, 10918.727031824188, 10995.0, 11006.394648294341, 4397.648188144941, 4611.169989401873, 4670.089332580114, 4717.103750287434, 4752.287156926489, 9507.904920950701, 9599.712008639752, 9607.903920960702, 9611.375260608178, 9615.471149086867, 4485.798139083749, 5041.117804384218, 5224.764885580158, 5280.128778751463, 5291.074062039128, 3622.601513833476, 4343.370211319341, 4348.565143485689, 4681.976590117028, 4788.808447662054, 3077.0, 3806.9428958565645, 3851.017990412427, 3876.573576906538, 3899.7465164764767, 1127.1208457403238, 1283.8202651628778, 1288.091895213872, 1288.4781663426327, 1297.4031945305076, 919.4988731141544, 931.38993958957, 934.2339281788868, 946.0464141547682, 960.9087136722001, 4611.423572053493, 5569.275994120739, 5626.409227031185, 5792.9710351447975, 5873.970630146822, 590.1236663554618, 890.098279608481, 1006.5369929832359, 1028.6605420211313, 1063.9361638301727, 3803.0, 3903.4144878268485, 3911.1799023693115, 3943.940840887389, 4002.9599704002585, 9805.852912206323, 10011.64959226438, 10064.194864410829, 10068.647597334058, 10085.092341689284, 10026.348287361445, 10052.346597471142, 10067.993200679874, 10072.798544029078, 10099.242556808269, 7842.803929901684, 7872.212778722196, 7912.367010639135, 7922.564258965812, 8021.719239826578, 4871.8294859681155, 5552.305961754781, 5589.077802162597, 5660.37735849048, 5799.898019376305, 9298.907010930076, 9322.161005509537, 9355.625774968925, 9396.53017349116, 9400.717978460658, 6593.80218593443, 9250.72247832566, 9273.21177699876, 9341.766455838386, 9363.110504502061, 6659.433948114271, 6846.486513511606, 7023.22744498115, 7214.96392518034, 7378.114626244885, 7869.3311068559815, 8073.717419890276, 8091.716789912325, 8103.959480202561, 8121.269085782308, 6992.615406152507, 7159.463040272105, 7270.491065625355, 7359.080114985627, 7407.148177959388, 5453.590980676386, 6864.798660234539, 7012.1935977363255, 7094.361507464353, 7105.82235444118, 6313.116163736989, 6367.395097465734, 6445.452136568444, 6458.38645328693, 6471.2234531856475, 4988.927380613186, 5012.348394708664, 5025.949740502694, 5060.645754797129, 5105.566026887756, 4940.036692844861, 4992.775325110306, 5079.5428411443145, 5160.761417259906, 5170.069387510284], "value": 4420.297317287389, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.50213900273076, 317.6712102973422, 342.9742769292302, 348.28253797177797, 362.3333067156432, 5100.0, 5131.0, 5251.2385704072985, 5252.212168174776, 5303.814366497173, 4782.0, 5169.974150129254, 5200.50595193457, 5206.843794686156, 5211.973940130303, 4127.596617150169, 4129.855455059073, 4130.731502452346, 4131.772752498611, 4153.6677065834665, 3760.4735337052834, 3938.8818335449982, 4105.158442519291, 4148.460700108997, 4180.707350485467, 3197.7601679873987, 3248.832388421294, 3642.8724994625195, 3935.2129574085156, 3938.4683067785913, 3724.832382542792, 3921.8627348042683, 3932.960670393288, 3940.4286378475103, 4000.1199136621585, 3244.6755324467363, 3360.815155166465, 3430.3482338355634, 3450.2236996675797, 3466.2201004773974, 4395.12097580482, 4476.462824461053, 4828.758562071883, 4935.298526105421, 5207.09940871583, 3883.728139030269, 3994.6404823565726, 4466.642668586505, 4513.255312873372, 4517.909641807179, 4735.502772208937, 5232.761463214808, 5557.360903496109, 5559.332880054379, 5561.416051314594, 3644.4168932970597, 3739.775613463201, 3794.827775504299, 3810.485584446092, 3819.427085937104, 5081.8475445736685, 5664.490195882349, 5751.22358481608, 5789.797357092523, 5812.6114783338735, 3698.7965661888857, 3797.5442946846, 3824.464574959508, 3842.540773904703, 3849.5188101487315, 3196.002498438476, 3833.9808300958316, 3853.9614603854166, 3875.689944804465, 3881.049142959993, 4438.800253988514, 4485.932711009337, 4507.3689683444345, 4524.0047189618235, 4533.977330113395, 4513.638908887281, 4673.088747694235, 5235.345581802275, 5486.862828429321, 5545.334559852843, 1136.931784092957, 1160.9941950290195, 1183.7869183547043, 1236.6290112966253, 1262.135437225485, 718.7017387784116, 723.2333726250191, 829.8423299573062, 859.9312055035582, 861.9828602249406, 4361.738295702268, 4375.6280716138845, 4868.488808675109, 4964.429090654621, 4991.053489139239, 4582.770861456914, 5346.278252435949, 5347.224652425377, 5374.462553744673, 5402.324709411324, 4410.42664453619, 4532.750698711602, 4885.802978270346, 4901.803927842846, 4927.526094103649, 2505.4613258149584, 2632.2498088044817, 2641.1944356971308, 2715.4026114254834, 2857.7856660750526, 4539.455265368177, 4935.777889994959, 5062.7468626568525, 5207.0366982108435, 5248.475152484721, 4565.246734288805, 4590.67865249436, 5206.323177986913, 5496.5053145217125, 5556.72216389187, 4763.523647635278, 5506.697131657717, 5569.944300557024, 5607.971960140255, 5641.912492377846, 4696.632132117027, 4816.760206503993, 5206.843794686166, 5300.224424817729, 5389.56883449331, 3970.0273433009097, 4474.977625111854, 4892.266160075875, 4941.0, 5271.710055946806, 4350.39035556846, 5131.666441681279, 5520.227168196536, 5642.178910544728, 5672.149177623224, 3766.604506526885, 3788.507494025759, 3791.563970143469, 3800.7909564974193, 3820.3066837878673, 4774.928376074292, 5642.294713160855, 5680.7443665036, 5681.573881958952, 5691.804721008469, 4464.419625448671, 4633.72197668141, 4671.388371011995, 4958.256261560795, 5182.989317083133, 5046.798128074836, 5065.290859279778, 5255.054090263637, 5292.3649162099255, 5444.972775136099, 4918.803247870045, 5222.6083043771105, 5342.504098852328, 5350.438203988525, 5358.97320513395, 5250.0, 5360.383555891122, 5373.731313434391, 5580.274564306615, 5583.525400341016, 5203.869903252449, 5393.516782884738, 5432.402435731988, 5495.258140151188, 5496.4503549646315], "value": 3914.721869880954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5949954031257, 663.3101574362663, 679.6839469646613, 706.6996526476246, 736.2012216744831, 11329.773404531905, 12302.81545776814, 14347.21090340031, 15105.0, 15250.0, 13727.45090196391, 13909.443622255123, 13996.930015349935, 14005.439782408717, 14040.368183431745, 786.4180506425233, 842.0400743152795, 869.7955980344614, 871.0810095349403, 873.7073080518003, 688.3495097133211, 714.6069661686078, 845.3406343052429, 882.0165515450291, 882.7528292078197, 897.9640814367417, 919.5540163020929, 920.6271460058687, 921.7879887625817, 925.051821882569, 915.3409545127497, 917.1745429113785, 917.9495127767971, 918.6646873891049, 922.492629054021, 682.6552590941592, 685.4002747595854, 686.6532401137443, 690.6615758278458, 691.1222747111141, 14584.052036617586, 14752.55742327732, 14989.175595342253, 15082.170480623561, 15208.543743687707, 13988.0, 14314.42742290307, 14347.641308967359, 14531.854681453156, 14533.200673962929, 11510.42447877611, 11705.239159454693, 11781.646550603497, 12004.459799309052, 12059.21615095016, 3232.9030129096163, 3737.925241495182, 3746.868859589901, 3747.7376583639157, 3926.8429262829454, 105745.0, 106492.0, 107393.92606073918, 107535.0, 109006.0, 10921.672349829518, 11026.338419694845, 11043.944780276048, 11065.114790816715, 11262.267952583055, 23877.0, 23884.40288992789, 23919.282421527383, 23929.923153458138, 24311.756882431302, 7205.351518363373, 7269.63651817407, 7399.556026638419, 7409.184989651134, 7475.962620186864, 4174.31123864559, 4197.580241975778, 4260.914781704349, 4342.6742994275555, 4362.8036738346855, 3061.6479104902774, 3390.7454241930645, 3521.29574085184, 3527.3650742866016, 3530.3645343838357, 635.9745610175634, 643.6910283064155, 647.2879832184653, 648.0538413915642, 665.5341261117237, 618.7617767159586, 619.1981384107592, 631.8072987738692, 638.4273900197386, 653.738504598155, 9221.262299016063, 9508.572114254875, 9673.951630241803, 9867.396253544794, 9898.7030389087, 604.9788257410969, 661.3948237362855, 663.4393937123124, 666.0109737040491, 669.0900375489331, 3976.562578116405, 4729.716217026989, 4810.278458231293, 4818.469968303484, 4831.444383895897, 62034.0, 102101.0, 106140.0, 107553.38669919957, 113504.0, 91056.54471727599, 91524.0, 93190.53404732933, 93925.53037234907, 94809.52595237117, 66353.6729265412, 80121.59939200267, 87045.56477217573, 87123.56438217769, 87746.12253877507, 8071.4753541019645, 8493.32053435736, 8670.869936951078, 9161.221296189899, 9218.492982886006, 57521.42478575161, 57857.26428207161, 57889.0, 58660.0, 59674.70162649159, 58890.11664824945, 65022.67488662527, 67144.0, 71867.92198117137, 71950.0, 13274.203547787163, 13328.0, 13437.664058398619, 13514.0, 13920.164790112625, 14142.858571414154, 14881.255937203314, 15092.849071509583, 15191.620209494851, 15327.0, 13641.0, 13960.860391395956, 14039.368228429541, 14042.648933776329, 14590.781138283146, 13967.511137110152, 14090.0, 14193.716125677634, 14227.430902764188, 14302.213378264296, 12228.205166664495, 13374.622281048107, 13487.39306731219, 13729.862701372858, 13847.930760346133, 11237.269577477438, 11397.772044559228, 11446.484908178985, 11706.473208705798, 11830.940845295718, 9707.66023189185, 11221.88778112241, 11335.206535542433, 11460.0, 11513.53945842157], "value": 7487.625241361699, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1612.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 132.0, 176.0, 156.0, 117.0, 118.0, 117.0, 117.0, 118.0, 116.0], "value": 127.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 111.0, 110.0, 153.0, 140.0, 140.0, 112.0, 111.0, 144.0, 140.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 242.0, 278.0, 194.0, 260.0, 276.0, 200.0, 197.0, 195.0, 194.0], "value": 224.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 62.0, 83.0, 60.0, 60.0, 60.0, 61.0, 70.0, 64.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 86.0, 72.0, 71.0, 72.0, 83.0, 70.0, 73.0, 102.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 133.0, 136.0, 116.0, 89.0, 119.0, 78.0, 132.0, 137.0, 86.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 95.0, 95.0, 111.0, 153.0, 124.0, 95.0, 98.0, 98.0], "value": 108.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 76.0, 142.0, 148.0, 101.0, 93.0, 92.0, 79.0, 148.0], "value": 115.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 66.0, 90.0, 102.0, 99.0, 86.0, 62.0, 53.0, 51.0], "value": 73.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 77.0, 76.0, 71.0, 70.0, 68.0, 68.0, 72.0, 76.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 89.0, 90.0, 88.0, 90.0, 92.0, 92.0, 89.0, 88.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 164.0, 160.0, 155.0, 159.0, 143.0, 140.0, 143.0, 193.0, 168.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 175.0, 175.0, 176.0, 175.0, 174.0, 171.0, 175.0, 174.0, 171.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 80.0, 86.0, 87.0, 89.0, 88.0, 67.0, 67.0, 66.0], "value": 77.1, "unit": "score"}]}]} 04:47:56 INFO - Return code: 0 04:47:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:47:56 ERROR - # TBPL SUCCESS # 04:47:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:56 INFO - 2017-01-10 04:47:56.386 screenresolution[1667:11370] starting screenresolution argv=screenresolution get 04:47:56 INFO - 2017-01-10 04:47:56.388 screenresolution[1667:11370] Display 0: 1600x1200x32@60 04:47:56 INFO - 2017-01-10 04:47:56.395 screenresolution[1668:11374] starting screenresolution argv=screenresolution list 04:47:56 INFO - Available Modes on Display 0 04:47:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:56 INFO - Intel Iris: 04:47:56 INFO - Chipset Model: Intel Iris 04:47:56 INFO - Type: GPU 04:47:56 INFO - Bus: Built-In 04:47:56 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:56 INFO - Vendor: Intel (0x8086) 04:47:56 INFO - Device ID: 0x0a2e 04:47:56 INFO - Revision ID: 0x0009 04:47:56 INFO - Displays: 04:47:56 INFO - Display: 04:47:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:56 INFO - Display Serial Number: 1600x1200 60 04:47:56 INFO - Main Display: Yes 04:47:56 INFO - Mirror: Off 04:47:56 INFO - Online: Yes 04:47:56 INFO - Rotation: Supported 04:47:56 INFO - Return code: 0 04:47:56 INFO - Running post-action listener: _resource_record_post_action 04:47:56 INFO - [mozharness: 2017-01-10 12:47:56.645942Z] Finished run-tests step (success) 04:47:56 INFO - Running post-run listener: _resource_record_post_run 04:47:56 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 33296384; Write bytes: 554390016; Read time: 196; Write time: 1694 04:47:56 INFO - TinderboxPrint: CPU usage
54.7% 04:47:56 INFO - TinderboxPrint: I/O read bytes / time
33,296,384 / 196 04:47:56 INFO - TinderboxPrint: I/O write bytes / time
554,390,016 / 1,694 04:47:56 INFO - TinderboxPrint: CPU idle
2,171.3 (45.3%) 04:47:56 INFO - TinderboxPrint: CPU system
970.3 (20.2%) 04:47:56 INFO - TinderboxPrint: CPU user
1,656.1 (34.5%) 04:47:56 INFO - TinderboxPrint: Swap in / out
279,302,144 / 0 04:47:56 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 229173760; Write bytes: 221523968; Read time: 16461; Write time: 471 04:47:56 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 32366592; Write bytes: 303829504; Read time: 185; Write time: 1155 04:47:57 INFO - Running post-run listener: _upload_blobber_files 04:47:57 INFO - Blob upload gear active. 04:47:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:57 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 04:47:57 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'] 04:47:57 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 04:47:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:47:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:47:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:59 INFO - (blobuploader) - INFO - Done attempting. 04:47:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:47:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:48:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:00 INFO - (blobuploader) - INFO - Done attempting. 04:48:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:48:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:01 INFO - (blobuploader) - INFO - Done attempting. 04:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:48:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:04 INFO - (blobuploader) - INFO - Done attempting. 04:48:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:04 INFO - Return code: 0 04:48:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad0055249a817583860137e2aff3ee59fa8f8ad7551966e682029f4257ad1be49adca2eee134c43104d511199e479df1831febea029ff8516f035e2c667850d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b01bd81ea7c766bbd5ea57b1df15a6a19691e540ae0113569a97c7630f900e0efb12a5bbc83925b8c3cc4eaa5e68164a83c8504dd62faeb317f4f4918687f885", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a52e50f00d70a5f0b42599ea3286f6158f45b371e3624f157bfae327c13c24b08512a0b570e004dcefd694f0f7c9d1932a74e094b0a2a065cc0c699688deb46b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2927833a4a640524942cebeb30cee5e006ddd8b007f01aa56532478a3b2f169d807941b069793c9a53301361602031baf34baa16994a0e5d7bffe52ac439ff3d"} 04:48:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:04 INFO - Contents: 04:48:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad0055249a817583860137e2aff3ee59fa8f8ad7551966e682029f4257ad1be49adca2eee134c43104d511199e479df1831febea029ff8516f035e2c667850d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b01bd81ea7c766bbd5ea57b1df15a6a19691e540ae0113569a97c7630f900e0efb12a5bbc83925b8c3cc4eaa5e68164a83c8504dd62faeb317f4f4918687f885", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a52e50f00d70a5f0b42599ea3286f6158f45b371e3624f157bfae327c13c24b08512a0b570e004dcefd694f0f7c9d1932a74e094b0a2a065cc0c699688deb46b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2927833a4a640524942cebeb30cee5e006ddd8b007f01aa56532478a3b2f169d807941b069793c9a53301361602031baf34baa16994a0e5d7bffe52ac439ff3d"} 04:48:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:04 INFO - Copying logs to upload dir... 04:48:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.799598 ========= master_lag: 1.44 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-10 04:48:05.586693) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2017-01-10 04:48:05.594323) ========= 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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad0055249a817583860137e2aff3ee59fa8f8ad7551966e682029f4257ad1be49adca2eee134c43104d511199e479df1831febea029ff8516f035e2c667850d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b01bd81ea7c766bbd5ea57b1df15a6a19691e540ae0113569a97c7630f900e0efb12a5bbc83925b8c3cc4eaa5e68164a83c8504dd62faeb317f4f4918687f885", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a52e50f00d70a5f0b42599ea3286f6158f45b371e3624f157bfae327c13c24b08512a0b570e004dcefd694f0f7c9d1932a74e094b0a2a065cc0c699688deb46b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2927833a4a640524942cebeb30cee5e006ddd8b007f01aa56532478a3b2f169d807941b069793c9a53301361602031baf34baa16994a0e5d7bffe52ac439ff3d"} build_url:https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011031 build_url: 'https://queue.taskcluster.net/v1/task/Fg5wNnOATF2NXDuuOInz6g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad0055249a817583860137e2aff3ee59fa8f8ad7551966e682029f4257ad1be49adca2eee134c43104d511199e479df1831febea029ff8516f035e2c667850d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b01bd81ea7c766bbd5ea57b1df15a6a19691e540ae0113569a97c7630f900e0efb12a5bbc83925b8c3cc4eaa5e68164a83c8504dd62faeb317f4f4918687f885", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a52e50f00d70a5f0b42599ea3286f6158f45b371e3624f157bfae327c13c24b08512a0b570e004dcefd694f0f7c9d1932a74e094b0a2a065cc0c699688deb46b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2927833a4a640524942cebeb30cee5e006ddd8b007f01aa56532478a3b2f169d807941b069793c9a53301361602031baf34baa16994a0e5d7bffe52ac439ff3d"}' ========= master_lag: 4.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2017-01-10 04:48:09.897603) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:48:09.898100) ========= 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.UduyAnpa1Z/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.HSpWR0bWSW/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.005345 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 04:48:09.930716) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 04:48:09.931103) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 04:48:09.931442) ========= ========= Total master_lag: 5.83 =========