builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0375 starttime: 1481691443.47 results: success (0) buildid: 20161213192606 builduid: ed8880dbdc7a4fa4996a31b9be17daf6 revision: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:23.473400) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:23.473863) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:23.474248) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:23.500567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:23.501030) ========= 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.MLqWSI39Df/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.XapkJcJcIV/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-13 20:57:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 71.3M=0s 2016-12-13 20:57:24 (71.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.346029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:23.871329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:23.871667) ========= 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.MLqWSI39Df/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.XapkJcJcIV/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.025394 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:23.921024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 20:57:23.921487) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e --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 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MLqWSI39Df/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.XapkJcJcIV/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-13 20:57:24,466 truncating revision to first 12 chars 2016-12-13 20:57:24,466 Setting DEBUG logging. 2016-12-13 20:57:24,466 attempt 1/10 2016-12-13 20:57:24,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1ea0c60db5d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 20:57:25,581 unpacking tar archive at: mozilla-central-1ea0c60db5d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 20:57:25.321155) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:25.321523) ========= script_repo_revision: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:25.322037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:25.322326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 20:57:25.342569) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-13 20:57:25.343055) ========= /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.MLqWSI39Df/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.XapkJcJcIV/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:57:25 INFO - MultiFileLogger online at 20161213 20:57:25 in /builds/slave/test 20:57:25 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 20:57:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:57:25 INFO - {'append_to_log': False, 20:57:25 INFO - 'base_work_dir': '/builds/slave/test', 20:57:25 INFO - 'blob_upload_branch': 'Firefox', 20:57:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:57:25 INFO - 'branch': 'Firefox', 20:57:25 INFO - 'buildbot_json_path': 'buildprops.json', 20:57:25 INFO - 'config_files': ('talos/mac_config.py',), 20:57:25 INFO - 'default_actions': ('clobber', 20:57:25 INFO - 'read-buildbot-config', 20:57:25 INFO - 'download-and-extract', 20:57:25 INFO - 'populate-webroot', 20:57:25 INFO - 'create-virtualenv', 20:57:25 INFO - 'install', 20:57:25 INFO - 'run-tests'), 20:57:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:57:25 INFO - 'download_minidump_stackwalk': True, 20:57:25 INFO - 'download_symbols': 'ondemand', 20:57:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:57:25 INFO - 'tooltool.py': '/tools/tooltool.py', 20:57:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:57:25 INFO - '/tools/misc-python/virtualenv.py')}, 20:57:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:57:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:57:25 INFO - 'installer_path': 'installer.exe', 20:57:25 INFO - 'log_level': 'info', 20:57:25 INFO - 'log_name': 'talos', 20:57:25 INFO - 'log_to_console': True, 20:57:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:57:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:57:25 INFO - 'opt_config_files': (), 20:57:25 INFO - 'pip_index': False, 20:57:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:57:25 INFO - 'cmd': ('bash', 20:57:25 INFO - '-c', 20:57:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:57:25 INFO - 'enabled': True, 20:57:25 INFO - 'halt_on_failure': False, 20:57:25 INFO - 'name': 'check_screen_resolution'},), 20:57:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:57:25 INFO - 'cmd': ('bash', 20:57:25 INFO - '-c', 20:57:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:57:25 INFO - 'enabled': True, 20:57:25 INFO - 'halt_on_failure': False, 20:57:25 INFO - 'name': 'check_screen_resolution'},), 20:57:25 INFO - 'run_cmd_checks_enabled': True, 20:57:25 INFO - 'sps_profile': False, 20:57:25 INFO - 'sps_profile_interval': 0, 20:57:25 INFO - 'suite': 'dromaeojs', 20:57:25 INFO - 'system_bits': '32', 20:57:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:57:25 INFO - 'title': 't-yosemite-r7-0375', 20:57:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:57:25 INFO - 'use_talos_json': True, 20:57:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:57:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:57:25 INFO - 'work_dir': 'build'} 20:57:25 INFO - [mozharness: 2016-12-14 04:57:25.995454Z] Running clobber step. 20:57:25 INFO - Running pre-action listener: _resource_record_pre_action 20:57:25 INFO - Running main action method: clobber 20:57:25 INFO - rmtree: /builds/slave/test/build 20:57:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:57:28 INFO - Running post-action listener: _resource_record_post_action 20:57:28 INFO - [mozharness: 2016-12-14 04:57:28.440807Z] Finished clobber step (success) 20:57:28 INFO - [mozharness: 2016-12-14 04:57:28.441050Z] Running read-buildbot-config step. 20:57:28 INFO - Running pre-action listener: _resource_record_pre_action 20:57:28 INFO - Running main action method: read_buildbot_config 20:57:28 INFO - Using buildbot properties: 20:57:28 INFO - { 20:57:28 INFO - "project": "", 20:57:28 INFO - "product": "firefox", 20:57:28 INFO - "script_repo_revision": "production", 20:57:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 20:57:28 INFO - "repository": "", 20:57:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 20:57:28 INFO - "buildid": "20161213192606", 20:57:28 INFO - "pgo_build": "False", 20:57:28 INFO - "basedir": "/builds/slave/test", 20:57:28 INFO - "buildnumber": 47, 20:57:28 INFO - "slavename": "t-yosemite-r7-0375", 20:57:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:57:28 INFO - "platform": "yosemite_r7", 20:57:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:57:28 INFO - "branch": "mozilla-central", 20:57:28 INFO - "repo_path": "mozilla-central", 20:57:28 INFO - "revision": "1ea0c60db5d25a7d522e2f252c1978ff4fc7538e", 20:57:28 INFO - "stage_platform": "macosx64", 20:57:28 INFO - "builduid": "ed8880dbdc7a4fa4996a31b9be17daf6", 20:57:28 INFO - "slavebuilddir": "test" 20:57:28 INFO - } 20:57:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 20:57:28 INFO - Running post-action listener: _resource_record_post_action 20:57:28 INFO - [mozharness: 2016-12-14 04:57:28.446901Z] Finished read-buildbot-config step (success) 20:57:28 INFO - [mozharness: 2016-12-14 04:57:28.447139Z] Running download-and-extract step. 20:57:28 INFO - Running pre-action listener: _resource_record_pre_action 20:57:28 INFO - Running main action method: download_and_extract 20:57:28 INFO - mkdir: /builds/slave/test/build/tests 20:57:28 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')]} 20:57:28 INFO - trying https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 20:57:28 INFO - Downloading https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/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 20:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/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 20:57:29 INFO - Downloaded 1199 bytes. 20:57:29 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 20:57:29 INFO - Using the following test package requirements: 20:57:29 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:57:29 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:57:29 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 20:57:29 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:57:29 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 20:57:29 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:57:29 INFO - u'jsshell-mac.zip'], 20:57:29 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:57:29 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 20:57:29 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:57:29 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:57:29 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 20:57:29 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:57:29 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 20:57:29 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:57:29 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 20:57:29 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:57:29 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 20:57:29 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:57:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:57:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:57:29 INFO - Fetch https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:57:30 INFO - Expected file size: 16276031 20:57:30 INFO - Obtained file size: 16276031 20:57:37 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 20:57:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:57:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:57:37 INFO - Fetch https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:57:38 INFO - Expected file size: 16276031 20:57:38 INFO - Obtained file size: 16276031 20:57:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 20:57:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:57:44 INFO - Fetch https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 20:57:45 INFO - Expected file size: 14409734 20:57:45 INFO - Obtained file size: 14409734 20:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:45 INFO - trying https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:57:45 INFO - Downloading https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 20:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/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 20:57:47 INFO - Downloaded 69668940 bytes. 20:57:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:57:47 INFO - mkdir: /builds/slave/test/properties 20:57:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:57:47 INFO - Writing to file /builds/slave/test/properties/build_url 20:57:47 INFO - Contents: 20:57:47 INFO - build_url:https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:57:48 INFO - Running post-action listener: _resource_record_post_action 20:57:48 INFO - Running post-action listener: set_extra_try_arguments 20:57:48 INFO - [mozharness: 2016-12-14 04:57:48.549584Z] Finished download-and-extract step (success) 20:57:48 INFO - [mozharness: 2016-12-14 04:57:48.549733Z] Running populate-webroot step. 20:57:48 INFO - Running pre-action listener: _resource_record_pre_action 20:57:48 INFO - Running main action method: populate_webroot 20:57:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:57:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:57:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:57:48 INFO - '--tppagecycles', 20:57:48 INFO - '7'], 20:57:48 INFO - 'tests': ['tsvgm']}}, 20:57:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:57:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:57:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:57:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:57:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:57:48 INFO - 'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:57:48 INFO - 'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['damp', 'tps']}, 20:57:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:57:48 INFO - 'tests': ['damp', 'tps']}, 20:57:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['dromaeo_dom']}, 20:57:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:57:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['basic_compositor_video']}, 20:57:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:57:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['a11yr', 20:57:48 INFO - 'ts_paint', 20:57:48 INFO - 'tpaint', 20:57:48 INFO - 'sessionrestore', 20:57:48 INFO - 'sessionrestore_no_auto_restore', 20:57:48 INFO - 'tabpaint']}, 20:57:48 INFO - 'other-e10s': {'tests': ['a11yr', 20:57:48 INFO - 'ts_paint', 20:57:48 INFO - 'tpaint', 20:57:48 INFO - 'sessionrestore', 20:57:48 INFO - 'sessionrestore_no_auto_restore', 20:57:48 INFO - 'tabpaint']}, 20:57:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:57:48 INFO - 'ts_paint', 20:57:48 INFO - 'tpaint', 20:57:48 INFO - 'sessionrestore', 20:57:48 INFO - 'sessionrestore_no_auto_restore', 20:57:48 INFO - 'tabpaint']}, 20:57:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:57:48 INFO - 'ts_paint', 20:57:48 INFO - 'tpaint', 20:57:48 INFO - 'sessionrestore', 20:57:48 INFO - 'sessionrestore_no_auto_restore', 20:57:48 INFO - 'tabpaint']}, 20:57:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['a11yr', 20:57:48 INFO - 'ts_paint', 20:57:48 INFO - 'tpaint', 20:57:48 INFO - 'sessionrestore', 20:57:48 INFO - 'sessionrestore_no_auto_restore', 20:57:48 INFO - 'tabpaint']}, 20:57:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['a11yr', 20:57:48 INFO - 'ts_paint', 20:57:48 INFO - 'tpaint', 20:57:48 INFO - 'sessionrestore', 20:57:48 INFO - 'sessionrestore_no_auto_restore', 20:57:48 INFO - 'tabpaint']}, 20:57:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['tsvgx', 20:57:48 INFO - 'tsvgr_opacity', 20:57:48 INFO - 'tart', 20:57:48 INFO - 'tscrollx', 20:57:48 INFO - 'cart', 20:57:48 INFO - 'tsvg_static']}, 20:57:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:57:48 INFO - 'tsvgr_opacity', 20:57:48 INFO - 'tart', 20:57:48 INFO - 'tscrollx', 20:57:48 INFO - 'cart', 20:57:48 INFO - 'tsvg_static']}, 20:57:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:57:48 INFO - 'talos_options': ['--disable-e10s'], 20:57:48 INFO - 'tests': ['tp5o']}, 20:57:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:57:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:57:48 INFO - 'talos_options': ['--disable-e10s', 20:57:48 INFO - '--xperf_path', 20:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:48 INFO - 'tests': ['tp5n']}, 20:57:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:57:48 INFO - 'talos_options': ['--xperf_path', 20:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:48 INFO - 'tests': ['tp5n']}}, 20:57:48 INFO - 'talos.zip': {'path': '', 20:57:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:57:48 INFO - Running post-action listener: _resource_record_post_action 20:57:48 INFO - [mozharness: 2016-12-14 04:57:48.568484Z] Finished populate-webroot step (success) 20:57:48 INFO - [mozharness: 2016-12-14 04:57:48.568587Z] Running create-virtualenv step. 20:57:48 INFO - Running pre-action listener: _resource_record_pre_action 20:57:48 INFO - Running main action method: create_virtualenv 20:57:48 INFO - Creating virtualenv /builds/slave/test/build/venv 20:57:48 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 20:57:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:57:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:57:48 INFO - Using real prefix '/tools/python27' 20:57:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:57:49 INFO - Installing distribute.............................................................................................................................................................................................done. 20:57:52 INFO - Installing pip.................done. 20:57:52 INFO - Return code: 0 20:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:57:52 INFO - Reading from file tmpfile_stdout 20:57:52 INFO - Output received: 20:57:52 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) 20:57:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:52 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:57:52 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 20:57:52 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 20:57:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:57:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:57:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:57:52 INFO - 'HOME': '/Users/cltbld', 20:57:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:57:52 INFO - 'LOGNAME': 'cltbld', 20:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:52 INFO - 'MOZ_NO_REMOTE': '1', 20:57:52 INFO - 'NO_EM_RESTART': '1', 20:57:52 INFO - 'PAGER': '/bin/cat', 20:57:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:52 INFO - 'PWD': '/builds/slave/test', 20:57:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:57:52 INFO - 'SHELL': '/bin/bash', 20:57:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:57:52 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:57:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:57:52 INFO - 'USER': 'cltbld', 20:57:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:57:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:52 INFO - 'XPC_FLAGS': '0x0', 20:57:52 INFO - 'XPC_SERVICE_NAME': '0', 20:57:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:52 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 20:57:52 INFO - Cleaning up... 20:57:52 INFO - Return code: 0 20:57:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:52 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:57:52 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 20:57:52 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 20:57:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:57:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:57:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:57:52 INFO - 'HOME': '/Users/cltbld', 20:57:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:57:52 INFO - 'LOGNAME': 'cltbld', 20:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:52 INFO - 'MOZ_NO_REMOTE': '1', 20:57:52 INFO - 'NO_EM_RESTART': '1', 20:57:52 INFO - 'PAGER': '/bin/cat', 20:57:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:52 INFO - 'PWD': '/builds/slave/test', 20:57:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:57:52 INFO - 'SHELL': '/bin/bash', 20:57:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:57:52 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:57:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:57:52 INFO - 'USER': 'cltbld', 20:57:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:57:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:52 INFO - 'XPC_FLAGS': '0x0', 20:57:52 INFO - 'XPC_SERVICE_NAME': '0', 20:57:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:53 INFO - Downloading/unpacking psutil>=3.1.1 20:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:57:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:56 INFO - Installing collected packages: psutil 20:57:56 INFO - Running setup.py install for psutil 20:57:56 INFO - building 'psutil._psutil_osx' extension 20:57:56 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 20:57:57 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 20:57:57 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 20:57:57 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 20:57:57 INFO - building 'psutil._psutil_posix' extension 20:57:57 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 20:57:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:57:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:57:57 INFO - ^ 20:57:57 INFO - 1 warning generated. 20:57:57 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 20:57:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:57 INFO - Successfully installed psutil 20:57:57 INFO - Cleaning up... 20:57:57 INFO - Return code: 0 20:57:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:57 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:57:57 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 20:57:57 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 20:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:57:57 INFO - 'HOME': '/Users/cltbld', 20:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:57:57 INFO - 'LOGNAME': 'cltbld', 20:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:57 INFO - 'MOZ_NO_REMOTE': '1', 20:57:57 INFO - 'NO_EM_RESTART': '1', 20:57:57 INFO - 'PAGER': '/bin/cat', 20:57:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:57 INFO - 'PWD': '/builds/slave/test', 20:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:57:57 INFO - 'SHELL': '/bin/bash', 20:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:57:57 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:57:57 INFO - 'USER': 'cltbld', 20:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:57 INFO - 'XPC_FLAGS': '0x0', 20:57:57 INFO - 'XPC_SERVICE_NAME': '0', 20:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:58:00 INFO - Installing collected packages: mozsystemmonitor 20:58:00 INFO - Running setup.py install for mozsystemmonitor 20:58:00 INFO - Successfully installed mozsystemmonitor 20:58:00 INFO - Cleaning up... 20:58:00 INFO - Return code: 0 20:58:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:00 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:58:00 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 20:58:00 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 20:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:00 INFO - 'HOME': '/Users/cltbld', 20:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:00 INFO - 'LOGNAME': 'cltbld', 20:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:00 INFO - 'MOZ_NO_REMOTE': '1', 20:58:00 INFO - 'NO_EM_RESTART': '1', 20:58:00 INFO - 'PAGER': '/bin/cat', 20:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:00 INFO - 'PWD': '/builds/slave/test', 20:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:00 INFO - 'SHELL': '/bin/bash', 20:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:58:00 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:00 INFO - 'USER': 'cltbld', 20:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:00 INFO - 'XPC_FLAGS': '0x0', 20:58:01 INFO - 'XPC_SERVICE_NAME': '0', 20:58:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:01 INFO - Downloading/unpacking jsonschema==2.5.1 20:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:58:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:58:03 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 20:58:03 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 20:58:03 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 20:58:03 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 20:58:03 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 20:58:03 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 20:58:04 INFO - Downloading functools32-3.2.3-2.tar.gz 20:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:58:04 INFO - warning: no files found matching '*.txt' 20:58:04 INFO - no previously-included directories found matching 'build' 20:58:04 INFO - no previously-included directories found matching 'dist' 20:58:04 INFO - no previously-included directories found matching '.git*' 20:58:04 INFO - Installing collected packages: jsonschema, functools32 20:58:04 INFO - Running setup.py install for functools32 20:58:04 INFO - warning: no files found matching '*.txt' 20:58:04 INFO - no previously-included directories found matching 'build' 20:58:04 INFO - no previously-included directories found matching 'dist' 20:58:04 INFO - no previously-included directories found matching '.git*' 20:58:04 INFO - Successfully installed jsonschema functools32 20:58:04 INFO - Cleaning up... 20:58:04 INFO - Return code: 0 20:58:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:58:04 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')]} 20:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:04 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')]} 20:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:04 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:58:04 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 20:58:04 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 20:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:04 INFO - 'HOME': '/Users/cltbld', 20:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:04 INFO - 'LOGNAME': 'cltbld', 20:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:04 INFO - 'MOZ_NO_REMOTE': '1', 20:58:04 INFO - 'NO_EM_RESTART': '1', 20:58:04 INFO - 'PAGER': '/bin/cat', 20:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:04 INFO - 'PWD': '/builds/slave/test', 20:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:04 INFO - 'SHELL': '/bin/bash', 20:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:58:04 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:04 INFO - 'USER': 'cltbld', 20:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:04 INFO - 'XPC_FLAGS': '0x0', 20:58:04 INFO - 'XPC_SERVICE_NAME': '0', 20:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:58:04 INFO - Cleaning up... 20:58:04 INFO - Return code: 0 20:58:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:58:04 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')]} 20:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:04 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')]} 20:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:04 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:58:04 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 20:58:04 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 20:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:04 INFO - 'HOME': '/Users/cltbld', 20:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:04 INFO - 'LOGNAME': 'cltbld', 20:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:04 INFO - 'MOZ_NO_REMOTE': '1', 20:58:04 INFO - 'NO_EM_RESTART': '1', 20:58:04 INFO - 'PAGER': '/bin/cat', 20:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:04 INFO - 'PWD': '/builds/slave/test', 20:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:04 INFO - 'SHELL': '/bin/bash', 20:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:58:04 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:04 INFO - 'USER': 'cltbld', 20:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:04 INFO - 'XPC_FLAGS': '0x0', 20:58:04 INFO - 'XPC_SERVICE_NAME': '0', 20:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:05 INFO - Downloading/unpacking blobuploader==1.2.4 20:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:07 INFO - Downloading blobuploader-1.2.4.tar.gz 20:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:58:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:58:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:08 INFO - Downloading docopt-0.6.1.tar.gz 20:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:58:08 INFO - Installing collected packages: blobuploader, requests, docopt 20:58:08 INFO - Running setup.py install for blobuploader 20:58:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:58:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:58:09 INFO - Running setup.py install for requests 20:58:09 INFO - Running setup.py install for docopt 20:58:09 INFO - Successfully installed blobuploader requests docopt 20:58:09 INFO - Cleaning up... 20:58:09 INFO - Return code: 0 20:58:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:58:09 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')]} 20:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:09 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')]} 20:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:09 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:58:09 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 20:58:09 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 20:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:09 INFO - 'HOME': '/Users/cltbld', 20:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:09 INFO - 'LOGNAME': 'cltbld', 20:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:09 INFO - 'MOZ_NO_REMOTE': '1', 20:58:09 INFO - 'NO_EM_RESTART': '1', 20:58:09 INFO - 'PAGER': '/bin/cat', 20:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:09 INFO - 'PWD': '/builds/slave/test', 20:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:09 INFO - 'SHELL': '/bin/bash', 20:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:58:09 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:09 INFO - 'USER': 'cltbld', 20:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:09 INFO - 'XPC_FLAGS': '0x0', 20:58:09 INFO - 'XPC_SERVICE_NAME': '0', 20:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:58:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-xFcO_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:58:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-uBB7sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:58:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-meeU1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:58:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-5_TTxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:58:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-oLRMm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:58:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-zwNmsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:58:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-9urTN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:58:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-YeEAhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:58:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-wtopqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:58:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-jRXC3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:58:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-YnZcNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:58:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-6L4fog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:58:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-5JTAhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:58:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-sYHHam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:58:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-uCy44v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:58:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-vW6eZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:58:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-msjAWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:58:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:58:11 INFO - Running setup.py install for manifestparser 20:58:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:58:11 INFO - Running setup.py install for mozcrash 20:58:12 INFO - Running setup.py install for mozdebug 20:58:12 INFO - Running setup.py install for mozdevice 20:58:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:58:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:58:12 INFO - Running setup.py install for mozfile 20:58:12 INFO - Running setup.py install for mozhttpd 20:58:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:58:12 INFO - Running setup.py install for mozinfo 20:58:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:58:12 INFO - Running setup.py install for mozInstall 20:58:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:58:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:58:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:58:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:58:12 INFO - Running setup.py install for mozleak 20:58:13 INFO - Running setup.py install for mozlog 20:58:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:58:13 INFO - Running setup.py install for moznetwork 20:58:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:58:13 INFO - Running setup.py install for mozprocess 20:58:13 INFO - Running setup.py install for mozprofile 20:58:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:58:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:58:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:58:13 INFO - Running setup.py install for mozrunner 20:58:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:58:13 INFO - Running setup.py install for mozscreenshot 20:58:14 INFO - Running setup.py install for moztest 20:58:14 INFO - Running setup.py install for mozversion 20:58:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:58:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:58:14 INFO - Cleaning up... 20:58:14 INFO - Return code: 0 20:58:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:14 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:58:14 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 20:58:14 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 20:58:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:58:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:14 INFO - 'HOME': '/Users/cltbld', 20:58:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:14 INFO - 'LOGNAME': 'cltbld', 20:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:14 INFO - 'MOZ_NO_REMOTE': '1', 20:58:14 INFO - 'NO_EM_RESTART': '1', 20:58:14 INFO - 'PAGER': '/bin/cat', 20:58:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:14 INFO - 'PWD': '/builds/slave/test', 20:58:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:14 INFO - 'SHELL': '/bin/bash', 20:58:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:58:14 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:58:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:14 INFO - 'USER': 'cltbld', 20:58:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:14 INFO - 'XPC_FLAGS': '0x0', 20:58:14 INFO - 'XPC_SERVICE_NAME': '0', 20:58:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:58:14 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-R8_gxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:58:14 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)) 20:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:58:14 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-7EksmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:58:14 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)) 20:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:58:14 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-zcRLYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:58:14 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)) 20:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-3rWQAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:58:15 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)) 20:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-YLfB1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:58:15 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)) 20:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-16LIqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:58:15 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)) 20:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-urvk35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:58:15 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)) 20:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-lqxIl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:58:15 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)) 20:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-OPFtj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:58:15 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)) 20:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-iQxdXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:58:15 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)) 20:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-U_T1xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:58:15 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)) 20:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Ko8RrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:58:15 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)) 20:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:58:15 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-IVkDwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:58:16 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)) 20:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:58:16 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-vU7CBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:58:16 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)) 20:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:58:16 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-WOcDQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:58:16 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)) 20:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:58:16 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-sQvEpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:58:16 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)) 20:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:58:16 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Xk6DQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:58:16 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)) 20:58:16 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)) 20:58:16 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)) 20:58:16 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)) 20:58:16 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)) 20:58:16 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)) 20:58:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:19 INFO - Downloading blessings-1.6.tar.gz 20:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:58:19 INFO - Installing collected packages: blessings 20:58:19 INFO - Running setup.py install for blessings 20:58:19 INFO - Successfully installed blessings 20:58:19 INFO - Cleaning up... 20:58:19 INFO - Return code: 0 20:58:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:58:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:58:19 INFO - Reading from file tmpfile_stdout 20:58:19 INFO - Current package versions: 20:58:19 INFO - blessings == 1.6 20:58:19 INFO - blobuploader == 1.2.4 20:58:19 INFO - docopt == 0.6.1 20:58:19 INFO - functools32 == 3.2.3-2 20:58:19 INFO - jsonschema == 2.5.1 20:58:19 INFO - manifestparser == 1.1 20:58:19 INFO - mozInstall == 1.12 20:58:19 INFO - mozcrash == 1.0 20:58:19 INFO - mozdebug == 0.1 20:58:19 INFO - mozdevice == 0.49 20:58:19 INFO - mozfile == 1.2 20:58:19 INFO - mozhttpd == 0.7 20:58:19 INFO - mozinfo == 0.9 20:58:19 INFO - mozleak == 0.1 20:58:19 INFO - mozlog == 3.4 20:58:19 INFO - moznetwork == 0.27 20:58:19 INFO - mozprocess == 0.23 20:58:19 INFO - mozprofile == 0.28 20:58:19 INFO - mozrunner == 6.13 20:58:19 INFO - mozscreenshot == 0.1 20:58:19 INFO - mozsystemmonitor == 0.3 20:58:19 INFO - moztest == 0.7 20:58:19 INFO - mozversion == 1.4 20:58:19 INFO - psutil == 3.1.1 20:58:19 INFO - requests == 1.2.3 20:58:19 INFO - wsgiref == 0.1.2 20:58:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:58: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')]} 20:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58: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')]} 20:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:19 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:58:19 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 20:58:19 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 20:58:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:58:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:19 INFO - 'HOME': '/Users/cltbld', 20:58:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:19 INFO - 'LOGNAME': 'cltbld', 20:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:19 INFO - 'MOZ_NO_REMOTE': '1', 20:58:19 INFO - 'NO_EM_RESTART': '1', 20:58:19 INFO - 'PAGER': '/bin/cat', 20:58:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:19 INFO - 'PWD': '/builds/slave/test', 20:58:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:19 INFO - 'SHELL': '/bin/bash', 20:58:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:58:19 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:58:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:19 INFO - 'USER': 'cltbld', 20:58:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:19 INFO - 'XPC_FLAGS': '0x0', 20:58:19 INFO - 'XPC_SERVICE_NAME': '0', 20:58:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:19 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)) 20:58:19 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)) 20:58:19 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)) 20:58:19 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)) 20:58:19 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)) 20:58:19 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)) 20:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:58:20 INFO - Cleaning up... 20:58:20 INFO - Return code: 0 20:58:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:21 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 0x10c3323f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b98de5f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, '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.MLqWSI39Df/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.XapkJcJcIV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:58:21 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 20:58:21 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 20:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:21 INFO - 'HOME': '/Users/cltbld', 20:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:21 INFO - 'LOGNAME': 'cltbld', 20:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:21 INFO - 'MOZ_NO_REMOTE': '1', 20:58:21 INFO - 'NO_EM_RESTART': '1', 20:58:21 INFO - 'PAGER': '/bin/cat', 20:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:21 INFO - 'PWD': '/builds/slave/test', 20:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:21 INFO - 'SHELL': '/bin/bash', 20:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:58:21 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:21 INFO - 'USER': 'cltbld', 20:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:21 INFO - 'XPC_FLAGS': '0x0', 20:58:21 INFO - 'XPC_SERVICE_NAME': '0', 20:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:58:21 INFO - Cleaning up... 20:58:21 INFO - Return code: 0 20:58:21 INFO - Running post-action listener: _resource_record_post_action 20:58:21 INFO - Running post-action listener: _start_resource_monitoring 20:58:21 INFO - Starting resource monitoring. 20:58:21 INFO - [mozharness: 2016-12-14 04:58:21.452157Z] Finished create-virtualenv step (success) 20:58:21 INFO - [mozharness: 2016-12-14 04:58:21.453142Z] Running install step. 20:58:21 INFO - Running pre-action listener: _resource_record_pre_action 20:58:21 INFO - Running main action method: install 20:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:58:21 INFO - Reading from file tmpfile_stdout 20:58:21 INFO - Detecting whether we're running mozinstall >=1.0... 20:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:58:21 INFO - Reading from file tmpfile_stdout 20:58:21 INFO - Output received: 20:58:21 INFO - Usage: mozinstall [options] installer 20:58:21 INFO - Options: 20:58:21 INFO - -h, --help show this help message and exit 20:58:21 INFO - -d DEST, --destination=DEST 20:58:21 INFO - Directory to install application into. [default: 20:58:21 INFO - "/builds/slave/test"] 20:58:21 INFO - --app=APP Application being installed. [default: firefox] 20:58:21 INFO - mkdir: /builds/slave/test/build/application 20:58:21 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'] 20:58:21 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 20:58:44 INFO - Reading from file tmpfile_stdout 20:58:44 INFO - Output received: 20:58:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:58:44 INFO - Running post-action listener: _resource_record_post_action 20:58:44 INFO - [mozharness: 2016-12-14 04:58:44.099076Z] Finished install step (success) 20:58:44 INFO - [mozharness: 2016-12-14 04:58:44.099206Z] Running run-tests step. 20:58:44 INFO - Running pre-action listener: _resource_record_pre_action 20:58:44 INFO - Running main action method: run_tests 20:58:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:58:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:58:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:58:44 INFO - 2016-12-13 20:58:44.113 screenresolution[1622:7232] starting screenresolution argv=screenresolution get 20:58:44 INFO - 2016-12-13 20:58:44.116 screenresolution[1622:7232] Display 0: 1600x1200x32@60 20:58:44 INFO - 2016-12-13 20:58:44.122 screenresolution[1623:7235] starting screenresolution argv=screenresolution list 20:58:44 INFO - Available Modes on Display 0 20:58:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:58:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:58:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:58:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:58:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:58:44 INFO - Intel Iris: 20:58:44 INFO - Chipset Model: Intel Iris 20:58:44 INFO - Type: GPU 20:58:44 INFO - Bus: Built-In 20:58:44 INFO - VRAM (Dynamic, Max): 1536 MB 20:58:44 INFO - Vendor: Intel (0x8086) 20:58:44 INFO - Device ID: 0x0a2e 20:58:44 INFO - Revision ID: 0x0009 20:58:44 INFO - Displays: 20:58:44 INFO - Display: 20:58:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:58:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:58:44 INFO - Display Serial Number: 1600x1200 60 20:58:44 INFO - Main Display: Yes 20:58:44 INFO - Mirror: Off 20:58:44 INFO - Online: Yes 20:58:44 INFO - Rotation: Supported 20:58:44 INFO - Return code: 0 20:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:58:44 INFO - Python 2.7.3 20:58:44 INFO - Return code: 0 20:58:44 INFO - grabbing minidump binary from tooltool 20:58:44 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')]} 20:58:44 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 0x10c147d30>, '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 0x10bfaedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c13fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:58:44 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 20:58:44 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 20:58:44 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 20:58:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:58:44 INFO - Return code: 0 20:58:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:58:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:58:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:58:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:58:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:58:44 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 20:58:44 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --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 20:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MLqWSI39Df/Render', 20:58:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:44 INFO - 'HOME': '/Users/cltbld', 20:58:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:44 INFO - 'LOGNAME': 'cltbld', 20:58:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:58:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:44 INFO - 'MOZ_NO_REMOTE': '1', 20:58:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:58:44 INFO - 'NO_EM_RESTART': '1', 20:58:44 INFO - 'PAGER': '/bin/cat', 20:58:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:44 INFO - 'PWD': '/builds/slave/test', 20:58:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:58:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:44 INFO - 'SHELL': '/bin/bash', 20:58:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XapkJcJcIV/Listeners', 20:58:44 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:58:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:44 INFO - 'USER': 'cltbld', 20:58:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:44 INFO - 'XPC_FLAGS': '0x0', 20:58:44 INFO - 'XPC_SERVICE_NAME': '0', 20:58:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:44 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 20:58:44 INFO - mozversion application_buildid: 20161213192606 20:58:44 INFO - mozversion application_changeset: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e 20:58:44 INFO - mozversion application_display_name: Nightly 20:58:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:58:44 INFO - mozversion application_name: Firefox 20:58:44 INFO - mozversion application_remotingname: firefox 20:58:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:58:44 INFO - mozversion application_vendor: Mozilla 20:58:44 INFO - mozversion application_version: 53.0a1 20:58:44 INFO - mozversion platform_buildid: 20161213192606 20:58:44 INFO - mozversion platform_changeset: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e 20:58:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:58:44 INFO - mozversion platform_version: 53.0a1 20:58:44 INFO - using testdate: 1481691524 20:58:44 INFO - actual date: 1481691524 20:58:44 INFO - starting webserver on 'localhost:49236' 20:58:44 INFO - SUITE-START | Running 2 tests 20:58:44 INFO - TEST-START | dromaeo_css 20:58:44 INFO - operating with platform_type : mac_ 20:58:44 INFO - Initialising browser for dromaeo_css test... 20:58:44 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpJ9Nzdk/profile http://localhost:49236/getInfo.html) 20:58:47 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 20:58:47 INFO - PROCESS | 1633 | colorDepth:24 20:58:47 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 20:58:47 INFO - PROCESS | 1633 | __metrics 20:58:47 INFO - PROCESS | 1633 | 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" 20:58:47 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:58:47 INFO - TEST-INFO | 1633: exit 0 20:58:47 INFO - Browser initialized. 20:58:47 INFO - Running cycle 1/1 for dromaeo_css test... 20:58:47 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpJ9Nzdk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:58:59 INFO - PROCESS | 1635 | RSS: Main: 237326336 20:58:59 INFO - PROCESS | 1635 | 20:59:50 INFO - PROCESS | 1635 | 1481691590799 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] 21:02:03 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 21:02:05 INFO - PROCESS | 1635 | RSS: Main: 448270336 21:02:05 INFO - PROCESS | 1635 | 21:05:09 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 21:05:09 INFO - PROCESS | 1635 | RSS: Main: 373673984 21:05:09 INFO - PROCESS | 1635 | 21:08:11 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 21:08:12 INFO - PROCESS | 1635 | RSS: Main: 350629888 21:08:12 INFO - PROCESS | 1635 | 21:11:15 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 21:11:15 INFO - PROCESS | 1635 | RSS: Main: 335826944 21:11:15 INFO - PROCESS | 1635 | 21:14:19 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 21:14:19 INFO - PROCESS | 1635 | RSS: Main: 337563648 21:14:19 INFO - PROCESS | 1635 | 21:17:23 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 21:17:23 INFO - PROCESS | 1635 | RSS: Main: 455131136 21:17:23 INFO - PROCESS | 1635 | 21:17:23 INFO - PROCESS | 1635 | __start_tp_report 21:17:23 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 21:17:23 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 21:17:23 INFO - PROCESS | 1635 | |i|pagename|runs| 21:17:23 INFO - PROCESS | 1635 | |0;dojo.html;3331.883384081557;3335.7998520088813;3350.43042682744;3375.966240337599;3391.6608339166087;5548.361938377087;5605.803796867105;5642.956053130174;5648.463395977381;5660.094384898412;5374.220737992999;5603.103503439451;5614.494695477406;5649.548036157108;5668.773249070032;4057.472528571296;5058.671186372892;5161.974190129063;5187;5187.273781670569;4949.109160351135;5021.297018417425;5058.064258112261;5069.442361340268;5096.847094587169;5056;5061;5079.492050794928;5082.390113186423;5118.360204974379;5103.872403189913;5109.616778741609;5125.487451254845;5150.124478838607;5181.948180518184;5161.148410512261;5161.922571161435;5180.352455943007;5206.739663016834;5228.529432351069;5616.606837521375;5634.6337488063145;5647.407022262644;5668.773249070032;5689.175069614883;6015.218021657201;6081.756729730805;6183.258009038899;6197.0704394340755;6202;6147.862645410569;6154.661493617849;6168.352323006065;6212.813615591494;6258.843528911813;5752.568557358131;5757.740901659436;5768.913466298009;5771.192033115367;5813.854653633693;6251.812445626639;6290.119383286344;6314.873702525923;6337.556371053982;6343.143675603735;5898.351181370046;5916.497097746654;5934.9406505934385;5940.287165540163;5987.072003839412;6120.182659316514;6121.005657821351;6124.666108519761;6124.869201255686;6143.96928015357;6062.42406971337;6062.605930614496;6064.181335519736;6064.696765161724;6084.787032453843;6022.879542409128;6093.11649810775;6097.3292937776805;6099.176611157525;6145.248604147797;4911.435184953704;4917.311576379309;4921.188003979303;4922.532359425849;4950.381202349707;4320.200762858818;4321.135772845443;4422.933655995163;4423.4912985006495;4454.265046267395;5614.719264036782;5643.238162848045;5667.4332566743;5762.654240745569;5781.82654520365;6171.59884607499;6179.042248451407;6182.258129024546;6234.407731265614;6266.467350275187;5765.769369225184;5782.6819524925695;5787.247657804459;5789.623674461147;5805.36141024487;5236.345456817898;5297.708626025606;5331.946680533145;5332.68003919766;5333.973330133324;6254.468370188585;6257;6297.52768542352;6300.432961033345;6321.841953951188;6233.158523599256;6236.6258024518675;6242.781502647385;6259.874802504016;6262.34245404226;6252.812415627538;6278.717457714505;6291.056341548804;6315.5894866833505;6318.4313411793155;4948.505149485023;6023.939760602338;6096.664683442454;6110;6115.4190351916495;6214.285357183981;6231.844203894758;6236.126942228001;6243.37566243372;6253.530985176221;5992.221011268507;6041.154238406714;6044.607100538627;6058.818235452944;6070.332263450929;5841.299044114733;5909.143174239625;5919.260092488439;5934.258217722785;6048.092786082123;5643;5806.593538452268;5812.011957967071;5818.0981947798155;5820.4761571457075;5843.561732869966;5848.736806843617;5851.795187168599;5854;5854.209681692917;5746.827595172152;5788.652680839163;5796.449337312949;5799.942000580109;5800.76796928135 21:17:23 INFO - PROCESS | 1635 | |1;ext.html;468.6508551129409;486.5110563883298;490.72028943502215;506.04610309566453;565.8189379398594;37414.43878341827;39273.410898836504;39327;39467;39479;39418.60581394185;39827.805165845;39908.20183596334;39929.8003509982;40078.39882401766;8415.45299555527;9330.626774928995;9535.189508891752;9539.80920381592;9540.141387275144;8471.576421178946;9925.75928008999;11327.376994265313;11384.430778461085;11394.373309467976;11061.944690276538;11389.829152562717;11395.259308144985;11397.145214108976;11476.426178691074;8462.703805366844;8691.08743581921;11263.15526335524;11278.210525263194;11339.036181924464;10946.616868409646;11173.776524469466;11209.943950280278;11228.943855280671;11421.486033128529;37759.62240377589;37764.62235377639;38372;38398.27207775657;38611.613883861086;2982.612260406155;3367.175042114673;3391.8304084795664;3468.3756923753713;3657.1588534636917;22758.886205568866;29381.853090734625;30035.549466758017;30097.247568810737;30139;3168;3181.427343078245;3249.3014001989686;3285.950710739341;3287.819169945652;395483;396200;398108;398313.0084349589;399089;57148.42851571514;57485.712571436874;57502.424975750546;57574.7121264391;57749.42250577525;59609;59766.70116649389;59902.70048649816;59921.70039149776;59961;15216.315265813066;15517;15525.844741552666;15528.301226444837;15530.990485618398;11001.6149434771;11290.774184516264;11312.321260724382;12057.879421205851;12213.267203967791;12815.231086134861;15315;15586.19448499281;15657.37370505167;15983.36066557348;6501.447376972916;6557.475401967831;6633.966830165915;6722.764703235363;6738.35985581369;882.642529775442;940.6942743608355;968.5060619084318;969.3602222533094;1059.0256963593513;27869.860650696617;28760.712392876223;28853.990110346036;29688.554671679944;29785.255368615526;1012.2307046644603;1070.71626019105;1101.3171833463143;1162.2910024884814;1172.935488548121;14587.781183282259;15003.624909377353;15038.699226015637;15241.618959525878;15362.383835363835;512331.19172020996;514362;515404;516340;516734;55443.44556554383;55619.721901390236;55662.09406495022;55813;56134.15798763022;1341.7383610196114;1379.5033787836371;1392.5822253324166;1394.672252020754;1395.1768456610648;23457.765422345557;28238.85880570584;28414.573781392883;28871.42257154803;29083.854580726962;47205;47817.52182478131;47949;47954;47956.280655789495;379546;455111;456431;457302.7134864304;458155;37311.81344093262;37728.43407348947;37750;38018.61981380151;38072.80963595164;38736.22527549489;39840.60159398369;44782.3282650767;44876.55123448724;44960.10079798451;33857;34185.82907085449;34251.14372140716;34965.650343497255;35053.47419788654;33937.66062339444;33987;34697;34848.9545313641;35050.474242886885;33146.5028024575;33820.492692610125;34177.31645367129;34273.65726342705;34470.82764586261;30126.84936575303;30160;30264.368275807043;30651.2337191572;30705.692943070284;18993.810061899203;23248.083373263515;23369;23405.680466274353;23543.41141471477 21:17:23 INFO - PROCESS | 1635 | |2;jquery.html;345.9273552553964;364.6954792748055;366.2820871092659;377.31140668280386;388.45422181834516;13977.930110349447;14431.783523247146;15443.691126177484;17004;19706.014699265015;18727.15727792249;19424.902875485604;19805.504862378413;20107.497312567193;20123;5519.972400137994;5738.684372359518;5739;5745.138229265623;5749.885002299951;5500.1749737539485;5637.943620563783;5689.6017278790505;5711.628744131618;5737.196792449061;5695.288088988877;5698.287714035746;5704.48659620634;5704.857378565548;5711.8572035699235;5505.862353441176;5653.123765816305;5690.573207009491;5755.366909639936;5763.049096899049;5049.924251136236;5053.84838454847;5054.646174767768;5062.341895553592;5073.898522029575;22410.43973900649;22604;23582.882085589634;23651.645225321634;23824.16615418452;2233.140241007208;2348.8825558722165;2507.247825652297;2525.8231923765343;2885.2209903326193;9666.275029372826;9907.702768916944;10184.898151018544;10281.331713438603;10544.472776361228;1805.1786437171056;1824.2520566567644;1876.502726777405;1888.8488920886296;1996.9101390437465;102711.48644256806;109340;110372.9999999992;112676.74646507106;116090;11368.488418021208;11396.14528910335;11506.59726909571;11563.537458501734;11729.765404692029;12716.427760750788;14055.594440555862;14607.19660418687;14639.92680036593;14655.853441465662;7895.092064412666;8220.753377398687;8329.458585191944;8348.415610907177;8543.444676096158;8136.471129376571;8137.633806478722;8163.877541836877;8304.70933517324;8356.749297521084;4464.575865292792;4527.796249168795;4532.524084971096;4592.173408786451;4678.017616300547;1606.5501659535114;1876.6246750649925;1932.478230877655;1941.6019715958478;1943.8444924406015;817.2195553246754;853.6884037326455;884.633605106338;911.1753862754218;922.1331947968888;19923.900380498006;20630.690539641917;20764.328026193987;21092.578148437253;21119.366419007456;954.1174413667469;957.9952100239454;964.5273815830333;987.1066684650403;1003.6336737090909;10695.465226738632;11019.787823339426;11033.724156895982;11052.115830733523;11066.778664426827;560306;561247;564184;588326;592136;121768;123293.43772185053;125131.37434312953;125733.74266257403;128267;988.8615593816871;1012.7366884610054;1017.2574020964737;1025.2976710953021;1049.9895001050045;18140.637187256445;18411.723824142915;18647.347342842935;18707.532311692317;19048.714269285694;47590.524094759996;48998.51001490082;52166;52174.73912630413;52619;71270;72094.63952680203;72347.55304893978;73021.6348918252;73884.26115738989;5979.701014949323;7251.854962900818;7666.926630271878;7961.681532738626;7982.640781164745;11949;12152.57465988686;12362;12375.195612285173;12486.625401237978;10263.794724105626;10475.895241047492;10782.191335650015;10801.67594972152;10867.0762985144;10219.489025548544;10254.692359229235;10413.9479302603;10553.947230263799;10705.090067344363;10408.947955260175;10478;10500.632477863239;10584.312019718695;10634;7972.242636949481;7981.754848239834;7988.320992715684;8162.306203972729;8227.506349619041;9760.46317452547;9892.950535247566;10151.593936242467;10327.173826094046;10691.465426728477 21:17:23 INFO - PROCESS | 1635 | |3;mootools.html;1351.709382482766;1471.2864260833496;1494.484402881006;1700.2094026277778;1880.6050729346837;7260.201377848439;7624.733134340299;7777.105632852231;8054.395920305971;8083.474574152676;7937;8029.799255018613;8046.396520260974;8048.597570121485;8050.557219352933;2024.2611446821952;2253.842231043832;2297.597920363938;2297.6094064009076;2300.8274379421528;2111.398251498323;2225.8330625203093;2323.5701395241936;2332.988335058331;2341.2273949596593;2254.594173048859;2294.8737819419925;2303;2303.4011157099108;2319.7796209360085;2290;2314.9652755208517;2315.490592069742;2317.2468947591933;2324.465372964219;2291.472961218929;2317.6523521471745;2319.2694301295037;2319.7564255753073;2327.5461285049423;7965.761027169194;7989.520628762293;8034.839303213961;8042.597870106471;8054.43618946674;4917.901641967141;5078.847634570969;5085.211792172219;5102.770375333082;5107.591392688576;2823.6164279502896;3236.2394837213237;3463.3939060664284;3463.757536972413;3468.9826550867338;984.4339504784778;1030.4538594544904;1057.762003549203;1059.1315121600292;1060.241927022175;10105.797884042278;10345.224108191916;10365.222608304332;10371.377717336984;10385.948070259676;4385.7149285296355;4453.933191002137;4543.636509079266;4583.816647334136;4627.814887404534;8313;8318.625661845232;8382.287505561973;8386.203310685476;8387.119352467904;4943.950560494421;4963;4965.4041515018425;4969.875753106129;4974.17926042199;4531.886702832389;4535.16099521583;4593.494715581283;4674.462436819741;4675.579197872208;3413.7781044232543;3461.7230621550216;3503.2468019375956;3532.540769699974;3536.9469457958153;1078.2991055813627;1092.7759809239087;1093.3822390349428;1104.745908441047;1105.7567335186245;798.22572105058;828.6312590897113;882.4176043811182;883.3992884838372;892.5180402582663;4261.595148460891;5184;5324.92012619811;5409.24270602116;5515.696636685021;419.79782378391906;428.2676622974686;430.28357784288806;436.67467736536486;439.3453753906656;3244.8053116812594;3572.1783989682517;3593.3711600469815;3759.323321802102;3777.981110094432;9114.40756350835;9376.95311523438;9460.716178514656;9482.620695172116;9484.430934143973;9361.719148425558;9447.952760236154;9460.959294477601;9464.810703785886;9474.810503789886;6897.41371983377;7428;7442.292982166686;7509.924900751141;7540.132884718218;5293.7353132344;5443.428440013741;5482.780688772405;5493.285872836505;5515.255440515479;8551.57242137903;8605.139486051345;8805.647774088964;8936.28509719234;8949.507777072324;6893.93106068953;8500.872486912578;8814.955925220333;8877.11228877133;9014.278857691237;6685.596024834839;6922.27316131819;6923.584584924921;6939.201991770809;6947.548409353376;7392.519486233377;7406.518576292524;7410.703571857065;7465.7013719450615;7475.401967842451;6799.830004249933;6801.897971530332;6848.3494068063455;6849.1438570178725;6860.794176174722;6623.105880706043;6701.229358623626;6721.22705888829;6757.86484270302;6770.593764374154;6270;6458.321876202931;6462.7414903405215;6482.254540727877;6486.05952136928;4522.4573051234065;4649.325847752125;4671.065786842713;4672.322513235494;4767;4559;4570.428696412949;4636.976815115903;4690.437147542317;4839.395075615548 21:17:23 INFO - PROCESS | 1635 | |4;prototype.html;348.28427581320386;353.6534196487442;359.267095125943;368.7971615611413;370.6682519145363;5110.284560161575;5157.6131790115705;5177.68933863968;5204.869878253036;5267.420583735786;4207.915841683164;5051.949480505194;5079.822206222783;5118.181091025437;5126.513970500058;3428.8797194552963;3446.3451944130534;3656.780593164412;3962.48487696599;4058.655014323786;3413.812240326781;3639.7452178347526;4039.212353591051;4101.9589804102025;4122.711410201287;3087.1939915149665;3096.179512429208;4089.8159582818844;4107.445494858201;4128.483939507561;4045.2920738870725;4094.4267802507675;4094.7133700640966;4100.958990410118;4130.463039804837;3357.865685372582;3621.5835178954494;3631.455281707739;3636.654517820803;3656.305301992613;4617.492075871685;4773.737444440554;4888.902221955541;5101.199606293335;5160.819371321985;4467.5755803198645;4681.0871879983415;4712.6229901607785;4713.740744259065;4752.4297084349755;4641.535846415331;5220.216967454874;5225.581953443715;5500.834974950758;5565.860853478695;3364.0916952422954;3497.828227543776;3588.515550400715;3880.9029774255587;4055.655269302113;4755;4893.602134953847;5436.048691478975;5726.3700992890745;5735.741891614845;3397.2865698203655;3846;3881.0685435495843;3957.9802100989887;4122.928418328364;4107.199096176277;4159.2964573027775;4162.396452514368;4167.062410957571;4196.81114349855;4012.378081397388;4445.73325600465;4682.625389968863;4755.500672429414;4768.9523104769205;5502.394736578973;5543.473370029841;5559.444055594489;5561.721913904369;5564.527015203672;1250.2935841249664;1260.8550016748009;1274.5533819115371;1320.7490576790378;1347.8719521645428;764.4801534956172;799.3205775091126;823.7487566292218;849.1678155407735;944.4239014201331;4283.807228674717;4710.528947105262;4979.431479084077;4992.126377883856;5050.080969231669;5025.74871256443;5380.354357477127;5388.5419739321815;5398.974194902956;5453.536449401845;4343.913121737548;4611.9077618447445;4727.818045488628;4751.622029611443;4857.688424125467;2574.086199399224;2612.1641074856243;2617;2801.257666718321;2804.551271796503;5161.819336323286;5369;5636.549076073904;5656.208130861683;5683.744231509592;4923.704577725276;4963.081829861487;5432.538234250133;5520.503154716095;5521.199426083195;4704.764761761899;5262.736863156751;5518.475744804237;5597.041035637494;5621.578381621313;4616.792244348945;4821.783019764049;5032.370953630796;5063.316452278895;5424.24060631504;4951.356323677899;5320.946790532045;5333.839984800462;5334.466553344634;5380.838574842761;5171.9482805172975;5588.748506317144;5591.350551587373;5632.802851900164;5657.2928383952;3855.4024126260474;3861.6524512793985;3877.3990031544026;3888.96111038886;3896.2597106549665;4989.60083193351;5683.658980461186;5714.257146570919;5749.568782341257;5807.651540907559;4654.604358629555;5547.140193270049;5584.748686309207;5621.325440947113;5676.943230567642;4747.905041899212;5202.687838729688;5551.611387202857;5559;5594.468525490072;5464.617476776588;5501.422350653123;5504.174373843955;5520.309961254843;5540.86147846291;5160.922586161136;5221.694576355911;5293.994141113176;5377.892442151213;5587.972060139673;5386.919196212139;5407.404815579335;5432.755526001419;5481.232627432083;5521.585881059017 21:17:23 INFO - PROCESS | 1635 | |5;yui.html;672.8116127484303;727.1746567645722;741.8664640364735;796.1839114907223;798.936085113191;15234.390624375026;15866.603334916634;15891.68216635668;15906.920465397672;15913.920430397831;14313.499027534039;14466.710665786677;14469.276536173202;14470.5658830235;14477.131372117654;674.8414122681166;700.3486757315694;701.7298340139032;826.8470332988386;833.0669649992002;855.4525103933488;857.1642648417806;858.3347905373323;858.9613467393982;860.3504354212561;901.2564634176798;918.9218916392115;919.3886065766291;920.1764420843341;920.2591913509622;911.0843602179833;913.6025828764509;914.7484441778497;915.0986278515657;915.2129168914761;524.590819161055;545.4436474795726;649.3441623959834;676.9221539522969;678.6776281266408;14372.712545749026;14882.958192926499;14883.255837208204;14897.478588249467;14929.552113436614;13457.259850708208;13458.52895148665;13472.25902575358;13516.729665406736;13524.729505409836;12330.013598912155;12374.81437778434;12507.3746312684;12522.81215781764;12739.681507962283;4439.822407103712;4481;4523.344115103291;4629.282461218483;4637.652176086774;108644;109565.35651965307;111285.33072003926;111816.44091779488;113023.43488282507;10694.304870183412;10950.288231264942;10998.285111467729;11048.558057677763;11264;19145.425637230906;21336.93315334227;21342.35972920815;21649.458763531038;21942.341729748132;7736.6518506667335;7831.490953088031;7893.960530197312;7999.3200577950365;8071.23323284287;4125.133721918431;4195.685323600742;4230.682698797603;4246.193223287565;4278.89302767427;3424.434968230214;3459.6540345965204;3475.3223121491574;3537.0626783902285;3544.946825797615;484.92726091085916;616.5437576193674;632.7816903168399;662.9569078010011;674.8751480976035;599.0355527600559;657.8585604095047;667.7095463473307;680.3876511140014;684.5208354152113;7726.304632583095;8587.593151060513;8754.118133744045;9091.674383365635;9170.587323570455;563.9032082599305;564.9548931260509;599.7511032921376;670.3732010570133;688.1123350877413;4197.370394440858;4482.8655140345845;4513.68404211702;4534.59188673021;4629.375034370384;107394;108021;108242;108589.45705271424;110687;75749;95089.5245523768;96369;99672;100055;84140.57929710312;85339.57330213433;85378.75791139143;86184;86733;8509.191626795444;8837;8911.232490617489;8942.776430589287;9152.816943661222;54252.457475426316;54627.180592291945;56680.71659641675;56986.7150664244;58334.12498812606;59488.70255648694;62201.066983996185;64193;67940.6602966982;73952;12588.496460141492;13130.606081817561;13211.405486753312;13421.66445838862;13461;12091.576794812492;14489;14821.184834834188;14834.629134271298;15204.771928421304;13703;13820.654483637989;13838.37727302294;13992.580222593338;14376.28118594087;11842.230255033395;12867.742645147231;13229.40467678976;13633.931830340785;14176.574702758933;13336.19982801035;13378.598642040753;13515.93242033823;13636.522721704692;14023.789643155156;10214.182865370603;10804.459777011276;11464.426778660867;11476.540938362372;11818;11297.378644174321;11301.886981130083;11480.253783504046;11537.538498459968;11558.07535397183 21:17:23 INFO - PROCESS | 1635 | __end_tp_report 21:17:23 INFO - PROCESS | 1635 | __start_cc_report 21:17:23 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,2527 21:17:23 INFO - PROCESS | 1635 | __end_cc_report 21:17:23 INFO - PROCESS | 1635 | __startTimestamp1481692643466__endTimestamp 21:17:23 INFO - PROCESS | 1635 | 21:17:23 INFO - PROCESS | 1635 | ------- Summary: start ------- 21:17:23 INFO - PROCESS | 1635 | Number of tests: 6 21:17:23 INFO - PROCESS | 1635 | 21:17:23 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5661.31 Median:5812.01 stddev:641.40 (11.0%) stddev-sans-first:616.79 21:17:23 INFO - PROCESS | 1635 | Values: 3331.9 3335.8 3350.4 3376.0 3391.7 5548.4 5605.8 5643.0 5648.5 5660.1 5374.2 5603.1 5614.5 5649.5 5668.8 4057.5 5058.7 5162.0 5187.0 5187.3 4949.1 5021.3 5058.1 5069.4 5096.8 5056.0 5061.0 5079.5 5082.4 5118.4 5103.9 5109.6 5125.5 5150.1 5181.9 5161.1 5161.9 5180.4 5206.7 5228.5 5616.6 5634.6 5647.4 5668.8 5689.2 6015.2 6081.8 6183.3 6197.1 6202.0 6147.9 6154.7 6168.4 6212.8 6258.8 5752.6 5757.7 5768.9 5771.2 5813.9 6251.8 6290.1 6314.9 6337.6 6343.1 5898.4 5916.5 5934.9 5940.3 5987.1 6120.2 6121.0 6124.7 6124.9 6144.0 6062.4 6062.6 6064.2 6064.7 6084.8 6022.9 6093.1 6097.3 6099.2 6145.2 4911.4 4917.3 4921.2 4922.5 4950.4 4320.2 4321.1 4422.9 4423.5 4454.3 5614.7 5643.2 5667.4 5762.7 5781.8 6171.6 6179.0 6182.3 6234.4 6266.5 5765.8 5782.7 5787.2 5789.6 5805.4 5236.3 5297.7 5331.9 5332.7 5334.0 6254.5 6257.0 6297.5 6300.4 6321.8 6233.2 6236.6 6242.8 6259.9 6262.3 6252.8 6278.7 6291.1 6315.6 6318.4 4948.5 6023.9 6096.7 6110.0 6115.4 6214.3 6231.8 6236.1 6243.4 6253.5 5992.2 6041.2 6044.6 6058.8 6070.3 5841.3 5909.1 5919.3 5934.3 6048.1 5643.0 5806.6 5812.0 5818.1 5820.5 5843.6 5848.7 5851.8 5854.0 5854.2 5746.8 5788.7 5796.4 5799.9 5800.8 21:17:23 INFO - PROCESS | 1635 | 21:17:23 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:59439.79 Median:19082.69 stddev:120599.32 (632.0%) stddev-sans-first:120856.35 21:17:23 INFO - PROCESS | 1635 | Values: 468.7 486.5 490.7 506.0 565.8 37414.4 39273.4 39327.0 39467.0 39479.0 39418.6 39827.8 39908.2 39929.8 40078.4 8415.5 9330.6 9535.2 9539.8 9540.1 8471.6 9925.8 11327.4 11384.4 11394.4 11061.9 11389.8 11395.3 11397.1 11476.4 8462.7 8691.1 11263.2 11278.2 11339.0 10946.6 11173.8 11209.9 11228.9 11421.5 37759.6 37764.6 38372.0 38398.3 38611.6 2982.6 3367.2 3391.8 3468.4 3657.2 22758.9 29381.9 30035.5 30097.2 30139.0 3168.0 3181.4 3249.3 3286.0 3287.8 395483.0 396200.0 398108.0 398313.0 399089.0 57148.4 57485.7 57502.4 57574.7 57749.4 59609.0 59766.7 59902.7 59921.7 59961.0 15216.3 15517.0 15525.8 15528.3 15531.0 11001.6 11290.8 11312.3 12057.9 12213.3 12815.2 15315.0 15586.2 15657.4 15983.4 6501.4 6557.5 6634.0 6722.8 6738.4 882.6 940.7 968.5 969.4 1059.0 27869.9 28760.7 28854.0 29688.6 29785.3 1012.2 1070.7 1101.3 1162.3 1172.9 14587.8 15003.6 15038.7 15241.6 15362.4 512331.2 514362.0 515404.0 516340.0 516734.0 55443.4 55619.7 55662.1 55813.0 56134.2 1341.7 1379.5 1392.6 1394.7 1395.2 23457.8 28238.9 28414.6 28871.4 29083.9 47205.0 47817.5 47949.0 47954.0 47956.3 379546.0 455111.0 456431.0 457302.7 458155.0 37311.8 37728.4 37750.0 38018.6 38072.8 38736.2 39840.6 44782.3 44876.6 44960.1 33857.0 34185.8 34251.1 34965.7 35053.5 33937.7 33987.0 34697.0 34849.0 35050.5 33146.5 33820.5 34177.3 34273.7 34470.8 30126.8 30160.0 30264.4 30651.2 30705.7 18993.8 23248.1 23369.0 23405.7 23543.4 21:17:23 INFO - PROCESS | 1635 | 21:17:23 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:33453.26 Median:23617.26 stddev:95669.15 (405.1%) stddev-sans-first:95905.23 21:17:23 INFO - PROCESS | 1635 | Values: 345.9 364.7 366.3 377.3 388.5 13977.9 14431.8 15443.7 17004.0 19706.0 18727.2 19424.9 19805.5 20107.5 20123.0 5520.0 5738.7 5739.0 5745.1 5749.9 5500.2 5637.9 5689.6 5711.6 5737.2 5695.3 5698.3 5704.5 5704.9 5711.9 5505.9 5653.1 5690.6 5755.4 5763.0 5049.9 5053.8 5054.6 5062.3 5073.9 22410.4 22604.0 23582.9 23651.6 23824.2 2233.1 2348.9 2507.2 2525.8 2885.2 9666.3 9907.7 10184.9 10281.3 10544.5 1805.2 1824.3 1876.5 1888.8 1996.9 102711.5 109340.0 110373.0 112676.7 116090.0 11368.5 11396.1 11506.6 11563.5 11729.8 12716.4 14055.6 14607.2 14639.9 14655.9 7895.1 8220.8 8329.5 8348.4 8543.4 8136.5 8137.6 8163.9 8304.7 8356.7 4464.6 4527.8 4532.5 4592.2 4678.0 1606.6 1876.6 1932.5 1941.6 1943.8 817.2 853.7 884.6 911.2 922.1 19923.9 20630.7 20764.3 21092.6 21119.4 954.1 958.0 964.5 987.1 1003.6 10695.5 11019.8 11033.7 11052.1 11066.8 560306.0 561247.0 564184.0 588326.0 592136.0 121768.0 123293.4 125131.4 125733.7 128267.0 988.9 1012.7 1017.3 1025.3 1050.0 18140.6 18411.7 18647.3 18707.5 19048.7 47590.5 48998.5 52166.0 52174.7 52619.0 71270.0 72094.6 72347.6 73021.6 73884.3 5979.7 7251.9 7666.9 7961.7 7982.6 11949.0 12152.6 12362.0 12375.2 12486.6 10263.8 10475.9 10782.2 10801.7 10867.1 10219.5 10254.7 10413.9 10553.9 10705.1 10408.9 10478.0 10500.6 10584.3 10634.0 7972.2 7981.8 7988.3 8162.3 8227.5 9760.5 9893.0 10151.6 10327.2 10691.5 21:17:23 INFO - PROCESS | 1635 | 21:17:23 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5166.20 Median:5026.51 stddev:2793.93 (55.6%) stddev-sans-first:2787.06 21:17:23 INFO - PROCESS | 1635 | Values: 1351.7 1471.3 1494.5 1700.2 1880.6 7260.2 7624.7 7777.1 8054.4 8083.5 7937.0 8029.8 8046.4 8048.6 8050.6 2024.3 2253.8 2297.6 2297.6 2300.8 2111.4 2225.8 2323.6 2333.0 2341.2 2254.6 2294.9 2303.0 2303.4 2319.8 2290.0 2315.0 2315.5 2317.2 2324.5 2291.5 2317.7 2319.3 2319.8 2327.5 7965.8 7989.5 8034.8 8042.6 8054.4 4917.9 5078.8 5085.2 5102.8 5107.6 2823.6 3236.2 3463.4 3463.8 3469.0 984.4 1030.5 1057.8 1059.1 1060.2 10105.8 10345.2 10365.2 10371.4 10385.9 4385.7 4453.9 4543.6 4583.8 4627.8 8313.0 8318.6 8382.3 8386.2 8387.1 4944.0 4963.0 4965.4 4969.9 4974.2 4531.9 4535.2 4593.5 4674.5 4675.6 3413.8 3461.7 3503.2 3532.5 3536.9 1078.3 1092.8 1093.4 1104.7 1105.8 798.2 828.6 882.4 883.4 892.5 4261.6 5184.0 5324.9 5409.2 5515.7 419.8 428.3 430.3 436.7 439.3 3244.8 3572.2 3593.4 3759.3 3778.0 9114.4 9377.0 9460.7 9482.6 9484.4 9361.7 9448.0 9461.0 9464.8 9474.8 6897.4 7428.0 7442.3 7509.9 7540.1 5293.7 5443.4 5482.8 5493.3 5515.3 8551.6 8605.1 8805.6 8936.3 8949.5 6893.9 8500.9 8815.0 8877.1 9014.3 6685.6 6922.3 6923.6 6939.2 6947.5 7392.5 7406.5 7410.7 7465.7 7475.4 6799.8 6801.9 6848.3 6849.1 6860.8 6623.1 6701.2 6721.2 6757.9 6770.6 6270.0 6458.3 6462.7 6482.3 6486.1 4522.5 4649.3 4671.1 4672.3 4767.0 4559.0 4570.4 4637.0 4690.4 4839.4 21:17:23 INFO - PROCESS | 1635 | 21:17:23 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4424.27 Median:4957.22 stddev:1333.23 (26.9%) stddev-sans-first:1301.39 21:17:23 INFO - PROCESS | 1635 | Values: 348.3 353.7 359.3 368.8 370.7 5110.3 5157.6 5177.7 5204.9 5267.4 4207.9 5051.9 5079.8 5118.2 5126.5 3428.9 3446.3 3656.8 3962.5 4058.7 3413.8 3639.7 4039.2 4102.0 4122.7 3087.2 3096.2 4089.8 4107.4 4128.5 4045.3 4094.4 4094.7 4101.0 4130.5 3357.9 3621.6 3631.5 3636.7 3656.3 4617.5 4773.7 4888.9 5101.2 5160.8 4467.6 4681.1 4712.6 4713.7 4752.4 4641.5 5220.2 5225.6 5500.8 5565.9 3364.1 3497.8 3588.5 3880.9 4055.7 4755.0 4893.6 5436.0 5726.4 5735.7 3397.3 3846.0 3881.1 3958.0 4122.9 4107.2 4159.3 4162.4 4167.1 4196.8 4012.4 4445.7 4682.6 4755.5 4769.0 5502.4 5543.5 5559.4 5561.7 5564.5 1250.3 1260.9 1274.6 1320.7 1347.9 764.5 799.3 823.7 849.2 944.4 4283.8 4710.5 4979.4 4992.1 5050.1 5025.7 5380.4 5388.5 5399.0 5453.5 4343.9 4611.9 4727.8 4751.6 4857.7 2574.1 2612.2 2617.0 2801.3 2804.6 5161.8 5369.0 5636.5 5656.2 5683.7 4923.7 4963.1 5432.5 5520.5 5521.2 4704.8 5262.7 5518.5 5597.0 5621.6 4616.8 4821.8 5032.4 5063.3 5424.2 4951.4 5320.9 5333.8 5334.5 5380.8 5171.9 5588.7 5591.4 5632.8 5657.3 3855.4 3861.7 3877.4 3889.0 3896.3 4989.6 5683.7 5714.3 5749.6 5807.7 4654.6 5547.1 5584.7 5621.3 5676.9 4747.9 5202.7 5551.6 5559.0 5594.5 5464.6 5501.4 5504.2 5520.3 5540.9 5160.9 5221.7 5294.0 5377.9 5588.0 5386.9 5407.4 5432.8 5481.2 5521.6 21:17:23 INFO - PROCESS | 1635 | 21:17:23 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:21187.26 Median:4262.54 stddev:31083.34 (729.2%) stddev-sans-first:31132.37 21:17:23 INFO - PROCESS | 1635 | Values: 672.8 727.2 741.9 796.2 798.9 15234.4 15866.6 15891.7 15906.9 15913.9 14313.5 14466.7 14469.3 14470.6 14477.1 674.8 700.3 701.7 826.8 833.1 855.5 857.2 858.3 859.0 860.4 901.3 918.9 919.4 920.2 920.3 911.1 913.6 914.7 915.1 915.2 524.6 545.4 649.3 676.9 678.7 14372.7 14883.0 14883.3 14897.5 14929.6 13457.3 13458.5 13472.3 13516.7 13524.7 12330.0 12374.8 12507.4 12522.8 12739.7 4439.8 4481.0 4523.3 4629.3 4637.7 108644.0 109565.4 111285.3 111816.4 113023.4 10694.3 10950.3 10998.3 11048.6 11264.0 19145.4 21336.9 21342.4 21649.5 21942.3 7736.7 7831.5 7894.0 7999.3 8071.2 4125.1 4195.7 4230.7 4246.2 4278.9 3424.4 3459.7 3475.3 3537.1 3544.9 484.9 616.5 632.8 663.0 674.9 599.0 657.9 667.7 680.4 684.5 7726.3 8587.6 8754.1 9091.7 9170.6 563.9 565.0 599.8 670.4 688.1 4197.4 4482.9 4513.7 4534.6 4629.4 107394.0 108021.0 108242.0 108589.5 110687.0 75749.0 95089.5 96369.0 99672.0 100055.0 84140.6 85339.6 85378.8 86184.0 86733.0 8509.2 8837.0 8911.2 8942.8 9152.8 54252.5 54627.2 56680.7 56986.7 58334.1 59488.7 62201.1 64193.0 67940.7 73952.0 12588.5 13130.6 13211.4 13421.7 13461.0 12091.6 14489.0 14821.2 14834.6 15204.8 13703.0 13820.7 13838.4 13992.6 14376.3 11842.2 12867.7 13229.4 13633.9 14176.6 13336.2 13378.6 13515.9 13636.5 14023.8 10214.2 10804.5 11464.4 11476.5 11818.0 11297.4 11301.9 11480.3 11537.5 11558.1 21:17:23 INFO - PROCESS | 1635 | -------- Summary: end -------- 21:17:23 INFO - PROCESS | 1635 | 21:17:24 INFO - TEST-INFO | 1635: exit 0 21:17:24 INFO - TEST-OK | dromaeo_css | took 1119419ms 21:17:24 INFO - TEST-START | kraken 21:17:24 INFO - operating with platform_type : mac_ 21:17:24 INFO - Initialising browser for kraken test... 21:17:24 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpG2AGvN/profile http://localhost:49236/getInfo.html) 21:17:26 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 21:17:26 INFO - PROCESS | 1644 | colorDepth:24 21:17:26 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 21:17:26 INFO - PROCESS | 1644 | __metrics 21:17:26 INFO - PROCESS | 1644 | 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" 21:17:26 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:17:27 INFO - TEST-INFO | 1644: exit 0 21:17:27 INFO - Browser initialized. 21:17:27 INFO - Running cycle 1/1 for kraken test... 21:17:27 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpG2AGvN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:17:39 INFO - PROCESS | 1645 | RSS: Main: 237350912 21:17:39 INFO - PROCESS | 1645 | 21:17:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 21:17:42 INFO - PROCESS | 1645 | RSS: Main: 289071104 21:17:42 INFO - PROCESS | 1645 | 21:17:45 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 21:17:46 INFO - PROCESS | 1645 | RSS: Main: 290304000 21:17:46 INFO - PROCESS | 1645 | 21:17:49 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 21:17:50 INFO - PROCESS | 1645 | RSS: Main: 384196608 21:17:50 INFO - PROCESS | 1645 | 21:17:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 21:17:52 INFO - PROCESS | 1645 | RSS: Main: 285925376 21:17:52 INFO - PROCESS | 1645 | 21:17:54 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:17:55 INFO - PROCESS | 1645 | RSS: Main: 289345536 21:17:55 INFO - PROCESS | 1645 | 21:17:58 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 21:17:59 INFO - PROCESS | 1645 | RSS: Main: 331902976 21:17:59 INFO - PROCESS | 1645 | 21:18:02 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 21:18:03 INFO - PROCESS | 1645 | RSS: Main: 333836288 21:18:03 INFO - PROCESS | 1645 | 21:18:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 21:18:06 INFO - PROCESS | 1645 | RSS: Main: 331419648 21:18:06 INFO - PROCESS | 1645 | 21:18:08 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:18:08 INFO - PROCESS | 1645 | RSS: Main: 303947776 21:18:08 INFO - PROCESS | 1645 | 21:18:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:18:11 INFO - PROCESS | 1645 | RSS: Main: 307929088 21:18:11 INFO - PROCESS | 1645 | 21:18:13 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:18:14 INFO - PROCESS | 1645 | RSS: Main: 309637120 21:18:14 INFO - PROCESS | 1645 | 21:18:17 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:18:18 INFO - PROCESS | 1645 | RSS: Main: 326344704 21:18:18 INFO - PROCESS | 1645 | 21:18:21 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:18:21 INFO - PROCESS | 1645 | RSS: Main: 320667648 21:18:21 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 21:18:23 INFO - PROCESS | 1645 | RSS: Main: 364298240 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | __start_tp_report 21:18:23 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 21:18:23 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 21:18:23 INFO - PROCESS | 1645 | |i|pagename|runs| 21:18:23 INFO - PROCESS | 1645 | |0;ai-astar;114;113;114;113;113;111;112;116;123;118 21:18:23 INFO - PROCESS | 1645 | |1;audio-beat-detection;145;118;115;149;116;113;115;116;138;98 21:18:23 INFO - PROCESS | 1645 | |2;audio-dft;185;186;252;223;184;183;181;180;183;182 21:18:23 INFO - PROCESS | 1645 | |3;audio-fft;80;60;60;90;64;77;84;83;74;59 21:18:23 INFO - PROCESS | 1645 | |4;audio-oscillator;82;71;85;70;69;68;83;68;68;84 21:18:23 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;112;115;112;115;167;128;111;171;163;113 21:18:23 INFO - PROCESS | 1645 | |6;imaging-darkroom;99;122;162;162;99;99;99;99;100;110 21:18:23 INFO - PROCESS | 1645 | |7;imaging-desaturate;86;88;92;130;85;85;85;85;87;86 21:18:23 INFO - PROCESS | 1645 | |8;json-parse-financial;60;57;57;58;58;58;58;59;58;58 21:18:23 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;65;72;71;81;75;73;69;70;69;71 21:18:23 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;90;90;91;89;91;89;91;88;89;89 21:18:23 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;150;148;146;145;145;149;161;151;198;158 21:18:23 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;219;233;183;178;176;179;176;178;178;182 21:18:23 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;68;68;68;68;68;67;67;66;68;67 21:18:23 INFO - PROCESS | 1645 | __end_tp_report 21:18:23 INFO - PROCESS | 1645 | __start_cc_report 21:18:23 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2064 21:18:23 INFO - PROCESS | 1645 | __end_cc_report 21:18:23 INFO - PROCESS | 1645 | __startTimestamp1481692703736__endTimestamp 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | ------- Summary: start ------- 21:18:23 INFO - PROCESS | 1645 | Number of tests: 14 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:3.53 (3.1%) stddev-sans-first:3.73 21:18:23 INFO - PROCESS | 1645 | Values: 114.0 113.0 114.0 113.0 113.0 111.0 112.0 116.0 123.0 118.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:128.00 stddev:16.18 (12.6%) stddev-sans-first:14.93 21:18:23 INFO - PROCESS | 1645 | Values: 145.0 118.0 115.0 149.0 116.0 113.0 115.0 116.0 138.0 98.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:193.90 Median:184.50 stddev:24.04 (13.0%) stddev-sans-first:25.28 21:18:23 INFO - PROCESS | 1645 | Values: 185.0 186.0 252.0 223.0 184.0 183.0 181.0 180.0 183.0 182.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:73.10 Median:78.50 stddev:11.50 (14.7%) stddev-sans-first:11.93 21:18:23 INFO - PROCESS | 1645 | Values: 80.0 60.0 60.0 90.0 64.0 77.0 84.0 83.0 74.0 59.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:76.50 stddev:7.58 (9.9%) stddev-sans-first:7.58 21:18:23 INFO - PROCESS | 1645 | Values: 82.0 71.0 85.0 70.0 69.0 68.0 83.0 68.0 68.0 84.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:130.70 Median:121.50 stddev:25.57 (21.0%) stddev-sans-first:26.21 21:18:23 INFO - PROCESS | 1645 | Values: 112.0 115.0 112.0 115.0 167.0 128.0 111.0 171.0 163.0 113.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:115.10 Median:99.00 stddev:25.81 (26.1%) stddev-sans-first:26.71 21:18:23 INFO - PROCESS | 1645 | Values: 99.0 122.0 162.0 162.0 99.0 99.0 99.0 99.0 100.0 110.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:90.90 Median:86.00 stddev:13.91 (16.2%) stddev-sans-first:14.64 21:18:23 INFO - PROCESS | 1645 | Values: 86.0 88.0 92.0 130.0 85.0 85.0 85.0 85.0 87.0 86.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:0.88 (1.5%) stddev-sans-first:0.60 21:18:23 INFO - PROCESS | 1645 | Values: 60.0 57.0 57.0 58.0 58.0 58.0 58.0 59.0 58.0 58.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.50 stddev:4.25 (5.9%) stddev-sans-first:3.77 21:18:23 INFO - PROCESS | 1645 | Values: 65.0 72.0 71.0 81.0 75.0 73.0 69.0 70.0 69.0 71.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:90.00 stddev:1.06 (1.2%) stddev-sans-first:1.12 21:18:23 INFO - PROCESS | 1645 | Values: 90.0 90.0 91.0 89.0 91.0 89.0 91.0 88.0 89.0 89.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:155.10 Median:150.50 stddev:15.99 (10.6%) stddev-sans-first:16.85 21:18:23 INFO - PROCESS | 1645 | Values: 150.0 148.0 146.0 145.0 145.0 149.0 161.0 151.0 198.0 158.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.20 Median:180.50 stddev:20.32 (11.3%) stddev-sans-first:18.24 21:18:23 INFO - PROCESS | 1645 | Values: 219.0 233.0 183.0 178.0 176.0 179.0 176.0 178.0 178.0 182.0 21:18:23 INFO - PROCESS | 1645 | 21:18:23 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.71 (1.0%) stddev-sans-first:0.73 21:18:23 INFO - PROCESS | 1645 | Values: 68.0 68.0 68.0 68.0 68.0 67.0 67.0 66.0 68.0 67.0 21:18:23 INFO - PROCESS | 1645 | -------- Summary: end -------- 21:18:23 INFO - PROCESS | 1645 | 21:18:24 INFO - TEST-INFO | 1645: exit 0 21:18:24 INFO - TEST-OK | kraken | took 60533ms 21:18:24 INFO - SUITE-END | took 1179s 21:18:24 INFO - Completed test suite (00:19:40) 21:18:24 INFO - javascript benchmark 21:18:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3331.883384081557, 3335.7998520088813, 3350.43042682744, 3375.966240337599, 3391.6608339166087, 5548.361938377087, 5605.803796867105, 5642.956053130174, 5648.463395977381, 5660.094384898412, 5374.220737992999, 5603.103503439451, 5614.494695477406, 5649.548036157108, 5668.773249070032, 4057.472528571296, 5058.671186372892, 5161.974190129063, 5187.0, 5187.273781670569, 4949.109160351135, 5021.297018417425, 5058.064258112261, 5069.442361340268, 5096.847094587169, 5056.0, 5061.0, 5079.492050794928, 5082.390113186423, 5118.360204974379, 5103.872403189913, 5109.616778741609, 5125.487451254845, 5150.124478838607, 5181.948180518184, 5161.148410512261, 5161.922571161435, 5180.352455943007, 5206.739663016834, 5228.529432351069, 5616.606837521375, 5634.6337488063145, 5647.407022262644, 5668.773249070032, 5689.175069614883, 6015.218021657201, 6081.756729730805, 6183.258009038899, 6197.0704394340755, 6202.0, 6147.862645410569, 6154.661493617849, 6168.352323006065, 6212.813615591494, 6258.843528911813, 5752.568557358131, 5757.740901659436, 5768.913466298009, 5771.192033115367, 5813.854653633693, 6251.812445626639, 6290.119383286344, 6314.873702525923, 6337.556371053982, 6343.143675603735, 5898.351181370046, 5916.497097746654, 5934.9406505934385, 5940.287165540163, 5987.072003839412, 6120.182659316514, 6121.005657821351, 6124.666108519761, 6124.869201255686, 6143.96928015357, 6062.42406971337, 6062.605930614496, 6064.181335519736, 6064.696765161724, 6084.787032453843, 6022.879542409128, 6093.11649810775, 6097.3292937776805, 6099.176611157525, 6145.248604147797, 4911.435184953704, 4917.311576379309, 4921.188003979303, 4922.532359425849, 4950.381202349707, 4320.200762858818, 4321.135772845443, 4422.933655995163, 4423.4912985006495, 4454.265046267395, 5614.719264036782, 5643.238162848045, 5667.4332566743, 5762.654240745569, 5781.82654520365, 6171.59884607499, 6179.042248451407, 6182.258129024546, 6234.407731265614, 6266.467350275187, 5765.769369225184, 5782.6819524925695, 5787.247657804459, 5789.623674461147, 5805.36141024487, 5236.345456817898, 5297.708626025606, 5331.946680533145, 5332.68003919766, 5333.973330133324, 6254.468370188585, 6257.0, 6297.52768542352, 6300.432961033345, 6321.841953951188, 6233.158523599256, 6236.6258024518675, 6242.781502647385, 6259.874802504016, 6262.34245404226, 6252.812415627538, 6278.717457714505, 6291.056341548804, 6315.5894866833505, 6318.4313411793155, 4948.505149485023, 6023.939760602338, 6096.664683442454, 6110.0, 6115.4190351916495, 6214.285357183981, 6231.844203894758, 6236.126942228001, 6243.37566243372, 6253.530985176221, 5992.221011268507, 6041.154238406714, 6044.607100538627, 6058.818235452944, 6070.332263450929, 5841.299044114733, 5909.143174239625, 5919.260092488439, 5934.258217722785, 6048.092786082123, 5643.0, 5806.593538452268, 5812.011957967071, 5818.0981947798155, 5820.4761571457075, 5843.561732869966, 5848.736806843617, 5851.795187168599, 5854.0, 5854.209681692917, 5746.827595172152, 5788.652680839163, 5796.449337312949, 5799.942000580109, 5800.76796928135], "value": 5620.215063098382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.6508551129409, 486.5110563883298, 490.72028943502215, 506.04610309566453, 565.8189379398594, 37414.43878341827, 39273.410898836504, 39327.0, 39467.0, 39479.0, 39418.60581394185, 39827.805165845, 39908.20183596334, 39929.8003509982, 40078.39882401766, 8415.45299555527, 9330.626774928995, 9535.189508891752, 9539.80920381592, 9540.141387275144, 8471.576421178946, 9925.75928008999, 11327.376994265313, 11384.430778461085, 11394.373309467976, 11061.944690276538, 11389.829152562717, 11395.259308144985, 11397.145214108976, 11476.426178691074, 8462.703805366844, 8691.08743581921, 11263.15526335524, 11278.210525263194, 11339.036181924464, 10946.616868409646, 11173.776524469466, 11209.943950280278, 11228.943855280671, 11421.486033128529, 37759.62240377589, 37764.62235377639, 38372.0, 38398.27207775657, 38611.613883861086, 2982.612260406155, 3367.175042114673, 3391.8304084795664, 3468.3756923753713, 3657.1588534636917, 22758.886205568866, 29381.853090734625, 30035.549466758017, 30097.247568810737, 30139.0, 3168.0, 3181.427343078245, 3249.3014001989686, 3285.950710739341, 3287.819169945652, 395483.0, 396200.0, 398108.0, 398313.0084349589, 399089.0, 57148.42851571514, 57485.712571436874, 57502.424975750546, 57574.7121264391, 57749.42250577525, 59609.0, 59766.70116649389, 59902.70048649816, 59921.70039149776, 59961.0, 15216.315265813066, 15517.0, 15525.844741552666, 15528.301226444837, 15530.990485618398, 11001.6149434771, 11290.774184516264, 11312.321260724382, 12057.879421205851, 12213.267203967791, 12815.231086134861, 15315.0, 15586.19448499281, 15657.37370505167, 15983.36066557348, 6501.447376972916, 6557.475401967831, 6633.966830165915, 6722.764703235363, 6738.35985581369, 882.642529775442, 940.6942743608355, 968.5060619084318, 969.3602222533094, 1059.0256963593513, 27869.860650696617, 28760.712392876223, 28853.990110346036, 29688.554671679944, 29785.255368615526, 1012.2307046644603, 1070.71626019105, 1101.3171833463143, 1162.2910024884814, 1172.935488548121, 14587.781183282259, 15003.624909377353, 15038.699226015637, 15241.618959525878, 15362.383835363835, 512331.19172020996, 514362.0, 515404.0, 516340.0, 516734.0, 55443.44556554383, 55619.721901390236, 55662.09406495022, 55813.0, 56134.15798763022, 1341.7383610196114, 1379.5033787836371, 1392.5822253324166, 1394.672252020754, 1395.1768456610648, 23457.765422345557, 28238.85880570584, 28414.573781392883, 28871.42257154803, 29083.854580726962, 47205.0, 47817.52182478131, 47949.0, 47954.0, 47956.280655789495, 379546.0, 455111.0, 456431.0, 457302.7134864304, 458155.0, 37311.81344093262, 37728.43407348947, 37750.0, 38018.61981380151, 38072.80963595164, 38736.22527549489, 39840.60159398369, 44782.3282650767, 44876.55123448724, 44960.10079798451, 33857.0, 34185.82907085449, 34251.14372140716, 34965.650343497255, 35053.47419788654, 33937.66062339444, 33987.0, 34697.0, 34848.9545313641, 35050.474242886885, 33146.5028024575, 33820.492692610125, 34177.31645367129, 34273.65726342705, 34470.82764586261, 30126.84936575303, 30160.0, 30264.368275807043, 30651.2337191572, 30705.692943070284, 18993.810061899203, 23248.083373263515, 23369.0, 23405.680466274353, 23543.41141471477], "value": 19124.814823303976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.9273552553964, 364.6954792748055, 366.2820871092659, 377.31140668280386, 388.45422181834516, 13977.930110349447, 14431.783523247146, 15443.691126177484, 17004.0, 19706.014699265015, 18727.15727792249, 19424.902875485604, 19805.504862378413, 20107.497312567193, 20123.0, 5519.972400137994, 5738.684372359518, 5739.0, 5745.138229265623, 5749.885002299951, 5500.1749737539485, 5637.943620563783, 5689.6017278790505, 5711.628744131618, 5737.196792449061, 5695.288088988877, 5698.287714035746, 5704.48659620634, 5704.857378565548, 5711.8572035699235, 5505.862353441176, 5653.123765816305, 5690.573207009491, 5755.366909639936, 5763.049096899049, 5049.924251136236, 5053.84838454847, 5054.646174767768, 5062.341895553592, 5073.898522029575, 22410.43973900649, 22604.0, 23582.882085589634, 23651.645225321634, 23824.16615418452, 2233.140241007208, 2348.8825558722165, 2507.247825652297, 2525.8231923765343, 2885.2209903326193, 9666.275029372826, 9907.702768916944, 10184.898151018544, 10281.331713438603, 10544.472776361228, 1805.1786437171056, 1824.2520566567644, 1876.502726777405, 1888.8488920886296, 1996.9101390437465, 102711.48644256806, 109340.0, 110372.9999999992, 112676.74646507106, 116090.0, 11368.488418021208, 11396.14528910335, 11506.59726909571, 11563.537458501734, 11729.765404692029, 12716.427760750788, 14055.594440555862, 14607.19660418687, 14639.92680036593, 14655.853441465662, 7895.092064412666, 8220.753377398687, 8329.458585191944, 8348.415610907177, 8543.444676096158, 8136.471129376571, 8137.633806478722, 8163.877541836877, 8304.70933517324, 8356.749297521084, 4464.575865292792, 4527.796249168795, 4532.524084971096, 4592.173408786451, 4678.017616300547, 1606.5501659535114, 1876.6246750649925, 1932.478230877655, 1941.6019715958478, 1943.8444924406015, 817.2195553246754, 853.6884037326455, 884.633605106338, 911.1753862754218, 922.1331947968888, 19923.900380498006, 20630.690539641917, 20764.328026193987, 21092.578148437253, 21119.366419007456, 954.1174413667469, 957.9952100239454, 964.5273815830333, 987.1066684650403, 1003.6336737090909, 10695.465226738632, 11019.787823339426, 11033.724156895982, 11052.115830733523, 11066.778664426827, 560306.0, 561247.0, 564184.0, 588326.0, 592136.0, 121768.0, 123293.43772185053, 125131.37434312953, 125733.74266257403, 128267.0, 988.8615593816871, 1012.7366884610054, 1017.2574020964737, 1025.2976710953021, 1049.9895001050045, 18140.637187256445, 18411.723824142915, 18647.347342842935, 18707.532311692317, 19048.714269285694, 47590.524094759996, 48998.51001490082, 52166.0, 52174.73912630413, 52619.0, 71270.0, 72094.63952680203, 72347.55304893978, 73021.6348918252, 73884.26115738989, 5979.701014949323, 7251.854962900818, 7666.926630271878, 7961.681532738626, 7982.640781164745, 11949.0, 12152.57465988686, 12362.0, 12375.195612285173, 12486.625401237978, 10263.794724105626, 10475.895241047492, 10782.191335650015, 10801.67594972152, 10867.0762985144, 10219.489025548544, 10254.692359229235, 10413.9479302603, 10553.947230263799, 10705.090067344363, 10408.947955260175, 10478.0, 10500.632477863239, 10584.312019718695, 10634.0, 7972.242636949481, 7981.754848239834, 7988.320992715684, 8162.306203972729, 8227.506349619041, 9760.46317452547, 9892.950535247566, 10151.593936242467, 10327.173826094046, 10691.465426728477], "value": 9244.32881065252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.709382482766, 1471.2864260833496, 1494.484402881006, 1700.2094026277778, 1880.6050729346837, 7260.201377848439, 7624.733134340299, 7777.105632852231, 8054.395920305971, 8083.474574152676, 7937.0, 8029.799255018613, 8046.396520260974, 8048.597570121485, 8050.557219352933, 2024.2611446821952, 2253.842231043832, 2297.597920363938, 2297.6094064009076, 2300.8274379421528, 2111.398251498323, 2225.8330625203093, 2323.5701395241936, 2332.988335058331, 2341.2273949596593, 2254.594173048859, 2294.8737819419925, 2303.0, 2303.4011157099108, 2319.7796209360085, 2290.0, 2314.9652755208517, 2315.490592069742, 2317.2468947591933, 2324.465372964219, 2291.472961218929, 2317.6523521471745, 2319.2694301295037, 2319.7564255753073, 2327.5461285049423, 7965.761027169194, 7989.520628762293, 8034.839303213961, 8042.597870106471, 8054.43618946674, 4917.901641967141, 5078.847634570969, 5085.211792172219, 5102.770375333082, 5107.591392688576, 2823.6164279502896, 3236.2394837213237, 3463.3939060664284, 3463.757536972413, 3468.9826550867338, 984.4339504784778, 1030.4538594544904, 1057.762003549203, 1059.1315121600292, 1060.241927022175, 10105.797884042278, 10345.224108191916, 10365.222608304332, 10371.377717336984, 10385.948070259676, 4385.7149285296355, 4453.933191002137, 4543.636509079266, 4583.816647334136, 4627.814887404534, 8313.0, 8318.625661845232, 8382.287505561973, 8386.203310685476, 8387.119352467904, 4943.950560494421, 4963.0, 4965.4041515018425, 4969.875753106129, 4974.17926042199, 4531.886702832389, 4535.16099521583, 4593.494715581283, 4674.462436819741, 4675.579197872208, 3413.7781044232543, 3461.7230621550216, 3503.2468019375956, 3532.540769699974, 3536.9469457958153, 1078.2991055813627, 1092.7759809239087, 1093.3822390349428, 1104.745908441047, 1105.7567335186245, 798.22572105058, 828.6312590897113, 882.4176043811182, 883.3992884838372, 892.5180402582663, 4261.595148460891, 5184.0, 5324.92012619811, 5409.24270602116, 5515.696636685021, 419.79782378391906, 428.2676622974686, 430.28357784288806, 436.67467736536486, 439.3453753906656, 3244.8053116812594, 3572.1783989682517, 3593.3711600469815, 3759.323321802102, 3777.981110094432, 9114.40756350835, 9376.95311523438, 9460.716178514656, 9482.620695172116, 9484.430934143973, 9361.719148425558, 9447.952760236154, 9460.959294477601, 9464.810703785886, 9474.810503789886, 6897.41371983377, 7428.0, 7442.292982166686, 7509.924900751141, 7540.132884718218, 5293.7353132344, 5443.428440013741, 5482.780688772405, 5493.285872836505, 5515.255440515479, 8551.57242137903, 8605.139486051345, 8805.647774088964, 8936.28509719234, 8949.507777072324, 6893.93106068953, 8500.872486912578, 8814.955925220333, 8877.11228877133, 9014.278857691237, 6685.596024834839, 6922.27316131819, 6923.584584924921, 6939.201991770809, 6947.548409353376, 7392.519486233377, 7406.518576292524, 7410.703571857065, 7465.7013719450615, 7475.401967842451, 6799.830004249933, 6801.897971530332, 6848.3494068063455, 6849.1438570178725, 6860.794176174722, 6623.105880706043, 6701.229358623626, 6721.22705888829, 6757.86484270302, 6770.593764374154, 6270.0, 6458.321876202931, 6462.7414903405215, 6482.254540727877, 6486.05952136928, 4522.4573051234065, 4649.325847752125, 4671.065786842713, 4672.322513235494, 4767.0, 4559.0, 4570.428696412949, 4636.976815115903, 4690.437147542317, 4839.395075615548], "value": 4144.532571943868, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.28427581320386, 353.6534196487442, 359.267095125943, 368.7971615611413, 370.6682519145363, 5110.284560161575, 5157.6131790115705, 5177.68933863968, 5204.869878253036, 5267.420583735786, 4207.915841683164, 5051.949480505194, 5079.822206222783, 5118.181091025437, 5126.513970500058, 3428.8797194552963, 3446.3451944130534, 3656.780593164412, 3962.48487696599, 4058.655014323786, 3413.812240326781, 3639.7452178347526, 4039.212353591051, 4101.9589804102025, 4122.711410201287, 3087.1939915149665, 3096.179512429208, 4089.8159582818844, 4107.445494858201, 4128.483939507561, 4045.2920738870725, 4094.4267802507675, 4094.7133700640966, 4100.958990410118, 4130.463039804837, 3357.865685372582, 3621.5835178954494, 3631.455281707739, 3636.654517820803, 3656.305301992613, 4617.492075871685, 4773.737444440554, 4888.902221955541, 5101.199606293335, 5160.819371321985, 4467.5755803198645, 4681.0871879983415, 4712.6229901607785, 4713.740744259065, 4752.4297084349755, 4641.535846415331, 5220.216967454874, 5225.581953443715, 5500.834974950758, 5565.860853478695, 3364.0916952422954, 3497.828227543776, 3588.515550400715, 3880.9029774255587, 4055.655269302113, 4755.0, 4893.602134953847, 5436.048691478975, 5726.3700992890745, 5735.741891614845, 3397.2865698203655, 3846.0, 3881.0685435495843, 3957.9802100989887, 4122.928418328364, 4107.199096176277, 4159.2964573027775, 4162.396452514368, 4167.062410957571, 4196.81114349855, 4012.378081397388, 4445.73325600465, 4682.625389968863, 4755.500672429414, 4768.9523104769205, 5502.394736578973, 5543.473370029841, 5559.444055594489, 5561.721913904369, 5564.527015203672, 1250.2935841249664, 1260.8550016748009, 1274.5533819115371, 1320.7490576790378, 1347.8719521645428, 764.4801534956172, 799.3205775091126, 823.7487566292218, 849.1678155407735, 944.4239014201331, 4283.807228674717, 4710.528947105262, 4979.431479084077, 4992.126377883856, 5050.080969231669, 5025.74871256443, 5380.354357477127, 5388.5419739321815, 5398.974194902956, 5453.536449401845, 4343.913121737548, 4611.9077618447445, 4727.818045488628, 4751.622029611443, 4857.688424125467, 2574.086199399224, 2612.1641074856243, 2617.0, 2801.257666718321, 2804.551271796503, 5161.819336323286, 5369.0, 5636.549076073904, 5656.208130861683, 5683.744231509592, 4923.704577725276, 4963.081829861487, 5432.538234250133, 5520.503154716095, 5521.199426083195, 4704.764761761899, 5262.736863156751, 5518.475744804237, 5597.041035637494, 5621.578381621313, 4616.792244348945, 4821.783019764049, 5032.370953630796, 5063.316452278895, 5424.24060631504, 4951.356323677899, 5320.946790532045, 5333.839984800462, 5334.466553344634, 5380.838574842761, 5171.9482805172975, 5588.748506317144, 5591.350551587373, 5632.802851900164, 5657.2928383952, 3855.4024126260474, 3861.6524512793985, 3877.3990031544026, 3888.96111038886, 3896.2597106549665, 4989.60083193351, 5683.658980461186, 5714.257146570919, 5749.568782341257, 5807.651540907559, 4654.604358629555, 5547.140193270049, 5584.748686309207, 5621.325440947113, 5676.943230567642, 4747.905041899212, 5202.687838729688, 5551.611387202857, 5559.0, 5594.468525490072, 5464.617476776588, 5501.422350653123, 5504.174373843955, 5520.309961254843, 5540.86147846291, 5160.922586161136, 5221.694576355911, 5293.994141113176, 5377.892442151213, 5587.972060139673, 5386.919196212139, 5407.404815579335, 5432.755526001419, 5481.232627432083, 5521.585881059017], "value": 4011.2086202002456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.8116127484303, 727.1746567645722, 741.8664640364735, 796.1839114907223, 798.936085113191, 15234.390624375026, 15866.603334916634, 15891.68216635668, 15906.920465397672, 15913.920430397831, 14313.499027534039, 14466.710665786677, 14469.276536173202, 14470.5658830235, 14477.131372117654, 674.8414122681166, 700.3486757315694, 701.7298340139032, 826.8470332988386, 833.0669649992002, 855.4525103933488, 857.1642648417806, 858.3347905373323, 858.9613467393982, 860.3504354212561, 901.2564634176798, 918.9218916392115, 919.3886065766291, 920.1764420843341, 920.2591913509622, 911.0843602179833, 913.6025828764509, 914.7484441778497, 915.0986278515657, 915.2129168914761, 524.590819161055, 545.4436474795726, 649.3441623959834, 676.9221539522969, 678.6776281266408, 14372.712545749026, 14882.958192926499, 14883.255837208204, 14897.478588249467, 14929.552113436614, 13457.259850708208, 13458.52895148665, 13472.25902575358, 13516.729665406736, 13524.729505409836, 12330.013598912155, 12374.81437778434, 12507.3746312684, 12522.81215781764, 12739.681507962283, 4439.822407103712, 4481.0, 4523.344115103291, 4629.282461218483, 4637.652176086774, 108644.0, 109565.35651965307, 111285.33072003926, 111816.44091779488, 113023.43488282507, 10694.304870183412, 10950.288231264942, 10998.285111467729, 11048.558057677763, 11264.0, 19145.425637230906, 21336.93315334227, 21342.35972920815, 21649.458763531038, 21942.341729748132, 7736.6518506667335, 7831.490953088031, 7893.960530197312, 7999.3200577950365, 8071.23323284287, 4125.133721918431, 4195.685323600742, 4230.682698797603, 4246.193223287565, 4278.89302767427, 3424.434968230214, 3459.6540345965204, 3475.3223121491574, 3537.0626783902285, 3544.946825797615, 484.92726091085916, 616.5437576193674, 632.7816903168399, 662.9569078010011, 674.8751480976035, 599.0355527600559, 657.8585604095047, 667.7095463473307, 680.3876511140014, 684.5208354152113, 7726.304632583095, 8587.593151060513, 8754.118133744045, 9091.674383365635, 9170.587323570455, 563.9032082599305, 564.9548931260509, 599.7511032921376, 670.3732010570133, 688.1123350877413, 4197.370394440858, 4482.8655140345845, 4513.68404211702, 4534.59188673021, 4629.375034370384, 107394.0, 108021.0, 108242.0, 108589.45705271424, 110687.0, 75749.0, 95089.5245523768, 96369.0, 99672.0, 100055.0, 84140.57929710312, 85339.57330213433, 85378.75791139143, 86184.0, 86733.0, 8509.191626795444, 8837.0, 8911.232490617489, 8942.776430589287, 9152.816943661222, 54252.457475426316, 54627.180592291945, 56680.71659641675, 56986.7150664244, 58334.12498812606, 59488.70255648694, 62201.066983996185, 64193.0, 67940.6602966982, 73952.0, 12588.496460141492, 13130.606081817561, 13211.405486753312, 13421.66445838862, 13461.0, 12091.576794812492, 14489.0, 14821.184834834188, 14834.629134271298, 15204.771928421304, 13703.0, 13820.654483637989, 13838.37727302294, 13992.580222593338, 14376.28118594087, 11842.230255033395, 12867.742645147231, 13229.40467678976, 13633.931830340785, 14176.574702758933, 13336.19982801035, 13378.598642040753, 13515.93242033823, 13636.522721704692, 14023.789643155156, 10214.182865370603, 10804.459777011276, 11464.426778660867, 11476.540938362372, 11818.0, 11297.378644174321, 11301.886981130083, 11480.253783504046, 11537.538498459968, 11558.07535397183], "value": 7497.5815582493005, "unit": "score"}], "name": "dromaeo_css", "value": 7060.32029636421, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 113.0, 111.0, 112.0, 116.0, 123.0, 118.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 115.0, 149.0, 116.0, 113.0, 115.0, 116.0, 138.0, 98.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 252.0, 223.0, 184.0, 183.0, 181.0, 180.0, 183.0, 182.0], "value": 193.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 90.0, 64.0, 77.0, 84.0, 83.0, 74.0, 59.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 85.0, 70.0, 69.0, 68.0, 83.0, 68.0, 68.0, 84.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 112.0, 115.0, 167.0, 128.0, 111.0, 171.0, 163.0, 113.0], "value": 130.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 122.0, 162.0, 162.0, 99.0, 99.0, 99.0, 99.0, 100.0, 110.0], "value": 115.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 92.0, 130.0, 85.0, 85.0, 85.0, 85.0, 87.0, 86.0], "value": 90.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 57.0, 58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 71.0, 81.0, 75.0, 73.0, 69.0, 70.0, 69.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 91.0, 89.0, 91.0, 89.0, 91.0, 88.0, 89.0, 89.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 146.0, 145.0, 145.0, 149.0, 161.0, 151.0, 198.0, 158.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 233.0, 183.0, 178.0, 176.0, 179.0, 176.0, 178.0, 178.0, 182.0], "value": 188.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 66.0, 68.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1545.7, "alertThreshold": 2.0}]} 21:18:24 INFO - Return code: 0 21:18:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:18:25 INFO - # TBPL SUCCESS # 21:18:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:18:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:18:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:18:25 INFO - 2016-12-13 21:18:25.068 screenresolution[1649:9546] starting screenresolution argv=screenresolution get 21:18:25 INFO - 2016-12-13 21:18:25.071 screenresolution[1649:9546] Display 0: 1600x1200x32@60 21:18:25 INFO - 2016-12-13 21:18:25.077 screenresolution[1650:9549] starting screenresolution argv=screenresolution list 21:18:25 INFO - Available Modes on Display 0 21:18:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:18:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:18:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:18:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:18:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:18:25 INFO - Intel Iris: 21:18:25 INFO - Chipset Model: Intel Iris 21:18:25 INFO - Type: GPU 21:18:25 INFO - Bus: Built-In 21:18:25 INFO - VRAM (Dynamic, Max): 1536 MB 21:18:25 INFO - Vendor: Intel (0x8086) 21:18:25 INFO - Device ID: 0x0a2e 21:18:25 INFO - Revision ID: 0x0009 21:18:25 INFO - Displays: 21:18:25 INFO - Display: 21:18:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:18:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:18:25 INFO - Display Serial Number: 1600x1200 60 21:18:25 INFO - Main Display: Yes 21:18:25 INFO - Mirror: Off 21:18:25 INFO - Online: Yes 21:18:25 INFO - Rotation: Supported 21:18:25 INFO - Return code: 0 21:18:25 INFO - Running post-action listener: _resource_record_post_action 21:18:25 INFO - [mozharness: 2016-12-14 05:18:25.313022Z] Finished run-tests step (success) 21:18:25 INFO - Running post-run listener: _resource_record_post_run 21:18:25 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 37786624; Write bytes: 549671424; Read time: 253; Write time: 1682 21:18:25 INFO - TinderboxPrint: CPU usage
53.8% 21:18:25 INFO - TinderboxPrint: I/O read bytes / time
37,786,624 / 253 21:18:25 INFO - TinderboxPrint: I/O write bytes / time
549,671,424 / 1,682 21:18:25 INFO - TinderboxPrint: CPU idle
2,222.5 (46.2%) 21:18:25 INFO - TinderboxPrint: CPU system
964.5 (20.0%) 21:18:25 INFO - TinderboxPrint: CPU user
1,626.7 (33.8%) 21:18:25 INFO - TinderboxPrint: Swap in / out
286,740,480 / 0 21:18:25 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 237210112; Write bytes: 229355520; Read time: 17706; Write time: 491 21:18:25 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35800064; Write bytes: 298545664; Read time: 233; Write time: 1141 21:18:25 INFO - Running post-run listener: _upload_blobber_files 21:18:25 INFO - Blob upload gear active. 21:18:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:18:25 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 21:18:25 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'] 21:18:25 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 21:18:26 INFO - (blobuploader) - INFO - Open directory for files ... 21:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:18:27 INFO - (blobuploader) - INFO - Done attempting. 21:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:18:28 INFO - (blobuploader) - INFO - Done attempting. 21:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:18:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:18:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:18:31 INFO - (blobuploader) - INFO - Done attempting. 21:18:31 INFO - (blobuploader) - INFO - Iteration through files over. 21:18:31 INFO - Return code: 0 21:18:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:18:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:18:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bad02a0af5353c7bff92637f7b7da7d7bbfb2d37dbc80159941e39e17b4644352390445facdc8930c00ffc170dc47d3176b53e8c30c84b9f48ee1965e4f46013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7f6a1429ad956f4e8c6388025637f0914d824f79f8c5d6e04acccd3cbd00d32e76867a4ed023dce37ee9702a966321c97040228837e122ce41645e140b55ddc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bf5528ae2874c439d9f74768f4319def38208bec84f1734db511d42bb183ff9465d3571663651ce4340abed84189a7cb88306232fc86cceb4aca25cc1ce53ca"} 21:18:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:18:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:18:31 INFO - Contents: 21:18:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bad02a0af5353c7bff92637f7b7da7d7bbfb2d37dbc80159941e39e17b4644352390445facdc8930c00ffc170dc47d3176b53e8c30c84b9f48ee1965e4f46013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7f6a1429ad956f4e8c6388025637f0914d824f79f8c5d6e04acccd3cbd00d32e76867a4ed023dce37ee9702a966321c97040228837e122ce41645e140b55ddc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bf5528ae2874c439d9f74768f4319def38208bec84f1734db511d42bb183ff9465d3571663651ce4340abed84189a7cb88306232fc86cceb4aca25cc1ce53ca"} 21:18:31 INFO - Running post-run listener: copy_logs_to_upload_dir 21:18:31 INFO - Copying logs to upload dir... 21:18:31 INFO - mkdir: /builds/slave/test/build/upload/logs 21:18:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.463868 ========= master_lag: 0.48 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-13 21:18:31.284938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 21:18:31.288443) ========= 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.MLqWSI39Df/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.XapkJcJcIV/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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/bad02a0af5353c7bff92637f7b7da7d7bbfb2d37dbc80159941e39e17b4644352390445facdc8930c00ffc170dc47d3176b53e8c30c84b9f48ee1965e4f46013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7f6a1429ad956f4e8c6388025637f0914d824f79f8c5d6e04acccd3cbd00d32e76867a4ed023dce37ee9702a966321c97040228837e122ce41645e140b55ddc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bf5528ae2874c439d9f74768f4319def38208bec84f1734db511d42bb183ff9465d3571663651ce4340abed84189a7cb88306232fc86cceb4aca25cc1ce53ca"} build_url:https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/SGJxvOrkRPyQeJdtWUA1Xw/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/bad02a0af5353c7bff92637f7b7da7d7bbfb2d37dbc80159941e39e17b4644352390445facdc8930c00ffc170dc47d3176b53e8c30c84b9f48ee1965e4f46013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7f6a1429ad956f4e8c6388025637f0914d824f79f8c5d6e04acccd3cbd00d32e76867a4ed023dce37ee9702a966321c97040228837e122ce41645e140b55ddc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bf5528ae2874c439d9f74768f4319def38208bec84f1734db511d42bb183ff9465d3571663651ce4340abed84189a7cb88306232fc86cceb4aca25cc1ce53ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 21:18:31.322413) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:18:31.322742) ========= 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.MLqWSI39Df/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.XapkJcJcIV/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.005228 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:18:31.370938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 21:18:31.371266) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 21:18:31.371602) ========= ========= Total master_lag: 0.62 =========