builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0212 starttime: 1493803508.79 results: success (0) buildid: 20170503011121 builduid: 475dfeb79ada4388a6e975446d7047d7 revision: 604acb6a6aece0d9f296dbb7ca091f45713c0c9d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:08.792801) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:08.793249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:08.793520) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:08.821652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:08.822191) ========= 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.qyF9cscdHG/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.OTOLfox84k/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-05-03 02:25:08-- 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% 153M=0s 2017-05-03 02:25:08 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133698 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:08.982312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:08.982765) ========= 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.qyF9cscdHG/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.OTOLfox84k/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.025908 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:09.031702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 02:25:09.032063) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 604acb6a6aece0d9f296dbb7ca091f45713c0c9d --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 604acb6a6aece0d9f296dbb7ca091f45713c0c9d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qyF9cscdHG/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.OTOLfox84k/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-05-03 02:25:09,136 truncating revision to first 12 chars 2017-05-03 02:25:09,136 Setting DEBUG logging. 2017-05-03 02:25:09,136 attempt 1/10 2017-05-03 02:25:09,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/604acb6a6aec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 02:25:10,475 unpacking tar archive at: mozilla-central-604acb6a6aec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.614591 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 02:25:10.672750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:10.673147) ========= script_repo_revision: 604acb6a6aece0d9f296dbb7ca091f45713c0c9d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:10.673616) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:10.673947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 02:25:10.695205) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-05-03 02:25:10.695595) ========= /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.qyF9cscdHG/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.OTOLfox84k/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 02:25:10 INFO - MultiFileLogger online at 20170503 02:25:10 in /builds/slave/test 02:25:10 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 02:25:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:25:10 INFO - {'append_to_log': False, 02:25:10 INFO - 'base_work_dir': '/builds/slave/test', 02:25:10 INFO - 'blob_upload_branch': 'Firefox', 02:25:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:25:10 INFO - 'branch': 'Firefox', 02:25:10 INFO - 'buildbot_json_path': 'buildprops.json', 02:25:10 INFO - 'config_files': ('talos/mac_config.py',), 02:25:10 INFO - 'default_actions': ('clobber', 02:25:10 INFO - 'read-buildbot-config', 02:25:10 INFO - 'download-and-extract', 02:25:10 INFO - 'populate-webroot', 02:25:10 INFO - 'create-virtualenv', 02:25:10 INFO - 'install', 02:25:10 INFO - 'run-tests'), 02:25:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:25:10 INFO - 'download_minidump_stackwalk': True, 02:25:10 INFO - 'download_symbols': 'ondemand', 02:25:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:25:10 INFO - 'tooltool.py': '/tools/tooltool.py', 02:25:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:25:10 INFO - '/tools/misc-python/virtualenv.py')}, 02:25:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:25:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:25:10 INFO - 'gecko_profile': False, 02:25:10 INFO - 'gecko_profile_interval': 0, 02:25:10 INFO - 'installer_path': 'installer.exe', 02:25:10 INFO - 'log_level': 'info', 02:25:10 INFO - 'log_name': 'talos', 02:25:10 INFO - 'log_to_console': True, 02:25:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:25:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:25:10 INFO - 'opt_config_files': (), 02:25:10 INFO - 'pip_index': False, 02:25:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:25:10 INFO - 'cmd': ('bash', 02:25:10 INFO - '-c', 02:25:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:25:10 INFO - 'enabled': True, 02:25:10 INFO - 'halt_on_failure': False, 02:25:10 INFO - 'name': 'check_screen_resolution'},), 02:25:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:25:10 INFO - 'cmd': ('bash', 02:25:10 INFO - '-c', 02:25:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:25:10 INFO - 'enabled': True, 02:25:10 INFO - 'halt_on_failure': False, 02:25:10 INFO - 'name': 'check_screen_resolution'},), 02:25:10 INFO - 'run_cmd_checks_enabled': True, 02:25:10 INFO - 'suite': 'dromaeojs-e10s', 02:25:10 INFO - 'system_bits': '32', 02:25:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:25:10 INFO - 'title': 't-yosemite-r7-0212', 02:25:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:25:10 INFO - 'use_talos_json': True, 02:25:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:25:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:25:10 INFO - 'work_dir': 'build'} 02:25:10 INFO - [mozharness: 2017-05-03 09:25:10.908175Z] Running clobber step. 02:25:10 INFO - Running pre-action listener: _resource_record_pre_action 02:25:10 INFO - Running main action method: clobber 02:25:10 INFO - rmtree: /builds/slave/test/build 02:25:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:25:13 INFO - Running post-action listener: _resource_record_post_action 02:25:13 INFO - [mozharness: 2017-05-03 09:25:13.420312Z] Finished clobber step (success) 02:25:13 INFO - [mozharness: 2017-05-03 09:25:13.420438Z] Running read-buildbot-config step. 02:25:13 INFO - Running pre-action listener: _resource_record_pre_action 02:25:13 INFO - Running main action method: read_buildbot_config 02:25:13 INFO - Using buildbot properties: 02:25:13 INFO - { 02:25:13 INFO - "project": "", 02:25:13 INFO - "product": "firefox", 02:25:13 INFO - "script_repo_revision": "production", 02:25:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:25:13 INFO - "repository": "", 02:25:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:25:13 INFO - "buildid": "20170503011121", 02:25:13 INFO - "pgo_build": "False", 02:25:13 INFO - "basedir": "/builds/slave/test", 02:25:13 INFO - "buildnumber": 59, 02:25:13 INFO - "slavename": "t-yosemite-r7-0212", 02:25:13 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:25:13 INFO - "platform": "yosemite_r7", 02:25:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:25:13 INFO - "branch": "mozilla-central", 02:25:13 INFO - "repo_path": "mozilla-central", 02:25:13 INFO - "revision": "604acb6a6aece0d9f296dbb7ca091f45713c0c9d", 02:25:13 INFO - "stage_platform": "macosx64", 02:25:13 INFO - "builduid": "475dfeb79ada4388a6e975446d7047d7", 02:25:13 INFO - "slavebuilddir": "test" 02:25:13 INFO - } 02:25:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 02:25:13 INFO - Running post-action listener: _resource_record_post_action 02:25:13 INFO - [mozharness: 2017-05-03 09:25:13.425417Z] Finished read-buildbot-config step (success) 02:25:13 INFO - [mozharness: 2017-05-03 09:25:13.425609Z] Running download-and-extract step. 02:25:13 INFO - Running pre-action listener: _resource_record_pre_action 02:25:13 INFO - Running main action method: download_and_extract 02:25:13 INFO - mkdir: /builds/slave/test/build/tests 02:25:13 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')]} 02:25:13 INFO - trying https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 02:25:13 INFO - Downloading https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 02:25:14 INFO - Downloaded 1325 bytes. 02:25:14 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:25:14 INFO - Using the following test package requirements: 02:25:14 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:25:14 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 02:25:14 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:25:14 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:25:14 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 02:25:14 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:25:14 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 02:25:14 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:25:14 INFO - u'jsshell-mac.zip'], 02:25:14 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:25:14 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 02:25:14 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:25:14 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:25:14 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 02:25:14 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:25:14 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 02:25:14 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:25:14 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 02:25:14 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:25:14 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 02:25:14 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:25:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:25:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:25:14 INFO - Fetch https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:25:16 INFO - Content-Length response header: 52699688 02:25:16 INFO - Bytes received: 52699688 02:25:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:25:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:25:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:25:32 INFO - Fetch https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:25:34 INFO - Content-Length response header: 52699688 02:25:34 INFO - Bytes received: 52699688 02:25:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 02:25:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:25:50 INFO - Fetch https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 02:25:51 INFO - Content-Length response header: 14408811 02:25:51 INFO - Bytes received: 14408811 02:25:51 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')]} 02:25:51 INFO - trying https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:25:51 INFO - Downloading https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 02:25:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 02:25:53 INFO - Downloaded 71203800 bytes. 02:25:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:25:53 INFO - mkdir: /builds/slave/test/properties 02:25:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:25:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:25:53 INFO - Contents: 02:25:53 INFO - build_url:https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:25:54 INFO - Running post-action listener: _resource_record_post_action 02:25:54 INFO - Running post-action listener: set_extra_try_arguments 02:25:54 INFO - [mozharness: 2017-05-03 09:25:54.156261Z] Finished download-and-extract step (success) 02:25:54 INFO - [mozharness: 2017-05-03 09:25:54.156403Z] Running populate-webroot step. 02:25:54 INFO - Running pre-action listener: _resource_record_pre_action 02:25:54 INFO - Running main action method: populate_webroot 02:25:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:25:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:25:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:25:54 INFO - '--tppagecycles', 02:25:54 INFO - '7'], 02:25:54 INFO - 'tests': ['tsvgm']}}, 02:25:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:25:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:25:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:25:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:25:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:25:54 INFO - 'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:25:54 INFO - 'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['damp', 'tps']}, 02:25:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:25:54 INFO - 'tests': ['damp', 'tps']}, 02:25:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['dromaeo_dom']}, 02:25:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:25:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:25:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:25:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['a11yr', 02:25:54 INFO - 'ts_paint', 02:25:54 INFO - 'tpaint', 02:25:54 INFO - 'sessionrestore', 02:25:54 INFO - 'sessionrestore_no_auto_restore', 02:25:54 INFO - 'tabpaint']}, 02:25:54 INFO - 'other-e10s': {'tests': ['a11yr', 02:25:54 INFO - 'ts_paint', 02:25:54 INFO - 'tpaint', 02:25:54 INFO - 'sessionrestore', 02:25:54 INFO - 'sessionrestore_no_auto_restore', 02:25:54 INFO - 'tabpaint']}, 02:25:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:25:54 INFO - 'ts_paint', 02:25:54 INFO - 'tpaint', 02:25:54 INFO - 'sessionrestore', 02:25:54 INFO - 'sessionrestore_no_auto_restore', 02:25:54 INFO - 'tabpaint']}, 02:25:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:25:54 INFO - 'ts_paint', 02:25:54 INFO - 'tpaint', 02:25:54 INFO - 'sessionrestore', 02:25:54 INFO - 'sessionrestore_no_auto_restore', 02:25:54 INFO - 'tabpaint']}, 02:25:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['a11yr', 02:25:54 INFO - 'ts_paint', 02:25:54 INFO - 'tpaint', 02:25:54 INFO - 'sessionrestore', 02:25:54 INFO - 'sessionrestore_no_auto_restore', 02:25:54 INFO - 'tabpaint']}, 02:25:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['a11yr', 02:25:54 INFO - 'ts_paint', 02:25:54 INFO - 'tpaint', 02:25:54 INFO - 'sessionrestore', 02:25:54 INFO - 'sessionrestore_no_auto_restore', 02:25:54 INFO - 'tabpaint']}, 02:25:54 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:25:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:25:54 INFO - 'bloom_basic_ref']}, 02:25:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['tsvgx', 02:25:54 INFO - 'tsvgr_opacity', 02:25:54 INFO - 'tart', 02:25:54 INFO - 'tscrollx', 02:25:54 INFO - 'cart', 02:25:54 INFO - 'tsvg_static']}, 02:25:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:25:54 INFO - 'tsvgr_opacity', 02:25:54 INFO - 'tart', 02:25:54 INFO - 'tscrollx', 02:25:54 INFO - 'cart', 02:25:54 INFO - 'tsvg_static']}, 02:25:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:25:54 INFO - 'talos_options': ['--disable-e10s'], 02:25:54 INFO - 'tests': ['tp5o']}, 02:25:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:25:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:25:54 INFO - 'talos_options': ['--disable-e10s', 02:25:54 INFO - '--xperf_path', 02:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:54 INFO - 'tests': ['tp5n']}, 02:25:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:25:54 INFO - 'talos_options': ['--xperf_path', 02:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:54 INFO - 'tests': ['tp5n']}}, 02:25:54 INFO - 'talos.zip': {'path': '', 02:25:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:25:54 INFO - Running post-action listener: _resource_record_post_action 02:25:54 INFO - [mozharness: 2017-05-03 09:25:54.175575Z] Finished populate-webroot step (success) 02:25:54 INFO - [mozharness: 2017-05-03 09:25:54.175686Z] Running create-virtualenv step. 02:25:54 INFO - Running pre-action listener: _resource_record_pre_action 02:25:54 INFO - Running main action method: create_virtualenv 02:25:54 INFO - Creating virtualenv /builds/slave/test/build/venv 02:25:54 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 02:25:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:25:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:25:54 INFO - Using real prefix '/tools/python27' 02:25:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:25:55 INFO - Installing distribute.............................................................................................................................................................................................done. 02:25:57 INFO - Installing pip.................done. 02:25:57 INFO - Return code: 0 02:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:25:58 INFO - Reading from file tmpfile_stdout 02:25:58 INFO - Output received: 02:25:58 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) 02:25:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:58 INFO - 'HOME': '/Users/cltbld', 02:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:58 INFO - 'LOGNAME': 'cltbld', 02:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:58 INFO - 'MOZ_NO_REMOTE': '1', 02:25:58 INFO - 'NO_EM_RESTART': '1', 02:25:58 INFO - 'PAGER': '/bin/cat', 02:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:58 INFO - 'PWD': '/builds/slave/test', 02:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:58 INFO - 'SHELL': '/bin/bash', 02:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:25:58 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:58 INFO - 'USER': 'cltbld', 02:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:58 INFO - 'XPC_FLAGS': '0x0', 02:25:58 INFO - 'XPC_SERVICE_NAME': '0', 02:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:58 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 02:25:58 INFO - Cleaning up... 02:25:58 INFO - Return code: 0 02:25:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:58 INFO - 'HOME': '/Users/cltbld', 02:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:58 INFO - 'LOGNAME': 'cltbld', 02:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:58 INFO - 'MOZ_NO_REMOTE': '1', 02:25:58 INFO - 'NO_EM_RESTART': '1', 02:25:58 INFO - 'PAGER': '/bin/cat', 02:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:58 INFO - 'PWD': '/builds/slave/test', 02:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:58 INFO - 'SHELL': '/bin/bash', 02:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:25:58 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:58 INFO - 'USER': 'cltbld', 02:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:58 INFO - 'XPC_FLAGS': '0x0', 02:25:58 INFO - 'XPC_SERVICE_NAME': '0', 02:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:58 INFO - Downloading/unpacking psutil>=3.1.1 02:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:00 INFO - Installing collected packages: psutil 02:26:00 INFO - Running setup.py install for psutil 02:26:01 INFO - building 'psutil._psutil_osx' extension 02:26:01 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 02:26:01 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 02:26:01 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 02:26:01 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 02:26:01 INFO - building 'psutil._psutil_posix' extension 02:26:01 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 02:26:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:26:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:26:01 INFO - ^ 02:26:01 INFO - 1 warning generated. 02:26:01 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 02:26:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:02 INFO - Successfully installed psutil 02:26:02 INFO - Cleaning up... 02:26:02 INFO - Return code: 0 02:26:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:02 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 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:26:02 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 02:26:02 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 02:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:02 INFO - 'HOME': '/Users/cltbld', 02:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:02 INFO - 'LOGNAME': 'cltbld', 02:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:02 INFO - 'MOZ_NO_REMOTE': '1', 02:26:02 INFO - 'NO_EM_RESTART': '1', 02:26:02 INFO - 'PAGER': '/bin/cat', 02:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:02 INFO - 'PWD': '/builds/slave/test', 02:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:02 INFO - 'SHELL': '/bin/bash', 02:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:26:02 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:02 INFO - 'USER': 'cltbld', 02:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:02 INFO - 'XPC_FLAGS': '0x0', 02:26:02 INFO - 'XPC_SERVICE_NAME': '0', 02:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:26:02 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 02:26:02 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 02:26:02 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 02:26:02 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 02:26:02 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 02:26:02 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 02:26:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:26:05 INFO - Installing collected packages: mozsystemmonitor 02:26:05 INFO - Running setup.py install for mozsystemmonitor 02:26:05 INFO - Successfully installed mozsystemmonitor 02:26:05 INFO - Cleaning up... 02:26:05 INFO - Return code: 0 02:26:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:06 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')]} 02:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:06 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 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:26:06 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 02:26:06 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 02:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:06 INFO - 'HOME': '/Users/cltbld', 02:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:06 INFO - 'LOGNAME': 'cltbld', 02:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:06 INFO - 'MOZ_NO_REMOTE': '1', 02:26:06 INFO - 'NO_EM_RESTART': '1', 02:26:06 INFO - 'PAGER': '/bin/cat', 02:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:06 INFO - 'PWD': '/builds/slave/test', 02:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:06 INFO - 'SHELL': '/bin/bash', 02:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:26:06 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:06 INFO - 'USER': 'cltbld', 02:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:06 INFO - 'XPC_FLAGS': '0x0', 02:26:06 INFO - 'XPC_SERVICE_NAME': '0', 02:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:06 INFO - Downloading/unpacking jsonschema==2.5.1 02:26:06 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 02:26:06 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 02:26:06 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 02:26:06 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 02:26:06 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 02:26:06 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 02:26:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:26:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:26:07 INFO - warning: no files found matching '*.txt' 02:26:07 INFO - no previously-included directories found matching 'build' 02:26:07 INFO - no previously-included directories found matching 'dist' 02:26:07 INFO - no previously-included directories found matching '.git*' 02:26:07 INFO - Installing collected packages: jsonschema, functools32 02:26:08 INFO - Running setup.py install for functools32 02:26:08 INFO - warning: no files found matching '*.txt' 02:26:08 INFO - no previously-included directories found matching 'build' 02:26:08 INFO - no previously-included directories found matching 'dist' 02:26:08 INFO - no previously-included directories found matching '.git*' 02:26:08 INFO - Successfully installed jsonschema functools32 02:26:08 INFO - Cleaning up... 02:26:08 INFO - Return code: 0 02:26:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:26:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:26:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:08 INFO - 'HOME': '/Users/cltbld', 02:26:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:08 INFO - 'LOGNAME': 'cltbld', 02:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:08 INFO - 'MOZ_NO_REMOTE': '1', 02:26:08 INFO - 'NO_EM_RESTART': '1', 02:26:08 INFO - 'PAGER': '/bin/cat', 02:26:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:08 INFO - 'PWD': '/builds/slave/test', 02:26:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:08 INFO - 'SHELL': '/bin/bash', 02:26:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:26:08 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:26:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:08 INFO - 'USER': 'cltbld', 02:26:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:08 INFO - 'XPC_FLAGS': '0x0', 02:26:08 INFO - 'XPC_SERVICE_NAME': '0', 02:26:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:26:08 INFO - Cleaning up... 02:26:08 INFO - Return code: 0 02:26:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:26:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:26:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:08 INFO - 'HOME': '/Users/cltbld', 02:26:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:08 INFO - 'LOGNAME': 'cltbld', 02:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:08 INFO - 'MOZ_NO_REMOTE': '1', 02:26:08 INFO - 'NO_EM_RESTART': '1', 02:26:08 INFO - 'PAGER': '/bin/cat', 02:26:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:08 INFO - 'PWD': '/builds/slave/test', 02:26:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:08 INFO - 'SHELL': '/bin/bash', 02:26:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:26:08 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:26:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:08 INFO - 'USER': 'cltbld', 02:26:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:08 INFO - 'XPC_FLAGS': '0x0', 02:26:08 INFO - 'XPC_SERVICE_NAME': '0', 02:26:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:10 INFO - Downloading blobuploader-1.2.4.tar.gz 02:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:26:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:26:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:10 INFO - Downloading docopt-0.6.1.tar.gz 02:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:26:11 INFO - Installing collected packages: blobuploader, requests, docopt 02:26:11 INFO - Running setup.py install for blobuploader 02:26:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:26:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:26:11 INFO - Running setup.py install for requests 02:26:11 INFO - Running setup.py install for docopt 02:26:11 INFO - Successfully installed blobuploader requests docopt 02:26:11 INFO - Cleaning up... 02:26:11 INFO - Return code: 0 02:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:11 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')]} 02:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:11 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')]} 02:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:11 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 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:26:11 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 02:26:11 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 02:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:11 INFO - 'HOME': '/Users/cltbld', 02:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:11 INFO - 'LOGNAME': 'cltbld', 02:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:11 INFO - 'MOZ_NO_REMOTE': '1', 02:26:11 INFO - 'NO_EM_RESTART': '1', 02:26:11 INFO - 'PAGER': '/bin/cat', 02:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:11 INFO - 'PWD': '/builds/slave/test', 02:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:11 INFO - 'SHELL': '/bin/bash', 02:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:26:11 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:11 INFO - 'USER': 'cltbld', 02:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:11 INFO - 'XPC_FLAGS': '0x0', 02:26:11 INFO - 'XPC_SERVICE_NAME': '0', 02:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-bCA25F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-dhNhuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-1wwtFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-NEl8My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-TdlsNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-G0tlBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-YDejVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-VzjXah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-ORB_3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-kRQliH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-PbTsw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-lEKy3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-0IWWsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-4KZxOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-TDjXhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-RvilZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-CBKdF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:26:13 INFO - Running setup.py install for manifestparser 02:26:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:26:14 INFO - Running setup.py install for mozcrash 02:26:14 INFO - Running setup.py install for mozdebug 02:26:14 INFO - Running setup.py install for mozdevice 02:26:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:26:14 INFO - Running setup.py install for mozfile 02:26:14 INFO - Running setup.py install for mozhttpd 02:26:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:26:14 INFO - Running setup.py install for mozinfo 02:26:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:26:14 INFO - Running setup.py install for mozInstall 02:26:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:26:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:26:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:26:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:26:15 INFO - Running setup.py install for mozleak 02:26:15 INFO - Running setup.py install for mozlog 02:26:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:26:15 INFO - Running setup.py install for moznetwork 02:26:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:26:15 INFO - Running setup.py install for mozprocess 02:26:15 INFO - Running setup.py install for mozprofile 02:26:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:26:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:26:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:26:15 INFO - Running setup.py install for mozrunner 02:26:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:26:16 INFO - Running setup.py install for mozscreenshot 02:26:16 INFO - Running setup.py install for moztest 02:26:16 INFO - Running setup.py install for mozversion 02:26:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:26:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:26:16 INFO - Cleaning up... 02:26:16 INFO - Return code: 0 02:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:16 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 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:26:16 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 02:26:16 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 02:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:16 INFO - 'HOME': '/Users/cltbld', 02:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:16 INFO - 'LOGNAME': 'cltbld', 02:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:16 INFO - 'MOZ_NO_REMOTE': '1', 02:26:16 INFO - 'NO_EM_RESTART': '1', 02:26:16 INFO - 'PAGER': '/bin/cat', 02:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:16 INFO - 'PWD': '/builds/slave/test', 02:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:16 INFO - 'SHELL': '/bin/bash', 02:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:26:16 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:16 INFO - 'USER': 'cltbld', 02:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:16 INFO - 'XPC_FLAGS': '0x0', 02:26:16 INFO - 'XPC_SERVICE_NAME': '0', 02:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:16 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-hqdKmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:16 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)) 02:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:16 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-VzI1CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:16 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)) 02:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:16 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-MtTuvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:17 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)) 02:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:17 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-LkkDqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 02:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:17 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-2CKIOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:17 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)) 02:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:17 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-8XAJ0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:17 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)) 02:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:17 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-HBE6MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:17 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)) 02:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:17 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-cYbJgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:17 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)) 02:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:17 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-8KwXxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:17 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)) 02:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:17 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-FPvUmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:17 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)) 02:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:17 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-DhwnUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:17 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)) 02:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:17 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-EZ4YmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:18 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-dD92DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:18 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)) 02:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:18 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-6P1luP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:18 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)) 02:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:18 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-oMVor5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:18 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)) 02:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:18 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-WjOSAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:18 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)) 02:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:18 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-EjoYve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:18 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)) 02:26:18 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)) 02:26:18 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)) 02:26:18 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)) 02:26:18 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:18 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:18 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 02:26:18 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 02:26:18 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 02:26:18 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 02:26:18 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 02:26:18 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 02:26:19 INFO - Downloading blessings-1.6.tar.gz 02:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:20 INFO - Installing collected packages: blessings 02:26:20 INFO - Running setup.py install for blessings 02:26:20 INFO - Successfully installed blessings 02:26:20 INFO - Cleaning up... 02:26:20 INFO - Return code: 0 02:26:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:20 INFO - Reading from file tmpfile_stdout 02:26:20 INFO - Current package versions: 02:26:20 INFO - blessings == 1.6 02:26:20 INFO - blobuploader == 1.2.4 02:26:20 INFO - docopt == 0.6.1 02:26:20 INFO - functools32 == 3.2.3-2 02:26:20 INFO - jsonschema == 2.5.1 02:26:20 INFO - manifestparser == 1.1 02:26:20 INFO - mozInstall == 1.12 02:26:20 INFO - mozcrash == 1.0 02:26:20 INFO - mozdebug == 0.1 02:26:20 INFO - mozdevice == 0.50 02:26:20 INFO - mozfile == 1.2 02:26:20 INFO - mozhttpd == 0.7 02:26:20 INFO - mozinfo == 0.9 02:26:20 INFO - mozleak == 0.1 02:26:20 INFO - mozlog == 3.4 02:26:20 INFO - moznetwork == 0.27 02:26:20 INFO - mozprocess == 0.25 02:26:20 INFO - mozprofile == 0.28 02:26:20 INFO - mozrunner == 6.13 02:26:20 INFO - mozscreenshot == 0.1 02:26:20 INFO - mozsystemmonitor == 0.3 02:26:20 INFO - moztest == 0.8 02:26:20 INFO - mozversion == 1.4 02:26:20 INFO - psutil == 3.1.1 02:26:20 INFO - requests == 1.2.3 02:26:20 INFO - wsgiref == 0.1.2 02:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:20 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')]} 02:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:20 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')]} 02:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:20 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 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:26:20 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 02:26:20 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 02:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:20 INFO - 'HOME': '/Users/cltbld', 02:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:20 INFO - 'LOGNAME': 'cltbld', 02:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:20 INFO - 'MOZ_NO_REMOTE': '1', 02:26:20 INFO - 'NO_EM_RESTART': '1', 02:26:20 INFO - 'PAGER': '/bin/cat', 02:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:20 INFO - 'PWD': '/builds/slave/test', 02:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:20 INFO - 'SHELL': '/bin/bash', 02:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:26:20 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:20 INFO - 'USER': 'cltbld', 02:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:20 INFO - 'XPC_FLAGS': '0x0', 02:26:20 INFO - 'XPC_SERVICE_NAME': '0', 02:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:20 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)) 02:26:20 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)) 02:26:20 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)) 02:26:20 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)) 02:26:20 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)) 02:26:20 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)) 02:26:20 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)) 02:26:20 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)) 02:26:20 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)) 02:26:20 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)) 02:26:20 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)) 02:26:20 INFO - Cleaning up... 02:26:20 INFO - Return code: 0 02:26:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26:20 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')]} 02:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:20 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')]} 02:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:20 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 0x102013b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102016768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facb8562a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, '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.qyF9cscdHG/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.OTOLfox84k/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 02:26:20 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 02:26:20 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 02:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:20 INFO - 'HOME': '/Users/cltbld', 02:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:20 INFO - 'LOGNAME': 'cltbld', 02:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:20 INFO - 'MOZ_NO_REMOTE': '1', 02:26:20 INFO - 'NO_EM_RESTART': '1', 02:26:20 INFO - 'PAGER': '/bin/cat', 02:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:20 INFO - 'PWD': '/builds/slave/test', 02:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:20 INFO - 'SHELL': '/bin/bash', 02:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:26:20 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:20 INFO - 'USER': 'cltbld', 02:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:20 INFO - 'XPC_FLAGS': '0x0', 02:26:20 INFO - 'XPC_SERVICE_NAME': '0', 02:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:21 INFO - Cleaning up... 02:26:21 INFO - Return code: 0 02:26:21 INFO - Running post-action listener: _resource_record_post_action 02:26:21 INFO - Running post-action listener: _start_resource_monitoring 02:26:21 INFO - Starting resource monitoring. 02:26:21 INFO - [mozharness: 2017-05-03 09:26:21.135365Z] Finished create-virtualenv step (success) 02:26:21 INFO - [mozharness: 2017-05-03 09:26:21.136329Z] Running install step. 02:26:21 INFO - Running pre-action listener: _resource_record_pre_action 02:26:21 INFO - Running main action method: install 02:26:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:21 INFO - Reading from file tmpfile_stdout 02:26:21 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:21 INFO - Reading from file tmpfile_stdout 02:26:21 INFO - Output received: 02:26:21 INFO - Usage: mozinstall [options] installer 02:26:21 INFO - Options: 02:26:21 INFO - -h, --help show this help message and exit 02:26:21 INFO - -d DEST, --destination=DEST 02:26:21 INFO - Directory to install application into. [default: 02:26:21 INFO - "/builds/slave/test"] 02:26:21 INFO - --app=APP Application being installed. [default: firefox] 02:26:21 INFO - mkdir: /builds/slave/test/build/application 02:26:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:26:41 INFO - Reading from file tmpfile_stdout 02:26:41 INFO - Output received: 02:26:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:26:41 INFO - Running post-action listener: _resource_record_post_action 02:26:41 INFO - [mozharness: 2017-05-03 09:26:41.222132Z] Finished install step (success) 02:26:41 INFO - [mozharness: 2017-05-03 09:26:41.222283Z] Running run-tests step. 02:26:41 INFO - Running pre-action listener: _resource_record_pre_action 02:26:41 INFO - Running main action method: run_tests 02:26:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:26:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:26:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:26:41 INFO - 2017-05-03 02:26:41.236 screenresolution[1628:7601] starting screenresolution argv=screenresolution get 02:26:41 INFO - 2017-05-03 02:26:41.239 screenresolution[1628:7601] Display 0: 1600x1200x32@60 02:26:41 INFO - 2017-05-03 02:26:41.245 screenresolution[1629:7604] starting screenresolution argv=screenresolution list 02:26:41 INFO - Available Modes on Display 0 02:26:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:26:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:26:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:26:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:26:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:26:41 INFO - Intel Iris: 02:26:41 INFO - Chipset Model: Intel Iris 02:26:41 INFO - Type: GPU 02:26:41 INFO - Bus: Built-In 02:26:41 INFO - VRAM (Dynamic, Max): 1536 MB 02:26:41 INFO - Vendor: Intel (0x8086) 02:26:41 INFO - Device ID: 0x0a2e 02:26:41 INFO - Revision ID: 0x0009 02:26:41 INFO - Displays: 02:26:41 INFO - Display: 02:26:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:26:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:26:41 INFO - Display Serial Number: 1600x1200 60 02:26:41 INFO - Main Display: Yes 02:26:41 INFO - Mirror: Off 02:26:41 INFO - Online: Yes 02:26:41 INFO - Rotation: Supported 02:26:41 INFO - Return code: 0 02:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:26:41 INFO - Python 2.7.3 02:26:41 INFO - Return code: 0 02:26:41 INFO - grabbing minidump binary from tooltool 02:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:41 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 0x101df1d30>, '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 0x101d17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:26:41 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 02:26:41 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 02:26:41 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 02:26:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:26:41 INFO - Return code: 0 02:26:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:26:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:26:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:26:41 INFO - ENV: RUST_BACKTRACE is now 1 02:26:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:26:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:26:41 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.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 02:26:41 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.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 02:26:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qyF9cscdHG/Render', 02:26:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:41 INFO - 'HOME': '/Users/cltbld', 02:26:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:41 INFO - 'LOGNAME': 'cltbld', 02:26:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:26:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:41 INFO - 'MOZ_NO_REMOTE': '1', 02:26:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:26:41 INFO - 'NO_EM_RESTART': '1', 02:26:41 INFO - 'PAGER': '/bin/cat', 02:26:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:41 INFO - 'PWD': '/builds/slave/test', 02:26:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:26:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:41 INFO - 'RUST_BACKTRACE': '1', 02:26:41 INFO - 'SHELL': '/bin/bash', 02:26:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OTOLfox84k/Listeners', 02:26:41 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 02:26:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:41 INFO - 'USER': 'cltbld', 02:26:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:41 INFO - 'XPC_FLAGS': '0x0', 02:26:41 INFO - 'XPC_SERVICE_NAME': '0', 02:26:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:41 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.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 02:26:41 INFO - mozversion application_buildid: 20170503011121 02:26:41 INFO - mozversion application_changeset: 604acb6a6aece0d9f296dbb7ca091f45713c0c9d 02:26:41 INFO - mozversion application_display_name: Nightly 02:26:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:26:41 INFO - mozversion application_name: Firefox 02:26:41 INFO - mozversion application_remotingname: firefox 02:26:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:26:41 INFO - mozversion application_vendor: Mozilla 02:26:41 INFO - mozversion application_version: 55.0a1 02:26:41 INFO - mozversion platform_buildid: 20170503011121 02:26:41 INFO - mozversion platform_changeset: 604acb6a6aece0d9f296dbb7ca091f45713c0c9d 02:26:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:26:41 INFO - mozversion platform_version: 55.0a1 02:26:41 INFO - using testdate: 1493803601 02:26:41 INFO - actual date: 1493803601 02:26:41 INFO - starting webserver on 'localhost:49242' 02:26:41 INFO - SUITE-START | Running 2 tests 02:26:41 INFO - TEST-START | dromaeo_css 02:26:41 INFO - operating with platform_type : mac_ 02:26:41 INFO - Initialising browser for dromaeo_css test... 02:26:41 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp1uKnO1/profile http://localhost:49242/getInfo.html) 02:26:44 INFO - PID 1639 | 2017-05-03 02:26:44.859 plugin-container[1641:7785] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 02:26:44 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:26:44 INFO - PID 1639 | 2017-05-03 02:26:44.861 plugin-container[1641:7785] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f0b, name = 'com.apple.CFPasteboardClient' 02:26:44 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:26:44 INFO - PID 1639 | 2017-05-03 02:26:44.861 plugin-container[1641:7785] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:26:44 INFO - PID 1639 | __metrics Screen width/height:1600/1200 02:26:44 INFO - PID 1639 | colorDepth:24 02:26:44 INFO - PID 1639 | Browser inner width/height: 1024/691 02:26:44 INFO - PID 1639 | __metrics 02:26:45 INFO - TEST-INFO | 1639: exit 0 02:26:45 INFO - Browser initialized. 02:26:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:26:45 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp1uKnO1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:48 INFO - PID 1642 | 2017-05-03 02:26:48.137 plugin-container[1643:7923] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 02:26:48 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:26:48 INFO - PID 1642 | 2017-05-03 02:26:48.137 plugin-container[1643:7923] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 02:26:48 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:26:48 INFO - PID 1642 | 2017-05-03 02:26:48.137 plugin-container[1643:7923] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:26:57 INFO - PID 1642 | RSS: Main: 234659840 02:26:57 INFO - PID 1642 | 02:30:01 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 02:30:02 INFO - PID 1642 | RSS: Main: 250445824 02:30:02 INFO - PID 1642 | 02:33:04 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 02:33:05 INFO - PID 1642 | RSS: Main: 256585728 02:33:05 INFO - PID 1642 | 02:36:06 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 02:36:07 INFO - PID 1642 | RSS: Main: 265408512 02:36:07 INFO - PID 1642 | 02:39:09 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 02:39:09 INFO - PID 1642 | RSS: Main: 258330624 02:39:09 INFO - PID 1642 | 02:42:12 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 02:42:13 INFO - PID 1642 | RSS: Main: 262721536 02:42:13 INFO - PID 1642 | 02:45:15 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 02:45:15 INFO - PID 1642 | RSS: Main: 261513216 02:45:15 INFO - PID 1642 | 02:45:15 INFO - PID 1642 | __start_tp_report 02:45:15 INFO - PID 1642 | _x_x_mozilla_page_load 02:45:15 INFO - PID 1642 | _x_x_mozilla_page_load_details 02:45:15 INFO - PID 1642 | |i|pagename|runs| 02:45:15 INFO - PID 1642 | |0;dojo.html;3433.313337332534;3588.8923332300024;3616.6021737608867;3638.5451818522674;3641.890743277701;6126.326104128542;6145.17040199573;6194.814155575335;6202.348753380892;6264;6145.586515101518;6183.814485565429;6196.225471816023;6225.501959843213;6235.376462353763;5307.018201632691;5417.079096553595;5462.235287059795;5476.507114359717;5529.198266251391;5540.085885828834;5592.636478628897;5592.832215033535;5593.916091258634;5626.099824028156;5467.753951072212;5492.835214943558;5495.752691128869;5504.972475137619;5526.336839579236;5469.945300547023;5480.890382192334;5483.314585676791;5503.2020357048405;5518.779248830042;5412.621116521845;5446.509814116748;5451.945480545183;5470.91793623096;5531.834044978657;5153.201253805666;5217.817376391846;6145.2178868128185;6160.4455598995855;6163.476104531121;6615.669216539202;6665.766698165541;6667.033280174396;6684.86630267392;6696.799096027127;6732.865342693168;6734.3602357775935;6740.865182696319;6758.628275444848;6770.289119642416;6082.756689732361;6167.660778657217;6291.245050593912;6313.652749098797;6326;6785.321467853175;6834.555753875982;6902.689378977958;6908.723651053901;6927.618980956096;6331.113644089831;6409.359064093554;6409.647469389229;6517.771877984248;6523.282438931714;6583.177102862142;6615.503837212132;6674.733010679615;6727;6762.087118238975;6599;6609.570377925419;6619.635920024445;6626.469882409396;6638.203415590064;6408.743650253938;6476.546641735127;6537.5096867734155;6578.605283682994;6627.403533681992;5281.867953301121;5293.3647962244;5298;5301.5493683037375;5344.518993290545;3607.8376473058775;4579.992401671627;4697.671163018625;4708.4349878014855;4736.407949006374;5045.344105266292;5302.443243459458;6270.122182894398;6296.401841825019;6378.71496179468;6639.535232533676;6710.463162946952;6724.731010759613;6739.460843132538;6766.864662706718;4884.755762211875;6212.072424640248;6232.439080482778;6277.497800175975;6283.560150789401;5065.670731402447;5685.403032681509;5751.884962300731;5759.308882933991;5762.855928601818;6802.761903333359;6899.310068993061;6927.965360173167;6944.583325000516;6977.302269772982;6782.762603308861;6798.048273241849;6804.795856124324;6817.761378351734;6831.795046148623;6945.791626251221;6951.374376306157;6958.443324533924;7020.122484689414;7037.824054398681;6479.643619600779;6560.114384558024;6569.540132190892;6595.934040659724;6685.899711504234;5616.747246374005;6766.5263431559315;6772.93227067723;6787.457003439812;6789.966050169717;6286.811395658137;6448.355164483702;6448.709808058742;6571.178602674666;6586.1438013058;6422.6467544285515;6536.509761767791;6537.967310163609;6541.149650545399;6542.247641521286;6207.286162091236;6292.087647291026;6311.715972781144;6320.494360451245;6320.988641817287;6466.676666166767;6525.1517302750335;6580.8354791130605;6585.703643335965;6610.6694665267505;5249.553787928069;6402;6406.295307516262;6410.230772307353;6432.2281326241155 02:45:15 INFO - PID 1642 | |1;ext.html;684.962327072011;828.9419740618157;1204.6506513111199;1296.3647812571842;1299.1101095749418;38124.42813357802;38605.806970965175;38877;38921.80539097307;38982.440702371874;38941.831745047624;39271.60728392715;39316;39546.8022659887;39591;8181.79545511361;8417.579121043924;8425.662973481085;8425.915740842605;8441.662333506652;8360.581970901461;8473.95763021184;8480.78798030051;8484.703035393763;8490.150984901491;8418.579071046423;8481.236688698016;8481.95759021204;8513.914860851373;8528.189821966904;8366.03790564087;8458.492490450593;8482.957585212034;8483.151684831468;8493.66025358985;8174.100848906615;8183.877241841377;8272.090070092285;8288.792780180544;8296.792580185544;37577.43633845494;37592.81203593992;37708.62291377106;37817.81091094555;37882.86351409462;3639.490471333989;3658.506101676293;3663.816809159531;3665.7617254878346;3674.2835147146316;23434;27094.864525677247;30836.845815771;30912.690873091207;30953.53569696456;2651.973480265192;3072.4008818280445;3148.732357749594;3155.3373791503814;3191.856366463515;297002;298389;298942.50528747216;298970.01029989857;300186;46403.5359646406;49129.75435122873;49161;49194.7701307463;49602.75198623984;50579.49420505822;50788;50953.490465095616;53855.46144538583;53905;14597.489087881873;14629.92685036568;14696.853031469762;14725.263736813116;14782.852171478362;11750;11890.524379024742;11968.521259149711;11978.981786548067;11979;13997.65005874841;14061.78907316391;14067.155970641794;14096.718065638835;14147;5513.807016754395;5858.4182270787505;6115.541334399849;6132.50939924805;6138.1099740537375;853.3599800149888;1018.3940555369543;1037.056278786301;1038.5949479702922;1068.738159151013;21546.892265538885;22879.656805147937;23691.815409229468;23855.403614909766;23944.808031190223;1119.2724728926264;1120.5853834081443;1149.3563604381407;1151.8329842173005;1165.6153469355093;12261.448234829275;12765.361731913366;12808.6797830055;12815.743685126432;12864.742705145845;286685;334939;335554;337445;337884;55968.16047759287;56047.719761400935;56175.15737263944;56218;56322.7183864078;1533.6165958510373;1537.0700726060795;1576.8659663928465;1580.123031717385;1588.118594180241;22861.657075143554;24520.264392068268;24737.50524989526;24738.50522989494;24807.883645235648;32953;39072.80463597664;39241;39550.20899581935;39554.406683899186;270130;271867;272228;272618;272671;35433.46849797203;35845.10387240235;36935.44596831103;37033.44449833308;37168.81415593013;44501.55498445104;45825.54174458213;46496.53503464922;47062;47135.764321178176;30808.229794255323;31690.89081882123;32160.517592236603;32324.35351293008;32556.837215813768;31363.529547057267;31824.84087579547;32143;32437.51343729799;32723.509147362332;37647.68233111828;37749.62250377571;38258;39049.21901561896;39126;30373.39253214879;30602.387952240384;31635.050948471584;31668;32455;18713;25197.622035669112;25216.49567008613;25470.490590188463;25515 02:45:15 INFO - PID 1642 | |2;jquery.html;410.5996653263068;428.1202129623624;430.4210836425007;440.1087797210649;453.6484224725837;18173.636527269446;19627.509312267182;21326.89336553317;22114.668279975773;22135.00392482338;21929.780702192973;22661.546769064607;22777.63334199949;23165.536689266206;23357.2992810216;6055.818325450233;6197.535184861131;6223.471004964584;6230.439260466557;6231.22109736283;5947.88104237915;6149.5080393568405;6162.106494558287;6201.813945581617;6221.377862213765;5280.287161233242;5391.137418013119;5982.760689572412;6064.938635738728;6086.482648974842;6096.786612468564;6169.167162433081;6188.319284878659;6190.783322583688;6210.472109870644;5312.574994000471;5414.485623865727;5507.091329930557;5518.448155184489;5518.475744804237;28049.719502804914;28808;28975.710242897512;29046.41907161866;29361.706382936325;2164.8809315487642;2227.465408302012;2238.8880555972137;2239.8432109752325;2241.69737085493;17845.821541784677;17897.19462624185;18239.270429182816;18452.53868653281;18695.813041869544;2150.849440539163;2168.4036889855415;2221.255879280427;2222.7999480046874;2226.554689062194;172651;172653.5979081985;174446;175156;175245;12942.411517696499;13011.284379359036;13095.41070651804;13199.274039927705;13270.668233294246;14380.784288235685;15095.01882377642;16764;16954.15229238533;16982.490525284262;7238.420926325882;7424.294692004251;8093.716719914774;9132.726018219464;9169.724908252763;8823.55882205887;8829;8832.58678611419;9004;9007.504587247633;8084.555349455836;8178.591070446454;8204.958975205085;8246.09292977772;8273.751787446387;2205.6619982818265;2213.0594497338566;2218.7670294618833;2227.3318004598877;2393.066703985447;843.2747836860295;997.7206382212992;1003.0871906565137;1006.5420233793607;1036.72008557689;15266.847331526764;20784.79215207859;21422.57154856894;21537.784622153576;22108.88945555262;1018.5823812236947;1029.577873072037;1052.4527245832123;1060.390275591538;1065.4832406282947;9197.95401023004;10125.341852779546;11041.39272340029;11197.832032519518;11269.098472122374;532656;535323;535681;543853;549772;123890;126617.7338226606;136546.31726841303;139533;141894;1190.2560899437851;1213.8664746877837;1260.0297770716497;1262.9368531573384;1270.7776139175792;22481.550368992856;22757.886210568842;22759.970589988858;22952.770472295062;23051.423714407272;55758.442415576945;56892.71553642205;57387.139192912975;57594.42405575891;58486.415135848096;77848.61075694585;78381.21618783739;78624.60687696753;78992.21007789849;79063;9099;9140.634374625206;9276.907230927603;9277;9291.163795258459;14299.71400571962;14358.282085895455;14512.201828899511;14859.628509287355;14872.33074511628;11138.498767555317;12099.818502722643;12124.515019399478;12137.271763694207;12254.632361029184;9796.314258001872;10688.89311106879;11219.66341009771;11604.361760103275;11893.989010934167;12034.773566890153;12177;12256.632301030982;12261.816072758736;12400.31798251105;8885.289176865706;9044.457332560067;9099.954500227457;9128.863067053866;9139.954300228455;9418.246540276898;11777.587784427848;11819.877111674377;11859.822102668639;12106.939465302617 02:45:15 INFO - PID 1642 | |3;mootools.html;1434.9641258968525;1489.7690857917028;1491.068082448469;1512.8880272999343;1525.7406240939042;11203.271787333828;11659.183857130014;11668.299902005885;11687.707807304821;11898.881011189886;11674.941625291884;11817.586384476544;11869.169158158933;11896.762064758721;11896.929276365125;2481.7021957365096;2540.0855691950883;2540.5808041673104;2546.63073854291;2547.5159719653298;2204;2511.6860392450944;2527.84832910026;2531;2537.2388283514965;2499.3126890105277;2511.937201569957;2536.1250368622796;2552.0174732727846;2556.309796354992;2062.762782280042;2252.839787509434;2342.461233916209;2371.442710962931;2508.8118391120647;2465.2111324376206;2478.529079474894;2480.045182604692;2490.6264060390904;2498.2755001049673;11389.259698119678;11726.237794543413;11750.823737643857;11784.528618855236;11880.346580938045;6464.806055818333;6653.667316634197;6723.899141512881;6724.428423584001;6728.091707619506;3706.36991711407;3963.920721585552;4303.91392172158;4360.49854266757;4377.956220437819;1087.2932593814085;1235.7899157143306;1236.9752604947942;1295.6242689619999;1296.863829297929;12595.874041259562;12879.87120128796;16182.919085404616;16343;16373.59066023347;4171.3325867860995;4866.099771542276;5467.125259958467;5565.693886836263;5628.380878103405;8620.28461034772;10970.396628185526;11487.13846461502;11728.12039097054;11728.88271117295;6479.287278399373;6531.856925038194;6534.705938232791;6537.70580323877;6537.836554086186;6009.858126955952;6085.117657939574;6195.473384762256;6197.1324014637985;6199.969000155061;3682.889513314551;4293.506246781598;4366.890827729332;4397.2964325707735;4406.383106365048;1269.2701696524534;1286.1832736212386;1289.0283625963214;1298.480607756886;1301.8958483321312;682.757621044532;707.706301884712;832.2883934236262;841.4362377207286;843.4559708987669;6125.448709616156;6197.721102550396;6206.844828879224;6292.653904035322;6299.811005669837;543.787354200128;589.8908701890164;590.6072461812932;599.7241269016214;622.5766478794463;4015.19696060789;4286.957130428718;4308.676849236257;4346.587074227943;4400.185965596311;14342.49801256951;14616.196109214095;14931.17878516692;14957.775633365509;14965.625859353604;14321.928390357982;14780.187089710169;14898.627534311729;14924.17917014553;14971.550853474413;8483.95758021206;8513.233808957224;8562.315014798802;8638.870416943751;8684.522351270614;6523.151990241238;6575.24384695747;6629.7348106075215;6727.327267273234;6792.830179245559;12757.617271481871;13237;13499.32503374847;13574.981876359116;13580.456781729015;13268.734625307632;13541.729165416833;13543.72912541724;13555.59333220005;13883.167009979434;7428.442866785121;9100.453972761656;9206.079392060741;9425.905740942502;9434.24526037929;10809.837852432378;10831.458427078773;10976.780464390828;10982.06652434552;10998.780024399308;8932.955335223282;9052.818943621223;9106.134917182857;9119.316051296046;9297.30270229749;8801.91198088011;8829.293656507592;8846.734597962071;8929.464232146092;9034.593443294936;6894.758683446055;7013.684384202621;7477.289657482531;8043.155468675939;8064.193580641889;5997.220361352996;6017.879642407215;6029;6060;6145.8156255312415;5619.409961953936;6047.516198704006;6089.934261504308;6142.447179753844;6238.937610624017 02:45:15 INFO - PID 1642 | |4;prototype.html;407.4377359244243;411.9794010299484;412.15508208173236;413.5905453600936;423.8410596026492;5871.735771890265;6472.482201423886;6497.675116244181;6499.350064993499;6514.185726784141;5862.208601838751;6196.473299769514;6240.719167637456;6312.6212427254395;6330.430261276484;4481;4580.931286030721;4586.380838586798;4591.1965406053805;4596.7012144210685;4576.835080077114;4592.471865735433;4608.5161058088925;4609.631229501649;4623.861284161464;4531.56950089741;4544.5228251033495;4554.111948170108;4584.610308123813;4608.331791890174;4369.868903932887;4527.841525546623;4556.931646025312;4569.246074397721;4572.794224259899;3871.1096447816876;3879.6314350136972;3882.844686212548;3888.9027774305587;3890.533136023667;4821.7589120543835;5349.411564727877;6021.759129634809;6197.752089916398;6212.751489940397;5321.441248668912;5400.729963501848;5429.511343979061;5456.536194423439;5472.413000229929;5363.839084827422;5762.193292938992;6604.636744979024;6757;6793.4225590824835;3844.3656796628525;4198.349255865346;4384.89037774055;4386.956130438687;4396.758178300192;5933.881322373529;6975.651217439158;7004.474664400191;7119.540494198729;7192.4246060315045;3850.961490385116;3903.277893589695;4285.628598848339;4441.356003379557;4448.733076015449;3870.5935876732538;4451.020775429401;4515.622735065836;4523.615492683093;4532.27483602622;5175.922361164586;5194.142966410575;5299.735013249322;5328.467153284718;5360.490753378501;5654.8407576446725;6735.124433823572;6776.830579235559;6779.966100169468;6791.524593278522;1321.596912941562;1532.1266877879725;1538.6461113943856;1540.5147378575714;1543.467503711218;858.454881150474;989.3618615992644;995.3132338686283;1004.4932601098352;1006.2050979726081;5224.16413373866;6421.550491465646;6496.252930912911;6509.218893732783;6573.934260657332;5858.418227078665;5912.822615321461;7023.541760383825;7043.9647801761685;7064.92935070653;5989.760409583655;6400.135981642418;6472.983437835715;6473;6506.251781045145;3204.7115759581284;3209.6950789674943;3545.9290814183573;3603.5135256740004;3727.254549090193;5773.88452230953;5856.565141540264;6737.831554211086;7290.234525374865;7303.780886573411;6022.789202377983;6984.196817366068;7082;7238.746643867439;7258.419326453871;6918.308169183142;7019.4384449243935;7266.63666816657;7333.266673332838;7374.9262507375315;7057.541259818096;7070.46971477131;7107.040549525748;7107.60908150036;7109.537880037781;5741.827745167651;6826.522143449911;6908.378245957888;6940.466729643745;6944.930550694428;6453.548251622341;7080.504364694422;7286.6720997556295;7316.9634151828905;7416.4066874648815;3707.3141468828353;3904.1996390740396;4062.8374865005067;4333.328334108218;4432.490263619725;5350.919736203882;6939.514234003571;6951.513394062367;7058.494234546662;7101.786946391617;6823.829404264933;6824.658767061528;6833.180018397824;6836.623985680835;6844.836377815684;6585.6377899216;6711.194656641039;6790.287019863041;6795.966020169867;6798.824376199569;5915.260592425947;6473.838154046187;6623.4038936495945;6636.568623039487;6660.933390666225;6580.440662543738;6715.4963377747845;6788.151481064867;6807.489438292049;6812.4890633203695;5729.427057294404;6594.241662208716;6600.2409722882485;6612.858892026249;6619.602823830585 02:45:15 INFO - PID 1642 | |5;yui.html;807.3379828540592;840.7183593496178;858.7509622209559;871.3595507302132;884.0408157149494;16515.66968660626;16733.91633041836;16830.66338673226;18592.256309747594;19149.42551723447;17867.73198402025;18203.27068928453;18229.17968691409;18367.632647347044;18438.170282337294;1007.3502590828911;1010.5604062232916;1023.2172388123055;1034.4724190662778;1035.2597892506856;1017.7150397888603;1020.8928062553437;1025.133761971137;1027.0807627173674;1027.3527677563125;1073.431081526792;1080.6055789636805;1080.751427171747;1082.7401423658305;1084.5932775209296;1059.8251288537383;1072.2815713471953;1075.510642657589;1077.2513103393144;1080.5461706083424;762.1730422491603;766.8312971146339;775.3758224629171;777.0054330457024;779;16977.83022169775;17312.307507699676;17336.3065477382;17513.562160945952;17526.123693815385;16397.42609008691;17057.488275351636;17272.481825545256;17577.912110439494;17631.942083474903;12084.577039803564;14154.646133846736;14571.562853114423;14625.976181667287;15666;3549.112721819545;3576.445650924111;3594.2452085061905;3595.406757884946;3602.2075143468655;124492;124971.12774286428;125653;127554.08668869974;128979;11513.078953683686;13096.738065238642;13230.20618762858;13332.800007999887;13443.193408395528;21290.25484108049;25464.236072917472;25800.09699660503;25834.095806646677;26376;7777.377809775205;7811.375089992787;7875.133735289113;7879.881801772978;7887.921120788834;3845.2309538092495;3963.246983073207;4010.3783913493453;4027.556968733437;4037.414574886625;4311.094670119247;4332.328489084134;4404.383386325917;4406.977965110218;4408.603225709638;873.895132584094;890.2699786175403;894.4186278918755;898.6854600889767;899.5277479323407;621.7761605821901;651.8565915498583;655.7016557466342;664.6045602866287;683.1452606174261;10537.6301080859;11090.778184436265;11182.273152245078;11803.52785888572;12250.571230006906;638.1480723234533;652.1880259077479;665.7170702451439;676.0024128699681;687.5737043033351;4284.400183974246;5402.486763757437;5522.282103326542;5564.998300305984;5604.243427137366;114115;114219;114599.42700286445;114830.42584787022;114966.42516787362;82020.58989705013;87073;89215.55392222997;89542;89656;80447;80631.59684201541;81207.593962031;83156;83311.16688833034;11065.557377705123;11749.530018799152;12674.746505069663;12852.357382130669;12852.871471285167;37534.249315014094;39106.6089339103;39785.60214397935;40022;41148;53118.2032269524;53762;54013.72993135166;54097.18854217111;54180.458195419116;15882.126483043081;16636.750448743038;16761.580960476087;17115;17151.571210719332;16578.50264492067;16870.287367521465;18250.17874195691;18254.269829207213;18552;16532.83467165361;17215.913920430317;17326.74009889878;17358;17428.390006349717;16725.996440213625;16847;16852.9888206708;17086.829131708524;17177.570560736083;13761.761441470317;15860.44488442899;16126.838731613003;16509.257083431516;16926.238319275417;11718.88281117178;11776.70558236051;12208.511659533875;12292.262464252173;12303.44634491432;12343.321117338273;12349.567765128177;12443.253404795742;13032.5438609652;13065.608031759062 02:45:15 INFO - PID 1642 | __end_tp_report 02:45:15 INFO - PID 1642 | __start_cc_report 02:45:15 INFO - PID 1642 | _x_x_mozilla_cycle_collect,423 02:45:15 INFO - PID 1642 | __end_cc_report 02:45:15 INFO - PID 1642 | __startTimestamp1493804715345__endTimestamp 02:45:15 INFO - PID 1642 | 02:45:15 INFO - PID 1642 | ------- Summary: start ------- 02:45:15 INFO - PID 1642 | Number of tests: 6 02:45:15 INFO - PID 1642 | 02:45:15 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:6113.73 Median:6331.11 stddev:762.62 (12.0%) stddev-sans-first:735.40 02:45:15 INFO - PID 1642 | Values: 3433.3 3588.9 3616.6 3638.5 3641.9 6126.3 6145.2 6194.8 6202.3 6264.0 6145.6 6183.8 6196.2 6225.5 6235.4 5307.0 5417.1 5462.2 5476.5 5529.2 5540.1 5592.6 5592.8 5593.9 5626.1 5467.8 5492.8 5495.8 5505.0 5526.3 5469.9 5480.9 5483.3 5503.2 5518.8 5412.6 5446.5 5451.9 5470.9 5531.8 5153.2 5217.8 6145.2 6160.4 6163.5 6615.7 6665.8 6667.0 6684.9 6696.8 6732.9 6734.4 6740.9 6758.6 6770.3 6082.8 6167.7 6291.2 6313.7 6326.0 6785.3 6834.6 6902.7 6908.7 6927.6 6331.1 6409.4 6409.6 6517.8 6523.3 6583.2 6615.5 6674.7 6727.0 6762.1 6599.0 6609.6 6619.6 6626.5 6638.2 6408.7 6476.5 6537.5 6578.6 6627.4 5281.9 5293.4 5298.0 5301.5 5344.5 3607.8 4580.0 4697.7 4708.4 4736.4 5045.3 5302.4 6270.1 6296.4 6378.7 6639.5 6710.5 6724.7 6739.5 6766.9 4884.8 6212.1 6232.4 6277.5 6283.6 5065.7 5685.4 5751.9 5759.3 5762.9 6802.8 6899.3 6928.0 6944.6 6977.3 6782.8 6798.0 6804.8 6817.8 6831.8 6945.8 6951.4 6958.4 7020.1 7037.8 6479.6 6560.1 6569.5 6595.9 6685.9 5616.7 6766.5 6772.9 6787.5 6790.0 6286.8 6448.4 6448.7 6571.2 6586.1 6422.6 6536.5 6538.0 6541.1 6542.2 6207.3 6292.1 6311.7 6320.5 6321.0 6466.7 6525.2 6580.8 6585.7 6610.7 5249.6 6402.0 6406.3 6410.2 6432.2 02:45:15 INFO - PID 1642 | 02:45:15 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:45477.97 Median:336499.50 stddev:78659.45 (23.4%) stddev-sans-first:78808.21 02:45:15 INFO - PID 1642 | Values: 685.0 828.9 1204.7 1296.4 1299.1 38124.4 38605.8 38877.0 38921.8 38982.4 38941.8 39271.6 39316.0 39546.8 39591.0 8181.8 8417.6 8425.7 8425.9 8441.7 8360.6 8474.0 8480.8 8484.7 8490.2 8418.6 8481.2 8482.0 8513.9 8528.2 8366.0 8458.5 8483.0 8483.2 8493.7 8174.1 8183.9 8272.1 8288.8 8296.8 37577.4 37592.8 37708.6 37817.8 37882.9 3639.5 3658.5 3663.8 3665.8 3674.3 23434.0 27094.9 30836.8 30912.7 30953.5 2652.0 3072.4 3148.7 3155.3 3191.9 297002.0 298389.0 298942.5 298970.0 300186.0 46403.5 49129.8 49161.0 49194.8 49602.8 50579.5 50788.0 50953.5 53855.5 53905.0 14597.5 14629.9 14696.9 14725.3 14782.9 11750.0 11890.5 11968.5 11979.0 11979.0 13997.7 14061.8 14067.2 14096.7 14147.0 5513.8 5858.4 6115.5 6132.5 6138.1 853.4 1018.4 1037.1 1038.6 1068.7 21546.9 22879.7 23691.8 23855.4 23944.8 1119.3 1120.6 1149.4 1151.8 1165.6 12261.4 12765.4 12808.7 12815.7 12864.7 286685.0 334939.0 335554.0 337445.0 337884.0 55968.2 56047.7 56175.2 56218.0 56322.7 1533.6 1537.1 1576.9 1580.1 1588.1 22861.7 24520.3 24737.5 24738.5 24807.9 32953.0 39072.8 39241.0 39550.2 39554.4 270130.0 271867.0 272228.0 272618.0 272671.0 35433.5 35845.1 36935.4 37033.4 37168.8 44501.6 45825.5 46496.5 47062.0 47135.8 30808.2 31690.9 32160.5 32324.4 32556.8 31363.5 31824.8 32143.0 32437.5 32723.5 37647.7 37749.6 38258.0 39049.2 39126.0 30373.4 30602.4 31635.1 31668.0 32455.0 18713.0 25197.6 25216.5 25470.5 25515.0 02:45:15 INFO - PID 1642 | 02:45:15 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:36141.82 Median:22571.55 stddev:92546.47 (410.0%) stddev-sans-first:92767.20 02:45:15 INFO - PID 1642 | Values: 410.6 428.1 430.4 440.1 453.6 18173.6 19627.5 21326.9 22114.7 22135.0 21929.8 22661.5 22777.6 23165.5 23357.3 6055.8 6197.5 6223.5 6230.4 6231.2 5947.9 6149.5 6162.1 6201.8 6221.4 5280.3 5391.1 5982.8 6064.9 6086.5 6096.8 6169.2 6188.3 6190.8 6210.5 5312.6 5414.5 5507.1 5518.4 5518.5 28049.7 28808.0 28975.7 29046.4 29361.7 2164.9 2227.5 2238.9 2239.8 2241.7 17845.8 17897.2 18239.3 18452.5 18695.8 2150.8 2168.4 2221.3 2222.8 2226.6 172651.0 172653.6 174446.0 175156.0 175245.0 12942.4 13011.3 13095.4 13199.3 13270.7 14380.8 15095.0 16764.0 16954.2 16982.5 7238.4 7424.3 8093.7 9132.7 9169.7 8823.6 8829.0 8832.6 9004.0 9007.5 8084.6 8178.6 8205.0 8246.1 8273.8 2205.7 2213.1 2218.8 2227.3 2393.1 843.3 997.7 1003.1 1006.5 1036.7 15266.8 20784.8 21422.6 21537.8 22108.9 1018.6 1029.6 1052.5 1060.4 1065.5 9198.0 10125.3 11041.4 11197.8 11269.1 532656.0 535323.0 535681.0 543853.0 549772.0 123890.0 126617.7 136546.3 139533.0 141894.0 1190.3 1213.9 1260.0 1262.9 1270.8 22481.6 22757.9 22760.0 22952.8 23051.4 55758.4 56892.7 57387.1 57594.4 58486.4 77848.6 78381.2 78624.6 78992.2 79063.0 9099.0 9140.6 9276.9 9277.0 9291.2 14299.7 14358.3 14512.2 14859.6 14872.3 11138.5 12099.8 12124.5 12137.3 12254.6 9796.3 10688.9 11219.7 11604.4 11894.0 12034.8 12177.0 12256.6 12261.8 12400.3 8885.3 9044.5 9100.0 9128.9 9140.0 9418.2 11777.6 11819.9 11859.8 12106.9 02:45:15 INFO - PID 1642 | 02:45:15 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:6973.04 Median:3835.15 stddev:4400.85 (114.8%) stddev-sans-first:4393.52 02:45:15 INFO - PID 1642 | Values: 1435.0 1489.8 1491.1 1512.9 1525.7 11203.3 11659.2 11668.3 11687.7 11898.9 11674.9 11817.6 11869.2 11896.8 11896.9 2481.7 2540.1 2540.6 2546.6 2547.5 2204.0 2511.7 2527.8 2531.0 2537.2 2499.3 2511.9 2536.1 2552.0 2556.3 2062.8 2252.8 2342.5 2371.4 2508.8 2465.2 2478.5 2480.0 2490.6 2498.3 11389.3 11726.2 11750.8 11784.5 11880.3 6464.8 6653.7 6723.9 6724.4 6728.1 3706.4 3963.9 4303.9 4360.5 4378.0 1087.3 1235.8 1237.0 1295.6 1296.9 12595.9 12879.9 16182.9 16343.0 16373.6 4171.3 4866.1 5467.1 5565.7 5628.4 8620.3 10970.4 11487.1 11728.1 11728.9 6479.3 6531.9 6534.7 6537.7 6537.8 6009.9 6085.1 6195.5 6197.1 6200.0 3682.9 4293.5 4366.9 4397.3 4406.4 1269.3 1286.2 1289.0 1298.5 1301.9 682.8 707.7 832.3 841.4 843.5 6125.4 6197.7 6206.8 6292.7 6299.8 543.8 589.9 590.6 599.7 622.6 4015.2 4287.0 4308.7 4346.6 4400.2 14342.5 14616.2 14931.2 14957.8 14965.6 14321.9 14780.2 14898.6 14924.2 14971.6 8484.0 8513.2 8562.3 8638.9 8684.5 6523.2 6575.2 6629.7 6727.3 6792.8 12757.6 13237.0 13499.3 13575.0 13580.5 13268.7 13541.7 13543.7 13555.6 13883.2 7428.4 9100.5 9206.1 9425.9 9434.2 10809.8 10831.5 10976.8 10982.1 10998.8 8933.0 9052.8 9106.1 9119.3 9297.3 8801.9 8829.3 8846.7 8929.5 9034.6 6894.8 7013.7 7477.3 8043.2 8064.2 5997.2 6017.9 6029.0 6060.0 6145.8 5619.4 6047.5 6089.9 6142.4 6238.9 02:45:15 INFO - PID 1642 | 02:45:15 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5406.39 Median:6022.27 stddev:1757.68 (29.2%) stddev-sans-first:1722.10 02:45:15 INFO - PID 1642 | Values: 407.4 412.0 412.2 413.6 423.8 5871.7 6472.5 6497.7 6499.4 6514.2 5862.2 6196.5 6240.7 6312.6 6330.4 4481.0 4580.9 4586.4 4591.2 4596.7 4576.8 4592.5 4608.5 4609.6 4623.9 4531.6 4544.5 4554.1 4584.6 4608.3 4369.9 4527.8 4556.9 4569.2 4572.8 3871.1 3879.6 3882.8 3888.9 3890.5 4821.8 5349.4 6021.8 6197.8 6212.8 5321.4 5400.7 5429.5 5456.5 5472.4 5363.8 5762.2 6604.6 6757.0 6793.4 3844.4 4198.3 4384.9 4387.0 4396.8 5933.9 6975.7 7004.5 7119.5 7192.4 3851.0 3903.3 4285.6 4441.4 4448.7 3870.6 4451.0 4515.6 4523.6 4532.3 5175.9 5194.1 5299.7 5328.5 5360.5 5654.8 6735.1 6776.8 6780.0 6791.5 1321.6 1532.1 1538.6 1540.5 1543.5 858.5 989.4 995.3 1004.5 1006.2 5224.2 6421.6 6496.3 6509.2 6573.9 5858.4 5912.8 7023.5 7044.0 7064.9 5989.8 6400.1 6473.0 6473.0 6506.3 3204.7 3209.7 3545.9 3603.5 3727.3 5773.9 5856.6 6737.8 7290.2 7303.8 6022.8 6984.2 7082.0 7238.7 7258.4 6918.3 7019.4 7266.6 7333.3 7374.9 7057.5 7070.5 7107.0 7107.6 7109.5 5741.8 6826.5 6908.4 6940.5 6944.9 6453.5 7080.5 7286.7 7317.0 7416.4 3707.3 3904.2 4062.8 4333.3 4432.5 5350.9 6939.5 6951.5 7058.5 7101.8 6823.8 6824.7 6833.2 6836.6 6844.8 6585.6 6711.2 6790.3 6796.0 6798.8 5915.3 6473.8 6623.4 6636.6 6660.9 6580.4 6715.5 6788.2 6807.5 6812.5 5729.4 6594.2 6600.2 6612.9 6619.6 02:45:15 INFO - PID 1642 | 02:45:15 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:21990.30 Median:17470.98 stddev:31213.00 (178.7%) stddev-sans-first:31260.03 02:45:15 INFO - PID 1642 | Values: 807.3 840.7 858.8 871.4 884.0 16515.7 16733.9 16830.7 18592.3 19149.4 17867.7 18203.3 18229.2 18367.6 18438.2 1007.4 1010.6 1023.2 1034.5 1035.3 1017.7 1020.9 1025.1 1027.1 1027.4 1073.4 1080.6 1080.8 1082.7 1084.6 1059.8 1072.3 1075.5 1077.3 1080.5 762.2 766.8 775.4 777.0 779.0 16977.8 17312.3 17336.3 17513.6 17526.1 16397.4 17057.5 17272.5 17577.9 17631.9 12084.6 14154.6 14571.6 14626.0 15666.0 3549.1 3576.4 3594.2 3595.4 3602.2 124492.0 124971.1 125653.0 127554.1 128979.0 11513.1 13096.7 13230.2 13332.8 13443.2 21290.3 25464.2 25800.1 25834.1 26376.0 7777.4 7811.4 7875.1 7879.9 7887.9 3845.2 3963.2 4010.4 4027.6 4037.4 4311.1 4332.3 4404.4 4407.0 4408.6 873.9 890.3 894.4 898.7 899.5 621.8 651.9 655.7 664.6 683.1 10537.6 11090.8 11182.3 11803.5 12250.6 638.1 652.2 665.7 676.0 687.6 4284.4 5402.5 5522.3 5565.0 5604.2 114115.0 114219.0 114599.4 114830.4 114966.4 82020.6 87073.0 89215.6 89542.0 89656.0 80447.0 80631.6 81207.6 83156.0 83311.2 11065.6 11749.5 12674.7 12852.4 12852.9 37534.2 39106.6 39785.6 40022.0 41148.0 53118.2 53762.0 54013.7 54097.2 54180.5 15882.1 16636.8 16761.6 17115.0 17151.6 16578.5 16870.3 18250.2 18254.3 18552.0 16532.8 17215.9 17326.7 17358.0 17428.4 16726.0 16847.0 16853.0 17086.8 17177.6 13761.8 15860.4 16126.8 16509.3 16926.2 11718.9 11776.7 12208.5 12292.3 12303.4 12343.3 12349.6 12443.3 13032.5 13065.6 02:45:15 INFO - PID 1642 | -------- Summary: end -------- 02:45:15 INFO - PID 1642 | 02:45:15 INFO - TEST-INFO | 1642: exit 0 02:45:15 INFO - TEST-OK | dromaeo_css | took 1114114ms 02:45:15 INFO - TEST-START | kraken 02:45:15 INFO - operating with platform_type : mac_ 02:45:15 INFO - Initialising browser for kraken test... 02:45:15 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpGPI0EC/profile http://localhost:49242/getInfo.html) 02:45:18 INFO - PID 1655 | 2017-05-03 02:45:18.619 plugin-container[1656:10373] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9237, name = 'com.apple.tsm.portname' 02:45:18 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:18 INFO - PID 1655 | 2017-05-03 02:45:18.622 plugin-container[1656:10373] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461f, name = 'com.apple.CFPasteboardClient' 02:45:18 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:18 INFO - PID 1655 | 2017-05-03 02:45:18.622 plugin-container[1656:10373] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:45:18 INFO - PID 1655 | __metrics Screen width/height:1600/1200 02:45:18 INFO - PID 1655 | colorDepth:24 02:45:18 INFO - PID 1655 | Browser inner width/height: 1024/691 02:45:18 INFO - PID 1655 | __metrics 02:45:19 INFO - TEST-INFO | 1655: exit 0 02:45:19 INFO - Browser initialized. 02:45:19 INFO - Running cycle 1/1 for kraken test... 02:45:19 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpGPI0EC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:22 INFO - PID 1657 | 2017-05-03 02:45:22.041 plugin-container[1658:10500] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 02:45:22 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:22 INFO - PID 1657 | 2017-05-03 02:45:22.041 plugin-container[1658:10500] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 02:45:22 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:22 INFO - PID 1657 | 2017-05-03 02:45:22.041 plugin-container[1658:10500] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:45:31 INFO - PID 1657 | RSS: Main: 234622976 02:45:31 INFO - PID 1657 | 02:45:34 INFO - PID 1657 | 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) 02:45:35 INFO - PID 1657 | RSS: Main: 248197120 02:45:35 INFO - PID 1657 | 02:45:38 INFO - PID 1657 | 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) 02:45:38 INFO - PID 1657 | RSS: Main: 256348160 02:45:38 INFO - PID 1657 | 02:45:42 INFO - PID 1657 | 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) 02:45:42 INFO - PID 1657 | RSS: Main: 258789376 02:45:42 INFO - PID 1657 | 02:45:44 INFO - PID 1657 | 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) 02:45:45 INFO - PID 1657 | RSS: Main: 261050368 02:45:45 INFO - PID 1657 | 02:45:47 INFO - PID 1657 | 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) 02:45:47 INFO - PID 1657 | RSS: Main: 261640192 02:45:47 INFO - PID 1657 | 02:45:50 INFO - PID 1657 | 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) 02:45:51 INFO - PID 1657 | RSS: Main: 267886592 02:45:51 INFO - PID 1657 | 02:45:54 INFO - PID 1657 | 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) 02:45:55 INFO - PID 1657 | RSS: Main: 268009472 02:45:55 INFO - PID 1657 | 02:45:58 INFO - PID 1657 | 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) 02:45:59 INFO - PID 1657 | RSS: Main: 267751424 02:45:59 INFO - PID 1657 | 02:46:00 INFO - PID 1657 | 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) 02:46:01 INFO - PID 1657 | RSS: Main: 267558912 02:46:01 INFO - PID 1657 | 02:46:03 INFO - PID 1657 | 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) 02:46:03 INFO - PID 1657 | RSS: Main: 267636736 02:46:03 INFO - PID 1657 | 02:46:06 INFO - PID 1657 | 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) 02:46:06 INFO - PID 1657 | RSS: Main: 267296768 02:46:06 INFO - PID 1657 | 02:46:09 INFO - PID 1657 | 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) 02:46:10 INFO - PID 1657 | RSS: Main: 267886592 02:46:10 INFO - PID 1657 | 02:46:13 INFO - PID 1657 | 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) 02:46:13 INFO - PID 1657 | RSS: Main: 267730944 02:46:13 INFO - PID 1657 | 02:46:15 INFO - PID 1657 | 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) 02:46:16 INFO - PID 1657 | RSS: Main: 269209600 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | __start_tp_report 02:46:16 INFO - PID 1657 | _x_x_mozilla_page_load 02:46:16 INFO - PID 1657 | _x_x_mozilla_page_load_details 02:46:16 INFO - PID 1657 | |i|pagename|runs| 02:46:16 INFO - PID 1657 | |0;ai-astar;148;168;136;114;117;115;116;115;116;115 02:46:16 INFO - PID 1657 | |1;audio-beat-detection;149;106;111;175;144;112;115;146;141;112 02:46:16 INFO - PID 1657 | |2;audio-dft;198;198;202;215;246;255;203;201;196;198 02:46:16 INFO - PID 1657 | |3;audio-fft;80;58;60;81;60;62;60;83;80;55 02:46:16 INFO - PID 1657 | |4;audio-oscillator;85;72;86;85;100;101;107;71;71;90 02:46:16 INFO - PID 1657 | |5;imaging-gaussian-blur;91;91;89;90;104;113;76;87;116;137 02:46:16 INFO - PID 1657 | |6;imaging-darkroom;98;99;98;125;155;127;98;147;117;143 02:46:16 INFO - PID 1657 | |7;imaging-desaturate;93;91;90;94;91;91;93;136;147;83 02:46:16 INFO - PID 1657 | |8;json-parse-financial;55;52;50;51;55;52;52;53;53;50 02:46:16 INFO - PID 1657 | |9;json-stringify-tinderbox;57;66;60;70;54;80;50;55;65;80 02:46:16 INFO - PID 1657 | |10;stanford-crypto-aes;81;86;83;89;73;84;107;109;81;84 02:46:16 INFO - PID 1657 | |11;stanford-crypto-ccm;138;139;135;146;136;145;145;143;187;140 02:46:16 INFO - PID 1657 | |12;stanford-crypto-pbkdf2;183;188;185;163;229;243;197;185;185;179 02:46:16 INFO - PID 1657 | |13;stanford-crypto-sha256-iterative;72;67;69;71;69;70;66;74;94;102 02:46:16 INFO - PID 1657 | __end_tp_report 02:46:16 INFO - PID 1657 | __start_cc_report 02:46:16 INFO - PID 1657 | _x_x_mozilla_cycle_collect,971 02:46:16 INFO - PID 1657 | __end_cc_report 02:46:16 INFO - PID 1657 | __startTimestamp1493804776011__endTimestamp 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | ------- Summary: start ------- 02:46:16 INFO - PID 1657 | Number of tests: 14 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#0] ai-astar Cycles:10 Average:126.00 Median:116.50 stddev:18.67 (16.0%) stddev-sans-first:18.02 02:46:16 INFO - PID 1657 | Values: 148.0 168.0 136.0 114.0 117.0 115.0 116.0 115.0 116.0 115.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:142.50 stddev:22.99 (16.1%) stddev-sans-first:23.45 02:46:16 INFO - PID 1657 | Values: 149.0 106.0 111.0 175.0 144.0 112.0 115.0 146.0 141.0 112.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#2] audio-dft Cycles:10 Average:211.20 Median:202.50 stddev:21.48 (10.6%) stddev-sans-first:22.25 02:46:16 INFO - PID 1657 | Values: 198.0 198.0 202.0 215.0 246.0 255.0 203.0 201.0 196.0 198.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#3] audio-fft Cycles:10 Average:67.90 Median:71.00 stddev:11.45 (16.1%) stddev-sans-first:11.27 02:46:16 INFO - PID 1657 | Values: 80.0 58.0 60.0 81.0 60.0 62.0 60.0 83.0 80.0 55.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:78.50 stddev:12.99 (16.6%) stddev-sans-first:13.77 02:46:16 INFO - PID 1657 | Values: 85.0 72.0 86.0 85.0 100.0 101.0 107.0 71.0 71.0 90.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:88.00 stddev:18.06 (20.5%) stddev-sans-first:18.89 02:46:16 INFO - PID 1657 | Values: 91.0 91.0 89.0 90.0 104.0 113.0 76.0 87.0 116.0 137.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#6] imaging-darkroom Cycles:10 Average:120.70 Median:126.50 stddev:22.25 (17.6%) stddev-sans-first:22.03 02:46:16 INFO - PID 1657 | Values: 98.0 99.0 98.0 125.0 155.0 127.0 98.0 147.0 117.0 143.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#7] imaging-desaturate Cycles:10 Average:100.90 Median:91.00 stddev:21.76 (23.9%) stddev-sans-first:22.90 02:46:16 INFO - PID 1657 | Values: 93.0 91.0 90.0 94.0 91.0 91.0 93.0 136.0 147.0 83.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:1.77 (3.4%) stddev-sans-first:1.58 02:46:16 INFO - PID 1657 | Values: 55.0 52.0 50.0 51.0 55.0 52.0 52.0 53.0 53.0 50.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:65.50 stddev:10.51 (16.0%) stddev-sans-first:10.86 02:46:16 INFO - PID 1657 | Values: 57.0 66.0 60.0 70.0 54.0 80.0 50.0 55.0 65.0 80.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:83.50 stddev:11.48 (13.7%) stddev-sans-first:11.92 02:46:16 INFO - PID 1657 | Values: 81.0 86.0 83.0 89.0 73.0 84.0 107.0 109.0 81.0 84.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:144.00 stddev:15.12 (10.5%) stddev-sans-first:15.80 02:46:16 INFO - PID 1657 | Values: 138.0 139.0 135.0 146.0 136.0 145.0 145.0 143.0 187.0 140.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:186.50 stddev:24.08 (12.9%) stddev-sans-first:25.23 02:46:16 INFO - PID 1657 | Values: 183.0 188.0 185.0 163.0 229.0 243.0 197.0 185.0 185.0 179.0 02:46:16 INFO - PID 1657 | 02:46:16 INFO - PID 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:70.50 stddev:12.28 (17.4%) stddev-sans-first:12.96 02:46:16 INFO - PID 1657 | Values: 72.0 67.0 69.0 71.0 69.0 70.0 66.0 74.0 94.0 102.0 02:46:16 INFO - PID 1657 | -------- Summary: end -------- 02:46:16 INFO - PID 1657 | 02:46:17 INFO - TEST-INFO | 1657: exit 0 02:46:17 INFO - TEST-OK | kraken | took 61136ms 02:46:17 INFO - SUITE-END | took 1175s 02:46:17 INFO - Completed test suite (00:19:35) 02:46:17 INFO - javascript benchmark 02:46:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7918.346951496889, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3433.313337332534, 3588.8923332300024, 3616.6021737608867, 3638.5451818522674, 3641.890743277701, 6126.326104128542, 6145.17040199573, 6194.814155575335, 6202.348753380892, 6264.0, 6145.586515101518, 6183.814485565429, 6196.225471816023, 6225.501959843213, 6235.376462353763, 5307.018201632691, 5417.079096553595, 5462.235287059795, 5476.507114359717, 5529.198266251391, 5540.085885828834, 5592.636478628897, 5592.832215033535, 5593.916091258634, 5626.099824028156, 5467.753951072212, 5492.835214943558, 5495.752691128869, 5504.972475137619, 5526.336839579236, 5469.945300547023, 5480.890382192334, 5483.314585676791, 5503.2020357048405, 5518.779248830042, 5412.621116521845, 5446.509814116748, 5451.945480545183, 5470.91793623096, 5531.834044978657, 5153.201253805666, 5217.817376391846, 6145.2178868128185, 6160.4455598995855, 6163.476104531121, 6615.669216539202, 6665.766698165541, 6667.033280174396, 6684.86630267392, 6696.799096027127, 6732.865342693168, 6734.3602357775935, 6740.865182696319, 6758.628275444848, 6770.289119642416, 6082.756689732361, 6167.660778657217, 6291.245050593912, 6313.652749098797, 6326.0, 6785.321467853175, 6834.555753875982, 6902.689378977958, 6908.723651053901, 6927.618980956096, 6331.113644089831, 6409.359064093554, 6409.647469389229, 6517.771877984248, 6523.282438931714, 6583.177102862142, 6615.503837212132, 6674.733010679615, 6727.0, 6762.087118238975, 6599.0, 6609.570377925419, 6619.635920024445, 6626.469882409396, 6638.203415590064, 6408.743650253938, 6476.546641735127, 6537.5096867734155, 6578.605283682994, 6627.403533681992, 5281.867953301121, 5293.3647962244, 5298.0, 5301.5493683037375, 5344.518993290545, 3607.8376473058775, 4579.992401671627, 4697.671163018625, 4708.4349878014855, 4736.407949006374, 5045.344105266292, 5302.443243459458, 6270.122182894398, 6296.401841825019, 6378.71496179468, 6639.535232533676, 6710.463162946952, 6724.731010759613, 6739.460843132538, 6766.864662706718, 4884.755762211875, 6212.072424640248, 6232.439080482778, 6277.497800175975, 6283.560150789401, 5065.670731402447, 5685.403032681509, 5751.884962300731, 5759.308882933991, 5762.855928601818, 6802.761903333359, 6899.310068993061, 6927.965360173167, 6944.583325000516, 6977.302269772982, 6782.762603308861, 6798.048273241849, 6804.795856124324, 6817.761378351734, 6831.795046148623, 6945.791626251221, 6951.374376306157, 6958.443324533924, 7020.122484689414, 7037.824054398681, 6479.643619600779, 6560.114384558024, 6569.540132190892, 6595.934040659724, 6685.899711504234, 5616.747246374005, 6766.5263431559315, 6772.93227067723, 6787.457003439812, 6789.966050169717, 6286.811395658137, 6448.355164483702, 6448.709808058742, 6571.178602674666, 6586.1438013058, 6422.6467544285515, 6536.509761767791, 6537.967310163609, 6541.149650545399, 6542.247641521286, 6207.286162091236, 6292.087647291026, 6311.715972781144, 6320.494360451245, 6320.988641817287, 6466.676666166767, 6525.1517302750335, 6580.8354791130605, 6585.703643335965, 6610.6694665267505, 5249.553787928069, 6402.0, 6406.295307516262, 6410.230772307353, 6432.2281326241155], "value": 6063.005137335779, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.962327072011, 828.9419740618157, 1204.6506513111199, 1296.3647812571842, 1299.1101095749418, 38124.42813357802, 38605.806970965175, 38877.0, 38921.80539097307, 38982.440702371874, 38941.831745047624, 39271.60728392715, 39316.0, 39546.8022659887, 39591.0, 8181.79545511361, 8417.579121043924, 8425.662973481085, 8425.915740842605, 8441.662333506652, 8360.581970901461, 8473.95763021184, 8480.78798030051, 8484.703035393763, 8490.150984901491, 8418.579071046423, 8481.236688698016, 8481.95759021204, 8513.914860851373, 8528.189821966904, 8366.03790564087, 8458.492490450593, 8482.957585212034, 8483.151684831468, 8493.66025358985, 8174.100848906615, 8183.877241841377, 8272.090070092285, 8288.792780180544, 8296.792580185544, 37577.43633845494, 37592.81203593992, 37708.62291377106, 37817.81091094555, 37882.86351409462, 3639.490471333989, 3658.506101676293, 3663.816809159531, 3665.7617254878346, 3674.2835147146316, 23434.0, 27094.864525677247, 30836.845815771, 30912.690873091207, 30953.53569696456, 2651.973480265192, 3072.4008818280445, 3148.732357749594, 3155.3373791503814, 3191.856366463515, 297002.0, 298389.0, 298942.50528747216, 298970.01029989857, 300186.0, 46403.5359646406, 49129.75435122873, 49161.0, 49194.7701307463, 49602.75198623984, 50579.49420505822, 50788.0, 50953.490465095616, 53855.46144538583, 53905.0, 14597.489087881873, 14629.92685036568, 14696.853031469762, 14725.263736813116, 14782.852171478362, 11750.0, 11890.524379024742, 11968.521259149711, 11978.981786548067, 11979.0, 13997.65005874841, 14061.78907316391, 14067.155970641794, 14096.718065638835, 14147.0, 5513.807016754395, 5858.4182270787505, 6115.541334399849, 6132.50939924805, 6138.1099740537375, 853.3599800149888, 1018.3940555369543, 1037.056278786301, 1038.5949479702922, 1068.738159151013, 21546.892265538885, 22879.656805147937, 23691.815409229468, 23855.403614909766, 23944.808031190223, 1119.2724728926264, 1120.5853834081443, 1149.3563604381407, 1151.8329842173005, 1165.6153469355093, 12261.448234829275, 12765.361731913366, 12808.6797830055, 12815.743685126432, 12864.742705145845, 286685.0, 334939.0, 335554.0, 337445.0, 337884.0, 55968.16047759287, 56047.719761400935, 56175.15737263944, 56218.0, 56322.7183864078, 1533.6165958510373, 1537.0700726060795, 1576.8659663928465, 1580.123031717385, 1588.118594180241, 22861.657075143554, 24520.264392068268, 24737.50524989526, 24738.50522989494, 24807.883645235648, 32953.0, 39072.80463597664, 39241.0, 39550.20899581935, 39554.406683899186, 270130.0, 271867.0, 272228.0, 272618.0, 272671.0, 35433.46849797203, 35845.10387240235, 36935.44596831103, 37033.44449833308, 37168.81415593013, 44501.55498445104, 45825.54174458213, 46496.53503464922, 47062.0, 47135.764321178176, 30808.229794255323, 31690.89081882123, 32160.517592236603, 32324.35351293008, 32556.837215813768, 31363.529547057267, 31824.84087579547, 32143.0, 32437.51343729799, 32723.509147362332, 37647.68233111828, 37749.62250377571, 38258.0, 39049.21901561896, 39126.0, 30373.39253214879, 30602.387952240384, 31635.050948471584, 31668.0, 32455.0, 18713.0, 25197.622035669112, 25216.49567008613, 25470.490590188463, 25515.0], "value": 17831.370065655916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.5996653263068, 428.1202129623624, 430.4210836425007, 440.1087797210649, 453.6484224725837, 18173.636527269446, 19627.509312267182, 21326.89336553317, 22114.668279975773, 22135.00392482338, 21929.780702192973, 22661.546769064607, 22777.63334199949, 23165.536689266206, 23357.2992810216, 6055.818325450233, 6197.535184861131, 6223.471004964584, 6230.439260466557, 6231.22109736283, 5947.88104237915, 6149.5080393568405, 6162.106494558287, 6201.813945581617, 6221.377862213765, 5280.287161233242, 5391.137418013119, 5982.760689572412, 6064.938635738728, 6086.482648974842, 6096.786612468564, 6169.167162433081, 6188.319284878659, 6190.783322583688, 6210.472109870644, 5312.574994000471, 5414.485623865727, 5507.091329930557, 5518.448155184489, 5518.475744804237, 28049.719502804914, 28808.0, 28975.710242897512, 29046.41907161866, 29361.706382936325, 2164.8809315487642, 2227.465408302012, 2238.8880555972137, 2239.8432109752325, 2241.69737085493, 17845.821541784677, 17897.19462624185, 18239.270429182816, 18452.53868653281, 18695.813041869544, 2150.849440539163, 2168.4036889855415, 2221.255879280427, 2222.7999480046874, 2226.554689062194, 172651.0, 172653.5979081985, 174446.0, 175156.0, 175245.0, 12942.411517696499, 13011.284379359036, 13095.41070651804, 13199.274039927705, 13270.668233294246, 14380.784288235685, 15095.01882377642, 16764.0, 16954.15229238533, 16982.490525284262, 7238.420926325882, 7424.294692004251, 8093.716719914774, 9132.726018219464, 9169.724908252763, 8823.55882205887, 8829.0, 8832.58678611419, 9004.0, 9007.504587247633, 8084.555349455836, 8178.591070446454, 8204.958975205085, 8246.09292977772, 8273.751787446387, 2205.6619982818265, 2213.0594497338566, 2218.7670294618833, 2227.3318004598877, 2393.066703985447, 843.2747836860295, 997.7206382212992, 1003.0871906565137, 1006.5420233793607, 1036.72008557689, 15266.847331526764, 20784.79215207859, 21422.57154856894, 21537.784622153576, 22108.88945555262, 1018.5823812236947, 1029.577873072037, 1052.4527245832123, 1060.390275591538, 1065.4832406282947, 9197.95401023004, 10125.341852779546, 11041.39272340029, 11197.832032519518, 11269.098472122374, 532656.0, 535323.0, 535681.0, 543853.0, 549772.0, 123890.0, 126617.7338226606, 136546.31726841303, 139533.0, 141894.0, 1190.2560899437851, 1213.8664746877837, 1260.0297770716497, 1262.9368531573384, 1270.7776139175792, 22481.550368992856, 22757.886210568842, 22759.970589988858, 22952.770472295062, 23051.423714407272, 55758.442415576945, 56892.71553642205, 57387.139192912975, 57594.42405575891, 58486.415135848096, 77848.61075694585, 78381.21618783739, 78624.60687696753, 78992.21007789849, 79063.0, 9099.0, 9140.634374625206, 9276.907230927603, 9277.0, 9291.163795258459, 14299.71400571962, 14358.282085895455, 14512.201828899511, 14859.628509287355, 14872.33074511628, 11138.498767555317, 12099.818502722643, 12124.515019399478, 12137.271763694207, 12254.632361029184, 9796.314258001872, 10688.89311106879, 11219.66341009771, 11604.361760103275, 11893.989010934167, 12034.773566890153, 12177.0, 12256.632301030982, 12261.816072758736, 12400.31798251105, 8885.289176865706, 9044.457332560067, 9099.954500227457, 9128.863067053866, 9139.954300228455, 9418.246540276898, 11777.587784427848, 11819.877111674377, 11859.822102668639, 12106.939465302617], "value": 10614.56463458044, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.9641258968525, 1489.7690857917028, 1491.068082448469, 1512.8880272999343, 1525.7406240939042, 11203.271787333828, 11659.183857130014, 11668.299902005885, 11687.707807304821, 11898.881011189886, 11674.941625291884, 11817.586384476544, 11869.169158158933, 11896.762064758721, 11896.929276365125, 2481.7021957365096, 2540.0855691950883, 2540.5808041673104, 2546.63073854291, 2547.5159719653298, 2204.0, 2511.6860392450944, 2527.84832910026, 2531.0, 2537.2388283514965, 2499.3126890105277, 2511.937201569957, 2536.1250368622796, 2552.0174732727846, 2556.309796354992, 2062.762782280042, 2252.839787509434, 2342.461233916209, 2371.442710962931, 2508.8118391120647, 2465.2111324376206, 2478.529079474894, 2480.045182604692, 2490.6264060390904, 2498.2755001049673, 11389.259698119678, 11726.237794543413, 11750.823737643857, 11784.528618855236, 11880.346580938045, 6464.806055818333, 6653.667316634197, 6723.899141512881, 6724.428423584001, 6728.091707619506, 3706.36991711407, 3963.920721585552, 4303.91392172158, 4360.49854266757, 4377.956220437819, 1087.2932593814085, 1235.7899157143306, 1236.9752604947942, 1295.6242689619999, 1296.863829297929, 12595.874041259562, 12879.87120128796, 16182.919085404616, 16343.0, 16373.59066023347, 4171.3325867860995, 4866.099771542276, 5467.125259958467, 5565.693886836263, 5628.380878103405, 8620.28461034772, 10970.396628185526, 11487.13846461502, 11728.12039097054, 11728.88271117295, 6479.287278399373, 6531.856925038194, 6534.705938232791, 6537.70580323877, 6537.836554086186, 6009.858126955952, 6085.117657939574, 6195.473384762256, 6197.1324014637985, 6199.969000155061, 3682.889513314551, 4293.506246781598, 4366.890827729332, 4397.2964325707735, 4406.383106365048, 1269.2701696524534, 1286.1832736212386, 1289.0283625963214, 1298.480607756886, 1301.8958483321312, 682.757621044532, 707.706301884712, 832.2883934236262, 841.4362377207286, 843.4559708987669, 6125.448709616156, 6197.721102550396, 6206.844828879224, 6292.653904035322, 6299.811005669837, 543.787354200128, 589.8908701890164, 590.6072461812932, 599.7241269016214, 622.5766478794463, 4015.19696060789, 4286.957130428718, 4308.676849236257, 4346.587074227943, 4400.185965596311, 14342.49801256951, 14616.196109214095, 14931.17878516692, 14957.775633365509, 14965.625859353604, 14321.928390357982, 14780.187089710169, 14898.627534311729, 14924.17917014553, 14971.550853474413, 8483.95758021206, 8513.233808957224, 8562.315014798802, 8638.870416943751, 8684.522351270614, 6523.151990241238, 6575.24384695747, 6629.7348106075215, 6727.327267273234, 6792.830179245559, 12757.617271481871, 13237.0, 13499.32503374847, 13574.981876359116, 13580.456781729015, 13268.734625307632, 13541.729165416833, 13543.72912541724, 13555.59333220005, 13883.167009979434, 7428.442866785121, 9100.453972761656, 9206.079392060741, 9425.905740942502, 9434.24526037929, 10809.837852432378, 10831.458427078773, 10976.780464390828, 10982.06652434552, 10998.780024399308, 8932.955335223282, 9052.818943621223, 9106.134917182857, 9119.316051296046, 9297.30270229749, 8801.91198088011, 8829.293656507592, 8846.734597962071, 8929.464232146092, 9034.593443294936, 6894.758683446055, 7013.684384202621, 7477.289657482531, 8043.155468675939, 8064.193580641889, 5997.220361352996, 6017.879642407215, 6029.0, 6060.0, 6145.8156255312415, 5619.409961953936, 6047.516198704006, 6089.934261504308, 6142.447179753844, 6238.937610624017], "value": 5242.092105070009, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.4377359244243, 411.9794010299484, 412.15508208173236, 413.5905453600936, 423.8410596026492, 5871.735771890265, 6472.482201423886, 6497.675116244181, 6499.350064993499, 6514.185726784141, 5862.208601838751, 6196.473299769514, 6240.719167637456, 6312.6212427254395, 6330.430261276484, 4481.0, 4580.931286030721, 4586.380838586798, 4591.1965406053805, 4596.7012144210685, 4576.835080077114, 4592.471865735433, 4608.5161058088925, 4609.631229501649, 4623.861284161464, 4531.56950089741, 4544.5228251033495, 4554.111948170108, 4584.610308123813, 4608.331791890174, 4369.868903932887, 4527.841525546623, 4556.931646025312, 4569.246074397721, 4572.794224259899, 3871.1096447816876, 3879.6314350136972, 3882.844686212548, 3888.9027774305587, 3890.533136023667, 4821.7589120543835, 5349.411564727877, 6021.759129634809, 6197.752089916398, 6212.751489940397, 5321.441248668912, 5400.729963501848, 5429.511343979061, 5456.536194423439, 5472.413000229929, 5363.839084827422, 5762.193292938992, 6604.636744979024, 6757.0, 6793.4225590824835, 3844.3656796628525, 4198.349255865346, 4384.89037774055, 4386.956130438687, 4396.758178300192, 5933.881322373529, 6975.651217439158, 7004.474664400191, 7119.540494198729, 7192.4246060315045, 3850.961490385116, 3903.277893589695, 4285.628598848339, 4441.356003379557, 4448.733076015449, 3870.5935876732538, 4451.020775429401, 4515.622735065836, 4523.615492683093, 4532.27483602622, 5175.922361164586, 5194.142966410575, 5299.735013249322, 5328.467153284718, 5360.490753378501, 5654.8407576446725, 6735.124433823572, 6776.830579235559, 6779.966100169468, 6791.524593278522, 1321.596912941562, 1532.1266877879725, 1538.6461113943856, 1540.5147378575714, 1543.467503711218, 858.454881150474, 989.3618615992644, 995.3132338686283, 1004.4932601098352, 1006.2050979726081, 5224.16413373866, 6421.550491465646, 6496.252930912911, 6509.218893732783, 6573.934260657332, 5858.418227078665, 5912.822615321461, 7023.541760383825, 7043.9647801761685, 7064.92935070653, 5989.760409583655, 6400.135981642418, 6472.983437835715, 6473.0, 6506.251781045145, 3204.7115759581284, 3209.6950789674943, 3545.9290814183573, 3603.5135256740004, 3727.254549090193, 5773.88452230953, 5856.565141540264, 6737.831554211086, 7290.234525374865, 7303.780886573411, 6022.789202377983, 6984.196817366068, 7082.0, 7238.746643867439, 7258.419326453871, 6918.308169183142, 7019.4384449243935, 7266.63666816657, 7333.266673332838, 7374.9262507375315, 7057.541259818096, 7070.46971477131, 7107.040549525748, 7107.60908150036, 7109.537880037781, 5741.827745167651, 6826.522143449911, 6908.378245957888, 6940.466729643745, 6944.930550694428, 6453.548251622341, 7080.504364694422, 7286.6720997556295, 7316.9634151828905, 7416.4066874648815, 3707.3141468828353, 3904.1996390740396, 4062.8374865005067, 4333.328334108218, 4432.490263619725, 5350.919736203882, 6939.514234003571, 6951.513394062367, 7058.494234546662, 7101.786946391617, 6823.829404264933, 6824.658767061528, 6833.180018397824, 6836.623985680835, 6844.836377815684, 6585.6377899216, 6711.194656641039, 6790.287019863041, 6795.966020169867, 6798.824376199569, 5915.260592425947, 6473.838154046187, 6623.4038936495945, 6636.568623039487, 6660.933390666225, 6580.440662543738, 6715.4963377747845, 6788.151481064867, 6807.489438292049, 6812.4890633203695, 5729.427057294404, 6594.241662208716, 6600.2409722882485, 6612.858892026249, 6619.602823830585], "value": 4853.798082752448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.3379828540592, 840.7183593496178, 858.7509622209559, 871.3595507302132, 884.0408157149494, 16515.66968660626, 16733.91633041836, 16830.66338673226, 18592.256309747594, 19149.42551723447, 17867.73198402025, 18203.27068928453, 18229.17968691409, 18367.632647347044, 18438.170282337294, 1007.3502590828911, 1010.5604062232916, 1023.2172388123055, 1034.4724190662778, 1035.2597892506856, 1017.7150397888603, 1020.8928062553437, 1025.133761971137, 1027.0807627173674, 1027.3527677563125, 1073.431081526792, 1080.6055789636805, 1080.751427171747, 1082.7401423658305, 1084.5932775209296, 1059.8251288537383, 1072.2815713471953, 1075.510642657589, 1077.2513103393144, 1080.5461706083424, 762.1730422491603, 766.8312971146339, 775.3758224629171, 777.0054330457024, 779.0, 16977.83022169775, 17312.307507699676, 17336.3065477382, 17513.562160945952, 17526.123693815385, 16397.42609008691, 17057.488275351636, 17272.481825545256, 17577.912110439494, 17631.942083474903, 12084.577039803564, 14154.646133846736, 14571.562853114423, 14625.976181667287, 15666.0, 3549.112721819545, 3576.445650924111, 3594.2452085061905, 3595.406757884946, 3602.2075143468655, 124492.0, 124971.12774286428, 125653.0, 127554.08668869974, 128979.0, 11513.078953683686, 13096.738065238642, 13230.20618762858, 13332.800007999887, 13443.193408395528, 21290.25484108049, 25464.236072917472, 25800.09699660503, 25834.095806646677, 26376.0, 7777.377809775205, 7811.375089992787, 7875.133735289113, 7879.881801772978, 7887.921120788834, 3845.2309538092495, 3963.246983073207, 4010.3783913493453, 4027.556968733437, 4037.414574886625, 4311.094670119247, 4332.328489084134, 4404.383386325917, 4406.977965110218, 4408.603225709638, 873.895132584094, 890.2699786175403, 894.4186278918755, 898.6854600889767, 899.5277479323407, 621.7761605821901, 651.8565915498583, 655.7016557466342, 664.6045602866287, 683.1452606174261, 10537.6301080859, 11090.778184436265, 11182.273152245078, 11803.52785888572, 12250.571230006906, 638.1480723234533, 652.1880259077479, 665.7170702451439, 676.0024128699681, 687.5737043033351, 4284.400183974246, 5402.486763757437, 5522.282103326542, 5564.998300305984, 5604.243427137366, 114115.0, 114219.0, 114599.42700286445, 114830.42584787022, 114966.42516787362, 82020.58989705013, 87073.0, 89215.55392222997, 89542.0, 89656.0, 80447.0, 80631.59684201541, 81207.593962031, 83156.0, 83311.16688833034, 11065.557377705123, 11749.530018799152, 12674.746505069663, 12852.357382130669, 12852.871471285167, 37534.249315014094, 39106.6089339103, 39785.60214397935, 40022.0, 41148.0, 53118.2032269524, 53762.0, 54013.72993135166, 54097.18854217111, 54180.458195419116, 15882.126483043081, 16636.750448743038, 16761.580960476087, 17115.0, 17151.571210719332, 16578.50264492067, 16870.287367521465, 18250.17874195691, 18254.269829207213, 18552.0, 16532.83467165361, 17215.913920430317, 17326.74009889878, 17358.0, 17428.390006349717, 16725.996440213625, 16847.0, 16852.9888206708, 17086.829131708524, 17177.570560736083, 13761.761441470317, 15860.44488442899, 16126.838731613003, 16509.257083431516, 16926.238319275417, 11718.88281117178, 11776.70558236051, 12208.511659533875, 12292.262464252173, 12303.44634491432, 12343.321117338273, 12349.567765128177, 12443.253404795742, 13032.5438609652, 13065.608031759062], "value": 8441.39822949566, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 168.0, 136.0, 114.0, 117.0, 115.0, 116.0, 115.0, 116.0, 115.0], "value": 126.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 106.0, 111.0, 175.0, 144.0, 112.0, 115.0, 146.0, 141.0, 112.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 198.0, 202.0, 215.0, 246.0, 255.0, 203.0, 201.0, 196.0, 198.0], "value": 211.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 60.0, 81.0, 60.0, 62.0, 60.0, 83.0, 80.0, 55.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 86.0, 85.0, 100.0, 101.0, 107.0, 71.0, 71.0, 90.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 89.0, 90.0, 104.0, 113.0, 76.0, 87.0, 116.0, 137.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 98.0, 125.0, 155.0, 127.0, 98.0, 147.0, 117.0, 143.0], "value": 120.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 90.0, 94.0, 91.0, 91.0, 93.0, 136.0, 147.0, 83.0], "value": 100.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 50.0, 51.0, 55.0, 52.0, 52.0, 53.0, 53.0, 50.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 66.0, 60.0, 70.0, 54.0, 80.0, 50.0, 55.0, 65.0, 80.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 83.0, 89.0, 73.0, 84.0, 107.0, 109.0, 81.0, 84.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 135.0, 146.0, 136.0, 145.0, 145.0, 143.0, 187.0, 140.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 188.0, 185.0, 163.0, 229.0, 243.0, 197.0, 185.0, 185.0, 179.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 69.0, 71.0, 69.0, 70.0, 66.0, 74.0, 94.0, 102.0], "value": 75.4, "unit": "score"}]}]} 02:46:17 INFO - Return code: 0 02:46:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:46:17 INFO - # TBPL SUCCESS # 02:46:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:46:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:46:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:46:17 INFO - 2017-05-03 02:46:17.338 screenresolution[1663:10898] starting screenresolution argv=screenresolution get 02:46:17 INFO - 2017-05-03 02:46:17.341 screenresolution[1663:10898] Display 0: 1600x1200x32@60 02:46:17 INFO - 2017-05-03 02:46:17.347 screenresolution[1664:10901] starting screenresolution argv=screenresolution list 02:46:17 INFO - Available Modes on Display 0 02:46:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:46:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:46:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:46:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:46:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:46:17 INFO - Intel Iris: 02:46:17 INFO - Chipset Model: Intel Iris 02:46:17 INFO - Type: GPU 02:46:17 INFO - Bus: Built-In 02:46:17 INFO - VRAM (Dynamic, Max): 1536 MB 02:46:17 INFO - Vendor: Intel (0x8086) 02:46:17 INFO - Device ID: 0x0a2e 02:46:17 INFO - Revision ID: 0x0009 02:46:17 INFO - Displays: 02:46:17 INFO - Display: 02:46:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:46:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:46:17 INFO - Display Serial Number: 1600x1200 60 02:46:17 INFO - Main Display: Yes 02:46:17 INFO - Mirror: Off 02:46:17 INFO - Online: Yes 02:46:17 INFO - Rotation: Supported 02:46:17 INFO - Return code: 0 02:46:17 INFO - Running post-action listener: _resource_record_post_action 02:46:17 INFO - [mozharness: 2017-05-03 09:46:17.590394Z] Finished run-tests step (success) 02:46:17 INFO - Running post-run listener: _resource_record_post_run 02:46:17 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 39013376; Write bytes: 507795968; Read time: 251; Write time: 1620 02:46:17 INFO - TinderboxPrint: CPU usage
54.0% 02:46:17 INFO - TinderboxPrint: I/O read bytes / time
39,013,376 / 251 02:46:17 INFO - TinderboxPrint: I/O write bytes / time
507,795,968 / 1,620 02:46:17 INFO - TinderboxPrint: CPU idle
2,201.1 (46.0%) 02:46:17 INFO - TinderboxPrint: CPU system
959.4 (20.1%) 02:46:17 INFO - TinderboxPrint: CPU user
1,621.1 (33.9%) 02:46:17 INFO - TinderboxPrint: Swap in / out
248,365,056 / 0 02:46:17 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209791488; Write bytes: 211531264; Read time: 16137; Write time: 472 02:46:17 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34999296; Write bytes: 294929408; Read time: 226; Write time: 1141 02:46:18 INFO - Running post-run listener: _upload_blobber_files 02:46:18 INFO - Blob upload gear active. 02:46:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:46:18 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 02:46:18 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'] 02:46:18 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 02:46:18 INFO - (blobuploader) - INFO - Open directory for files ... 02:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:19 INFO - (blobuploader) - INFO - Done attempting. 02:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:46:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:20 INFO - (blobuploader) - INFO - Done attempting. 02:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:21 INFO - (blobuploader) - INFO - Done attempting. 02:46:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:46:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:46:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:23 INFO - (blobuploader) - INFO - Done attempting. 02:46:23 INFO - (blobuploader) - INFO - Iteration through files over. 02:46:23 INFO - Return code: 0 02:46:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:46:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:46:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32855bf42c63c400d11310e20802a07f777195185f022fd5a47e6e62faaa5c8efc115a9973a661598ed60a8df8a47c8730eaac3a552042c311677dbce5c73874", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a193637ca3d7eaaabf6358611b1725e51c8e0a3de9a4eb9eb4e277855422298838246fcb1cf981679bb7c6faced24c9d876ed0a98704acef556374773060277", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c83cbc4327dbef814c6a519a107ace22f563e76add28bbecaacd17de0cf411735dffd353ba2eedf35eb0baf7aeadb02cb5f9916900b385b429b4a4c8a8c27ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d69070fc71dc4117664077bbbd78cc9efc22184f5b18d0b1a7e76d855b46c4e2f2837c85808ff9b720ce8416a94791e14a6855bad4bfcd1146fbb57d3f202068"} 02:46:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:46:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:46:23 INFO - Contents: 02:46:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32855bf42c63c400d11310e20802a07f777195185f022fd5a47e6e62faaa5c8efc115a9973a661598ed60a8df8a47c8730eaac3a552042c311677dbce5c73874", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a193637ca3d7eaaabf6358611b1725e51c8e0a3de9a4eb9eb4e277855422298838246fcb1cf981679bb7c6faced24c9d876ed0a98704acef556374773060277", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c83cbc4327dbef814c6a519a107ace22f563e76add28bbecaacd17de0cf411735dffd353ba2eedf35eb0baf7aeadb02cb5f9916900b385b429b4a4c8a8c27ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d69070fc71dc4117664077bbbd78cc9efc22184f5b18d0b1a7e76d855b46c4e2f2837c85808ff9b720ce8416a94791e14a6855bad4bfcd1146fbb57d3f202068"} 02:46:23 INFO - Running post-run listener: copy_logs_to_upload_dir 02:46:23 INFO - Copying logs to upload dir... 02:46:23 INFO - mkdir: /builds/slave/test/build/upload/logs 02:46:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.615152 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-05-03 02:46:23.352213) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:23.356514) ========= 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.qyF9cscdHG/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.OTOLfox84k/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/32855bf42c63c400d11310e20802a07f777195185f022fd5a47e6e62faaa5c8efc115a9973a661598ed60a8df8a47c8730eaac3a552042c311677dbce5c73874", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a193637ca3d7eaaabf6358611b1725e51c8e0a3de9a4eb9eb4e277855422298838246fcb1cf981679bb7c6faced24c9d876ed0a98704acef556374773060277", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c83cbc4327dbef814c6a519a107ace22f563e76add28bbecaacd17de0cf411735dffd353ba2eedf35eb0baf7aeadb02cb5f9916900b385b429b4a4c8a8c27ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d69070fc71dc4117664077bbbd78cc9efc22184f5b18d0b1a7e76d855b46c4e2f2837c85808ff9b720ce8416a94791e14a6855bad4bfcd1146fbb57d3f202068"} build_url:https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010684 build_url: 'https://queue.taskcluster.net/v1/task/NE7m8POeTfm-_ilsOOCczQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32855bf42c63c400d11310e20802a07f777195185f022fd5a47e6e62faaa5c8efc115a9973a661598ed60a8df8a47c8730eaac3a552042c311677dbce5c73874", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a193637ca3d7eaaabf6358611b1725e51c8e0a3de9a4eb9eb4e277855422298838246fcb1cf981679bb7c6faced24c9d876ed0a98704acef556374773060277", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c83cbc4327dbef814c6a519a107ace22f563e76add28bbecaacd17de0cf411735dffd353ba2eedf35eb0baf7aeadb02cb5f9916900b385b429b4a4c8a8c27ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d69070fc71dc4117664077bbbd78cc9efc22184f5b18d0b1a7e76d855b46c4e2f2837c85808ff9b720ce8416a94791e14a6855bad4bfcd1146fbb57d3f202068"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:23.396111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:23.396458) ========= 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.qyF9cscdHG/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.OTOLfox84k/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.005209 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 02:46:23.444815) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 02:46:23.445135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 02:46:23.445474) ========= ========= Total master_lag: 0.19 =========