builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0343 starttime: 1481977857.59 results: success (0) buildid: 20161217030205 builduid: 8f1b690f72f34d808a34bc2373eea071 revision: 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:57.585397) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:57.585958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:57.586283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:57.613138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:57.613600) ========= 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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-17 04:30:57-- 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% 157M=0s 2016-12-17 04:30:57 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135232 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:57.774209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:57.774797) ========= 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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.025319 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:57.825281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-17 04:30:57.825807) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 --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 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-17 04:30:57,926 truncating revision to first 12 chars 2016-12-17 04:30:57,926 Setting DEBUG logging. 2016-12-17 04:30:57,926 attempt 1/10 2016-12-17 04:30:57,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34a1ab064cb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-17 04:30:59,048 unpacking tar archive at: mozilla-central-34a1ab064cb5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.399077 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-17 04:30:59.248101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:59.248450) ========= script_repo_revision: 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:59.248879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:59.249160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 04:30:59.268926) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-17 04:30:59.269337) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:30:59 INFO - MultiFileLogger online at 20161217 04:30:59 in /builds/slave/test 04:30:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:30:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:59 INFO - {'append_to_log': False, 04:30:59 INFO - 'base_work_dir': '/builds/slave/test', 04:30:59 INFO - 'blob_upload_branch': 'Firefox', 04:30:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:59 INFO - 'branch': 'Firefox', 04:30:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:59 INFO - 'config_files': ('talos/mac_config.py',), 04:30:59 INFO - 'default_actions': ('clobber', 04:30:59 INFO - 'read-buildbot-config', 04:30:59 INFO - 'download-and-extract', 04:30:59 INFO - 'populate-webroot', 04:30:59 INFO - 'create-virtualenv', 04:30:59 INFO - 'install', 04:30:59 INFO - 'run-tests'), 04:30:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:59 INFO - 'download_minidump_stackwalk': True, 04:30:59 INFO - 'download_symbols': 'ondemand', 04:30:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:59 INFO - 'installer_path': 'installer.exe', 04:30:59 INFO - 'log_level': 'info', 04:30:59 INFO - 'log_name': 'talos', 04:30:59 INFO - 'log_to_console': True, 04:30:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:30:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:30:59 INFO - 'opt_config_files': (), 04:30:59 INFO - 'pip_index': False, 04:30:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:59 INFO - 'cmd': ('bash', 04:30:59 INFO - '-c', 04:30:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:59 INFO - 'enabled': True, 04:30:59 INFO - 'halt_on_failure': False, 04:30:59 INFO - 'name': 'check_screen_resolution'},), 04:30:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:59 INFO - 'cmd': ('bash', 04:30:59 INFO - '-c', 04:30:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:59 INFO - 'enabled': True, 04:30:59 INFO - 'halt_on_failure': False, 04:30:59 INFO - 'name': 'check_screen_resolution'},), 04:30:59 INFO - 'run_cmd_checks_enabled': True, 04:30:59 INFO - 'sps_profile': False, 04:30:59 INFO - 'sps_profile_interval': 0, 04:30:59 INFO - 'suite': 'dromaeojs', 04:30:59 INFO - 'system_bits': '32', 04:30:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:59 INFO - 'title': 't-yosemite-r7-0343', 04:30:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:59 INFO - 'use_talos_json': True, 04:30:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:59 INFO - 'work_dir': 'build'} 04:30:59 INFO - [mozharness: 2016-12-17 12:30:59.476437Z] Running clobber step. 04:30:59 INFO - Running pre-action listener: _resource_record_pre_action 04:30:59 INFO - Running main action method: clobber 04:30:59 INFO - rmtree: /builds/slave/test/build 04:30:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:01 INFO - Running post-action listener: _resource_record_post_action 04:31:01 INFO - [mozharness: 2016-12-17 12:31:01.980153Z] Finished clobber step (success) 04:31:01 INFO - [mozharness: 2016-12-17 12:31:01.980340Z] Running read-buildbot-config step. 04:31:01 INFO - Running pre-action listener: _resource_record_pre_action 04:31:01 INFO - Running main action method: read_buildbot_config 04:31:01 INFO - Using buildbot properties: 04:31:01 INFO - { 04:31:01 INFO - "project": "", 04:31:01 INFO - "product": "firefox", 04:31:01 INFO - "script_repo_revision": "production", 04:31:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:31:01 INFO - "repository": "", 04:31:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:31:01 INFO - "buildid": "20161217030205", 04:31:01 INFO - "stage_platform": "macosx64", 04:31:01 INFO - "basedir": "/builds/slave/test", 04:31:01 INFO - "nightly_build": "True", 04:31:01 INFO - "buildnumber": 46, 04:31:01 INFO - "slavename": "t-yosemite-r7-0343", 04:31:01 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:31:01 INFO - "platform": "yosemite_r7", 04:31:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:31:01 INFO - "branch": "mozilla-central", 04:31:01 INFO - "repo_path": "mozilla-central", 04:31:01 INFO - "revision": "34a1ab064cb5b868fa75cb74d052e978eb34d6c1", 04:31:01 INFO - "pgo_build": "False", 04:31:01 INFO - "builduid": "8f1b690f72f34d808a34bc2373eea071", 04:31:01 INFO - "slavebuilddir": "test" 04:31:01 INFO - } 04:31:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:31:01 INFO - Running post-action listener: _resource_record_post_action 04:31:01 INFO - [mozharness: 2016-12-17 12:31:01.986086Z] Finished read-buildbot-config step (success) 04:31:01 INFO - [mozharness: 2016-12-17 12:31:01.986315Z] Running download-and-extract step. 04:31:01 INFO - Running pre-action listener: _resource_record_pre_action 04:31:01 INFO - Running main action method: download_and_extract 04:31:01 INFO - mkdir: /builds/slave/test/build/tests 04:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:01 INFO - trying https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:31:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:31:03 INFO - Downloaded 1199 bytes. 04:31:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:31:03 INFO - Using the following test package requirements: 04:31:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:31:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:31:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:31:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:31:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:31:03 INFO - u'jsshell-mac.zip'], 04:31:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:31:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:31:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:31:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:31:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:31:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:31:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:31:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:31:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:31:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:31:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:31:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:31:04 INFO - Expected file size: 16278133 04:31:04 INFO - Obtained file size: 16278133 04:31:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:31:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:31:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:31:11 INFO - Expected file size: 16278133 04:31:11 INFO - Obtained file size: 16278133 04:31:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:31:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:31:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:31:18 INFO - Expected file size: 14409734 04:31:18 INFO - Obtained file size: 14409734 04:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:19 INFO - trying https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:31:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:31:21 INFO - Downloaded 69640750 bytes. 04:31:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:31:21 INFO - mkdir: /builds/slave/test/properties 04:31:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:21 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:21 INFO - Contents: 04:31:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:31:21 INFO - Running post-action listener: _resource_record_post_action 04:31:21 INFO - Running post-action listener: set_extra_try_arguments 04:31:21 INFO - [mozharness: 2016-12-17 12:31:21.771896Z] Finished download-and-extract step (success) 04:31:21 INFO - [mozharness: 2016-12-17 12:31:21.772039Z] Running populate-webroot step. 04:31:21 INFO - Running pre-action listener: _resource_record_pre_action 04:31:21 INFO - Running main action method: populate_webroot 04:31:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:21 INFO - '--tppagecycles', 04:31:21 INFO - '7'], 04:31:21 INFO - 'tests': ['tsvgm']}}, 04:31:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:31:21 INFO - 'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:31:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:31:21 INFO - 'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['damp', 'tps']}, 04:31:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:31:21 INFO - 'tests': ['damp', 'tps']}, 04:31:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['dromaeo_dom']}, 04:31:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['basic_compositor_video']}, 04:31:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:31:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['a11yr', 04:31:21 INFO - 'ts_paint', 04:31:21 INFO - 'tpaint', 04:31:21 INFO - 'sessionrestore', 04:31:21 INFO - 'sessionrestore_no_auto_restore', 04:31:21 INFO - 'tabpaint']}, 04:31:21 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:21 INFO - 'ts_paint', 04:31:21 INFO - 'tpaint', 04:31:21 INFO - 'sessionrestore', 04:31:21 INFO - 'sessionrestore_no_auto_restore', 04:31:21 INFO - 'tabpaint']}, 04:31:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:21 INFO - 'ts_paint', 04:31:21 INFO - 'tpaint', 04:31:21 INFO - 'sessionrestore', 04:31:21 INFO - 'sessionrestore_no_auto_restore', 04:31:21 INFO - 'tabpaint']}, 04:31:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:21 INFO - 'ts_paint', 04:31:21 INFO - 'tpaint', 04:31:21 INFO - 'sessionrestore', 04:31:21 INFO - 'sessionrestore_no_auto_restore', 04:31:21 INFO - 'tabpaint']}, 04:31:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['a11yr', 04:31:21 INFO - 'ts_paint', 04:31:21 INFO - 'tpaint', 04:31:21 INFO - 'sessionrestore', 04:31:21 INFO - 'sessionrestore_no_auto_restore', 04:31:21 INFO - 'tabpaint']}, 04:31:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['a11yr', 04:31:21 INFO - 'ts_paint', 04:31:21 INFO - 'tpaint', 04:31:21 INFO - 'sessionrestore', 04:31:21 INFO - 'sessionrestore_no_auto_restore', 04:31:21 INFO - 'tabpaint']}, 04:31:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['tsvgx', 04:31:21 INFO - 'tsvgr_opacity', 04:31:21 INFO - 'tart', 04:31:21 INFO - 'tscrollx', 04:31:21 INFO - 'cart', 04:31:21 INFO - 'tsvg_static']}, 04:31:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:21 INFO - 'tsvgr_opacity', 04:31:21 INFO - 'tart', 04:31:21 INFO - 'tscrollx', 04:31:21 INFO - 'cart', 04:31:21 INFO - 'tsvg_static']}, 04:31:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:31:21 INFO - 'talos_options': ['--disable-e10s'], 04:31:21 INFO - 'tests': ['tp5o']}, 04:31:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:31:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:31:21 INFO - 'talos_options': ['--disable-e10s', 04:31:21 INFO - '--xperf_path', 04:31:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:21 INFO - 'tests': ['tp5n']}, 04:31:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:31:21 INFO - 'talos_options': ['--xperf_path', 04:31:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:21 INFO - 'tests': ['tp5n']}}, 04:31:21 INFO - 'talos.zip': {'path': '', 04:31:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:21 INFO - Running post-action listener: _resource_record_post_action 04:31:21 INFO - [mozharness: 2016-12-17 12:31:21.790379Z] Finished populate-webroot step (success) 04:31:21 INFO - [mozharness: 2016-12-17 12:31:21.790515Z] Running create-virtualenv step. 04:31:21 INFO - Running pre-action listener: _resource_record_pre_action 04:31:21 INFO - Running main action method: create_virtualenv 04:31:21 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:21 INFO - Using real prefix '/tools/python27' 04:31:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:22 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:25 INFO - Installing pip.................done. 04:31:25 INFO - Return code: 0 04:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:31:25 INFO - Reading from file tmpfile_stdout 04:31:25 INFO - Output received: 04:31:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:31:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:25 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 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:25 INFO - 'HOME': '/Users/cltbld', 04:31:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:25 INFO - 'LOGNAME': 'cltbld', 04:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:25 INFO - 'MOZ_NO_REMOTE': '1', 04:31:25 INFO - 'NO_EM_RESTART': '1', 04:31:25 INFO - 'PAGER': '/bin/cat', 04:31:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:25 INFO - 'PWD': '/builds/slave/test', 04:31:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:25 INFO - 'SHELL': '/bin/bash', 04:31:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:25 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:25 INFO - 'USER': 'cltbld', 04:31:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:25 INFO - 'XPC_FLAGS': '0x0', 04:31:25 INFO - 'XPC_SERVICE_NAME': '0', 04:31:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:31:26 INFO - Cleaning up... 04:31:26 INFO - Return code: 0 04:31:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:26 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 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:26 INFO - 'HOME': '/Users/cltbld', 04:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:26 INFO - 'LOGNAME': 'cltbld', 04:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:26 INFO - 'MOZ_NO_REMOTE': '1', 04:31:26 INFO - 'NO_EM_RESTART': '1', 04:31:26 INFO - 'PAGER': '/bin/cat', 04:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:26 INFO - 'PWD': '/builds/slave/test', 04:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:26 INFO - 'SHELL': '/bin/bash', 04:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:26 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:26 INFO - 'USER': 'cltbld', 04:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:26 INFO - 'XPC_FLAGS': '0x0', 04:31:26 INFO - 'XPC_SERVICE_NAME': '0', 04:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:26 INFO - Downloading/unpacking psutil>=3.1.1 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:29 INFO - Installing collected packages: psutil 04:31:29 INFO - Running setup.py install for psutil 04:31:29 INFO - building 'psutil._psutil_osx' extension 04:31:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:31:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:31:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:31:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:31:30 INFO - building 'psutil._psutil_posix' extension 04:31:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:31:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:31:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:31:30 INFO - ^ 04:31:30 INFO - 1 warning generated. 04:31:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:30 INFO - Successfully installed psutil 04:31:30 INFO - Cleaning up... 04:31:31 INFO - Return code: 0 04:31:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 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 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:31 INFO - 'HOME': '/Users/cltbld', 04:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:31 INFO - 'LOGNAME': 'cltbld', 04:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:31 INFO - 'MOZ_NO_REMOTE': '1', 04:31:31 INFO - 'NO_EM_RESTART': '1', 04:31:31 INFO - 'PAGER': '/bin/cat', 04:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:31 INFO - 'PWD': '/builds/slave/test', 04:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:31 INFO - 'SHELL': '/bin/bash', 04:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:31 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:31 INFO - 'USER': 'cltbld', 04:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:31 INFO - 'XPC_FLAGS': '0x0', 04:31:31 INFO - 'XPC_SERVICE_NAME': '0', 04:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:31:33 INFO - Installing collected packages: mozsystemmonitor 04:31:33 INFO - Running setup.py install for mozsystemmonitor 04:31:34 INFO - Successfully installed mozsystemmonitor 04:31:34 INFO - Cleaning up... 04:31:34 INFO - Return code: 0 04:31:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:34 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 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:31:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:34 INFO - 'HOME': '/Users/cltbld', 04:31:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:34 INFO - 'LOGNAME': 'cltbld', 04:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:34 INFO - 'MOZ_NO_REMOTE': '1', 04:31:34 INFO - 'NO_EM_RESTART': '1', 04:31:34 INFO - 'PAGER': '/bin/cat', 04:31:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:34 INFO - 'PWD': '/builds/slave/test', 04:31:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:34 INFO - 'SHELL': '/bin/bash', 04:31:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:34 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:34 INFO - 'USER': 'cltbld', 04:31:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:34 INFO - 'XPC_FLAGS': '0x0', 04:31:34 INFO - 'XPC_SERVICE_NAME': '0', 04:31:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:34 INFO - Downloading/unpacking jsonschema==2.5.1 04:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:37 INFO - warning: no files found matching '*.txt' 04:31:37 INFO - no previously-included directories found matching 'build' 04:31:37 INFO - no previously-included directories found matching 'dist' 04:31:37 INFO - no previously-included directories found matching '.git*' 04:31:37 INFO - Installing collected packages: jsonschema, functools32 04:31:37 INFO - Running setup.py install for functools32 04:31:37 INFO - warning: no files found matching '*.txt' 04:31:37 INFO - no previously-included directories found matching 'build' 04:31:37 INFO - no previously-included directories found matching 'dist' 04:31:37 INFO - no previously-included directories found matching '.git*' 04:31:37 INFO - Successfully installed jsonschema functools32 04:31:37 INFO - Cleaning up... 04:31:37 INFO - Return code: 0 04:31:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:37 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 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:37 INFO - 'HOME': '/Users/cltbld', 04:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:37 INFO - 'LOGNAME': 'cltbld', 04:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:37 INFO - 'MOZ_NO_REMOTE': '1', 04:31:37 INFO - 'NO_EM_RESTART': '1', 04:31:37 INFO - 'PAGER': '/bin/cat', 04:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:37 INFO - 'PWD': '/builds/slave/test', 04:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:37 INFO - 'SHELL': '/bin/bash', 04:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:37 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:37 INFO - 'USER': 'cltbld', 04:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:37 INFO - 'XPC_FLAGS': '0x0', 04:31:37 INFO - 'XPC_SERVICE_NAME': '0', 04:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:31:38 INFO - Cleaning up... 04:31:38 INFO - Return code: 0 04:31:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:38 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 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:38 INFO - 'HOME': '/Users/cltbld', 04:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:38 INFO - 'LOGNAME': 'cltbld', 04:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:38 INFO - 'MOZ_NO_REMOTE': '1', 04:31:38 INFO - 'NO_EM_RESTART': '1', 04:31:38 INFO - 'PAGER': '/bin/cat', 04:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:38 INFO - 'PWD': '/builds/slave/test', 04:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:38 INFO - 'SHELL': '/bin/bash', 04:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:38 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:38 INFO - 'USER': 'cltbld', 04:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:38 INFO - 'XPC_FLAGS': '0x0', 04:31:38 INFO - 'XPC_SERVICE_NAME': '0', 04:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:42 INFO - Downloading docopt-0.6.1.tar.gz 04:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:42 INFO - Running setup.py install for blobuploader 04:31:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:42 INFO - Running setup.py install for requests 04:31:42 INFO - Running setup.py install for docopt 04:31:42 INFO - Successfully installed blobuploader requests docopt 04:31:42 INFO - Cleaning up... 04:31:43 INFO - Return code: 0 04:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 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 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:43 INFO - 'HOME': '/Users/cltbld', 04:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:43 INFO - 'LOGNAME': 'cltbld', 04:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:43 INFO - 'MOZ_NO_REMOTE': '1', 04:31:43 INFO - 'NO_EM_RESTART': '1', 04:31:43 INFO - 'PAGER': '/bin/cat', 04:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:43 INFO - 'PWD': '/builds/slave/test', 04:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:43 INFO - 'SHELL': '/bin/bash', 04:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:43 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:43 INFO - 'USER': 'cltbld', 04:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:43 INFO - 'XPC_FLAGS': '0x0', 04:31:43 INFO - 'XPC_SERVICE_NAME': '0', 04:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-hwR6_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-N45On2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-gi5e1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-ODZ83i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-TFYZgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-wrEqEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-YCtt_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-WOX5ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-P9NaAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-wGncvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-zaUGg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-2mfb0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-TlrNox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-yorTXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-BTRwra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-MWSjoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-UzyMgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:45 INFO - Running setup.py install for manifestparser 04:31:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozcrash 04:31:45 INFO - Running setup.py install for mozdebug 04:31:45 INFO - Running setup.py install for mozdevice 04:31:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozfile 04:31:45 INFO - Running setup.py install for mozhttpd 04:31:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozinfo 04:31:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for mozInstall 04:31:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for mozleak 04:31:46 INFO - Running setup.py install for mozlog 04:31:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for moznetwork 04:31:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for mozprocess 04:31:46 INFO - Running setup.py install for mozprofile 04:31:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:47 INFO - Running setup.py install for mozrunner 04:31:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:47 INFO - Running setup.py install for mozscreenshot 04:31:47 INFO - Running setup.py install for moztest 04:31:47 INFO - Running setup.py install for mozversion 04:31:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:47 INFO - Cleaning up... 04:31:47 INFO - Return code: 0 04:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:47 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 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:47 INFO - 'HOME': '/Users/cltbld', 04:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:47 INFO - 'LOGNAME': 'cltbld', 04:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:47 INFO - 'MOZ_NO_REMOTE': '1', 04:31:47 INFO - 'NO_EM_RESTART': '1', 04:31:47 INFO - 'PAGER': '/bin/cat', 04:31:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:47 INFO - 'PWD': '/builds/slave/test', 04:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:47 INFO - 'SHELL': '/bin/bash', 04:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:47 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:47 INFO - 'USER': 'cltbld', 04:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:47 INFO - 'XPC_FLAGS': '0x0', 04:31:47 INFO - 'XPC_SERVICE_NAME': '0', 04:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-P4R9dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-aukJD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-vHWkGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-5nmqMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-JnYZhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-N5xtp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-cj7Wwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-zcTEz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-XFquHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-uUZJMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-oHW7JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:49 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-dlgcQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:49 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-zmmEck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:49 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-KhRQRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:49 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-X2zLeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:49 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-JKs0XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:49 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-RiZ7lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:52 INFO - Downloading blessings-1.6.tar.gz 04:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:52 INFO - Installing collected packages: blessings 04:31:52 INFO - Running setup.py install for blessings 04:31:52 INFO - Successfully installed blessings 04:31:52 INFO - Cleaning up... 04:31:52 INFO - Return code: 0 04:31:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:53 INFO - Reading from file tmpfile_stdout 04:31:53 INFO - Current package versions: 04:31:53 INFO - blessings == 1.6 04:31:53 INFO - blobuploader == 1.2.4 04:31:53 INFO - docopt == 0.6.1 04:31:53 INFO - functools32 == 3.2.3-2 04:31:53 INFO - jsonschema == 2.5.1 04:31:53 INFO - manifestparser == 1.1 04:31:53 INFO - mozInstall == 1.12 04:31:53 INFO - mozcrash == 1.0 04:31:53 INFO - mozdebug == 0.1 04:31:53 INFO - mozdevice == 0.49 04:31:53 INFO - mozfile == 1.2 04:31:53 INFO - mozhttpd == 0.7 04:31:53 INFO - mozinfo == 0.9 04:31:53 INFO - mozleak == 0.1 04:31:53 INFO - mozlog == 3.4 04:31:53 INFO - moznetwork == 0.27 04:31:53 INFO - mozprocess == 0.23 04:31:53 INFO - mozprofile == 0.28 04:31:53 INFO - mozrunner == 6.13 04:31:53 INFO - mozscreenshot == 0.1 04:31:53 INFO - mozsystemmonitor == 0.3 04:31:53 INFO - moztest == 0.7 04:31:53 INFO - mozversion == 1.4 04:31:53 INFO - psutil == 3.1.1 04:31:53 INFO - requests == 1.2.3 04:31:53 INFO - wsgiref == 0.1.2 04:31:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 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 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:53 INFO - 'HOME': '/Users/cltbld', 04:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:53 INFO - 'LOGNAME': 'cltbld', 04:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:53 INFO - 'MOZ_NO_REMOTE': '1', 04:31:53 INFO - 'NO_EM_RESTART': '1', 04:31:53 INFO - 'PAGER': '/bin/cat', 04:31:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:53 INFO - 'PWD': '/builds/slave/test', 04:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:53 INFO - 'SHELL': '/bin/bash', 04:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:53 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:53 INFO - 'USER': 'cltbld', 04:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:53 INFO - 'XPC_FLAGS': '0x0', 04:31:53 INFO - 'XPC_SERVICE_NAME': '0', 04:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:53 INFO - Cleaning up... 04:31:53 INFO - Return code: 0 04:31:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10274a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad08d72600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, '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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:53 INFO - 'HOME': '/Users/cltbld', 04:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:53 INFO - 'LOGNAME': 'cltbld', 04:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:53 INFO - 'MOZ_NO_REMOTE': '1', 04:31:53 INFO - 'NO_EM_RESTART': '1', 04:31:53 INFO - 'PAGER': '/bin/cat', 04:31:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:53 INFO - 'PWD': '/builds/slave/test', 04:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:53 INFO - 'SHELL': '/bin/bash', 04:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:31:53 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:53 INFO - 'USER': 'cltbld', 04:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:53 INFO - 'XPC_FLAGS': '0x0', 04:31:53 INFO - 'XPC_SERVICE_NAME': '0', 04:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:53 INFO - Cleaning up... 04:31:53 INFO - Return code: 0 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - Running post-action listener: _start_resource_monitoring 04:31:53 INFO - Starting resource monitoring. 04:31:53 INFO - [mozharness: 2016-12-17 12:31:53.579404Z] Finished create-virtualenv step (success) 04:31:53 INFO - [mozharness: 2016-12-17 12:31:53.580367Z] Running install step. 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: install 04:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:53 INFO - Reading from file tmpfile_stdout 04:31:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:53 INFO - Reading from file tmpfile_stdout 04:31:53 INFO - Output received: 04:31:53 INFO - Usage: mozinstall [options] installer 04:31:53 INFO - Options: 04:31:53 INFO - -h, --help show this help message and exit 04:31:53 INFO - -d DEST, --destination=DEST 04:31:53 INFO - Directory to install application into. [default: 04:31:53 INFO - "/builds/slave/test"] 04:31:53 INFO - --app=APP Application being installed. [default: firefox] 04:31:53 INFO - mkdir: /builds/slave/test/build/application 04:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:32:15 INFO - Reading from file tmpfile_stdout 04:32:15 INFO - Output received: 04:32:15 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:32:15 INFO - Running post-action listener: _resource_record_post_action 04:32:15 INFO - [mozharness: 2016-12-17 12:32:15.951282Z] Finished install step (success) 04:32:15 INFO - [mozharness: 2016-12-17 12:32:15.951412Z] Running run-tests step. 04:32:15 INFO - Running pre-action listener: _resource_record_pre_action 04:32:15 INFO - Running main action method: run_tests 04:32:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:15 INFO - 2016-12-17 04:32:15.963 screenresolution[1629:7821] starting screenresolution argv=screenresolution get 04:32:15 INFO - 2016-12-17 04:32:15.966 screenresolution[1629:7821] Display 0: 1600x1200x32@60 04:32:15 INFO - 2016-12-17 04:32:15.970 screenresolution[1630:7823] starting screenresolution argv=screenresolution list 04:32:15 INFO - Available Modes on Display 0 04:32:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:16 INFO - Intel Iris: 04:32:16 INFO - Chipset Model: Intel Iris 04:32:16 INFO - Type: GPU 04:32:16 INFO - Bus: Built-In 04:32:16 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:16 INFO - Vendor: Intel (0x8086) 04:32:16 INFO - Device ID: 0x0a2e 04:32:16 INFO - Revision ID: 0x0009 04:32:16 INFO - Displays: 04:32:16 INFO - Display: 04:32:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:16 INFO - Display Serial Number: 1600x1200 60 04:32:16 INFO - Main Display: Yes 04:32:16 INFO - Mirror: Off 04:32:16 INFO - Online: Yes 04:32:16 INFO - Rotation: Supported 04:32:16 INFO - Return code: 0 04:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:16 INFO - Python 2.7.3 04:32:16 INFO - Return code: 0 04:32:16 INFO - grabbing minidump binary from tooltool 04:32: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')]} 04:32:16 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 0x10255fd30>, '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 0x1023c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102557b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:32:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:32:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:32:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:16 INFO - Return code: 0 04:32:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:32:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:32:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0343 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZtxcXyKMgA/Render', 04:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:16 INFO - 'HOME': '/Users/cltbld', 04:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:16 INFO - 'LOGNAME': 'cltbld', 04:32:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:16 INFO - 'MOZ_NO_REMOTE': '1', 04:32:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:16 INFO - 'NO_EM_RESTART': '1', 04:32:16 INFO - 'PAGER': '/bin/cat', 04:32:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:16 INFO - 'PWD': '/builds/slave/test', 04:32:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:16 INFO - 'SHELL': '/bin/bash', 04:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pkvgBNC5Gg/Listeners', 04:32:16 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 04:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:16 INFO - 'USER': 'cltbld', 04:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:16 INFO - 'XPC_FLAGS': '0x0', 04:32:16 INFO - 'XPC_SERVICE_NAME': '0', 04:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:32:16 INFO - mozversion application_buildid: 20161217030205 04:32:16 INFO - mozversion application_changeset: 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 04:32:16 INFO - mozversion application_display_name: Nightly 04:32:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:16 INFO - mozversion application_name: Firefox 04:32:16 INFO - mozversion application_remotingname: firefox 04:32:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:32:16 INFO - mozversion application_vendor: Mozilla 04:32:16 INFO - mozversion application_version: 53.0a1 04:32:16 INFO - mozversion platform_buildid: 20161217030205 04:32:16 INFO - mozversion platform_changeset: 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 04:32:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:32:16 INFO - mozversion platform_version: 53.0a1 04:32:16 INFO - using testdate: 1481977936 04:32:16 INFO - actual date: 1481977936 04:32:16 INFO - starting webserver on 'localhost:49240' 04:32:16 INFO - SUITE-START | Running 2 tests 04:32:16 INFO - TEST-START | dromaeo_css 04:32:16 INFO - operating with platform_type : mac_ 04:32:16 INFO - Initialising browser for dromaeo_css test... 04:32:16 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpENiKEq/profile http://localhost:49240/getInfo.html) 04:32:18 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 04:32:18 INFO - PROCESS | 1640 | colorDepth:24 04:32:18 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 04:32:18 INFO - PROCESS | 1640 | __metrics 04:32:19 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:32:19 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:19 INFO - TEST-INFO | 1640: exit 0 04:32:19 INFO - Browser initialized. 04:32:19 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:19 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpENiKEq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:31 INFO - PROCESS | 1643 | RSS: Main: 236773376 04:32:31 INFO - PROCESS | 1643 | 04:33:22 INFO - PROCESS | 1643 | 1481978002719 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:35:35 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 04:35:37 INFO - PROCESS | 1643 | RSS: Main: 427147264 04:35:37 INFO - PROCESS | 1643 | 04:38:40 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 04:38:40 INFO - PROCESS | 1643 | RSS: Main: 375078912 04:38:40 INFO - PROCESS | 1643 | 04:41:43 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 04:41:44 INFO - PROCESS | 1643 | RSS: Main: 365690880 04:41:44 INFO - PROCESS | 1643 | 04:44:46 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 04:44:47 INFO - PROCESS | 1643 | RSS: Main: 346451968 04:44:47 INFO - PROCESS | 1643 | 04:47:50 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 04:47:51 INFO - PROCESS | 1643 | RSS: Main: 331165696 04:47:51 INFO - PROCESS | 1643 | 04:50:54 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 04:50:55 INFO - PROCESS | 1643 | RSS: Main: 481107968 04:50:55 INFO - PROCESS | 1643 | 04:50:55 INFO - PROCESS | 1643 | __start_tp_report 04:50:55 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 04:50:55 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 04:50:55 INFO - PROCESS | 1643 | |i|pagename|runs| 04:50:55 INFO - PROCESS | 1643 | |0;dojo.html;3285.09659843543;3292.242784159643;3312.420326442872;3329.3674201901654;3363.6804503572166;5519.69641669708;5526.50261476467;5536.889262214763;5631.662100273981;5647.463490968356;5286.920696189561;5570.053090974534;5630.436956304367;5631.352394474637;5644.435556444364;4540.568645978627;5172.172452407615;5176.352955880515;5182.792688292464;5198.636095473318;5093.312402825627;5163.122269214224;5231.843044708646;5241.554467870235;5265.236540701596;5202.427732949392;5223.347081614798;5226.686398816064;5240.03059434004;5268.446813084609;5070.923936140961;5103.719295438749;5161.5870730341485;5168.405633352175;5191.091558977183;5092.618053645954;5123.897522049576;5127.4872512748425;5146.9485305146845;5210.192420174879;4680.461746899116;5581.441855814427;5586;5599.440055994409;5624.043912534838;6152.538559608002;6152.692365381758;6158.414950579688;6166.506679465632;6170.043643235261;6033.969830150865;6056.848578785522;6105.542084343692;6119.9291020253595;6173.722182501753;5697.487226149584;5711.8000869969355;5714.971305165027;5737.684427356494;5758.971205143989;6317.4946004319545;6329.810105696836;6333.429991300805;6354.887894618423;6358.078078678565;5724.942750572524;5813.360530341659;5816.621919575298;5949.762009519657;5998.640081595118;6045.093236014545;6101.398774955092;6140.8771824563255;6164.260288765287;6184.072389141665;6021.397860214031;6060.545459090586;6065.2418447694035;6079.331273559905;6093.69531523422;5913.231279933581;6028.397160284024;6103.267607887082;6111.419415155553;6123.203983482119;4763;4793.089313030513;4809.989902120524;4811.133995880705;4838.395200599925;4323.178596066738;4340.175366680321;4346.261135606955;4352.194843953878;4396.494403143615;5669.092945128759;5672.829815105553;5676.914846277309;5685.886282274331;5689.886202276014;6021.2473440819895;6025.3974602540275;6075.179850720185;6131.816045518642;6196.1635179251125;5647.435256474319;5676.4323567642905;5691.943080569141;5717.399673034354;5717.885642287131;5284.735763211824;5291.444398338196;5293.708846013506;5303.814366497154;5308.336457942757;5300.602454815904;6165.290991535851;6248.4688801452385;6340.334264902303;6386.904196436964;6069.0592958091565;6133.1510485532735;6134.877302453837;6144.771045790949;6165.599236049642;6374.96812515953;6381.744730210739;6390.169277993831;6392.520560957853;6425.293217745951;5981.162637230878;6087.086936959491;6095.1466794647895;6099.695015249131;6125.356837531995;5915.467607915309;6000.5799594028;6003.849903752441;6073.362296958932;6085;4877.5366340197625;5938.792142275172;5939.881202376015;5971.970140149271;5995.070764031582;5888.381719919346;5909.5863289569315;5919.556033297434;5922.911156332744;5942.376050514634;5653.858653533694;5701.828945131652;5703.885922281448;5709.429057094258;5804.303483581997;5874.823755287348;5886.735096920735;5892.852678683067;5900.793472228452;5916.467517923407;5718.285214348207;5718.79984200551;5727.4845263926445;5728.856778580569;5736.913946290725 04:50:55 INFO - PROCESS | 1643 | |1;ext.html;467;467.7790965579838;479.4797644555657;487.8316980641677;493.8938128302414;29087.85456072722;30813.691863081363;30841.920532781383;30861;30874.91937782178;31346.686533134663;31939.528466014777;32150;34445.82777086117;39114.80442597783;9107.590158442852;9328.207102396305;9332.813343733122;9338.206252468548;9344.345895787297;8661.830652861878;8745.47527148373;9199.724008279762;9247.352685312031;9336.81326373472;7607.961960190219;8317.293030092449;9311.674091406801;9375.859362109573;10780.353178809257;11010.889891101067;11015.944920275388;11121.27711698745;11135.665930022113;11145.275557088764;9346.719598412059;10935.56257749689;11024;11029.503672334764;11033.282836615594;30216.92071570332;30629.540556891665;30678;38213.23573528514;38396.616033839586;2884.956725649117;3371.6291207967106;3772.43413487979;4032.6169013943627;4139.91720165595;28389.60896692172;29155.41689166226;29367.853160734274;29400.411991760044;29654.70345296541;3081.260497480611;3147.6222853257527;3153.7003984621424;3213.630432500269;3252.073159149631;475027.62486187345;475666;476411;476875;477077;54318.7284063585;55930.44069559334;56122;56219;56261;58661;58921;58931.52671183255;58936;59167;15084.321205545777;15306.234688265766;15310.311036003406;15313;15344;12136.45385957634;12185.086118541145;12216.3281019543;12231.266124032587;12231.633051008484;12114.394280285951;12867.742645147044;15000.549983500512;15050.247487625575;15253.16107614092;5530.2810634618045;6653.565969947784;6745.628990405575;6771.4582833373215;6780.491463140284;856.8157846063126;947.3131979314942;990.0693348252763;1077.3858900426837;1121.7363919478917;27812.582811257846;28708;28726;29548.409031819243;29553.408931821243;1053.378506681062;1069.2835800014009;1087.8205096159045;1118.9216754827246;1179.5222934711455;14599.41602335916;14902.329395177243;14934.402623894923;15278;15557.533274001798;598921;605186;605512;605567;607369;56119.71940140273;56418.87162256732;56481.43518564844;56483.71758141183;56654.7167264161;1270.9046821488241;1375.1748950629542;1394.7907813828008;1408.2325132802441;1418.7091646212502;27841.582376263967;28654.71345286604;28870.664855362127;29337;29357.55963660504;34393.65606343905;44385.117637060546;44389.89025274394;44411.11177776491;44487.55512444834;546709.3290670901;550571;551662;552060;552345;37313.81343093267;37604.81197594104;37900.83090860058;37942.2411551773;38138.61861381351;44240.77879610581;44811.87970300768;45069.54930450654;45163.32255016243;45318.77340613276;36693.63306367009;37009.62990370062;37266.06834829151;37840.24319513649;37948;33050.17374565655;34099.829500852335;34779.43492542791;36533.45199822058;37732.62267377291;35990;36105.458418124275;36134.63865361418;36720.26559468742;36839;31271.061868143992;31731.04806855798;32896.83551582227;32969.01092967215;33194.33611327712;24233.273001809976;24443.755562444858;24474.26577202687;24776.876115619307;24802.751972480764 04:50:55 INFO - PROCESS | 1643 | |2;jquery.html;353.2987020763785;367.65624141427764;372.545494496714;378.4701418014779;402.48280958967734;14415.13509189448;14704.485343012997;15450.22748862558;19622.803771962277;20021.399358019284;16762.41331553396;19109.904450477763;19632.01839908006;20541.794582054175;20569.794302056976;5660.5471562274915;5681.289838770153;5897.41025897409;5915.201447804534;5927.911081333784;4111.835526578933;4349.1301739652035;4474.552544745532;4901.705897646153;5878.294604647448;4325.891852703676;6159.81520554384;6443.548951573392;6452.967735161317;6496.870062598745;5473.233747275384;5747.195392645033;5798.7390567424145;6445.387688169616;6488.351164883521;5647.01177293976;5648.293963254593;5660.547156227533;5661.60368774186;5675.858103547403;12907.354632268443;13088.411021504055;13189.274589897552;13320.400581973834;13333.333333333294;2003.6593779057596;2209.127394679093;2251.774822517735;2480.620155038749;2616.476704659076;10027.799444011152;10209.336393134497;10268.845967310497;12394.070444716592;14628.163452525769;1687.2576066530687;1796.092973048602;1863.2267608942273;1868.701007838753;1911.6559019376507;98742;104481.47759261231;108969.45515272373;113070;113458;11122.833157502644;11166.274192177483;11367.943160284145;11385.259958102863;11563.479643416067;14397.85602143986;14441;14442.711145777026;14458.421663133357;14468.565943021726;8195.057568379594;8336;8362.54006029662;8476.660933562589;8508.404411691123;7298.051253337138;7817.335526480199;8225.136360682161;8272.37957153204;8384.664613415516;3736.626337366242;4343.652507799368;4450.109978004412;4455.6212721919;4518.932216016762;1747.1875577856358;1855.1095474172203;1910.9489780620604;1914.7362740591143;1915.722220278052;740.6704016712512;747.8279995601042;758.5145506875604;867.5878957495139;951.1867353412871;19255;21054.473638158863;21209.575808483743;21288.574228515652;21378.679319809904;855.8630619100913;959.0649117110761;980.6126580001003;982.6609819612365;992.0872797026608;10751.301165424222;11121.888781112248;11160.386178760245;11170.944145279222;11184.496697648625;477156;480725;485092;493883;494792;109790.3531447029;116464.41767791107;119670;120104.39947800204;125483;1026.0560284538392;1032.3135115148343;1070.3310430980637;1102.9669109926715;1104.536094840169;14612.561623151323;18401.079946002916;18904;19227.134778934702;19564.771812650753;49249.753751231015;53106.73446632742;54233.457665424416;54375;55409;72962.63518682373;73042;73358;73411;74067.62966185134;7749.186335434698;7780.144184139854;7947.443678942419;7978.401619878417;8274.420790544604;10746.408947507962;12046.337451440255;12073;12392.194507356993;12554.560590379659;9005.864912026194;10285.845712314172;10778.245522813328;10790;10961.56153753841;10075.294729368874;10413.271071025258;10447.320924139907;10816;10939.28894621847;9443.905560944302;9907.058829411195;10853.40306283162;11040.558377664804;11237.157213209206;6591.34086591337;7843.215678432111;7865.449418540876;7892.171322011106;8101.797455063671;9555.665551705657;10470.895291046992;10666.786664266827;10772.24594278393;10819.891801081889 04:50:55 INFO - PROCESS | 1643 | |3;mootools.html;1460.9853901460986;1489.6275931017246;1675.3466148202203;1796.7664203653524;1853.4338483981032;6552.770653027145;8451.704190353339;8464.746057618273;8471.068182499928;8473.91526084739;7383.224761400056;7656.770296891103;7939.444238903265;8193.221643943816;8195.754127376173;2301.551197516481;2341.625339945609;2342.871142087193;2344.519373528431;2347.507023525062;2328.3015095471374;2348.307249361434;2367.7868991790733;2368.159303447277;2371.774681405264;1957.784643689193;2053.3531937439657;2123.6389813731703;2127.9787202127936;2230.0522278031854;2301.5972204864165;2317.8029867461287;2320.385097949045;2324.140068174769;2329.126577533425;2329.813614910803;2337.3338598499518;2351.259353303704;2358.4221865642858;2363.3737059679197;8210.220029097285;8434.83130337396;8442;8448.915510844936;8472.576371181416;5048.015636950796;5219.556337711299;5222.451642577551;5232.581393488512;5237.738113094369;3367.1413789483527;3528.4530897710897;3591.94612080819;3593.083763640281;3593.964060359389;1007.8337074382719;1051.8264486359742;1076.2251179151076;1082.4912291223113;1093.0763504838399;10564.78870422595;10710.089642380408;10714.78570428587;10727.927207279288;10735.516901739362;4571.26859702446;4723.291506274087;4731.668783185144;4764.4520880099235;4793.640476964241;8558.35812314079;8606.13938606147;8614.05245423003;8621.137886211454;8623.827523449496;5066.392032956069;5070.163423035158;5075.543201111917;5076.416212135578;5079.161938280143;4643.164230438486;4750.61995040396;4776.355192049098;4781.330613714083;4861.659683822169;2909.330853903614;3484.878029269014;3498.9852942646858;3561.554805649294;3571.08937221007;1128.7178205448638;1132.2413982631656;1136.085451211766;1146.0258780037068;1150.3040660400338;821.326512259953;879.4811061473761;906.7234493479552;910.8497097978892;941.9697082372827;4538.72767633943;5460.481254280837;5521.337439507285;5623.409541998113;5792.275965504312;414.91079417924686;415.21731536054756;434.1664005110196;444.17383666380505;451.9593236608721;3542.6634469725336;3630.891073267753;3669.798161101112;3895.9091454392815;3930.7248492605245;9813.41119532816;9820.508974551243;9828.655997040069;10073.49632518371;10215.7446063849;6806.7957961261245;9762.267829912786;9796.9020309796;10123.139533139765;10157.288989770794;7336.7065317386705;7821.765347039598;7834.921650783419;7849.921500784919;7854.842903142019;4915.729634870117;4947.233178857283;5381.3542374913695;5500.954818584456;5713.944829163271;7747.341475974606;8974.685885993958;9268.165865072177;9358.344915855825;9396;9290.489023103524;9443.386179898285;9533.33266671354;9592.280578956466;9597.712068637951;6992.720291188499;7081.291870813084;7147.642617868982;7186.46101542376;7200.89198662031;7698.499597526143;7708.691652334068;7709.3447057000785;7791.610419479117;7908;5665.546756259571;7083.574985500681;7130.786076417716;7159.928400715926;7199.820004499929;6999.335063168991;7009.649517524205;7040.788776336718;7073.504854660125;7188.209296977224;6387.329330420239;6623.635700036544;6721.059051732859;6722;6723.159605049369;4380.956190438183;4668.622756286835;4886.731229782396;4935.457099718957;5063.772130254221;4768.213244814567;4856.635752318661;4937.456879743298;4966.925496117489;5041.168207245763 04:50:55 INFO - PROCESS | 1643 | |4;prototype.html;320.2410287618345;326.6733266733267;346.546024707633;359.91182160370715;375.1465416178194;4749.240121580544;4896.926546101811;4905.33777939978;4972.975135124324;5224.582033437326;4784.612462385912;4955.876103097425;5171.741802664325;5175.58595312375;5176.4729404825575;3271.7382609391193;3802.790846503441;4046;4058.701215611006;4087.7547347159266;3190.4416727072785;3371.061639557252;3495.6679115484117;4005;4087.261534771695;3182.379436009979;4033.8184781684895;4056.371262454324;4072.287349713803;4073.307537718595;4026.959730402717;4062.431259623655;4090.0367823444617;4094.5700701426217;4098.426220329156;2927.7950543461966;3609.917024892548;3612.945805812915;3616.475611036385;3633.563972323338;4356.738595684237;4955.886614110316;5013.799448022111;5042.319286896259;5073.315102461157;4615.653825963066;4641.512641172696;4644.0494992103395;4646.605038571725;4659.4175728034;4564.589186973155;5241.135212689902;5243.329669231515;5423.901532559382;5449.237106805051;3924.4113382992496;3954.7231693781446;3960.8611349871035;3971;3991.481107456041;4507.774611269423;4958.851234462972;5575.944240557583;5697.544196464273;5705.315362156526;4022.6379625833815;4025.269134272291;4027.35562310029;4029.576894426043;4029.576894426043;3871.741683952727;4053.574374690674;4114.7450027741825;4126.319157339006;4143.70994030421;4370.759608221579;4403.581659742319;4508.842190523316;4511.233090374644;4546.909061818745;4548.226801443762;5398.568114550826;5399.299220745453;5407.729613519308;5418.620696551282;1160.257435241446;1207.4988879615037;1259.9307038112809;1274.8470183577845;1335.1788649980192;797.8484088023257;843.4770442325797;865.7186414415214;940.9717708468756;940.9905900940903;3866.8592765134354;4204.579542045771;4520.50274469808;4750.976245118753;4893.902121957541;4571.977140114344;5198.298229739013;5283.445238250005;5340.813071542478;5353.411124776271;4056.858009969637;4606.930896036562;4840.854774356775;4849.563539281482;4855.984766321937;2562.9871850641002;2624.973750262511;2752.559590465516;2766.7233276672173;2777.7639050505936;4647.117047760915;4736.976315118472;4858.732769697701;4876.463589005207;5081.306907339116;5035.370578677665;5067.594592432597;5299.364076310791;5395.514403703607;5397.541208997279;5628.1557766333735;5828.737706803204;5851.502622277069;5879.412058794086;5890.970545147246;4953.356063711694;4996.400431948189;5226.085435048927;5491.972540137273;5699.686517241592;4687.414073240845;5174.4476657002;5555.3611334697025;5559.11054231321;5594.580406469449;5836.212111364912;5866.67733274674;5874.647521148574;5876.324222714443;5897.439743224387;3301.8679252829616;3571.6427757452;3780.6597406233573;3791.1090893640526;3813.427985802041;5359.311816777703;5393.325834270716;5560.36055853582;5612.859678507906;5623.517070855883;5081.593472522263;5286.748649580557;5364.865878353073;5527.281453411031;5553.805616803554;4656.883577910579;4668.953310466852;4966.726830024383;5515.338159420895;5551.916721249104;4481.708688935209;5172.991266702957;5212.791488340424;5388.757505912165;5448.809291674773;5003.849114703566;5129.461406552407;5270.0224373229;5352.277442545206;5455.863603409946;4695.178343789755;4737.384140061908;5110.5911527077005;5383.919241211307;5400.675959442446 04:50:55 INFO - PROCESS | 1643 | |5;yui.html;722.2813300765739;727.9708811647531;775.4494309040581;815.0667485728841;833.4166083741383;14336.283185840706;15281.2359382031;15284.770728439069;15326;15417.845821541781;13852.792208116862;13920.791188132162;14087.929560352184;14090.929545352285;14112;685.9965700171517;707.6214225389392;709.4820780829997;712.0671919785073;857.3055824781947;700.2787129256848;705.696550483292;839.9706010289641;862.7368652560966;867.5488745852153;778.81697801017;921.2721949659795;921.9262459003263;926.4117285523673;935.4434111703525;926.6339795780697;927.8561822917492;928.614624930653;929.5770424456856;931.818295432391;635.7933671556763;677.14003215916;688.6350234375789;694.2883544367064;695.8538706871564;11793.646190614296;12248.142630015902;14117.78823317651;14621.561353159423;14644.926775366055;13851;13916.373763180682;13954.09298395601;13996.440142394293;14033.578992630237;11628.941855290754;11744.823827642593;11931.761364772656;11962.282263064244;12168.2699038058;3635.818209089535;3644.380455322575;3814.275287695329;3866.690664746842;3867.5939026402384;97204;101761.4911925443;102744.48627756814;104271.47864260706;105062.4240636391;10769.676909692722;10827.404492752818;10841.728956776144;10905.945470272756;10964.396958167217;18080.728789068173;21664.458388540097;21841.781582183976;22063;22069.33791986243;7658;7678.923210767933;7750.961245193738;7792.025996750406;7813.843723125619;4237.110206856533;4286.271333873249;4305.48334199898;4363;4437.955620443754;3481.4603736420895;3492.231709024011;3504.159001839591;3546.8049257291095;3547.822608869546;635.656745357511;639.7025383196835;641.2817644238482;656.2059907511964;656.255150404285;614.9938500615026;652.7813182583888;661.6195687479623;669.3340869539372;697.1181455458849;8304.875426868603;8677.956610217036;8729.476231426135;9056.773580660405;9266.397684150508;606.4966078155121;660.8116686744255;673.0341959288437;680.9182898052266;691.7233106757337;4290.141971605629;4463.419755431838;4471.664625153061;4539.84110556129;4570.131674981742;105262.47368763108;105809;106492;106818;113592;90885;92606.81519017415;93165;94859.52570237104;99192;79533.60233198798;84457.57771211104;86592;87048;87641;8600.182982616641;8748.60631271607;8775.956120219358;8805.559722014003;8873.689420870238;55058.348249552575;55289.06488273052;55995.88008239894;57077;57964;73746.26253737608;75472.9243321066;76471;79115;80951.78572321302;11660.825087623862;11783.646490605295;11919.821202681793;12019;12097.758044838878;12409.93795031019;12701.301428421526;12759.61721148367;12970.054930005268;13087.476500940236;11825.34960577142;11830.166324219415;11954.760904781682;12238.632841014783;12487.937560312505;11881.405929703653;12046.457909393923;12194;12318;12586.811197832223;11777.411129443322;12021.639350819489;12195.939020304842;12239.510419583117;12427.937860311002;7894.921050789649;9469.337146399686;10044.283615062473;10149.746256343651;10152.086312231935;10256.897431025594;10264.076233139054;10375.636852710119;10405.791884162123;10423.114035307084 04:50:55 INFO - PROCESS | 1643 | __end_tp_report 04:50:55 INFO - PROCESS | 1643 | __start_cc_report 04:50:55 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,2106 04:50:55 INFO - PROCESS | 1643 | __end_cc_report 04:50:55 INFO - PROCESS | 1643 | __startTimestamp1481979055047__endTimestamp 04:50:55 INFO - PROCESS | 1643 | 04:50:55 INFO - PROCESS | 1643 | ------- Summary: start ------- 04:50:55 INFO - PROCESS | 1643 | Number of tests: 6 04:50:55 INFO - PROCESS | 1643 | 04:50:55 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5626.06 Median:5727.48 stddev:631.58 (11.0%) stddev-sans-first:606.23 04:50:55 INFO - PROCESS | 1643 | Values: 3285.1 3292.2 3312.4 3329.4 3363.7 5519.7 5526.5 5536.9 5631.7 5647.5 5286.9 5570.1 5630.4 5631.4 5644.4 4540.6 5172.2 5176.4 5182.8 5198.6 5093.3 5163.1 5231.8 5241.6 5265.2 5202.4 5223.3 5226.7 5240.0 5268.4 5070.9 5103.7 5161.6 5168.4 5191.1 5092.6 5123.9 5127.5 5146.9 5210.2 4680.5 5581.4 5586.0 5599.4 5624.0 6152.5 6152.7 6158.4 6166.5 6170.0 6034.0 6056.8 6105.5 6119.9 6173.7 5697.5 5711.8 5715.0 5737.7 5759.0 6317.5 6329.8 6333.4 6354.9 6358.1 5724.9 5813.4 5816.6 5949.8 5998.6 6045.1 6101.4 6140.9 6164.3 6184.1 6021.4 6060.5 6065.2 6079.3 6093.7 5913.2 6028.4 6103.3 6111.4 6123.2 4763.0 4793.1 4810.0 4811.1 4838.4 4323.2 4340.2 4346.3 4352.2 4396.5 5669.1 5672.8 5676.9 5685.9 5689.9 6021.2 6025.4 6075.2 6131.8 6196.2 5647.4 5676.4 5691.9 5717.4 5717.9 5284.7 5291.4 5293.7 5303.8 5308.3 5300.6 6165.3 6248.5 6340.3 6386.9 6069.1 6133.2 6134.9 6144.8 6165.6 6375.0 6381.7 6390.2 6392.5 6425.3 5981.2 6087.1 6095.1 6099.7 6125.4 5915.5 6000.6 6003.8 6073.4 6085.0 4877.5 5938.8 5939.9 5972.0 5995.1 5888.4 5909.6 5919.6 5922.9 5942.4 5653.9 5701.8 5703.9 5709.4 5804.3 5874.8 5886.7 5892.9 5900.8 5916.5 5718.3 5718.8 5727.5 5728.9 5736.9 04:50:55 INFO - PROCESS | 1643 | 04:50:55 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:66704.05 Median:36047.73 stddev:145992.61 (405.0%) stddev-sans-first:146317.46 04:50:55 INFO - PROCESS | 1643 | Values: 467.0 467.8 479.5 487.8 493.9 29087.9 30813.7 30841.9 30861.0 30874.9 31346.7 31939.5 32150.0 34445.8 39114.8 9107.6 9328.2 9332.8 9338.2 9344.3 8661.8 8745.5 9199.7 9247.4 9336.8 7608.0 8317.3 9311.7 9375.9 10780.4 11010.9 11015.9 11121.3 11135.7 11145.3 9346.7 10935.6 11024.0 11029.5 11033.3 30216.9 30629.5 30678.0 38213.2 38396.6 2885.0 3371.6 3772.4 4032.6 4139.9 28389.6 29155.4 29367.9 29400.4 29654.7 3081.3 3147.6 3153.7 3213.6 3252.1 475027.6 475666.0 476411.0 476875.0 477077.0 54318.7 55930.4 56122.0 56219.0 56261.0 58661.0 58921.0 58931.5 58936.0 59167.0 15084.3 15306.2 15310.3 15313.0 15344.0 12136.5 12185.1 12216.3 12231.3 12231.6 12114.4 12867.7 15000.5 15050.2 15253.2 5530.3 6653.6 6745.6 6771.5 6780.5 856.8 947.3 990.1 1077.4 1121.7 27812.6 28708.0 28726.0 29548.4 29553.4 1053.4 1069.3 1087.8 1118.9 1179.5 14599.4 14902.3 14934.4 15278.0 15557.5 598921.0 605186.0 605512.0 605567.0 607369.0 56119.7 56418.9 56481.4 56483.7 56654.7 1270.9 1375.2 1394.8 1408.2 1418.7 27841.6 28654.7 28870.7 29337.0 29357.6 34393.7 44385.1 44389.9 44411.1 44487.6 546709.3 550571.0 551662.0 552060.0 552345.0 37313.8 37604.8 37900.8 37942.2 38138.6 44240.8 44811.9 45069.5 45163.3 45318.8 36693.6 37009.6 37266.1 37840.2 37948.0 33050.2 34099.8 34779.4 36533.5 37732.6 35990.0 36105.5 36134.6 36720.3 36839.0 31271.1 31731.0 32896.8 32969.0 33194.3 24233.3 24443.8 24474.3 24776.9 24802.8 04:50:55 INFO - PROCESS | 1643 | 04:50:55 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:30643.85 Median:11793.90 stddev:81857.34 (694.1%) stddev-sans-first:82055.38 04:50:55 INFO - PROCESS | 1643 | Values: 353.3 367.7 372.5 378.5 402.5 14415.1 14704.5 15450.2 19622.8 20021.4 16762.4 19109.9 19632.0 20541.8 20569.8 5660.5 5681.3 5897.4 5915.2 5927.9 4111.8 4349.1 4474.6 4901.7 5878.3 4325.9 6159.8 6443.5 6453.0 6496.9 5473.2 5747.2 5798.7 6445.4 6488.4 5647.0 5648.3 5660.5 5661.6 5675.9 12907.4 13088.4 13189.3 13320.4 13333.3 2003.7 2209.1 2251.8 2480.6 2616.5 10027.8 10209.3 10268.8 12394.1 14628.2 1687.3 1796.1 1863.2 1868.7 1911.7 98742.0 104481.5 108969.5 113070.0 113458.0 11122.8 11166.3 11367.9 11385.3 11563.5 14397.9 14441.0 14442.7 14458.4 14468.6 8195.1 8336.0 8362.5 8476.7 8508.4 7298.1 7817.3 8225.1 8272.4 8384.7 3736.6 4343.7 4450.1 4455.6 4518.9 1747.2 1855.1 1910.9 1914.7 1915.7 740.7 747.8 758.5 867.6 951.2 19255.0 21054.5 21209.6 21288.6 21378.7 855.9 959.1 980.6 982.7 992.1 10751.3 11121.9 11160.4 11170.9 11184.5 477156.0 480725.0 485092.0 493883.0 494792.0 109790.4 116464.4 119670.0 120104.4 125483.0 1026.1 1032.3 1070.3 1103.0 1104.5 14612.6 18401.1 18904.0 19227.1 19564.8 49249.8 53106.7 54233.5 54375.0 55409.0 72962.6 73042.0 73358.0 73411.0 74067.6 7749.2 7780.1 7947.4 7978.4 8274.4 10746.4 12046.3 12073.0 12392.2 12554.6 9005.9 10285.8 10778.2 10790.0 10961.6 10075.3 10413.3 10447.3 10816.0 10939.3 9443.9 9907.1 10853.4 11040.6 11237.2 6591.3 7843.2 7865.4 7892.2 8101.8 9555.7 10470.9 10666.8 10772.2 10819.9 04:50:55 INFO - PROCESS | 1643 | 04:50:55 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5332.82 Median:5044.59 stddev:2924.67 (58.0%) stddev-sans-first:2918.40 04:50:55 INFO - PROCESS | 1643 | Values: 1461.0 1489.6 1675.3 1796.8 1853.4 6552.8 8451.7 8464.7 8471.1 8473.9 7383.2 7656.8 7939.4 8193.2 8195.8 2301.6 2341.6 2342.9 2344.5 2347.5 2328.3 2348.3 2367.8 2368.2 2371.8 1957.8 2053.4 2123.6 2128.0 2230.1 2301.6 2317.8 2320.4 2324.1 2329.1 2329.8 2337.3 2351.3 2358.4 2363.4 8210.2 8434.8 8442.0 8448.9 8472.6 5048.0 5219.6 5222.5 5232.6 5237.7 3367.1 3528.5 3591.9 3593.1 3594.0 1007.8 1051.8 1076.2 1082.5 1093.1 10564.8 10710.1 10714.8 10727.9 10735.5 4571.3 4723.3 4731.7 4764.5 4793.6 8558.4 8606.1 8614.1 8621.1 8623.8 5066.4 5070.2 5075.5 5076.4 5079.2 4643.2 4750.6 4776.4 4781.3 4861.7 2909.3 3484.9 3499.0 3561.6 3571.1 1128.7 1132.2 1136.1 1146.0 1150.3 821.3 879.5 906.7 910.8 942.0 4538.7 5460.5 5521.3 5623.4 5792.3 414.9 415.2 434.2 444.2 452.0 3542.7 3630.9 3669.8 3895.9 3930.7 9813.4 9820.5 9828.7 10073.5 10215.7 6806.8 9762.3 9796.9 10123.1 10157.3 7336.7 7821.8 7834.9 7849.9 7854.8 4915.7 4947.2 5381.4 5501.0 5713.9 7747.3 8974.7 9268.2 9358.3 9396.0 9290.5 9443.4 9533.3 9592.3 9597.7 6992.7 7081.3 7147.6 7186.5 7200.9 7698.5 7708.7 7709.3 7791.6 7908.0 5665.5 7083.6 7130.8 7159.9 7199.8 6999.3 7009.6 7040.8 7073.5 7188.2 6387.3 6623.6 6721.1 6722.0 6723.2 4381.0 4668.6 4886.7 4935.5 5063.8 4768.2 4856.6 4937.5 4966.9 5041.2 04:50:55 INFO - PROCESS | 1643 | 04:50:55 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4374.58 Median:4812.73 stddev:1311.51 (27.3%) stddev-sans-first:1279.40 04:50:55 INFO - PROCESS | 1643 | Values: 320.2 326.7 346.5 359.9 375.1 4749.2 4896.9 4905.3 4973.0 5224.6 4784.6 4955.9 5171.7 5175.6 5176.5 3271.7 3802.8 4046.0 4058.7 4087.8 3190.4 3371.1 3495.7 4005.0 4087.3 3182.4 4033.8 4056.4 4072.3 4073.3 4027.0 4062.4 4090.0 4094.6 4098.4 2927.8 3609.9 3612.9 3616.5 3633.6 4356.7 4955.9 5013.8 5042.3 5073.3 4615.7 4641.5 4644.0 4646.6 4659.4 4564.6 5241.1 5243.3 5423.9 5449.2 3924.4 3954.7 3960.9 3971.0 3991.5 4507.8 4958.9 5575.9 5697.5 5705.3 4022.6 4025.3 4027.4 4029.6 4029.6 3871.7 4053.6 4114.7 4126.3 4143.7 4370.8 4403.6 4508.8 4511.2 4546.9 4548.2 5398.6 5399.3 5407.7 5418.6 1160.3 1207.5 1259.9 1274.8 1335.2 797.8 843.5 865.7 941.0 941.0 3866.9 4204.6 4520.5 4751.0 4893.9 4572.0 5198.3 5283.4 5340.8 5353.4 4056.9 4606.9 4840.9 4849.6 4856.0 2563.0 2625.0 2752.6 2766.7 2777.8 4647.1 4737.0 4858.7 4876.5 5081.3 5035.4 5067.6 5299.4 5395.5 5397.5 5628.2 5828.7 5851.5 5879.4 5891.0 4953.4 4996.4 5226.1 5492.0 5699.7 4687.4 5174.4 5555.4 5559.1 5594.6 5836.2 5866.7 5874.6 5876.3 5897.4 3301.9 3571.6 3780.7 3791.1 3813.4 5359.3 5393.3 5560.4 5612.9 5623.5 5081.6 5286.7 5364.9 5527.3 5553.8 4656.9 4669.0 4966.7 5515.3 5551.9 4481.7 5173.0 5212.8 5388.8 5448.8 5003.8 5129.5 5270.0 5352.3 5455.9 4695.2 4737.4 5110.6 5383.9 5400.7 04:50:55 INFO - PROCESS | 1643 | 04:50:55 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20889.69 Median:4334.24 stddev:30959.59 (714.3%) stddev-sans-first:31009.40 04:50:55 INFO - PROCESS | 1643 | Values: 722.3 728.0 775.4 815.1 833.4 14336.3 15281.2 15284.8 15326.0 15417.8 13852.8 13920.8 14087.9 14090.9 14112.0 686.0 707.6 709.5 712.1 857.3 700.3 705.7 840.0 862.7 867.5 778.8 921.3 921.9 926.4 935.4 926.6 927.9 928.6 929.6 931.8 635.8 677.1 688.6 694.3 695.9 11793.6 12248.1 14117.8 14621.6 14644.9 13851.0 13916.4 13954.1 13996.4 14033.6 11628.9 11744.8 11931.8 11962.3 12168.3 3635.8 3644.4 3814.3 3866.7 3867.6 97204.0 101761.5 102744.5 104271.5 105062.4 10769.7 10827.4 10841.7 10905.9 10964.4 18080.7 21664.5 21841.8 22063.0 22069.3 7658.0 7678.9 7751.0 7792.0 7813.8 4237.1 4286.3 4305.5 4363.0 4438.0 3481.5 3492.2 3504.2 3546.8 3547.8 635.7 639.7 641.3 656.2 656.3 615.0 652.8 661.6 669.3 697.1 8304.9 8678.0 8729.5 9056.8 9266.4 606.5 660.8 673.0 680.9 691.7 4290.1 4463.4 4471.7 4539.8 4570.1 105262.5 105809.0 106492.0 106818.0 113592.0 90885.0 92606.8 93165.0 94859.5 99192.0 79533.6 84457.6 86592.0 87048.0 87641.0 8600.2 8748.6 8776.0 8805.6 8873.7 55058.3 55289.1 55995.9 57077.0 57964.0 73746.3 75472.9 76471.0 79115.0 80951.8 11660.8 11783.6 11919.8 12019.0 12097.8 12409.9 12701.3 12759.6 12970.1 13087.5 11825.3 11830.2 11954.8 12238.6 12487.9 11881.4 12046.5 12194.0 12318.0 12586.8 11777.4 12021.6 12195.9 12239.5 12427.9 7894.9 9469.3 10044.3 10149.7 10152.1 10256.9 10264.1 10375.6 10405.8 10423.1 04:50:55 INFO - PROCESS | 1643 | -------- Summary: end -------- 04:50:55 INFO - PROCESS | 1643 | 04:50:55 INFO - TEST-INFO | 1643: exit 0 04:50:55 INFO - TEST-OK | dromaeo_css | took 1119181ms 04:50:55 INFO - TEST-START | kraken 04:50:55 INFO - operating with platform_type : mac_ 04:50:55 INFO - Initialising browser for kraken test... 04:50:55 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpWSZFQZ/profile http://localhost:49240/getInfo.html) 04:50:58 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 04:50:58 INFO - PROCESS | 1650 | colorDepth:24 04:50:58 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 04:50:58 INFO - PROCESS | 1650 | __metrics 04:50:58 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:50:58 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:59 INFO - TEST-INFO | 1650: exit 0 04:50:59 INFO - Browser initialized. 04:50:59 INFO - Running cycle 1/1 for kraken test... 04:50:59 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpWSZFQZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:11 INFO - PROCESS | 1652 | RSS: Main: 236883968 04:51:11 INFO - PROCESS | 1652 | 04:51:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:14 INFO - PROCESS | 1652 | RSS: Main: 288890880 04:51:14 INFO - PROCESS | 1652 | 04:51:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 04:51:17 INFO - PROCESS | 1652 | RSS: Main: 290828288 04:51:17 INFO - PROCESS | 1652 | 04:51:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 04:51:21 INFO - PROCESS | 1652 | RSS: Main: 384540672 04:51:21 INFO - PROCESS | 1652 | 04:51:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 04:51:24 INFO - PROCESS | 1652 | RSS: Main: 285507584 04:51:24 INFO - PROCESS | 1652 | 04:51:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:27 INFO - PROCESS | 1652 | RSS: Main: 289128448 04:51:27 INFO - PROCESS | 1652 | 04:51:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:30 INFO - PROCESS | 1652 | RSS: Main: 330907648 04:51:30 INFO - PROCESS | 1652 | 04:51:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:34 INFO - PROCESS | 1652 | RSS: Main: 334213120 04:51:34 INFO - PROCESS | 1652 | 04:51:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 04:51:37 INFO - PROCESS | 1652 | RSS: Main: 329109504 04:51:37 INFO - PROCESS | 1652 | 04:51:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:40 INFO - PROCESS | 1652 | RSS: Main: 305463296 04:51:40 INFO - PROCESS | 1652 | 04:51:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:42 INFO - PROCESS | 1652 | RSS: Main: 308150272 04:51:42 INFO - PROCESS | 1652 | 04:51:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:45 INFO - PROCESS | 1652 | RSS: Main: 310132736 04:51:45 INFO - PROCESS | 1652 | 04:51:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:49 INFO - PROCESS | 1652 | RSS: Main: 325394432 04:51:49 INFO - PROCESS | 1652 | 04:51:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:52 INFO - PROCESS | 1652 | RSS: Main: 319844352 04:51:52 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 04:51:54 INFO - PROCESS | 1652 | RSS: Main: 363905024 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | __start_tp_report 04:51:54 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 04:51:54 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 04:51:54 INFO - PROCESS | 1652 | |i|pagename|runs| 04:51:54 INFO - PROCESS | 1652 | |0;ai-astar;113;117;115;114;116;114;114;114;116;116 04:51:54 INFO - PROCESS | 1652 | |1;audio-beat-detection;143;110;111;146;113;110;107;113;154;138 04:51:54 INFO - PROCESS | 1652 | |2;audio-dft;187;183;182;183;183;185;180;183;181;181 04:51:54 INFO - PROCESS | 1652 | |3;audio-fft;79;59;59;88;59;57;59;59;73;59 04:51:54 INFO - PROCESS | 1652 | |4;audio-oscillator;91;70;85;70;68;69;80;68;69;84 04:51:54 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;110;113;111;112;110;113;110;114;109;112 04:51:54 INFO - PROCESS | 1652 | |6;imaging-darkroom;98;98;99;97;97;99;96;98;97;98 04:51:54 INFO - PROCESS | 1652 | |7;imaging-desaturate;87;88;88;86;87;87;87;86;88;88 04:51:54 INFO - PROCESS | 1652 | |8;json-parse-financial;56;56;53;53;53;55;57;75;84;82 04:51:54 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;67;70;74;77;74;69;72;71;71;72 04:51:54 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;88;88;86;87;87;87;86;86;88;87 04:51:54 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;150;142;144;145;140;139;140;142;205;141 04:51:54 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;180;230;237;185;176;174;174;232;169;230 04:51:54 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;67;66;64;66;67;67;71;62;78 04:51:54 INFO - PROCESS | 1652 | __end_tp_report 04:51:54 INFO - PROCESS | 1652 | __start_cc_report 04:51:54 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2081 04:51:54 INFO - PROCESS | 1652 | __end_cc_report 04:51:54 INFO - PROCESS | 1652 | __startTimestamp1481979114971__endTimestamp 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | ------- Summary: start ------- 04:51:54 INFO - PROCESS | 1652 | Number of tests: 14 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.50 stddev:1.29 (1.1%) stddev-sans-first:1.17 04:51:54 INFO - PROCESS | 1652 | Values: 113.0 117.0 115.0 114.0 116.0 114.0 114.0 114.0 116.0 116.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:125.50 stddev:18.35 (14.6%) stddev-sans-first:18.20 04:51:54 INFO - PROCESS | 1652 | Values: 143.0 110.0 111.0 146.0 113.0 110.0 107.0 113.0 154.0 138.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:2.04 (1.1%) stddev-sans-first:1.50 04:51:54 INFO - PROCESS | 1652 | Values: 187.0 183.0 182.0 183.0 183.0 185.0 180.0 183.0 181.0 181.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.10 Median:59.00 stddev:10.90 (18.5%) stddev-sans-first:10.33 04:51:54 INFO - PROCESS | 1652 | Values: 79.0 59.0 59.0 88.0 59.0 57.0 59.0 59.0 73.0 59.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:75.00 stddev:8.69 (11.6%) stddev-sans-first:7.16 04:51:54 INFO - PROCESS | 1652 | Values: 91.0 70.0 85.0 70.0 68.0 69.0 80.0 68.0 69.0 84.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:111.40 Median:112.00 stddev:1.65 (1.5%) stddev-sans-first:1.67 04:51:54 INFO - PROCESS | 1652 | Values: 110.0 113.0 111.0 112.0 110.0 113.0 110.0 114.0 109.0 112.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:98.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 04:51:54 INFO - PROCESS | 1652 | Values: 98.0 98.0 99.0 97.0 97.0 99.0 96.0 98.0 97.0 98.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:87.20 Median:87.50 stddev:0.79 (0.9%) stddev-sans-first:0.83 04:51:54 INFO - PROCESS | 1652 | Values: 87.0 88.0 88.0 86.0 87.0 87.0 87.0 86.0 88.0 88.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:56.50 stddev:12.65 (22.4%) stddev-sans-first:13.20 04:51:54 INFO - PROCESS | 1652 | Values: 56.0 56.0 53.0 53.0 53.0 55.0 57.0 75.0 84.0 82.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:2.83 (3.9%) stddev-sans-first:2.44 04:51:54 INFO - PROCESS | 1652 | Values: 67.0 70.0 74.0 77.0 74.0 69.0 72.0 71.0 71.0 72.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 04:51:54 INFO - PROCESS | 1652 | Values: 88.0 88.0 86.0 87.0 87.0 87.0 86.0 86.0 88.0 87.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:148.80 Median:143.00 stddev:20.00 (14.0%) stddev-sans-first:21.21 04:51:54 INFO - PROCESS | 1652 | Values: 150.0 142.0 144.0 145.0 140.0 139.0 140.0 142.0 205.0 141.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.70 Median:207.50 stddev:29.23 (14.1%) stddev-sans-first:30.21 04:51:54 INFO - PROCESS | 1652 | Values: 180.0 230.0 237.0 185.0 176.0 174.0 174.0 232.0 169.0 230.0 04:51:54 INFO - PROCESS | 1652 | 04:51:54 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:4.35 (6.5%) stddev-sans-first:4.61 04:51:54 INFO - PROCESS | 1652 | Values: 68.0 67.0 66.0 64.0 66.0 67.0 67.0 71.0 62.0 78.0 04:51:54 INFO - PROCESS | 1652 | -------- Summary: end -------- 04:51:54 INFO - PROCESS | 1652 | 04:51:55 INFO - TEST-INFO | 1652: exit 0 04:51:55 INFO - TEST-OK | kraken | took 60231ms 04:51:55 INFO - SUITE-END | took 1179s 04:51:56 INFO - Completed test suite (00:19:39) 04:51:56 INFO - javascript benchmark 04:51:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.09659843543, 3292.242784159643, 3312.420326442872, 3329.3674201901654, 3363.6804503572166, 5519.69641669708, 5526.50261476467, 5536.889262214763, 5631.662100273981, 5647.463490968356, 5286.920696189561, 5570.053090974534, 5630.436956304367, 5631.352394474637, 5644.435556444364, 4540.568645978627, 5172.172452407615, 5176.352955880515, 5182.792688292464, 5198.636095473318, 5093.312402825627, 5163.122269214224, 5231.843044708646, 5241.554467870235, 5265.236540701596, 5202.427732949392, 5223.347081614798, 5226.686398816064, 5240.03059434004, 5268.446813084609, 5070.923936140961, 5103.719295438749, 5161.5870730341485, 5168.405633352175, 5191.091558977183, 5092.618053645954, 5123.897522049576, 5127.4872512748425, 5146.9485305146845, 5210.192420174879, 4680.461746899116, 5581.441855814427, 5586.0, 5599.440055994409, 5624.043912534838, 6152.538559608002, 6152.692365381758, 6158.414950579688, 6166.506679465632, 6170.043643235261, 6033.969830150865, 6056.848578785522, 6105.542084343692, 6119.9291020253595, 6173.722182501753, 5697.487226149584, 5711.8000869969355, 5714.971305165027, 5737.684427356494, 5758.971205143989, 6317.4946004319545, 6329.810105696836, 6333.429991300805, 6354.887894618423, 6358.078078678565, 5724.942750572524, 5813.360530341659, 5816.621919575298, 5949.762009519657, 5998.640081595118, 6045.093236014545, 6101.398774955092, 6140.8771824563255, 6164.260288765287, 6184.072389141665, 6021.397860214031, 6060.545459090586, 6065.2418447694035, 6079.331273559905, 6093.69531523422, 5913.231279933581, 6028.397160284024, 6103.267607887082, 6111.419415155553, 6123.203983482119, 4763.0, 4793.089313030513, 4809.989902120524, 4811.133995880705, 4838.395200599925, 4323.178596066738, 4340.175366680321, 4346.261135606955, 4352.194843953878, 4396.494403143615, 5669.092945128759, 5672.829815105553, 5676.914846277309, 5685.886282274331, 5689.886202276014, 6021.2473440819895, 6025.3974602540275, 6075.179850720185, 6131.816045518642, 6196.1635179251125, 5647.435256474319, 5676.4323567642905, 5691.943080569141, 5717.399673034354, 5717.885642287131, 5284.735763211824, 5291.444398338196, 5293.708846013506, 5303.814366497154, 5308.336457942757, 5300.602454815904, 6165.290991535851, 6248.4688801452385, 6340.334264902303, 6386.904196436964, 6069.0592958091565, 6133.1510485532735, 6134.877302453837, 6144.771045790949, 6165.599236049642, 6374.96812515953, 6381.744730210739, 6390.169277993831, 6392.520560957853, 6425.293217745951, 5981.162637230878, 6087.086936959491, 6095.1466794647895, 6099.695015249131, 6125.356837531995, 5915.467607915309, 6000.5799594028, 6003.849903752441, 6073.362296958932, 6085.0, 4877.5366340197625, 5938.792142275172, 5939.881202376015, 5971.970140149271, 5995.070764031582, 5888.381719919346, 5909.5863289569315, 5919.556033297434, 5922.911156332744, 5942.376050514634, 5653.858653533694, 5701.828945131652, 5703.885922281448, 5709.429057094258, 5804.303483581997, 5874.823755287348, 5886.735096920735, 5892.852678683067, 5900.793472228452, 5916.467517923407, 5718.285214348207, 5718.79984200551, 5727.4845263926445, 5728.856778580569, 5736.913946290725], "value": 5586.252789829786, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.0, 467.7790965579838, 479.4797644555657, 487.8316980641677, 493.8938128302414, 29087.85456072722, 30813.691863081363, 30841.920532781383, 30861.0, 30874.91937782178, 31346.686533134663, 31939.528466014777, 32150.0, 34445.82777086117, 39114.80442597783, 9107.590158442852, 9328.207102396305, 9332.813343733122, 9338.206252468548, 9344.345895787297, 8661.830652861878, 8745.47527148373, 9199.724008279762, 9247.352685312031, 9336.81326373472, 7607.961960190219, 8317.293030092449, 9311.674091406801, 9375.859362109573, 10780.353178809257, 11010.889891101067, 11015.944920275388, 11121.27711698745, 11135.665930022113, 11145.275557088764, 9346.719598412059, 10935.56257749689, 11024.0, 11029.503672334764, 11033.282836615594, 30216.92071570332, 30629.540556891665, 30678.0, 38213.23573528514, 38396.616033839586, 2884.956725649117, 3371.6291207967106, 3772.43413487979, 4032.6169013943627, 4139.91720165595, 28389.60896692172, 29155.41689166226, 29367.853160734274, 29400.411991760044, 29654.70345296541, 3081.260497480611, 3147.6222853257527, 3153.7003984621424, 3213.630432500269, 3252.073159149631, 475027.62486187345, 475666.0, 476411.0, 476875.0, 477077.0, 54318.7284063585, 55930.44069559334, 56122.0, 56219.0, 56261.0, 58661.0, 58921.0, 58931.52671183255, 58936.0, 59167.0, 15084.321205545777, 15306.234688265766, 15310.311036003406, 15313.0, 15344.0, 12136.45385957634, 12185.086118541145, 12216.3281019543, 12231.266124032587, 12231.633051008484, 12114.394280285951, 12867.742645147044, 15000.549983500512, 15050.247487625575, 15253.16107614092, 5530.2810634618045, 6653.565969947784, 6745.628990405575, 6771.4582833373215, 6780.491463140284, 856.8157846063126, 947.3131979314942, 990.0693348252763, 1077.3858900426837, 1121.7363919478917, 27812.582811257846, 28708.0, 28726.0, 29548.409031819243, 29553.408931821243, 1053.378506681062, 1069.2835800014009, 1087.8205096159045, 1118.9216754827246, 1179.5222934711455, 14599.41602335916, 14902.329395177243, 14934.402623894923, 15278.0, 15557.533274001798, 598921.0, 605186.0, 605512.0, 605567.0, 607369.0, 56119.71940140273, 56418.87162256732, 56481.43518564844, 56483.71758141183, 56654.7167264161, 1270.9046821488241, 1375.1748950629542, 1394.7907813828008, 1408.2325132802441, 1418.7091646212502, 27841.582376263967, 28654.71345286604, 28870.664855362127, 29337.0, 29357.55963660504, 34393.65606343905, 44385.117637060546, 44389.89025274394, 44411.11177776491, 44487.55512444834, 546709.3290670901, 550571.0, 551662.0, 552060.0, 552345.0, 37313.81343093267, 37604.81197594104, 37900.83090860058, 37942.2411551773, 38138.61861381351, 44240.77879610581, 44811.87970300768, 45069.54930450654, 45163.32255016243, 45318.77340613276, 36693.63306367009, 37009.62990370062, 37266.06834829151, 37840.24319513649, 37948.0, 33050.17374565655, 34099.829500852335, 34779.43492542791, 36533.45199822058, 37732.62267377291, 35990.0, 36105.458418124275, 36134.63865361418, 36720.26559468742, 36839.0, 31271.061868143992, 31731.04806855798, 32896.83551582227, 32969.01092967215, 33194.33611327712, 24233.273001809976, 24443.755562444858, 24474.26577202687, 24776.876115619307, 24802.751972480764], "value": 19102.350834729154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2987020763785, 367.65624141427764, 372.545494496714, 378.4701418014779, 402.48280958967734, 14415.13509189448, 14704.485343012997, 15450.22748862558, 19622.803771962277, 20021.399358019284, 16762.41331553396, 19109.904450477763, 19632.01839908006, 20541.794582054175, 20569.794302056976, 5660.5471562274915, 5681.289838770153, 5897.41025897409, 5915.201447804534, 5927.911081333784, 4111.835526578933, 4349.1301739652035, 4474.552544745532, 4901.705897646153, 5878.294604647448, 4325.891852703676, 6159.81520554384, 6443.548951573392, 6452.967735161317, 6496.870062598745, 5473.233747275384, 5747.195392645033, 5798.7390567424145, 6445.387688169616, 6488.351164883521, 5647.01177293976, 5648.293963254593, 5660.547156227533, 5661.60368774186, 5675.858103547403, 12907.354632268443, 13088.411021504055, 13189.274589897552, 13320.400581973834, 13333.333333333294, 2003.6593779057596, 2209.127394679093, 2251.774822517735, 2480.620155038749, 2616.476704659076, 10027.799444011152, 10209.336393134497, 10268.845967310497, 12394.070444716592, 14628.163452525769, 1687.2576066530687, 1796.092973048602, 1863.2267608942273, 1868.701007838753, 1911.6559019376507, 98742.0, 104481.47759261231, 108969.45515272373, 113070.0, 113458.0, 11122.833157502644, 11166.274192177483, 11367.943160284145, 11385.259958102863, 11563.479643416067, 14397.85602143986, 14441.0, 14442.711145777026, 14458.421663133357, 14468.565943021726, 8195.057568379594, 8336.0, 8362.54006029662, 8476.660933562589, 8508.404411691123, 7298.051253337138, 7817.335526480199, 8225.136360682161, 8272.37957153204, 8384.664613415516, 3736.626337366242, 4343.652507799368, 4450.109978004412, 4455.6212721919, 4518.932216016762, 1747.1875577856358, 1855.1095474172203, 1910.9489780620604, 1914.7362740591143, 1915.722220278052, 740.6704016712512, 747.8279995601042, 758.5145506875604, 867.5878957495139, 951.1867353412871, 19255.0, 21054.473638158863, 21209.575808483743, 21288.574228515652, 21378.679319809904, 855.8630619100913, 959.0649117110761, 980.6126580001003, 982.6609819612365, 992.0872797026608, 10751.301165424222, 11121.888781112248, 11160.386178760245, 11170.944145279222, 11184.496697648625, 477156.0, 480725.0, 485092.0, 493883.0, 494792.0, 109790.3531447029, 116464.41767791107, 119670.0, 120104.39947800204, 125483.0, 1026.0560284538392, 1032.3135115148343, 1070.3310430980637, 1102.9669109926715, 1104.536094840169, 14612.561623151323, 18401.079946002916, 18904.0, 19227.134778934702, 19564.771812650753, 49249.753751231015, 53106.73446632742, 54233.457665424416, 54375.0, 55409.0, 72962.63518682373, 73042.0, 73358.0, 73411.0, 74067.62966185134, 7749.186335434698, 7780.144184139854, 7947.443678942419, 7978.401619878417, 8274.420790544604, 10746.408947507962, 12046.337451440255, 12073.0, 12392.194507356993, 12554.560590379659, 9005.864912026194, 10285.845712314172, 10778.245522813328, 10790.0, 10961.56153753841, 10075.294729368874, 10413.271071025258, 10447.320924139907, 10816.0, 10939.28894621847, 9443.905560944302, 9907.058829411195, 10853.40306283162, 11040.558377664804, 11237.157213209206, 6591.34086591337, 7843.215678432111, 7865.449418540876, 7892.171322011106, 8101.797455063671, 9555.665551705657, 10470.895291046992, 10666.786664266827, 10772.24594278393, 10819.891801081889], "value": 9057.414339005252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.9853901460986, 1489.6275931017246, 1675.3466148202203, 1796.7664203653524, 1853.4338483981032, 6552.770653027145, 8451.704190353339, 8464.746057618273, 8471.068182499928, 8473.91526084739, 7383.224761400056, 7656.770296891103, 7939.444238903265, 8193.221643943816, 8195.754127376173, 2301.551197516481, 2341.625339945609, 2342.871142087193, 2344.519373528431, 2347.507023525062, 2328.3015095471374, 2348.307249361434, 2367.7868991790733, 2368.159303447277, 2371.774681405264, 1957.784643689193, 2053.3531937439657, 2123.6389813731703, 2127.9787202127936, 2230.0522278031854, 2301.5972204864165, 2317.8029867461287, 2320.385097949045, 2324.140068174769, 2329.126577533425, 2329.813614910803, 2337.3338598499518, 2351.259353303704, 2358.4221865642858, 2363.3737059679197, 8210.220029097285, 8434.83130337396, 8442.0, 8448.915510844936, 8472.576371181416, 5048.015636950796, 5219.556337711299, 5222.451642577551, 5232.581393488512, 5237.738113094369, 3367.1413789483527, 3528.4530897710897, 3591.94612080819, 3593.083763640281, 3593.964060359389, 1007.8337074382719, 1051.8264486359742, 1076.2251179151076, 1082.4912291223113, 1093.0763504838399, 10564.78870422595, 10710.089642380408, 10714.78570428587, 10727.927207279288, 10735.516901739362, 4571.26859702446, 4723.291506274087, 4731.668783185144, 4764.4520880099235, 4793.640476964241, 8558.35812314079, 8606.13938606147, 8614.05245423003, 8621.137886211454, 8623.827523449496, 5066.392032956069, 5070.163423035158, 5075.543201111917, 5076.416212135578, 5079.161938280143, 4643.164230438486, 4750.61995040396, 4776.355192049098, 4781.330613714083, 4861.659683822169, 2909.330853903614, 3484.878029269014, 3498.9852942646858, 3561.554805649294, 3571.08937221007, 1128.7178205448638, 1132.2413982631656, 1136.085451211766, 1146.0258780037068, 1150.3040660400338, 821.326512259953, 879.4811061473761, 906.7234493479552, 910.8497097978892, 941.9697082372827, 4538.72767633943, 5460.481254280837, 5521.337439507285, 5623.409541998113, 5792.275965504312, 414.91079417924686, 415.21731536054756, 434.1664005110196, 444.17383666380505, 451.9593236608721, 3542.6634469725336, 3630.891073267753, 3669.798161101112, 3895.9091454392815, 3930.7248492605245, 9813.41119532816, 9820.508974551243, 9828.655997040069, 10073.49632518371, 10215.7446063849, 6806.7957961261245, 9762.267829912786, 9796.9020309796, 10123.139533139765, 10157.288989770794, 7336.7065317386705, 7821.765347039598, 7834.921650783419, 7849.921500784919, 7854.842903142019, 4915.729634870117, 4947.233178857283, 5381.3542374913695, 5500.954818584456, 5713.944829163271, 7747.341475974606, 8974.685885993958, 9268.165865072177, 9358.344915855825, 9396.0, 9290.489023103524, 9443.386179898285, 9533.33266671354, 9592.280578956466, 9597.712068637951, 6992.720291188499, 7081.291870813084, 7147.642617868982, 7186.46101542376, 7200.89198662031, 7698.499597526143, 7708.691652334068, 7709.3447057000785, 7791.610419479117, 7908.0, 5665.546756259571, 7083.574985500681, 7130.786076417716, 7159.928400715926, 7199.820004499929, 6999.335063168991, 7009.649517524205, 7040.788776336718, 7073.504854660125, 7188.209296977224, 6387.329330420239, 6623.635700036544, 6721.059051732859, 6722.0, 6723.159605049369, 4380.956190438183, 4668.622756286835, 4886.731229782396, 4935.457099718957, 5063.772130254221, 4768.213244814567, 4856.635752318661, 4937.456879743298, 4966.925496117489, 5041.168207245763], "value": 4261.825290881729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.2410287618345, 326.6733266733267, 346.546024707633, 359.91182160370715, 375.1465416178194, 4749.240121580544, 4896.926546101811, 4905.33777939978, 4972.975135124324, 5224.582033437326, 4784.612462385912, 4955.876103097425, 5171.741802664325, 5175.58595312375, 5176.4729404825575, 3271.7382609391193, 3802.790846503441, 4046.0, 4058.701215611006, 4087.7547347159266, 3190.4416727072785, 3371.061639557252, 3495.6679115484117, 4005.0, 4087.261534771695, 3182.379436009979, 4033.8184781684895, 4056.371262454324, 4072.287349713803, 4073.307537718595, 4026.959730402717, 4062.431259623655, 4090.0367823444617, 4094.5700701426217, 4098.426220329156, 2927.7950543461966, 3609.917024892548, 3612.945805812915, 3616.475611036385, 3633.563972323338, 4356.738595684237, 4955.886614110316, 5013.799448022111, 5042.319286896259, 5073.315102461157, 4615.653825963066, 4641.512641172696, 4644.0494992103395, 4646.605038571725, 4659.4175728034, 4564.589186973155, 5241.135212689902, 5243.329669231515, 5423.901532559382, 5449.237106805051, 3924.4113382992496, 3954.7231693781446, 3960.8611349871035, 3971.0, 3991.481107456041, 4507.774611269423, 4958.851234462972, 5575.944240557583, 5697.544196464273, 5705.315362156526, 4022.6379625833815, 4025.269134272291, 4027.35562310029, 4029.576894426043, 4029.576894426043, 3871.741683952727, 4053.574374690674, 4114.7450027741825, 4126.319157339006, 4143.70994030421, 4370.759608221579, 4403.581659742319, 4508.842190523316, 4511.233090374644, 4546.909061818745, 4548.226801443762, 5398.568114550826, 5399.299220745453, 5407.729613519308, 5418.620696551282, 1160.257435241446, 1207.4988879615037, 1259.9307038112809, 1274.8470183577845, 1335.1788649980192, 797.8484088023257, 843.4770442325797, 865.7186414415214, 940.9717708468756, 940.9905900940903, 3866.8592765134354, 4204.579542045771, 4520.50274469808, 4750.976245118753, 4893.902121957541, 4571.977140114344, 5198.298229739013, 5283.445238250005, 5340.813071542478, 5353.411124776271, 4056.858009969637, 4606.930896036562, 4840.854774356775, 4849.563539281482, 4855.984766321937, 2562.9871850641002, 2624.973750262511, 2752.559590465516, 2766.7233276672173, 2777.7639050505936, 4647.117047760915, 4736.976315118472, 4858.732769697701, 4876.463589005207, 5081.306907339116, 5035.370578677665, 5067.594592432597, 5299.364076310791, 5395.514403703607, 5397.541208997279, 5628.1557766333735, 5828.737706803204, 5851.502622277069, 5879.412058794086, 5890.970545147246, 4953.356063711694, 4996.400431948189, 5226.085435048927, 5491.972540137273, 5699.686517241592, 4687.414073240845, 5174.4476657002, 5555.3611334697025, 5559.11054231321, 5594.580406469449, 5836.212111364912, 5866.67733274674, 5874.647521148574, 5876.324222714443, 5897.439743224387, 3301.8679252829616, 3571.6427757452, 3780.6597406233573, 3791.1090893640526, 3813.427985802041, 5359.311816777703, 5393.325834270716, 5560.36055853582, 5612.859678507906, 5623.517070855883, 5081.593472522263, 5286.748649580557, 5364.865878353073, 5527.281453411031, 5553.805616803554, 4656.883577910579, 4668.953310466852, 4966.726830024383, 5515.338159420895, 5551.916721249104, 4481.708688935209, 5172.991266702957, 5212.791488340424, 5388.757505912165, 5448.809291674773, 5003.849114703566, 5129.461406552407, 5270.0224373229, 5352.277442545206, 5455.863603409946, 4695.178343789755, 4737.384140061908, 5110.5911527077005, 5383.919241211307, 5400.675959442446], "value": 3969.474531868976, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.2813300765739, 727.9708811647531, 775.4494309040581, 815.0667485728841, 833.4166083741383, 14336.283185840706, 15281.2359382031, 15284.770728439069, 15326.0, 15417.845821541781, 13852.792208116862, 13920.791188132162, 14087.929560352184, 14090.929545352285, 14112.0, 685.9965700171517, 707.6214225389392, 709.4820780829997, 712.0671919785073, 857.3055824781947, 700.2787129256848, 705.696550483292, 839.9706010289641, 862.7368652560966, 867.5488745852153, 778.81697801017, 921.2721949659795, 921.9262459003263, 926.4117285523673, 935.4434111703525, 926.6339795780697, 927.8561822917492, 928.614624930653, 929.5770424456856, 931.818295432391, 635.7933671556763, 677.14003215916, 688.6350234375789, 694.2883544367064, 695.8538706871564, 11793.646190614296, 12248.142630015902, 14117.78823317651, 14621.561353159423, 14644.926775366055, 13851.0, 13916.373763180682, 13954.09298395601, 13996.440142394293, 14033.578992630237, 11628.941855290754, 11744.823827642593, 11931.761364772656, 11962.282263064244, 12168.2699038058, 3635.818209089535, 3644.380455322575, 3814.275287695329, 3866.690664746842, 3867.5939026402384, 97204.0, 101761.4911925443, 102744.48627756814, 104271.47864260706, 105062.4240636391, 10769.676909692722, 10827.404492752818, 10841.728956776144, 10905.945470272756, 10964.396958167217, 18080.728789068173, 21664.458388540097, 21841.781582183976, 22063.0, 22069.33791986243, 7658.0, 7678.923210767933, 7750.961245193738, 7792.025996750406, 7813.843723125619, 4237.110206856533, 4286.271333873249, 4305.48334199898, 4363.0, 4437.955620443754, 3481.4603736420895, 3492.231709024011, 3504.159001839591, 3546.8049257291095, 3547.822608869546, 635.656745357511, 639.7025383196835, 641.2817644238482, 656.2059907511964, 656.255150404285, 614.9938500615026, 652.7813182583888, 661.6195687479623, 669.3340869539372, 697.1181455458849, 8304.875426868603, 8677.956610217036, 8729.476231426135, 9056.773580660405, 9266.397684150508, 606.4966078155121, 660.8116686744255, 673.0341959288437, 680.9182898052266, 691.7233106757337, 4290.141971605629, 4463.419755431838, 4471.664625153061, 4539.84110556129, 4570.131674981742, 105262.47368763108, 105809.0, 106492.0, 106818.0, 113592.0, 90885.0, 92606.81519017415, 93165.0, 94859.52570237104, 99192.0, 79533.60233198798, 84457.57771211104, 86592.0, 87048.0, 87641.0, 8600.182982616641, 8748.60631271607, 8775.956120219358, 8805.559722014003, 8873.689420870238, 55058.348249552575, 55289.06488273052, 55995.88008239894, 57077.0, 57964.0, 73746.26253737608, 75472.9243321066, 76471.0, 79115.0, 80951.78572321302, 11660.825087623862, 11783.646490605295, 11919.821202681793, 12019.0, 12097.758044838878, 12409.93795031019, 12701.301428421526, 12759.61721148367, 12970.054930005268, 13087.476500940236, 11825.34960577142, 11830.166324219415, 11954.760904781682, 12238.632841014783, 12487.937560312505, 11881.405929703653, 12046.457909393923, 12194.0, 12318.0, 12586.811197832223, 11777.411129443322, 12021.639350819489, 12195.939020304842, 12239.510419583117, 12427.937860311002, 7894.921050789649, 9469.337146399686, 10044.283615062473, 10149.746256343651, 10152.086312231935, 10256.897431025594, 10264.076233139054, 10375.636852710119, 10405.791884162123, 10423.114035307084], "value": 7306.84347790829, "unit": "score"}], "name": "dromaeo_css", "value": 7018.101780555242, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 115.0, 114.0, 116.0, 114.0, 114.0, 114.0, 116.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 111.0, 146.0, 113.0, 110.0, 107.0, 113.0, 154.0, 138.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 182.0, 183.0, 183.0, 185.0, 180.0, 183.0, 181.0, 181.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 88.0, 59.0, 57.0, 59.0, 59.0, 73.0, 59.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 85.0, 70.0, 68.0, 69.0, 80.0, 68.0, 69.0, 84.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 111.0, 112.0, 110.0, 113.0, 110.0, 114.0, 109.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 99.0, 97.0, 97.0, 99.0, 96.0, 98.0, 97.0, 98.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 86.0, 87.0, 87.0, 87.0, 86.0, 88.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 53.0, 53.0, 55.0, 57.0, 75.0, 84.0, 82.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 74.0, 77.0, 74.0, 69.0, 72.0, 71.0, 71.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 86.0, 87.0, 87.0, 87.0, 86.0, 86.0, 88.0, 87.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 142.0, 144.0, 145.0, 140.0, 139.0, 140.0, 142.0, 205.0, 141.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 230.0, 237.0, 185.0, 176.0, 174.0, 174.0, 232.0, 169.0, 230.0], "value": 198.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 64.0, 66.0, 67.0, 67.0, 71.0, 62.0, 78.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1495.2, "alertThreshold": 2.0}]} 04:51:56 INFO - Return code: 0 04:51:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:56 INFO - # TBPL SUCCESS # 04:51:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:56 INFO - 2016-12-17 04:51:56.292 screenresolution[1656:10143] starting screenresolution argv=screenresolution get 04:51:56 INFO - 2016-12-17 04:51:56.294 screenresolution[1656:10143] Display 0: 1600x1200x32@60 04:51:56 INFO - 2016-12-17 04:51:56.301 screenresolution[1657:10146] starting screenresolution argv=screenresolution list 04:51:56 INFO - Available Modes on Display 0 04:51:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:56 INFO - Intel Iris: 04:51:56 INFO - Chipset Model: Intel Iris 04:51:56 INFO - Type: GPU 04:51:56 INFO - Bus: Built-In 04:51:56 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:56 INFO - Vendor: Intel (0x8086) 04:51:56 INFO - Device ID: 0x0a2e 04:51:56 INFO - Revision ID: 0x0009 04:51:56 INFO - Displays: 04:51:56 INFO - Display: 04:51:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:56 INFO - Display Serial Number: 1600x1200 60 04:51:56 INFO - Main Display: Yes 04:51:56 INFO - Mirror: Off 04:51:56 INFO - Online: Yes 04:51:56 INFO - Rotation: Supported 04:51:56 INFO - Return code: 0 04:51:56 INFO - Running post-action listener: _resource_record_post_action 04:51:56 INFO - [mozharness: 2016-12-17 12:51:56.539669Z] Finished run-tests step (success) 04:51:56 INFO - Running post-run listener: _resource_record_post_run 04:51:56 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37651456; Write bytes: 552242176; Read time: 244; Write time: 1703 04:51:56 INFO - TinderboxPrint: CPU usage
53.9% 04:51:56 INFO - TinderboxPrint: I/O read bytes / time
37,651,456 / 244 04:51:56 INFO - TinderboxPrint: I/O write bytes / time
552,242,176 / 1,703 04:51:56 INFO - TinderboxPrint: CPU idle
2,218.5 (46.1%) 04:51:56 INFO - TinderboxPrint: CPU system
969.5 (20.2%) 04:51:56 INFO - TinderboxPrint: CPU user
1,621.6 (33.7%) 04:51:56 INFO - TinderboxPrint: Swap in / out
286,433,280 / 0 04:51:56 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248656384; Write bytes: 235696128; Read time: 17656; Write time: 485 04:51:56 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 30292992; Write bytes: 300858368; Read time: 182; Write time: 1177 04:51:57 INFO - Running post-run listener: _upload_blobber_files 04:51:57 INFO - Blob upload gear active. 04:51:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:58 INFO - (blobuploader) - INFO - Done attempting. 04:51:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:59 INFO - (blobuploader) - INFO - Done attempting. 04:51:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:01 INFO - (blobuploader) - INFO - Done attempting. 04:52:01 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:01 INFO - Return code: 0 04:52:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9657028a23cd2116ca47f8131baf3cff6847dbee439674437956a738c0ed511cb9ecd85f92b997f17027162856573b2dff1c4d6c6e71f263c0c3f7f9970cde8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0631a1d2d6c567efe2634d725c82db2b1314dac2a076b69b7da3b749cc200e8448ba9b28b14ab0cd4f7e7dbde5c299a993724f1cc6cf65e69e7c597f02b496f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e37283d96c9c09e3f5e2d4c9ef6f7bf91b3f0b63c04e70e445c2f4c92d03baf101181a1e010ceaca301227294978f34823054871296a841a7e3db4905fa4b7"} 04:52:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:01 INFO - Contents: 04:52:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9657028a23cd2116ca47f8131baf3cff6847dbee439674437956a738c0ed511cb9ecd85f92b997f17027162856573b2dff1c4d6c6e71f263c0c3f7f9970cde8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0631a1d2d6c567efe2634d725c82db2b1314dac2a076b69b7da3b749cc200e8448ba9b28b14ab0cd4f7e7dbde5c299a993724f1cc6cf65e69e7c597f02b496f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e37283d96c9c09e3f5e2d4c9ef6f7bf91b3f0b63c04e70e445c2f4c92d03baf101181a1e010ceaca301227294978f34823054871296a841a7e3db4905fa4b7"} 04:52:01 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:01 INFO - Copying logs to upload dir... 04:52:01 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.650827 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-17 04:52:01.977263) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 04:52:01.985071) ========= 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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9657028a23cd2116ca47f8131baf3cff6847dbee439674437956a738c0ed511cb9ecd85f92b997f17027162856573b2dff1c4d6c6e71f263c0c3f7f9970cde8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0631a1d2d6c567efe2634d725c82db2b1314dac2a076b69b7da3b749cc200e8448ba9b28b14ab0cd4f7e7dbde5c299a993724f1cc6cf65e69e7c597f02b496f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e37283d96c9c09e3f5e2d4c9ef6f7bf91b3f0b63c04e70e445c2f4c92d03baf101181a1e010ceaca301227294978f34823054871296a841a7e3db4905fa4b7"} build_url:https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010981 build_url: 'https://queue.taskcluster.net/v1/task/Gq_jBLXPSw-SY0vbl_qHmw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9657028a23cd2116ca47f8131baf3cff6847dbee439674437956a738c0ed511cb9ecd85f92b997f17027162856573b2dff1c4d6c6e71f263c0c3f7f9970cde8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0631a1d2d6c567efe2634d725c82db2b1314dac2a076b69b7da3b749cc200e8448ba9b28b14ab0cd4f7e7dbde5c299a993724f1cc6cf65e69e7c597f02b496f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e37283d96c9c09e3f5e2d4c9ef6f7bf91b3f0b63c04e70e445c2f4c92d03baf101181a1e010ceaca301227294978f34823054871296a841a7e3db4905fa4b7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 04:52:02.025462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 04:52:02.025923) ========= 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.ZtxcXyKMgA/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.pkvgBNC5Gg/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.005038 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 04:52:02.077374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 04:52:02.079120) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 04:52:02.079678) ========= ========= Total master_lag: 0.21 =========