builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0373 starttime: 1479735767.96 results: success (0) buildid: 20161121031409 builduid: 6f4234acb1e643e590bcccc2aec2e7de revision: 0a335e78a46864a25041bfb411d64ce573fa0e1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:47.963810) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:47.964786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:47.965134) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:47.996943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:47.997375) ========= 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.qX6nBLpinX/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.mix9eykBTW/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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-11-21 05:42:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-11-21 05:42:48 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120793 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:48.144775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:48.145281) ========= 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.qX6nBLpinX/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.mix9eykBTW/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.027800 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:48.198206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 05:42:48.198624) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 0a335e78a46864a25041bfb411d64ce573fa0e1e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 0a335e78a46864a25041bfb411d64ce573fa0e1e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qX6nBLpinX/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.mix9eykBTW/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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-11-21 05:42:48,298 truncating revision to first 12 chars 2016-11-21 05:42:48,298 Setting DEBUG logging. 2016-11-21 05:42:48,298 attempt 1/10 2016-11-21 05:42:48,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/0a335e78a468?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 05:42:49,604 unpacking tar archive at: cedar-0a335e78a468/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572732 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 05:42:49.797423) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:49.797809) ========= script_repo_revision: 0a335e78a46864a25041bfb411d64ce573fa0e1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:49.798414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:49.798725) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 05:42:49.820828) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-21 05:42:49.821229) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qX6nBLpinX/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.mix9eykBTW/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:42:50 INFO - MultiFileLogger online at 20161121 05:42:50 in /builds/slave/test 05:42:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 05:42:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:42:50 INFO - {'append_to_log': False, 05:42:50 INFO - 'base_work_dir': '/builds/slave/test', 05:42:50 INFO - 'blob_upload_branch': 'Cedar', 05:42:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:42:50 INFO - 'branch': 'Cedar', 05:42:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:50 INFO - 'config_files': ('talos/mac_config.py',), 05:42:50 INFO - 'default_actions': ('clobber', 05:42:50 INFO - 'read-buildbot-config', 05:42:50 INFO - 'download-and-extract', 05:42:50 INFO - 'populate-webroot', 05:42:50 INFO - 'create-virtualenv', 05:42:50 INFO - 'install', 05:42:50 INFO - 'run-tests'), 05:42:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:50 INFO - 'download_minidump_stackwalk': True, 05:42:50 INFO - 'download_symbols': 'ondemand', 05:42:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:42:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:42:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:42:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:42:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:50 INFO - 'installer_path': 'installer.exe', 05:42:50 INFO - 'log_level': 'info', 05:42:50 INFO - 'log_name': 'talos', 05:42:50 INFO - 'log_to_console': True, 05:42:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:42:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:42:50 INFO - 'opt_config_files': (), 05:42:50 INFO - 'pip_index': False, 05:42:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:42:50 INFO - 'cmd': ('bash', 05:42:50 INFO - '-c', 05:42:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:42:50 INFO - 'enabled': True, 05:42:50 INFO - 'halt_on_failure': False, 05:42:50 INFO - 'name': 'check_screen_resolution'},), 05:42:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:42:50 INFO - 'cmd': ('bash', 05:42:50 INFO - '-c', 05:42:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:42:50 INFO - 'enabled': True, 05:42:50 INFO - 'halt_on_failure': False, 05:42:50 INFO - 'name': 'check_screen_resolution'},), 05:42:50 INFO - 'run_cmd_checks_enabled': True, 05:42:50 INFO - 'sps_profile': False, 05:42:50 INFO - 'sps_profile_interval': 0, 05:42:50 INFO - 'suite': 'dromaeojs', 05:42:50 INFO - 'system_bits': '32', 05:42:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:50 INFO - 'title': 't-yosemite-r7-0373', 05:42:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:50 INFO - 'use_talos_json': True, 05:42:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:42:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:50 INFO - 'work_dir': 'build'} 05:42:50 INFO - [mozharness: 2016-11-21 13:42:50.028290Z] Running clobber step. 05:42:50 INFO - Running pre-action listener: _resource_record_pre_action 05:42:50 INFO - Running main action method: clobber 05:42:50 INFO - rmtree: /builds/slave/test/build 05:42:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:42:51 INFO - Running post-action listener: _resource_record_post_action 05:42:51 INFO - [mozharness: 2016-11-21 13:42:51.981951Z] Finished clobber step (success) 05:42:51 INFO - [mozharness: 2016-11-21 13:42:51.982085Z] Running read-buildbot-config step. 05:42:51 INFO - Running pre-action listener: _resource_record_pre_action 05:42:51 INFO - Running main action method: read_buildbot_config 05:42:51 INFO - Using buildbot properties: 05:42:51 INFO - { 05:42:51 INFO - "project": "", 05:42:51 INFO - "product": "firefox", 05:42:51 INFO - "script_repo_revision": "default", 05:42:51 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 05:42:51 INFO - "repository": "", 05:42:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 05:42:51 INFO - "buildid": "20161121031409", 05:42:51 INFO - "pgo_build": "False", 05:42:51 INFO - "basedir": "/builds/slave/test", 05:42:51 INFO - "buildnumber": 0, 05:42:51 INFO - "slavename": "t-yosemite-r7-0373", 05:42:51 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:42:51 INFO - "platform": "yosemite_r7", 05:42:51 INFO - "scheduler": "tests-cedar-macosx64-talos", 05:42:51 INFO - "branch": "cedar", 05:42:51 INFO - "repo_path": "projects/cedar", 05:42:51 INFO - "revision": "0a335e78a46864a25041bfb411d64ce573fa0e1e", 05:42:51 INFO - "stage_platform": "macosx64", 05:42:51 INFO - "builduid": "6f4234acb1e643e590bcccc2aec2e7de", 05:42:51 INFO - "slavebuilddir": "test" 05:42:51 INFO - } 05:42:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:42:51 INFO - Running post-action listener: _resource_record_post_action 05:42:51 INFO - [mozharness: 2016-11-21 13:42:51.985318Z] Finished read-buildbot-config step (success) 05:42:51 INFO - [mozharness: 2016-11-21 13:42:51.985423Z] Running download-and-extract step. 05:42:51 INFO - Running pre-action listener: _resource_record_pre_action 05:42:51 INFO - Running main action method: download_and_extract 05:42:51 INFO - mkdir: /builds/slave/test/build/tests 05:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:51 INFO - trying https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:42:51 INFO - Downloading https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/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 05:42:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/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 05:42:53 INFO - Downloaded 1199 bytes. 05:42:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:42:53 INFO - Using the following test package requirements: 05:42:53 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:42:53 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:42:53 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:42:53 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:42:53 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:42:53 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:42:53 INFO - u'jsshell-mac.zip'], 05:42:53 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:42:53 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:42:53 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:42:53 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:42:53 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:42:53 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:42:53 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:42:53 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:42:53 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:42:53 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:42:53 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:42:53 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:42:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:42:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:42:53 INFO - Fetch https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:42:53 INFO - Http code: 200 05:42:53 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 05:42:53 INFO - x-amz-cf-id: _6T9lljsHw84Dw6i3Tzs2Gj6hM-vxK0Ga3cS2bZ8upbvNM9PWnJKcA== 05:42:53 INFO - x-amz-version-id: yDufusQrsGUwZMsjhrfJLyIXWNyapmjz 05:42:54 INFO - Expected file size: 16265513 05:42:54 INFO - Obtained file size: 16265513 05:43:00 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 05:43:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:43:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:43:00 INFO - Fetch https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:43:01 INFO - Http code: 200 05:43:01 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 05:43:01 INFO - x-amz-cf-id: LhrCIdI5VtxlHJC2TqJ_whDx9eCvRiX_7KKFcQ8A0AgrUOsPhqCJag== 05:43:01 INFO - x-amz-version-id: yDufusQrsGUwZMsjhrfJLyIXWNyapmjz 05:43:01 INFO - Expected file size: 16265513 05:43:01 INFO - Obtained file size: 16265513 05:43:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:43:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:43:08 INFO - Fetch https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:43:08 INFO - Http code: 200 05:43:08 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 05:43:08 INFO - x-amz-cf-id: dw0nk_CaKAgzKRBqw0g9nvBiYMezNVEsHdq4K_dm4riVk826wyh1pA== 05:43:08 INFO - x-amz-version-id: QZjzbkmacGYNsdzcHOIxzoHJ7QU.8nsd 05:43:08 INFO - Expected file size: 14409392 05:43:08 INFO - Obtained file size: 14409392 05:43: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')]} 05:43:09 INFO - trying https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:43:09 INFO - Downloading https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:43:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/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 05:43:12 INFO - Downloaded 107469972 bytes. 05:43:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:43:12 INFO - mkdir: /builds/slave/test/properties 05:43:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:43:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:43:12 INFO - Contents: 05:43:12 INFO - build_url:https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:43:12 INFO - Running post-action listener: _resource_record_post_action 05:43:12 INFO - Running post-action listener: set_extra_try_arguments 05:43:12 INFO - [mozharness: 2016-11-21 13:43:12.744054Z] Finished download-and-extract step (success) 05:43:12 INFO - [mozharness: 2016-11-21 13:43:12.744200Z] Running populate-webroot step. 05:43:12 INFO - Running pre-action listener: _resource_record_pre_action 05:43:12 INFO - Running main action method: populate_webroot 05:43:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:12 INFO - '--tppagecycles', 05:43:12 INFO - '7'], 05:43:12 INFO - 'tests': ['tsvgm']}}, 05:43:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:43:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:43:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:43:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:43:12 INFO - 'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:43:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:43:12 INFO - 'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['damp', 'tps']}, 05:43:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:43:12 INFO - 'tests': ['damp', 'tps']}, 05:43:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['dromaeo_dom']}, 05:43:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['basic_compositor_video']}, 05:43:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:43:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['a11yr', 05:43:12 INFO - 'ts_paint', 05:43:12 INFO - 'tpaint', 05:43:12 INFO - 'sessionrestore', 05:43:12 INFO - 'sessionrestore_no_auto_restore', 05:43:12 INFO - 'tabpaint']}, 05:43:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:43:12 INFO - 'ts_paint', 05:43:12 INFO - 'tpaint', 05:43:12 INFO - 'sessionrestore', 05:43:12 INFO - 'sessionrestore_no_auto_restore', 05:43:12 INFO - 'tabpaint']}, 05:43:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:43:12 INFO - 'ts_paint', 05:43:12 INFO - 'tpaint', 05:43:12 INFO - 'sessionrestore', 05:43:12 INFO - 'sessionrestore_no_auto_restore', 05:43:12 INFO - 'tabpaint']}, 05:43:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:43:12 INFO - 'ts_paint', 05:43:12 INFO - 'tpaint', 05:43:12 INFO - 'sessionrestore', 05:43:12 INFO - 'sessionrestore_no_auto_restore', 05:43:12 INFO - 'tabpaint']}, 05:43:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['a11yr', 05:43:12 INFO - 'ts_paint', 05:43:12 INFO - 'tpaint', 05:43:12 INFO - 'sessionrestore', 05:43:12 INFO - 'sessionrestore_no_auto_restore', 05:43:12 INFO - 'tabpaint']}, 05:43:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['a11yr', 05:43:12 INFO - 'ts_paint', 05:43:12 INFO - 'tpaint', 05:43:12 INFO - 'sessionrestore', 05:43:12 INFO - 'sessionrestore_no_auto_restore', 05:43:12 INFO - 'tabpaint']}, 05:43:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['tsvgx', 05:43:12 INFO - 'tsvgr_opacity', 05:43:12 INFO - 'tart', 05:43:12 INFO - 'tscrollx', 05:43:12 INFO - 'cart']}, 05:43:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:43:12 INFO - 'tsvgr_opacity', 05:43:12 INFO - 'tart', 05:43:12 INFO - 'tscrollx', 05:43:12 INFO - 'cart']}, 05:43:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:43:12 INFO - 'talos_options': ['--disable-e10s'], 05:43:12 INFO - 'tests': ['tp5o']}, 05:43:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:43:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:43:12 INFO - 'talos_options': ['--disable-e10s', 05:43:12 INFO - '--xperf_path', 05:43:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:12 INFO - 'tests': ['tp5n']}, 05:43:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:43:12 INFO - 'talos_options': ['--xperf_path', 05:43:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:12 INFO - 'tests': ['tp5n']}}, 05:43:12 INFO - 'talos.zip': {'path': '', 05:43:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:12 INFO - Running post-action listener: _resource_record_post_action 05:43:12 INFO - [mozharness: 2016-11-21 13:43:12.762411Z] Finished populate-webroot step (success) 05:43:12 INFO - [mozharness: 2016-11-21 13:43:12.762539Z] Running create-virtualenv step. 05:43:12 INFO - Running pre-action listener: _resource_record_pre_action 05:43:12 INFO - Running main action method: create_virtualenv 05:43:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:43:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:43:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:43:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:12 INFO - Using real prefix '/tools/python27' 05:43:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:43:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:16 INFO - Installing pip.................done. 05:43:16 INFO - Return code: 0 05:43:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:43:16 INFO - Reading from file tmpfile_stdout 05:43:16 INFO - Output received: 05:43:16 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) 05:43:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:16 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 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:16 INFO - 'HOME': '/Users/cltbld', 05:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:16 INFO - 'LOGNAME': 'cltbld', 05:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:16 INFO - 'MOZ_NO_REMOTE': '1', 05:43:16 INFO - 'NO_EM_RESTART': '1', 05:43:16 INFO - 'PAGER': '/bin/cat', 05:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:16 INFO - 'PWD': '/builds/slave/test', 05:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:16 INFO - 'SHELL': '/bin/bash', 05:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:16 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:16 INFO - 'USER': 'cltbld', 05:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:16 INFO - 'XPC_FLAGS': '0x0', 05:43:16 INFO - 'XPC_SERVICE_NAME': '0', 05:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:43:16 INFO - Cleaning up... 05:43:16 INFO - Return code: 0 05:43:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:17 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 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43:17 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 05:43:17 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 05:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:17 INFO - 'HOME': '/Users/cltbld', 05:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:17 INFO - 'LOGNAME': 'cltbld', 05:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:17 INFO - 'MOZ_NO_REMOTE': '1', 05:43:17 INFO - 'NO_EM_RESTART': '1', 05:43:17 INFO - 'PAGER': '/bin/cat', 05:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:17 INFO - 'PWD': '/builds/slave/test', 05:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:17 INFO - 'SHELL': '/bin/bash', 05:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:17 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:17 INFO - 'USER': 'cltbld', 05:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:17 INFO - 'XPC_FLAGS': '0x0', 05:43:17 INFO - 'XPC_SERVICE_NAME': '0', 05:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:17 INFO - Downloading/unpacking psutil>=3.1.1 05:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:20 INFO - Installing collected packages: psutil 05:43:20 INFO - Running setup.py install for psutil 05:43:20 INFO - building 'psutil._psutil_osx' extension 05:43:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:43:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:43:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:43:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:43:21 INFO - building 'psutil._psutil_posix' extension 05:43:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:43:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:43:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:43:21 INFO - ^ 05:43:21 INFO - 1 warning generated. 05:43:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:43:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:21 INFO - Successfully installed psutil 05:43:21 INFO - Cleaning up... 05:43:21 INFO - Return code: 0 05:43:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:43:21 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')]} 05:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:21 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')]} 05:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:43: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 mozsystemmonitor==0.3 05:43:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:21 INFO - 'HOME': '/Users/cltbld', 05:43:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:21 INFO - 'LOGNAME': 'cltbld', 05:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:21 INFO - 'MOZ_NO_REMOTE': '1', 05:43:21 INFO - 'NO_EM_RESTART': '1', 05:43:21 INFO - 'PAGER': '/bin/cat', 05:43:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:21 INFO - 'PWD': '/builds/slave/test', 05:43:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:21 INFO - 'SHELL': '/bin/bash', 05:43:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:21 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:21 INFO - 'USER': 'cltbld', 05:43:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:21 INFO - 'XPC_FLAGS': '0x0', 05:43:21 INFO - 'XPC_SERVICE_NAME': '0', 05:43:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:43:24 INFO - Installing collected packages: mozsystemmonitor 05:43:24 INFO - Running setup.py install for mozsystemmonitor 05:43:24 INFO - Successfully installed mozsystemmonitor 05:43:24 INFO - Cleaning up... 05:43:24 INFO - Return code: 0 05:43:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:43:24 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')]} 05:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:24 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')]} 05:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:24 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 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43:24 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 05:43:24 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 05:43:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:24 INFO - 'HOME': '/Users/cltbld', 05:43:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:24 INFO - 'LOGNAME': 'cltbld', 05:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:24 INFO - 'MOZ_NO_REMOTE': '1', 05:43:24 INFO - 'NO_EM_RESTART': '1', 05:43:24 INFO - 'PAGER': '/bin/cat', 05:43:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:24 INFO - 'PWD': '/builds/slave/test', 05:43:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:24 INFO - 'SHELL': '/bin/bash', 05:43:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:24 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:24 INFO - 'USER': 'cltbld', 05:43:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:24 INFO - 'XPC_FLAGS': '0x0', 05:43:24 INFO - 'XPC_SERVICE_NAME': '0', 05:43:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:25 INFO - Downloading/unpacking jsonschema==2.5.1 05:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:43:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:43:28 INFO - warning: no files found matching '*.txt' 05:43:28 INFO - no previously-included directories found matching 'build' 05:43:28 INFO - no previously-included directories found matching 'dist' 05:43:28 INFO - no previously-included directories found matching '.git*' 05:43:28 INFO - Installing collected packages: jsonschema, functools32 05:43:28 INFO - Running setup.py install for functools32 05:43:28 INFO - warning: no files found matching '*.txt' 05:43:28 INFO - no previously-included directories found matching 'build' 05:43:28 INFO - no previously-included directories found matching 'dist' 05:43:28 INFO - no previously-included directories found matching '.git*' 05:43:28 INFO - Successfully installed jsonschema functools32 05:43:28 INFO - Cleaning up... 05:43:28 INFO - Return code: 0 05:43:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:43:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:28 INFO - 'HOME': '/Users/cltbld', 05:43:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:28 INFO - 'LOGNAME': 'cltbld', 05:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:28 INFO - 'MOZ_NO_REMOTE': '1', 05:43:28 INFO - 'NO_EM_RESTART': '1', 05:43:28 INFO - 'PAGER': '/bin/cat', 05:43:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:28 INFO - 'PWD': '/builds/slave/test', 05:43:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:28 INFO - 'SHELL': '/bin/bash', 05:43:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:28 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:28 INFO - 'USER': 'cltbld', 05:43:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:28 INFO - 'XPC_FLAGS': '0x0', 05:43:28 INFO - 'XPC_SERVICE_NAME': '0', 05:43:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:43:28 INFO - Cleaning up... 05:43:28 INFO - Return code: 0 05:43:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:43:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:28 INFO - 'HOME': '/Users/cltbld', 05:43:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:28 INFO - 'LOGNAME': 'cltbld', 05:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:28 INFO - 'MOZ_NO_REMOTE': '1', 05:43:28 INFO - 'NO_EM_RESTART': '1', 05:43:28 INFO - 'PAGER': '/bin/cat', 05:43:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:28 INFO - 'PWD': '/builds/slave/test', 05:43:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:28 INFO - 'SHELL': '/bin/bash', 05:43:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:28 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:28 INFO - 'USER': 'cltbld', 05:43:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:28 INFO - 'XPC_FLAGS': '0x0', 05:43:28 INFO - 'XPC_SERVICE_NAME': '0', 05:43:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:43:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:33 INFO - Downloading docopt-0.6.1.tar.gz 05:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:33 INFO - Running setup.py install for blobuploader 05:43:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:43:34 INFO - Running setup.py install for requests 05:43:34 INFO - Running setup.py install for docopt 05:43:34 INFO - Successfully installed blobuploader requests docopt 05:43:34 INFO - Cleaning up... 05:43:34 INFO - Return code: 0 05:43:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:34 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 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:34 INFO - 'HOME': '/Users/cltbld', 05:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:34 INFO - 'LOGNAME': 'cltbld', 05:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:34 INFO - 'MOZ_NO_REMOTE': '1', 05:43:34 INFO - 'NO_EM_RESTART': '1', 05:43:34 INFO - 'PAGER': '/bin/cat', 05:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:34 INFO - 'PWD': '/builds/slave/test', 05:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:34 INFO - 'SHELL': '/bin/bash', 05:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:34 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:34 INFO - 'USER': 'cltbld', 05:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:34 INFO - 'XPC_FLAGS': '0x0', 05:43:34 INFO - 'XPC_SERVICE_NAME': '0', 05:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:35 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-4V54Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:35 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-AAMuyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:35 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-0c4P6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:35 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-5kyDxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:35 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-mWg2gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:35 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-k_5Pfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:35 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-RFtgTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:35 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-NrAbys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:35 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-ZpN13O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:36 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-pcqTWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:36 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-vf93H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:36 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-jm3At0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:36 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Jmt2kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:36 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Nw7H9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:36 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-UFCqM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:36 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-v8SE2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:36 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-4CGIgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:36 INFO - Running setup.py install for manifestparser 05:43:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for mozcrash 05:43:37 INFO - Running setup.py install for mozdebug 05:43:37 INFO - Running setup.py install for mozdevice 05:43:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for mozfile 05:43:37 INFO - Running setup.py install for mozhttpd 05:43:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for mozinfo 05:43:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for mozInstall 05:43:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Running setup.py install for mozleak 05:43:38 INFO - Running setup.py install for mozlog 05:43:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Running setup.py install for moznetwork 05:43:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Running setup.py install for mozprocess 05:43:38 INFO - Running setup.py install for mozprofile 05:43:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Running setup.py install for mozrunner 05:43:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:43:39 INFO - Running setup.py install for mozscreenshot 05:43:39 INFO - Running setup.py install for moztest 05:43:39 INFO - Running setup.py install for mozversion 05:43:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:43:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:39 INFO - Cleaning up... 05:43:39 INFO - Return code: 0 05:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:39 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 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:39 INFO - 'HOME': '/Users/cltbld', 05:43:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:39 INFO - 'LOGNAME': 'cltbld', 05:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:39 INFO - 'MOZ_NO_REMOTE': '1', 05:43:39 INFO - 'NO_EM_RESTART': '1', 05:43:39 INFO - 'PAGER': '/bin/cat', 05:43:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:39 INFO - 'PWD': '/builds/slave/test', 05:43:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:39 INFO - 'SHELL': '/bin/bash', 05:43:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:39 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:39 INFO - 'USER': 'cltbld', 05:43:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:39 INFO - 'XPC_FLAGS': '0x0', 05:43:39 INFO - 'XPC_SERVICE_NAME': '0', 05:43:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:39 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-CEchi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:39 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-upJehZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:39 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)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:39 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-rTtdHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:40 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-O5Zg3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:40 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)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:40 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-LvQXOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:40 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-27kJHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:40 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-RiWXys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:40 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-U2MiTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:40 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-PnZ3DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:40 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-hU8ek5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:40 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)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:40 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-XhqBlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:40 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-z_Zue3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:41 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)) 05:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:41 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-11Zc6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:41 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-0tTt3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:41 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)) 05:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:41 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-XSqWQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:41 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Wkadki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:41 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-CcsBkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:43:41 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)) 05:43:41 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)) 05:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:41 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)) 05:43:41 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)) 05:43:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:44 INFO - Downloading blessings-1.6.tar.gz 05:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:44 INFO - Installing collected packages: blessings 05:43:44 INFO - Running setup.py install for blessings 05:43:44 INFO - Successfully installed blessings 05:43:44 INFO - Cleaning up... 05:43:44 INFO - Return code: 0 05:43:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:44 INFO - Reading from file tmpfile_stdout 05:43:44 INFO - Current package versions: 05:43:44 INFO - blessings == 1.6 05:43:44 INFO - blobuploader == 1.2.4 05:43:44 INFO - docopt == 0.6.1 05:43:44 INFO - functools32 == 3.2.3-2 05:43:44 INFO - jsonschema == 2.5.1 05:43:44 INFO - manifestparser == 1.1 05:43:44 INFO - mozInstall == 1.12 05:43:44 INFO - mozcrash == 1.0 05:43:44 INFO - mozdebug == 0.1 05:43:44 INFO - mozdevice == 0.49 05:43:44 INFO - mozfile == 1.2 05:43:44 INFO - mozhttpd == 0.7 05:43:44 INFO - mozinfo == 0.9 05:43:44 INFO - mozleak == 0.1 05:43:44 INFO - mozlog == 3.4 05:43:44 INFO - moznetwork == 0.27 05:43:44 INFO - mozprocess == 0.23 05:43:44 INFO - mozprofile == 0.28 05:43:44 INFO - mozrunner == 6.13 05:43:44 INFO - mozscreenshot == 0.1 05:43:44 INFO - mozsystemmonitor == 0.3 05:43:44 INFO - moztest == 0.7 05:43:44 INFO - mozversion == 1.4 05:43:44 INFO - psutil == 3.1.1 05:43:44 INFO - requests == 1.2.3 05:43:44 INFO - wsgiref == 0.1.2 05:43:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:45 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 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:45 INFO - 'HOME': '/Users/cltbld', 05:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:45 INFO - 'LOGNAME': 'cltbld', 05:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:45 INFO - 'MOZ_NO_REMOTE': '1', 05:43:45 INFO - 'NO_EM_RESTART': '1', 05:43:45 INFO - 'PAGER': '/bin/cat', 05:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:45 INFO - 'PWD': '/builds/slave/test', 05:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:45 INFO - 'SHELL': '/bin/bash', 05:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:45 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:45 INFO - 'USER': 'cltbld', 05:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:45 INFO - 'XPC_FLAGS': '0x0', 05:43:45 INFO - 'XPC_SERVICE_NAME': '0', 05:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:43:45 INFO - Cleaning up... 05:43:45 INFO - Return code: 0 05:43:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:46 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 0x10ef263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1bdc1490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, '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.qX6nBLpinX/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.mix9eykBTW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:43:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:43:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:43:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:43:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:43:46 INFO - 'HOME': '/Users/cltbld', 05:43:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:43:46 INFO - 'LOGNAME': 'cltbld', 05:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:46 INFO - 'MOZ_NO_REMOTE': '1', 05:43:46 INFO - 'NO_EM_RESTART': '1', 05:43:46 INFO - 'PAGER': '/bin/cat', 05:43:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:46 INFO - 'PWD': '/builds/slave/test', 05:43:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:43:46 INFO - 'SHELL': '/bin/bash', 05:43:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:43:46 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:43:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:43:46 INFO - 'USER': 'cltbld', 05:43:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:43:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:46 INFO - 'XPC_FLAGS': '0x0', 05:43:46 INFO - 'XPC_SERVICE_NAME': '0', 05:43:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:43:46 INFO - Cleaning up... 05:43:46 INFO - Return code: 0 05:43:46 INFO - Running post-action listener: _resource_record_post_action 05:43:46 INFO - Running post-action listener: _start_resource_monitoring 05:43:46 INFO - Starting resource monitoring. 05:43:46 INFO - [mozharness: 2016-11-21 13:43:46.317905Z] Finished create-virtualenv step (success) 05:43:46 INFO - [mozharness: 2016-11-21 13:43:46.318867Z] Running install step. 05:43:46 INFO - Running pre-action listener: _resource_record_pre_action 05:43:46 INFO - Running main action method: install 05:43:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:46 INFO - Reading from file tmpfile_stdout 05:43:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:43:46 INFO - Reading from file tmpfile_stdout 05:43:46 INFO - Output received: 05:43:46 INFO - Usage: mozinstall [options] installer 05:43:46 INFO - Options: 05:43:46 INFO - -h, --help show this help message and exit 05:43:46 INFO - -d DEST, --destination=DEST 05:43:46 INFO - Directory to install application into. [default: 05:43:46 INFO - "/builds/slave/test"] 05:43:46 INFO - --app=APP Application being installed. [default: firefox] 05:43:46 INFO - mkdir: /builds/slave/test/build/application 05:43:46 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'] 05:43:46 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 05:44:19 INFO - Reading from file tmpfile_stdout 05:44:19 INFO - Output received: 05:44:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:44:19 INFO - Running post-action listener: _resource_record_post_action 05:44:19 INFO - [mozharness: 2016-11-21 13:44:19.216088Z] Finished install step (success) 05:44:19 INFO - [mozharness: 2016-11-21 13:44:19.216245Z] Running run-tests step. 05:44:19 INFO - Running pre-action listener: _resource_record_pre_action 05:44:19 INFO - Running main action method: run_tests 05:44:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:44:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:44:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:44:19 INFO - 2016-11-21 05:44:19.230 screenresolution[1643:7305] starting screenresolution argv=screenresolution get 05:44:19 INFO - 2016-11-21 05:44:19.233 screenresolution[1643:7305] Display 0: 1600x1200x32@60 05:44:19 INFO - 2016-11-21 05:44:19.238 screenresolution[1644:7307] starting screenresolution argv=screenresolution list 05:44:19 INFO - Available Modes on Display 0 05:44:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:44:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:44:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:44:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:44:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:44:19 INFO - Intel Iris: 05:44:19 INFO - Chipset Model: Intel Iris 05:44:19 INFO - Type: GPU 05:44:19 INFO - Bus: Built-In 05:44:19 INFO - VRAM (Dynamic, Max): 1536 MB 05:44:19 INFO - Vendor: Intel (0x8086) 05:44:19 INFO - Device ID: 0x0a2e 05:44:19 INFO - Revision ID: 0x0009 05:44:19 INFO - Displays: 05:44:19 INFO - Display: 05:44:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:44:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:44:19 INFO - Display Serial Number: 1600x1200 60 05:44:19 INFO - Main Display: Yes 05:44:19 INFO - Mirror: Off 05:44:19 INFO - Online: Yes 05:44:19 INFO - Rotation: Supported 05:44:19 INFO - Return code: 0 05:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:44:19 INFO - Python 2.7.3 05:44:19 INFO - Return code: 0 05:44:19 INFO - grabbing minidump binary from tooltool 05:44: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')]} 05:44:19 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 0x10ed3cd30>, '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 0x10eba3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed34b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:44:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:44:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:44:19 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 05:44:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:19 INFO - Return code: 0 05:44:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:44:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:44:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:44:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:44:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0373 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX6nBLpinX/Render', 05:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:44:19 INFO - 'HOME': '/Users/cltbld', 05:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:44:19 INFO - 'LOGNAME': 'cltbld', 05:44:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:44:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:19 INFO - 'MOZ_NO_REMOTE': '1', 05:44:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:44:19 INFO - 'NO_EM_RESTART': '1', 05:44:19 INFO - 'PAGER': '/bin/cat', 05:44:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:19 INFO - 'PWD': '/builds/slave/test', 05:44:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:44:19 INFO - 'SHELL': '/bin/bash', 05:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mix9eykBTW/Listeners', 05:44:19 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:44:19 INFO - 'USER': 'cltbld', 05:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:19 INFO - 'XPC_FLAGS': '0x0', 05:44:19 INFO - 'XPC_SERVICE_NAME': '0', 05:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:44:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:44:19 INFO - mozversion application_buildid: 20161121031409 05:44:19 INFO - mozversion application_changeset: 0a335e78a46864a25041bfb411d64ce573fa0e1e 05:44:19 INFO - mozversion application_display_name: Nightly 05:44:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:19 INFO - mozversion application_name: Firefox 05:44:19 INFO - mozversion application_remotingname: firefox 05:44:19 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 05:44:19 INFO - mozversion application_vendor: Mozilla 05:44:19 INFO - mozversion application_version: 53.0a1 05:44:19 INFO - mozversion platform_buildid: 20161121031409 05:44:19 INFO - mozversion platform_changeset: 0a335e78a46864a25041bfb411d64ce573fa0e1e 05:44:19 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 05:44:19 INFO - mozversion platform_version: 53.0a1 05:44:19 INFO - using testdate: 1479735859 05:44:19 INFO - actual date: 1479735859 05:44:19 INFO - starting webserver on 'localhost:49236' 05:44:19 INFO - SUITE-START | Running 2 tests 05:44:19 INFO - TEST-START | dromaeo_css 05:44:19 INFO - operating with platform_type : mac_ 05:44:19 INFO - Initialising browser for dromaeo_css test... 05:44:19 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpu_p2IY/profile http://localhost:49236/getInfo.html) 05:44:22 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 05:44:22 INFO - PROCESS | 1654 | colorDepth:24 05:44:22 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 05:44:22 INFO - PROCESS | 1654 | __metrics 05:44:22 INFO - PROCESS | 1654 | 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" 05:44:22 INFO - PROCESS | 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:44:23 INFO - TEST-INFO | 1654: exit 0 05:44:23 INFO - Browser initialized. 05:44:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:23 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpu_p2IY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:35 INFO - PROCESS | 1657 | RSS: Main: 244146176 05:44:35 INFO - PROCESS | 1657 | 05:45:27 INFO - PROCESS | 1657 | 1479735927396 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:47:39 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 05:47:42 INFO - PROCESS | 1657 | RSS: Main: 521846784 05:47:42 INFO - PROCESS | 1657 | 05:50:45 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 05:50:46 INFO - PROCESS | 1657 | RSS: Main: 369729536 05:50:46 INFO - PROCESS | 1657 | 05:53:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 05:53:49 INFO - PROCESS | 1657 | RSS: Main: 348372992 05:53:49 INFO - PROCESS | 1657 | 05:56:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 05:56:52 INFO - PROCESS | 1657 | RSS: Main: 347549696 05:56:52 INFO - PROCESS | 1657 | 05:59:55 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 05:59:56 INFO - PROCESS | 1657 | RSS: Main: 327204864 05:59:56 INFO - PROCESS | 1657 | 06:03:00 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 06:03:00 INFO - PROCESS | 1657 | RSS: Main: 445624320 06:03:00 INFO - PROCESS | 1657 | 06:03:00 INFO - PROCESS | 1657 | __start_tp_report 06:03:00 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 06:03:00 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 06:03:00 INFO - PROCESS | 1657 | |i|pagename|runs| 06:03:00 INFO - PROCESS | 1657 | |0;dojo.html;3262.3964566555187;3299.851506682199;3300.306935543534;3302.45509490934;3351.983240083799;5195.714235717034;5504.834854954348;5556.638818476797;5653.971730141348;5667.489925906662;4154.875353739385;5603.887922241563;5622.269105016342;5626.156076588503;5632.99999999999;5069.569086627641;5092.79628814847;5109.872253193681;5118.0019896120275;5189.455107213745;5108.719020453892;5175.938932518825;5187.818426355078;5191.221316802491;5208.76560554774;5082.567981721558;5137.178051511759;5154.123798954187;5171.120909445384;5172.172452407615;5179.352580927384;5209.166533354645;5209.53114219722;5225.843224703265;5228.686278823283;5003.324551185616;5007.9499205008215;5058.342415485963;5137.40919794221;5149.3305870237;5544.251526043973;5551;5634.661920284796;5639.323281206241;5648.43515648436;5053.797848086072;6085.969570152165;6089.939100608982;6111.205543279345;6112.480439162677;6188.412100850412;6208.782692605782;6209.037599172136;6209.348018458042;6223.844403889939;5563.638363506359;5632.718364081779;5637.3235211774845;5652.576056795757;5679.290088738949;6254.9687251563455;6304.401081897213;6319.988801791691;6323.30443651198;6333.271673757485;5975.940240597625;6010.729517171738;6020.759169633253;6024.457798798129;6031.155638210654;5938.2280303560265;6060.2424696912885;6070.453659170696;6191.690415479208;6201.875962480725;4995.300657907896;6040.848978775566;6049.848753781191;6051.697415129314;6060.303065147476;6050.485708714808;6061.696915154224;6062.302835173923;6073.544484163705;6116.052011938156;4844.394450693663;4881.658283920092;4883.975580122076;4916.8770780730765;4918.286848407032;4288.7855607220135;4351.456067991501;4359.673024523174;4395.7362558246605;4420.381146639473;5542.667439953616;5592.7762889484775;5676.262085928803;5677.347105082886;5700.657960522382;6120.416658368064;6131.193168498116;6132.661461321608;6145.647957449354;6150.231221097363;5591.496765291144;5593.3847276799515;5637.46444087811;5652.0391533439415;5744.798932037359;5265.868353291198;5312.1766126250495;5319.494648008433;5322;5346.358436987509;6220.346863579259;6315;6320.304766475684;6327;6345.079963405188;6045.939540604713;6105.145279660762;6123.14276001369;6137.468918203611;6154.107654390178;6142.590862071594;6193.318734939063;6274.968625156845;6301.306856245901;6310.211223597051;6031.155638210742;6102.484703961281;6111.327753947151;6111.8956224267595;6116.8227554565365;5618.747156378055;6214.316425193135;6214.844628884314;6216.222972128484;6217.502599792097;5773.769049237983;5841.649501029951;5850.824475265749;5914.881702366015;5915.112733089899;5898.64608123514;5900.763969441346;5904.173415721888;5908.881822363614;5908.940910590839;5730.942690573041;5760.539156867357;5761.769529218785;5763.02028655138;5768.653880767168;5786.508146807569;5883.999720047516;5906.114082887601;5921.822345329647;5927.081302398135;5774.931637647049;5777.480026797609;5781.566382521243;5786.161006653927;5791 06:03:00 INFO - PROCESS | 1657 | |1;ext.html;484.9296851956465;491.02531475022084;491.3734987890437;535.6973310079804;539.8124126920775;30684.07947761565;37287.62712372875;37761.67834125806;38187.42718859219;41339.173216535724;39900.600993990054;40229.396559051565;40274.99999999993;40325.798371008175;40373.59626403735;8474.872876906851;9335.299852511054;9483.241340692728;9529.237660987104;9548.952255238713;8409.579521023956;11064.557417703281;11323.150763692714;11367.31796092233;11518;11220.990110890018;11294;11326;11339.546418143264;11345.09239260857;8481.618327175293;11243.156763242749;11338.376389298584;11339.319640821495;11341.603043893425;8444.197801208937;10987.61543345979;11287.040601548879;11295;11501.597444089417;38546.22907541862;38833.417498737545;38843.61156388428;38856.22287554261;38902.02744931371;2769.5568709006666;3245.399601073785;3332.01705496879;3364.96635033649;3617.222297206113;29068.41863162746;29361.41277174466;29662.70337296621;30528.08415747509;30646.54030189549;3138.6390565084853;3138.905832825019;3173.6032995875516;3205.5512228288057;3256.7068963793135;470803;483695;488842;489178.1082189168;490217;43493.56506434958;52130.47869521332;52557.73721131447;52683.47316526786;52687;30806.69193308083;31174;31306.843465782524;31381.8430907844;58625.706871466224;15554.988925720018;15631.921840390725;15653.60865978337;15671.843281567266;15678.68642627141;10783.299085559414;11007.229493935347;11892.524299028115;11997.940010300068;12003.63989080329;16118.113503757171;17916.283348665907;18042.63914721698;18405.26378944854;18620.882747035223;6310.245403984622;7377.93020012106;7471;7558.433117516208;7568.167501574822;749.8125468632842;844.7043534762906;972.9659461918799;1040.5837664934088;1059.9099076578423;24128;27750.306242344104;28534;28823.71176288252;29328.706712933024;849.6389034660244;894.4365050018447;1004.638330201127;1031.3554028732042;1106.883777203398;13351.93184545234;14379.928100359431;14518.637034074232;14875;14966.850331496546;544953;606796;609403;789284;790759;54649.45350546523;55192.44807551953;55380.89238215213;55419.72290138604;55558;1183.7573297473998;1215.9939200303943;1221.8167274908835;1265.4621785741024;1334.873187047229;23354;28869.566956495248;28929.56605650959;29046.27384315409;30440.543391849584;47266.52733472621;47845.76077119731;47854.34330507102;47986.28020579624;48051.75974120247;520444;525205;525378;525993;527110;25528;25991;26130.346741330857;26381.812818422834;26412.735872641028;41776.1644767109;41885.371719424846;44445.10488644576;44586.77706611446;45598.31602525898;37244.6275537252;37295.44056839204;37331.81334093312;37966;38401;36828.212332396615;37006.68169256236;37568.62431375651;37811.243775124894;38320;36056.639433606375;36386.8180659095;36869;37085.44371834479;37337;32081.67918320787;32984;33147;33330.66669333276;33539;23754.881225593763;24109.638355425035;24214.91032903559;24525.632115517925;24573.631395528722 06:03:00 INFO - PROCESS | 1657 | |2;jquery.html;332.7687257356137;347.9895603131907;370.2225326813691;378.48148037189054;378.88796382617005;14467.927660361696;14731.926340368296;15377.000494967819;19079.332223372185;19531.90234048828;18320.633587328244;19417.611647767073;19618.70571941422;19909.104090315934;19939.900300498477;5724.427557244274;6113.6943152842405;6115;6119.204503414549;6121.051237058263;5725.856853578673;5950.940490595082;5961.731722072495;6000.75996960121;6006.909896351558;5942.5840191186635;5952.523798096164;5954.13665018572;5954.791582294621;5961.254843144607;5641.435856414367;5852.239208902836;5907.852303692399;5921.792737254175;5940.316863560703;4920.655554111214;5159.5614372778355;5160.0969830279555;5162.277281180638;5167.844964651066;24188;24648.876755616107;24674;24978.500429991298;25014.874925625438;2404.3989002749313;2422.1643532981093;2550.7831834294107;2560;2836.886524539016;14892.478763243234;14982.026168299026;15069.547913562501;15429.997050191701;15611.765823512544;1731.9480415587552;1785.7053586158268;1802.630460755542;1854.7866995295578;1892.3944337811906;99964;108377.45811270972;120398.39800801028;125692;126099.99999999908;10967;11342.376169310766;11511.30932144074;11514.596989105341;11724.413779311;14494.565163045125;14494.855051449562;14521.346539405753;14523.273836308354;14524.419023239163;8010.5994700264755;8185.467944583583;8214.58927053657;8286.4199506034;8422.368322375847;8101.797455063553;8111.984567639057;8131.105578386373;8289.4197406181;8295.087540370554;4380.474343078851;4500.717295570812;4502.906148640897;4555.430571178603;4566.817327306937;1753.9824601754074;1834.2296235581089;1884.5288677830542;1886.9433916982512;1889.0932352470616;690.9378155965886;727.672547353693;794.6424109150789;822.6750433578703;987.693814917378;19926;20282;20518.487037824172;20626.793732062786;20677.27629532989;888.626776753765;902.1339514066569;911.2072496927715;927.6706769097009;942.7360339105062;8863.734087977371;10017.899821001696;10798.622048228432;10826.458677066115;10873.912608739221;556654;567628;569257.9982301138;578013;580340;93281;119745;131900;132160.6959826012;135695.32152339176;930.9394889332171;945.8439357506072;954.990450095518;965.3435663748578;965.35803690545;17269.827301727324;17695.557611059827;17917.910410447865;18404.26382944721;18406.447806565826;51773.96452071013;52002.47997520128;52265.7386713064;52905;53081.73459132834;56234.437655624555;56395.718021411274;75574.62212688901;76104.23895760972;77305.61347193229;7646.350060244719;7791.961040194763;7871.527708337518;7959.965204523375;7973.362131029619;9250.444973301623;10386.48067596602;11770.117241207116;11862.84892201328;12236;10330.48347582633;10565.894341056799;10878.673639790819;10895.891041089488;10915.181361398085;10287.53706083243;10339.741506462398;10381.221408394249;10803.405812680377;10878.40168790724;10731.248812583357;10895.291806032583;10979.231453798158;11010.229283950046;11116.388598627153;7716.305532502101;7837.568933708701;7964.084130325086;7993;8159.592020399075;10470.738231543968;10733.785324293314;10750.892491074988;10814.080803131506;10825 06:03:00 INFO - PROCESS | 1657 | |3;mootools.html;1491.559989803008;1511.5918701950475;1676.2289346900425;1809.6833054215508;1844.0687452836323;7407.851842963138;8212.301954333881;8217.671293148267;8223.259906608404;8354.95822520888;7399.926000740004;7624.542527448343;7630.923690763091;7943.324817390529;8172.141925097868;1861.823126802955;2304.135949019118;2309.1802410144323;2310.318456055459;2311.919082832101;2296.9655455168104;2326.6975293211945;2336.7663233676667;2354.176038386568;2360.445295355599;2284.565932472833;2284.931452056441;2310.260716570698;2313.410080429488;2314.7569505201964;2275.5221403505284;2300.723913130435;2303.1363238785457;2303.435658263736;2303.4586872084965;2287.222344402911;2315.305408377497;2316.131450705985;2316.7567405422355;2316.895739691718;8228.588570571448;8285.337173026144;8313.168683131698;8324;8332.62503187358;4988.326575912241;5121.923171152435;5153.2270159476;5181.818636347747;5203.9219411708855;2717.605947137654;3217.9678203217904;3537.028895727601;3555.982220088909;3557.7153827693724;902.7201567514026;1055.4247934875511;1086.869575650927;1099.1701265544543;1100.7468282295038;10389;10705.625303114353;10709.625163119332;10875.401852898009;10926.726831829188;4211.7262377945335;4260.446142001582;4438.356438316426;4443.488998765119;4467.307567327004;8543.530105844115;8563.400561960603;8564;8568.228859402683;8574.528400938008;4308.569143085666;5031;5060.367454068241;5063.8987220255385;5069.898602027939;3743.5694895087413;4044.373122166069;4232.238197124547;4724.551167639069;4739.715617062987;3108.3783243350967;3471.7049050830456;3502.141975216088;3631.618680038611;3638.599754027055;1114.8383484394717;1115.2472081345222;1126.6507382711386;1141.69174322934;1141.9429028548539;857.2070834478083;867.1328671328671;874.4622057434759;895.3463971300856;918.7840857398506;5381.461853814587;5486.643368181056;5563.332400112013;5673.687947162863;5770.538356931435;901.3960646366819;968.3608818179968;1009.8283291840405;1010.4240582867695;1030.0935177044153;3191.776575639683;3516.9472457913153;3594.6405359463843;3723.72072094594;3794.4118661607495;8363.62363693623;10004.899951000396;10118.696439106838;10120.139788117945;10130.746731331628;10023.799524009479;10070.748231294276;10081.899181008243;10091.798164036678;10125.797484050277;7305.342519173194;7589.772306830804;7703.882936974107;7712.383009359238;7803.219678032265;5435.83692489226;5558.24963629921;5578.748956296895;5638.21065050885;5684.658920464785;9080.63677452921;9098.317626178195;9236.953815230881;9294.349395542247;9429.104235097655;9405.341626086109;9441.527923603655;9463.479508627091;9476.33665643426;9659.46872921996;6560.737570497126;6782.626955517494;7025.964870175821;7193.352598265972;7221.4222862169845;7135.357817796424;7774.727884524014;7855.214478552099;7959.243871832166;7963.7212697557625;6813;6843.726250950105;6938.444924406136;7000;7055.082839231072;6922.930770692228;6926.757563485254;6952.687129079102;6985.685644146127;7039.331263529956;6288;6477.935220647733;6582.3746744059235;6587.505937054644;6649.501287403561;4644.535546445329;4718.292256161603;4734.21885388907;4767.141914455431;4876.366072410564;4118.402831589463;4752.9287060694805;4829.082474329866;4855.805767769391;4892.119418504703 06:03:00 INFO - PROCESS | 1657 | |4;prototype.html;296.1973053026299;298.88642315919947;305.4227510006088;311.05904638468627;313.7474333161804;4563.543645635435;5000.59995200384;5148.691078535286;5156.639035267533;5272.683638981659;4169.228078066817;4666.323383109456;4944.258361245815;4950.900981980359;5095.312132862063;3966.2860685076676;3975.70182236332;3997.460342853721;4003.4195041718935;4005.83976640934;3577.6601222883914;3705.8135699937034;3926.921461570767;3967.4643923070303;3984.561698213194;3897.9025524361978;3915.4714113594728;3920.980395098035;3927.371620540714;3930.351492003816;3911.2008476101028;3914.823832927525;3919.902002449933;3924.2151569686175;3936.134050508898;3263.624683161443;3407.6592340765974;3413.709834664032;3417.487376893486;3436.367725330473;4177.4778152730905;4597.793099310539;5032.9245061323745;5079.6952182869145;5136.864823816826;3621.6016238213774;4125.401816736587;4357.932306584907;4494.797549200901;4510.797014134372;5160.845174644766;5391.757370918318;5399.757010934517;5459.727013649302;5497.752601132958;3677.485152078711;3697.85208591656;3701.908421741707;3702.981485092584;3748.3440397930526;4272.764997925113;4845.588125009378;5385.899499195317;5750.95199544238;5927.992241318986;3775.6979441644603;3784.280986612535;3803.6386543278345;3805.5243094613174;3813.580506144322;3254.8047117173046;3705.481232627434;3773.811309434517;3834.271488417192;3871;4113.547509773923;4433.578810013044;4475;4479.507254202035;4492.865214043584;4152.43942067823;4320.660595215493;5410.161424979135;5433.456654334614;5437.32033495813;1106.8893110688866;1189.8869607387285;1190.6487586162102;1219.8963088137607;1248.9812652810215;713.12642013533;830.7092517618906;841.6002398860493;851.7827953871847;863.179979019921;4710.788014539354;4720.669553131248;4727.3854398927915;4749.810007599657;4757.785899634525;4477;4574.954250457519;4798.328234047236;4945.282933974626;4948.455669876311;4241.539906854017;4790.880227994258;4793.688410253392;4800.423949126127;4828.5412885775795;2268.4895898422724;2677.892884284646;2704.756571908538;2742.2732975761437;2755.76575991043;4815.927761083516;4857.344258525124;4939.777710002986;5326.791834450741;5417.729113544307;4378.233809083397;4909.337239472697;4957.355543779286;5288.2596436498925;5333.626646134733;4232.661387089025;5276.709780962007;5375.516203541543;5395.919061214085;5418.8916221675345;4748;4800.951990480051;4810.807567697253;5007.749612519432;5142.614303927146;4488.865334039984;4595.080983803319;4928.359313289393;5047.470015648304;5183.926429428108;4938.481459446706;4974.825881094144;5560.4161563035295;5717.342505611908;5792.507636850914;3281.5898012748407;3284.786488878215;3763.811809409464;3776.4712940187846;3795.715321350965;5075.264086707481;5468.894475626833;5635;5642.351129620146;5657.60396772222;4923.507649235191;5210.947890521046;5403.919216156863;5452.291202143854;5630.930123276565;4130.191469800565;4341.37050127736;5416.377116631637;5463.808766693147;5471.425500322409;5024.899502009866;5331.5201631853315;5336.573074153981;5384.949934762683;5390.353157621111;5514.724263786715;5520.254765606592;5535.7785688572;5547.639403438763;5558.499735023867;4516.683832131851;5302.8939421212135;5381.623286369917;5384.811531596375;5404.297441332759 06:03:00 INFO - PROCESS | 1657 | |5;yui.html;683.9897401538976;708.7448518533324;732.2604169788513;762.2910693055463;779.5907148746907;13969.09200901942;14813.333399996998;14890.776638350406;14907.180105094229;14918.403263869459;13358.66603334917;13469.124506907045;13475.528356507524;13491.123076999987;13507.459701611948;646.983825404364;662.4270006444439;670.1121014655577;799.564237490569;816.2898278497686;777.5179388778965;796.4902462424025;799.168864381043;805.2028491793112;809.1665584448028;862.706679728892;864.9437786543886;865.909079546648;865.9480431174118;866.4108406283724;684.1004079635263;860.4579115157442;863.0463338011532;863.8833757442759;864.4942708515463;522.728181345702;525.4325328645092;526.9789208431658;527.9862663685694;528.4952870009132;13277.46890124394;13734.45062197511;13778.586642400744;14127.576172714835;14194.787078193835;13168;13526.90195609858;13545.119567228197;13619.455221791117;13697.301728533339;11063.391513466757;11123.610673626465;11166.497507612095;11243;11546.960773530423;3656.140806910374;3656.933038926257;3658.32321020612;3694.07648087978;3822.560405553369;85989;86689;86752.56623716842;86991;89029;10689.465526723789;10806.08148307387;10843.51204195813;10890.891091088988;10905.672829815117;20856.89571552163;21000.36998890036;21025.26411575618;21064.78935210659;21082.89458552728;7416.925830741731;7522.210167932398;7637.045369328834;7640.197779233101;7650.846983060308;4160.18876319121;4251.256030194703;4261.424707664488;4261.765602891809;4275.358696195533;3197.2646291353117;3332.8833490827706;3339.833008349621;3601.819909004539;3781.243751249761;659.3274859643137;674.130371820356;675.7364627795164;688.9276625954203;691.405391363427;570.54356514788;592.3868795796416;616.6617254669469;631.5610650597882;650.2229835346715;7520.699172033057;8646.956765216133;8871.733847984571;8875.955620221857;8982.101789820965;524.6222719641928;539.6033915072419;586.571802584116;610.4048552661209;666.7857355480195;4277.422547956048;4308.590683885026;4324.913501729948;4386.407834942242;4478.888027799331;72332.63833680798;106755.46622266839;110460.4476977626;115452;121199.39400303118;67901;78824.63526094226;83974;98313;99115.50442247743;87476.5626171865;88611;89524.552377239;89825;90293.54853225691;8393.286570641563;8444.493330400195;8518.148185181431;8653.783655408664;8757.817694611145;45938;49219;49303.50696492989;49979.75010124926;52260.477395225564;48799.756001219765;53779.19331209957;64127.679361602895;66763.66618166878;71744.28255717584;11950.940245298718;12255.264684118982;12500.937495312466;12635.810462842881;12790.552330668754;13799.79300310476;14087.718245634826;14251.21618311003;14335.875893946275;14518.927405362905;12227.388630568257;12637.17858339205;12811.80782288285;13129.667209820927;13366.465341386236;12821.216917216323;12940;13156.802647960098;13326.866731332562;13559.254241016839;12533.248005119722;12590.055745819283;12662.113652044269;12896;13425.597232083053;9773.951130244302;10496.632617858644;10541.894581054397;10545.789084218426;10627.415492148006;8416.410851240355;8775.341849361195;9609.087136722;10985.505652245509;11210.047145992681 06:03:00 INFO - PROCESS | 1657 | __end_tp_report 06:03:00 INFO - PROCESS | 1657 | __start_cc_report 06:03:00 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,3360 06:03:00 INFO - PROCESS | 1657 | __end_cc_report 06:03:00 INFO - PROCESS | 1657 | __startTimestamp1479736980273__endTimestamp 06:03:00 INFO - PROCESS | 1657 | 06:03:00 INFO - PROCESS | 1657 | ------- Summary: start ------- 06:03:00 INFO - PROCESS | 1657 | Number of tests: 6 06:03:00 INFO - PROCESS | 1657 | 06:03:00 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5622.67 Median:5768.65 stddev:635.57 (11.0%) stddev-sans-first:609.95 06:03:00 INFO - PROCESS | 1657 | Values: 3262.4 3299.9 3300.3 3302.5 3352.0 5195.7 5504.8 5556.6 5654.0 5667.5 4154.9 5603.9 5622.3 5626.2 5633.0 5069.6 5092.8 5109.9 5118.0 5189.5 5108.7 5175.9 5187.8 5191.2 5208.8 5082.6 5137.2 5154.1 5171.1 5172.2 5179.4 5209.2 5209.5 5225.8 5228.7 5003.3 5007.9 5058.3 5137.4 5149.3 5544.3 5551.0 5634.7 5639.3 5648.4 5053.8 6086.0 6089.9 6111.2 6112.5 6188.4 6208.8 6209.0 6209.3 6223.8 5563.6 5632.7 5637.3 5652.6 5679.3 6255.0 6304.4 6320.0 6323.3 6333.3 5975.9 6010.7 6020.8 6024.5 6031.2 5938.2 6060.2 6070.5 6191.7 6201.9 4995.3 6040.8 6049.8 6051.7 6060.3 6050.5 6061.7 6062.3 6073.5 6116.1 4844.4 4881.7 4884.0 4916.9 4918.3 4288.8 4351.5 4359.7 4395.7 4420.4 5542.7 5592.8 5676.3 5677.3 5700.7 6120.4 6131.2 6132.7 6145.6 6150.2 5591.5 5593.4 5637.5 5652.0 5744.8 5265.9 5312.2 5319.5 5322.0 5346.4 6220.3 6315.0 6320.3 6327.0 6345.1 6045.9 6105.1 6123.1 6137.5 6154.1 6142.6 6193.3 6275.0 6301.3 6310.2 6031.2 6102.5 6111.3 6111.9 6116.8 5618.7 6214.3 6214.8 6216.2 6217.5 5773.8 5841.6 5850.8 5914.9 5915.1 5898.6 5900.8 5904.2 5908.9 5908.9 5730.9 5760.5 5761.8 5763.0 5768.7 5786.5 5884.0 5906.1 5921.8 5927.1 5774.9 5777.5 5781.6 5786.2 5791.0 06:03:00 INFO - PROCESS | 1657 | 06:03:00 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:67728.86 Median:19710.80 stddev:152121.98 (771.8%) stddev-sans-first:152464.94 06:03:00 INFO - PROCESS | 1657 | Values: 484.9 491.0 491.4 535.7 539.8 30684.1 37287.6 37761.7 38187.4 41339.2 39900.6 40229.4 40275.0 40325.8 40373.6 8474.9 9335.3 9483.2 9529.2 9549.0 8409.6 11064.6 11323.2 11367.3 11518.0 11221.0 11294.0 11326.0 11339.5 11345.1 8481.6 11243.2 11338.4 11339.3 11341.6 8444.2 10987.6 11287.0 11295.0 11501.6 38546.2 38833.4 38843.6 38856.2 38902.0 2769.6 3245.4 3332.0 3365.0 3617.2 29068.4 29361.4 29662.7 30528.1 30646.5 3138.6 3138.9 3173.6 3205.6 3256.7 470803.0 483695.0 488842.0 489178.1 490217.0 43493.6 52130.5 52557.7 52683.5 52687.0 30806.7 31174.0 31306.8 31381.8 58625.7 15555.0 15631.9 15653.6 15671.8 15678.7 10783.3 11007.2 11892.5 11997.9 12003.6 16118.1 17916.3 18042.6 18405.3 18620.9 6310.2 7377.9 7471.0 7558.4 7568.2 749.8 844.7 973.0 1040.6 1059.9 24128.0 27750.3 28534.0 28823.7 29328.7 849.6 894.4 1004.6 1031.4 1106.9 13351.9 14379.9 14518.6 14875.0 14966.9 544953.0 606796.0 609403.0 789284.0 790759.0 54649.5 55192.4 55380.9 55419.7 55558.0 1183.8 1216.0 1221.8 1265.5 1334.9 23354.0 28869.6 28929.6 29046.3 30440.5 47266.5 47845.8 47854.3 47986.3 48051.8 520444.0 525205.0 525378.0 525993.0 527110.0 25528.0 25991.0 26130.3 26381.8 26412.7 41776.2 41885.4 44445.1 44586.8 45598.3 37244.6 37295.4 37331.8 37966.0 38401.0 36828.2 37006.7 37568.6 37811.2 38320.0 36056.6 36386.8 36869.0 37085.4 37337.0 32081.7 32984.0 33147.0 33330.7 33539.0 23754.9 24109.6 24214.9 24525.6 24573.6 06:03:00 INFO - PROCESS | 1657 | 06:03:00 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:33587.40 Median:1584.83 stddev:95263.07 (6010.9%) stddev-sans-first:95497.58 06:03:00 INFO - PROCESS | 1657 | Values: 332.8 348.0 370.2 378.5 378.9 14467.9 14731.9 15377.0 19079.3 19531.9 18320.6 19417.6 19618.7 19909.1 19939.9 5724.4 6113.7 6115.0 6119.2 6121.1 5725.9 5950.9 5961.7 6000.8 6006.9 5942.6 5952.5 5954.1 5954.8 5961.3 5641.4 5852.2 5907.9 5921.8 5940.3 4920.7 5159.6 5160.1 5162.3 5167.8 24188.0 24648.9 24674.0 24978.5 25014.9 2404.4 2422.2 2550.8 2560.0 2836.9 14892.5 14982.0 15069.5 15430.0 15611.8 1731.9 1785.7 1802.6 1854.8 1892.4 99964.0 108377.5 120398.4 125692.0 126100.0 10967.0 11342.4 11511.3 11514.6 11724.4 14494.6 14494.9 14521.3 14523.3 14524.4 8010.6 8185.5 8214.6 8286.4 8422.4 8101.8 8112.0 8131.1 8289.4 8295.1 4380.5 4500.7 4502.9 4555.4 4566.8 1754.0 1834.2 1884.5 1886.9 1889.1 690.9 727.7 794.6 822.7 987.7 19926.0 20282.0 20518.5 20626.8 20677.3 888.6 902.1 911.2 927.7 942.7 8863.7 10017.9 10798.6 10826.5 10873.9 556654.0 567628.0 569258.0 578013.0 580340.0 93281.0 119745.0 131900.0 132160.7 135695.3 930.9 945.8 955.0 965.3 965.4 17269.8 17695.6 17917.9 18404.3 18406.4 51774.0 52002.5 52265.7 52905.0 53081.7 56234.4 56395.7 75574.6 76104.2 77305.6 7646.4 7792.0 7871.5 7960.0 7973.4 9250.4 10386.5 11770.1 11862.8 12236.0 10330.5 10565.9 10878.7 10895.9 10915.2 10287.5 10339.7 10381.2 10803.4 10878.4 10731.2 10895.3 10979.2 11010.2 11116.4 7716.3 7837.6 7964.1 7993.0 8159.6 10470.7 10733.8 10750.9 10814.1 10825.0 06:03:00 INFO - PROCESS | 1657 | 06:03:00 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5319.66 Median:4884.24 stddev:2924.40 (59.9%) stddev-sans-first:2918.46 06:03:00 INFO - PROCESS | 1657 | Values: 1491.6 1511.6 1676.2 1809.7 1844.1 7407.9 8212.3 8217.7 8223.3 8355.0 7399.9 7624.5 7630.9 7943.3 8172.1 1861.8 2304.1 2309.2 2310.3 2311.9 2297.0 2326.7 2336.8 2354.2 2360.4 2284.6 2284.9 2310.3 2313.4 2314.8 2275.5 2300.7 2303.1 2303.4 2303.5 2287.2 2315.3 2316.1 2316.8 2316.9 8228.6 8285.3 8313.2 8324.0 8332.6 4988.3 5121.9 5153.2 5181.8 5203.9 2717.6 3218.0 3537.0 3556.0 3557.7 902.7 1055.4 1086.9 1099.2 1100.7 10389.0 10705.6 10709.6 10875.4 10926.7 4211.7 4260.4 4438.4 4443.5 4467.3 8543.5 8563.4 8564.0 8568.2 8574.5 4308.6 5031.0 5060.4 5063.9 5069.9 3743.6 4044.4 4232.2 4724.6 4739.7 3108.4 3471.7 3502.1 3631.6 3638.6 1114.8 1115.2 1126.7 1141.7 1141.9 857.2 867.1 874.5 895.3 918.8 5381.5 5486.6 5563.3 5673.7 5770.5 901.4 968.4 1009.8 1010.4 1030.1 3191.8 3516.9 3594.6 3723.7 3794.4 8363.6 10004.9 10118.7 10120.1 10130.7 10023.8 10070.7 10081.9 10091.8 10125.8 7305.3 7589.8 7703.9 7712.4 7803.2 5435.8 5558.2 5578.7 5638.2 5684.7 9080.6 9098.3 9237.0 9294.3 9429.1 9405.3 9441.5 9463.5 9476.3 9659.5 6560.7 6782.6 7026.0 7193.4 7221.4 7135.4 7774.7 7855.2 7959.2 7963.7 6813.0 6843.7 6938.4 7000.0 7055.1 6922.9 6926.8 6952.7 6985.7 7039.3 6288.0 6477.9 6582.4 6587.5 6649.5 4644.5 4718.3 4734.2 4767.1 4876.4 4118.4 4752.9 4829.1 4855.8 4892.1 06:03:00 INFO - PROCESS | 1657 | 06:03:00 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4274.24 Median:4737.69 stddev:1294.30 (27.3%) stddev-sans-first:1263.02 06:03:00 INFO - PROCESS | 1657 | Values: 296.2 298.9 305.4 311.1 313.7 4563.5 5000.6 5148.7 5156.6 5272.7 4169.2 4666.3 4944.3 4950.9 5095.3 3966.3 3975.7 3997.5 4003.4 4005.8 3577.7 3705.8 3926.9 3967.5 3984.6 3897.9 3915.5 3921.0 3927.4 3930.4 3911.2 3914.8 3919.9 3924.2 3936.1 3263.6 3407.7 3413.7 3417.5 3436.4 4177.5 4597.8 5032.9 5079.7 5136.9 3621.6 4125.4 4357.9 4494.8 4510.8 5160.8 5391.8 5399.8 5459.7 5497.8 3677.5 3697.9 3701.9 3703.0 3748.3 4272.8 4845.6 5385.9 5751.0 5928.0 3775.7 3784.3 3803.6 3805.5 3813.6 3254.8 3705.5 3773.8 3834.3 3871.0 4113.5 4433.6 4475.0 4479.5 4492.9 4152.4 4320.7 5410.2 5433.5 5437.3 1106.9 1189.9 1190.6 1219.9 1249.0 713.1 830.7 841.6 851.8 863.2 4710.8 4720.7 4727.4 4749.8 4757.8 4477.0 4575.0 4798.3 4945.3 4948.5 4241.5 4790.9 4793.7 4800.4 4828.5 2268.5 2677.9 2704.8 2742.3 2755.8 4815.9 4857.3 4939.8 5326.8 5417.7 4378.2 4909.3 4957.4 5288.3 5333.6 4232.7 5276.7 5375.5 5395.9 5418.9 4748.0 4801.0 4810.8 5007.7 5142.6 4488.9 4595.1 4928.4 5047.5 5183.9 4938.5 4974.8 5560.4 5717.3 5792.5 3281.6 3284.8 3763.8 3776.5 3795.7 5075.3 5468.9 5635.0 5642.4 5657.6 4923.5 5210.9 5403.9 5452.3 5630.9 4130.2 4341.4 5416.4 5463.8 5471.4 5024.9 5331.5 5336.6 5384.9 5390.4 5514.7 5520.3 5535.8 5547.6 5558.5 4516.7 5302.9 5381.6 5384.8 5404.3 06:03:00 INFO - PROCESS | 1657 | 06:03:00 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:19679.88 Median:47368.88 stddev:28687.38 (60.6%) stddev-sans-first:28732.40 06:03:00 INFO - PROCESS | 1657 | Values: 684.0 708.7 732.3 762.3 779.6 13969.1 14813.3 14890.8 14907.2 14918.4 13358.7 13469.1 13475.5 13491.1 13507.5 647.0 662.4 670.1 799.6 816.3 777.5 796.5 799.2 805.2 809.2 862.7 864.9 865.9 865.9 866.4 684.1 860.5 863.0 863.9 864.5 522.7 525.4 527.0 528.0 528.5 13277.5 13734.5 13778.6 14127.6 14194.8 13168.0 13526.9 13545.1 13619.5 13697.3 11063.4 11123.6 11166.5 11243.0 11547.0 3656.1 3656.9 3658.3 3694.1 3822.6 85989.0 86689.0 86752.6 86991.0 89029.0 10689.5 10806.1 10843.5 10890.9 10905.7 20856.9 21000.4 21025.3 21064.8 21082.9 7416.9 7522.2 7637.0 7640.2 7650.8 4160.2 4251.3 4261.4 4261.8 4275.4 3197.3 3332.9 3339.8 3601.8 3781.2 659.3 674.1 675.7 688.9 691.4 570.5 592.4 616.7 631.6 650.2 7520.7 8647.0 8871.7 8876.0 8982.1 524.6 539.6 586.6 610.4 666.8 4277.4 4308.6 4324.9 4386.4 4478.9 72332.6 106755.5 110460.4 115452.0 121199.4 67901.0 78824.6 83974.0 98313.0 99115.5 87476.6 88611.0 89524.6 89825.0 90293.5 8393.3 8444.5 8518.1 8653.8 8757.8 45938.0 49219.0 49303.5 49979.8 52260.5 48799.8 53779.2 64127.7 66763.7 71744.3 11950.9 12255.3 12500.9 12635.8 12790.6 13799.8 14087.7 14251.2 14335.9 14518.9 12227.4 12637.2 12811.8 13129.7 13366.5 12821.2 12940.0 13156.8 13326.9 13559.3 12533.2 12590.1 12662.1 12896.0 13425.6 9774.0 10496.6 10541.9 10545.8 10627.4 8416.4 8775.3 9609.1 10985.5 11210.0 06:03:00 INFO - PROCESS | 1657 | -------- Summary: end -------- 06:03:00 INFO - PROCESS | 1657 | 06:03:00 INFO - TEST-INFO | 1657: exit 0 06:03:00 INFO - TEST-OK | dromaeo_css | took 1121114ms 06:03:00 INFO - TEST-START | kraken 06:03:00 INFO - operating with platform_type : mac_ 06:03:00 INFO - Initialising browser for kraken test... 06:03:00 INFO - TEST-INFO | started process 1777 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpVbgGJg/profile http://localhost:49236/getInfo.html) 06:03:03 INFO - PROCESS | 1777 | __metrics Screen width/height:1600/1200 06:03:03 INFO - PROCESS | 1777 | colorDepth:24 06:03:03 INFO - PROCESS | 1777 | Browser inner width/height: 1024/689 06:03:03 INFO - PROCESS | 1777 | __metrics 06:03:03 INFO - PROCESS | 1777 | 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" 06:03:03 INFO - PROCESS | 1777 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:03:04 INFO - TEST-INFO | 1777: exit 0 06:03:04 INFO - Browser initialized. 06:03:04 INFO - Running cycle 1/1 for kraken test... 06:03:04 INFO - TEST-INFO | started process 1779 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpVbgGJg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:16 INFO - PROCESS | 1779 | RSS: Main: 245215232 06:03:16 INFO - PROCESS | 1779 | 06:03:19 INFO - PROCESS | 1779 | 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) 06:03:20 INFO - PROCESS | 1779 | RSS: Main: 293752832 06:03:20 INFO - PROCESS | 1779 | 06:03:23 INFO - PROCESS | 1779 | 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) 06:03:23 INFO - PROCESS | 1779 | RSS: Main: 296898560 06:03:23 INFO - PROCESS | 1779 | 06:03:27 INFO - PROCESS | 1779 | 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) 06:03:28 INFO - PROCESS | 1779 | RSS: Main: 387874816 06:03:28 INFO - PROCESS | 1779 | 06:03:30 INFO - PROCESS | 1779 | 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) 06:03:30 INFO - PROCESS | 1779 | RSS: Main: 288972800 06:03:30 INFO - PROCESS | 1779 | 06:03:32 INFO - PROCESS | 1779 | 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) 06:03:33 INFO - PROCESS | 1779 | RSS: Main: 292605952 06:03:33 INFO - PROCESS | 1779 | 06:03:36 INFO - PROCESS | 1779 | 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) 06:03:36 INFO - PROCESS | 1779 | RSS: Main: 335073280 06:03:36 INFO - PROCESS | 1779 | 06:03:39 INFO - PROCESS | 1779 | 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) 06:03:40 INFO - PROCESS | 1779 | RSS: Main: 336334848 06:03:40 INFO - PROCESS | 1779 | 06:03:43 INFO - PROCESS | 1779 | 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) 06:03:44 INFO - PROCESS | 1779 | RSS: Main: 333107200 06:03:44 INFO - PROCESS | 1779 | 06:03:45 INFO - PROCESS | 1779 | 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) 06:03:46 INFO - PROCESS | 1779 | RSS: Main: 309100544 06:03:46 INFO - PROCESS | 1779 | 06:03:48 INFO - PROCESS | 1779 | 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) 06:03:48 INFO - PROCESS | 1779 | RSS: Main: 313626624 06:03:48 INFO - PROCESS | 1779 | 06:03:51 INFO - PROCESS | 1779 | 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) 06:03:51 INFO - PROCESS | 1779 | RSS: Main: 314937344 06:03:51 INFO - PROCESS | 1779 | 06:03:54 INFO - PROCESS | 1779 | 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) 06:03:55 INFO - PROCESS | 1779 | RSS: Main: 324915200 06:03:55 INFO - PROCESS | 1779 | 06:03:58 INFO - PROCESS | 1779 | 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) 06:03:59 INFO - PROCESS | 1779 | RSS: Main: 325382144 06:03:59 INFO - PROCESS | 1779 | 06:04:00 INFO - PROCESS | 1779 | 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) 06:04:01 INFO - PROCESS | 1779 | RSS: Main: 368807936 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | __start_tp_report 06:04:01 INFO - PROCESS | 1779 | _x_x_mozilla_page_load 06:04:01 INFO - PROCESS | 1779 | _x_x_mozilla_page_load_details 06:04:01 INFO - PROCESS | 1779 | |i|pagename|runs| 06:04:01 INFO - PROCESS | 1779 | |0;ai-astar;114;115;115;113;114;115;114;114;114;114 06:04:01 INFO - PROCESS | 1779 | |1;audio-beat-detection;181;142;147;155;114;119;104;132;182;137 06:04:01 INFO - PROCESS | 1779 | |2;audio-dft;186;184;185;176;181;185;181;181;183;186 06:04:01 INFO - PROCESS | 1779 | |3;audio-fft;80;60;59;88;62;60;58;60;84;59 06:04:01 INFO - PROCESS | 1779 | |4;audio-oscillator;91;70;92;70;69;93;125;98;70;94 06:04:01 INFO - PROCESS | 1779 | |5;imaging-gaussian-blur;89;86;89;85;87;85;89;86;89;85 06:04:01 INFO - PROCESS | 1779 | |6;imaging-darkroom;96;96;97;96;109;153;96;97;105;98 06:04:01 INFO - PROCESS | 1779 | |7;imaging-desaturate;101;134;135;87;86;85;87;84;85;85 06:04:01 INFO - PROCESS | 1779 | |8;json-parse-financial;56;56;55;56;57;53;54;56;54;53 06:04:01 INFO - PROCESS | 1779 | |9;json-stringify-tinderbox;66;70;71;81;75;73;70;72;71;72 06:04:01 INFO - PROCESS | 1779 | |10;stanford-crypto-aes;89;92;88;86;89;98;106;106;107;88 06:04:01 INFO - PROCESS | 1779 | |11;stanford-crypto-ccm;149;146;148;148;149;150;149;156;192;150 06:04:01 INFO - PROCESS | 1779 | |12;stanford-crypto-pbkdf2;204;172;171;173;176;173;175;164;172;173 06:04:01 INFO - PROCESS | 1779 | |13;stanford-crypto-sha256-iterative;67;69;68;67;67;67;68;67;67;68 06:04:01 INFO - PROCESS | 1779 | __end_tp_report 06:04:01 INFO - PROCESS | 1779 | __start_cc_report 06:04:01 INFO - PROCESS | 1779 | _x_x_mozilla_cycle_collect,2019 06:04:01 INFO - PROCESS | 1779 | __end_cc_report 06:04:01 INFO - PROCESS | 1779 | __startTimestamp1479737041130__endTimestamp 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | ------- Summary: start ------- 06:04:01 INFO - PROCESS | 1779 | Number of tests: 14 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 06:04:01 INFO - PROCESS | 1779 | Values: 114.0 115.0 115.0 113.0 114.0 115.0 114.0 114.0 114.0 114.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:144.50 stddev:26.23 (18.2%) stddev-sans-first:23.56 06:04:01 INFO - PROCESS | 1779 | Values: 181.0 142.0 147.0 155.0 114.0 119.0 104.0 132.0 182.0 137.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#2] audio-dft Cycles:10 Average:182.80 Median:184.50 stddev:3.12 (1.7%) stddev-sans-first:3.09 06:04:01 INFO - PROCESS | 1779 | Values: 186.0 184.0 185.0 176.0 181.0 185.0 181.0 181.0 183.0 186.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.00 stddev:11.93 (19.6%) stddev-sans-first:11.68 06:04:01 INFO - PROCESS | 1779 | Values: 80.0 60.0 59.0 88.0 62.0 60.0 58.0 60.0 84.0 59.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:91.50 stddev:17.89 (19.6%) stddev-sans-first:18.93 06:04:01 INFO - PROCESS | 1779 | Values: 91.0 70.0 92.0 70.0 69.0 93.0 125.0 98.0 70.0 94.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:1.83 (2.1%) stddev-sans-first:1.79 06:04:01 INFO - PROCESS | 1779 | Values: 89.0 86.0 89.0 85.0 87.0 85.0 89.0 86.0 89.0 85.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:96.00 stddev:17.69 (18.4%) stddev-sans-first:18.51 06:04:01 INFO - PROCESS | 1779 | Values: 96.0 96.0 97.0 96.0 109.0 153.0 96.0 97.0 105.0 98.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:85.00 stddev:20.41 (24.0%) stddev-sans-first:21.60 06:04:01 INFO - PROCESS | 1779 | Values: 101.0 134.0 135.0 87.0 86.0 85.0 87.0 84.0 85.0 85.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:1.41 (2.5%) stddev-sans-first:1.45 06:04:01 INFO - PROCESS | 1779 | Values: 56.0 56.0 55.0 56.0 57.0 53.0 54.0 56.0 54.0 53.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.00 stddev:3.90 (5.4%) stddev-sans-first:3.46 06:04:01 INFO - PROCESS | 1779 | Values: 66.0 70.0 71.0 81.0 75.0 73.0 70.0 72.0 71.0 72.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:88.50 stddev:8.53 (9.6%) stddev-sans-first:8.78 06:04:01 INFO - PROCESS | 1779 | Values: 89.0 92.0 88.0 86.0 89.0 98.0 106.0 106.0 107.0 88.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:149.50 stddev:13.70 (9.2%) stddev-sans-first:14.43 06:04:01 INFO - PROCESS | 1779 | Values: 149.0 146.0 148.0 148.0 149.0 150.0 149.0 156.0 192.0 150.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:173.00 stddev:10.58 (6.1%) stddev-sans-first:3.41 06:04:01 INFO - PROCESS | 1779 | Values: 204.0 172.0 171.0 173.0 176.0 173.0 175.0 164.0 172.0 173.0 06:04:01 INFO - PROCESS | 1779 | 06:04:01 INFO - PROCESS | 1779 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 06:04:01 INFO - PROCESS | 1779 | Values: 67.0 69.0 68.0 67.0 67.0 67.0 68.0 67.0 67.0 68.0 06:04:01 INFO - PROCESS | 1779 | -------- Summary: end -------- 06:04:01 INFO - PROCESS | 1779 | 06:04:02 INFO - TEST-INFO | 1779: exit 0 06:04:02 INFO - TEST-OK | kraken | took 61265ms 06:04:02 INFO - SUITE-END | took 1182s 06:04:02 INFO - Completed test suite (00:19:42) 06:04:02 INFO - javascript benchmark 06:04:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3262.3964566555187, 3299.851506682199, 3300.306935543534, 3302.45509490934, 3351.983240083799, 5195.714235717034, 5504.834854954348, 5556.638818476797, 5653.971730141348, 5667.489925906662, 4154.875353739385, 5603.887922241563, 5622.269105016342, 5626.156076588503, 5632.99999999999, 5069.569086627641, 5092.79628814847, 5109.872253193681, 5118.0019896120275, 5189.455107213745, 5108.719020453892, 5175.938932518825, 5187.818426355078, 5191.221316802491, 5208.76560554774, 5082.567981721558, 5137.178051511759, 5154.123798954187, 5171.120909445384, 5172.172452407615, 5179.352580927384, 5209.166533354645, 5209.53114219722, 5225.843224703265, 5228.686278823283, 5003.324551185616, 5007.9499205008215, 5058.342415485963, 5137.40919794221, 5149.3305870237, 5544.251526043973, 5551.0, 5634.661920284796, 5639.323281206241, 5648.43515648436, 5053.797848086072, 6085.969570152165, 6089.939100608982, 6111.205543279345, 6112.480439162677, 6188.412100850412, 6208.782692605782, 6209.037599172136, 6209.348018458042, 6223.844403889939, 5563.638363506359, 5632.718364081779, 5637.3235211774845, 5652.576056795757, 5679.290088738949, 6254.9687251563455, 6304.401081897213, 6319.988801791691, 6323.30443651198, 6333.271673757485, 5975.940240597625, 6010.729517171738, 6020.759169633253, 6024.457798798129, 6031.155638210654, 5938.2280303560265, 6060.2424696912885, 6070.453659170696, 6191.690415479208, 6201.875962480725, 4995.300657907896, 6040.848978775566, 6049.848753781191, 6051.697415129314, 6060.303065147476, 6050.485708714808, 6061.696915154224, 6062.302835173923, 6073.544484163705, 6116.052011938156, 4844.394450693663, 4881.658283920092, 4883.975580122076, 4916.8770780730765, 4918.286848407032, 4288.7855607220135, 4351.456067991501, 4359.673024523174, 4395.7362558246605, 4420.381146639473, 5542.667439953616, 5592.7762889484775, 5676.262085928803, 5677.347105082886, 5700.657960522382, 6120.416658368064, 6131.193168498116, 6132.661461321608, 6145.647957449354, 6150.231221097363, 5591.496765291144, 5593.3847276799515, 5637.46444087811, 5652.0391533439415, 5744.798932037359, 5265.868353291198, 5312.1766126250495, 5319.494648008433, 5322.0, 5346.358436987509, 6220.346863579259, 6315.0, 6320.304766475684, 6327.0, 6345.079963405188, 6045.939540604713, 6105.145279660762, 6123.14276001369, 6137.468918203611, 6154.107654390178, 6142.590862071594, 6193.318734939063, 6274.968625156845, 6301.306856245901, 6310.211223597051, 6031.155638210742, 6102.484703961281, 6111.327753947151, 6111.8956224267595, 6116.8227554565365, 5618.747156378055, 6214.316425193135, 6214.844628884314, 6216.222972128484, 6217.502599792097, 5773.769049237983, 5841.649501029951, 5850.824475265749, 5914.881702366015, 5915.112733089899, 5898.64608123514, 5900.763969441346, 5904.173415721888, 5908.881822363614, 5908.940910590839, 5730.942690573041, 5760.539156867357, 5761.769529218785, 5763.02028655138, 5768.653880767168, 5786.508146807569, 5883.999720047516, 5906.114082887601, 5921.822345329647, 5927.081302398135, 5774.931637647049, 5777.480026797609, 5781.566382521243, 5786.161006653927, 5791.0], "value": 5582.953144953302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.9296851956465, 491.02531475022084, 491.3734987890437, 535.6973310079804, 539.8124126920775, 30684.07947761565, 37287.62712372875, 37761.67834125806, 38187.42718859219, 41339.173216535724, 39900.600993990054, 40229.396559051565, 40274.99999999993, 40325.798371008175, 40373.59626403735, 8474.872876906851, 9335.299852511054, 9483.241340692728, 9529.237660987104, 9548.952255238713, 8409.579521023956, 11064.557417703281, 11323.150763692714, 11367.31796092233, 11518.0, 11220.990110890018, 11294.0, 11326.0, 11339.546418143264, 11345.09239260857, 8481.618327175293, 11243.156763242749, 11338.376389298584, 11339.319640821495, 11341.603043893425, 8444.197801208937, 10987.61543345979, 11287.040601548879, 11295.0, 11501.597444089417, 38546.22907541862, 38833.417498737545, 38843.61156388428, 38856.22287554261, 38902.02744931371, 2769.5568709006666, 3245.399601073785, 3332.01705496879, 3364.96635033649, 3617.222297206113, 29068.41863162746, 29361.41277174466, 29662.70337296621, 30528.08415747509, 30646.54030189549, 3138.6390565084853, 3138.905832825019, 3173.6032995875516, 3205.5512228288057, 3256.7068963793135, 470803.0, 483695.0, 488842.0, 489178.1082189168, 490217.0, 43493.56506434958, 52130.47869521332, 52557.73721131447, 52683.47316526786, 52687.0, 30806.69193308083, 31174.0, 31306.843465782524, 31381.8430907844, 58625.706871466224, 15554.988925720018, 15631.921840390725, 15653.60865978337, 15671.843281567266, 15678.68642627141, 10783.299085559414, 11007.229493935347, 11892.524299028115, 11997.940010300068, 12003.63989080329, 16118.113503757171, 17916.283348665907, 18042.63914721698, 18405.26378944854, 18620.882747035223, 6310.245403984622, 7377.93020012106, 7471.0, 7558.433117516208, 7568.167501574822, 749.8125468632842, 844.7043534762906, 972.9659461918799, 1040.5837664934088, 1059.9099076578423, 24128.0, 27750.306242344104, 28534.0, 28823.71176288252, 29328.706712933024, 849.6389034660244, 894.4365050018447, 1004.638330201127, 1031.3554028732042, 1106.883777203398, 13351.93184545234, 14379.928100359431, 14518.637034074232, 14875.0, 14966.850331496546, 544953.0, 606796.0, 609403.0, 789284.0, 790759.0, 54649.45350546523, 55192.44807551953, 55380.89238215213, 55419.72290138604, 55558.0, 1183.7573297473998, 1215.9939200303943, 1221.8167274908835, 1265.4621785741024, 1334.873187047229, 23354.0, 28869.566956495248, 28929.56605650959, 29046.27384315409, 30440.543391849584, 47266.52733472621, 47845.76077119731, 47854.34330507102, 47986.28020579624, 48051.75974120247, 520444.0, 525205.0, 525378.0, 525993.0, 527110.0, 25528.0, 25991.0, 26130.346741330857, 26381.812818422834, 26412.735872641028, 41776.1644767109, 41885.371719424846, 44445.10488644576, 44586.77706611446, 45598.31602525898, 37244.6275537252, 37295.44056839204, 37331.81334093312, 37966.0, 38401.0, 36828.212332396615, 37006.68169256236, 37568.62431375651, 37811.243775124894, 38320.0, 36056.639433606375, 36386.8180659095, 36869.0, 37085.44371834479, 37337.0, 32081.67918320787, 32984.0, 33147.0, 33330.66669333276, 33539.0, 23754.881225593763, 24109.638355425035, 24214.91032903559, 24525.632115517925, 24573.631395528722], "value": 19133.44739166356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.7687257356137, 347.9895603131907, 370.2225326813691, 378.48148037189054, 378.88796382617005, 14467.927660361696, 14731.926340368296, 15377.000494967819, 19079.332223372185, 19531.90234048828, 18320.633587328244, 19417.611647767073, 19618.70571941422, 19909.104090315934, 19939.900300498477, 5724.427557244274, 6113.6943152842405, 6115.0, 6119.204503414549, 6121.051237058263, 5725.856853578673, 5950.940490595082, 5961.731722072495, 6000.75996960121, 6006.909896351558, 5942.5840191186635, 5952.523798096164, 5954.13665018572, 5954.791582294621, 5961.254843144607, 5641.435856414367, 5852.239208902836, 5907.852303692399, 5921.792737254175, 5940.316863560703, 4920.655554111214, 5159.5614372778355, 5160.0969830279555, 5162.277281180638, 5167.844964651066, 24188.0, 24648.876755616107, 24674.0, 24978.500429991298, 25014.874925625438, 2404.3989002749313, 2422.1643532981093, 2550.7831834294107, 2560.0, 2836.886524539016, 14892.478763243234, 14982.026168299026, 15069.547913562501, 15429.997050191701, 15611.765823512544, 1731.9480415587552, 1785.7053586158268, 1802.630460755542, 1854.7866995295578, 1892.3944337811906, 99964.0, 108377.45811270972, 120398.39800801028, 125692.0, 126099.99999999908, 10967.0, 11342.376169310766, 11511.30932144074, 11514.596989105341, 11724.413779311, 14494.565163045125, 14494.855051449562, 14521.346539405753, 14523.273836308354, 14524.419023239163, 8010.5994700264755, 8185.467944583583, 8214.58927053657, 8286.4199506034, 8422.368322375847, 8101.797455063553, 8111.984567639057, 8131.105578386373, 8289.4197406181, 8295.087540370554, 4380.474343078851, 4500.717295570812, 4502.906148640897, 4555.430571178603, 4566.817327306937, 1753.9824601754074, 1834.2296235581089, 1884.5288677830542, 1886.9433916982512, 1889.0932352470616, 690.9378155965886, 727.672547353693, 794.6424109150789, 822.6750433578703, 987.693814917378, 19926.0, 20282.0, 20518.487037824172, 20626.793732062786, 20677.27629532989, 888.626776753765, 902.1339514066569, 911.2072496927715, 927.6706769097009, 942.7360339105062, 8863.734087977371, 10017.899821001696, 10798.622048228432, 10826.458677066115, 10873.912608739221, 556654.0, 567628.0, 569257.9982301138, 578013.0, 580340.0, 93281.0, 119745.0, 131900.0, 132160.6959826012, 135695.32152339176, 930.9394889332171, 945.8439357506072, 954.990450095518, 965.3435663748578, 965.35803690545, 17269.827301727324, 17695.557611059827, 17917.910410447865, 18404.26382944721, 18406.447806565826, 51773.96452071013, 52002.47997520128, 52265.7386713064, 52905.0, 53081.73459132834, 56234.437655624555, 56395.718021411274, 75574.62212688901, 76104.23895760972, 77305.61347193229, 7646.350060244719, 7791.961040194763, 7871.527708337518, 7959.965204523375, 7973.362131029619, 9250.444973301623, 10386.48067596602, 11770.117241207116, 11862.84892201328, 12236.0, 10330.48347582633, 10565.894341056799, 10878.673639790819, 10895.891041089488, 10915.181361398085, 10287.53706083243, 10339.741506462398, 10381.221408394249, 10803.405812680377, 10878.40168790724, 10731.248812583357, 10895.291806032583, 10979.231453798158, 11010.229283950046, 11116.388598627153, 7716.305532502101, 7837.568933708701, 7964.084130325086, 7993.0, 8159.592020399075, 10470.738231543968, 10733.785324293314, 10750.892491074988, 10814.080803131506, 10825.0], "value": 9338.54726646159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.559989803008, 1511.5918701950475, 1676.2289346900425, 1809.6833054215508, 1844.0687452836323, 7407.851842963138, 8212.301954333881, 8217.671293148267, 8223.259906608404, 8354.95822520888, 7399.926000740004, 7624.542527448343, 7630.923690763091, 7943.324817390529, 8172.141925097868, 1861.823126802955, 2304.135949019118, 2309.1802410144323, 2310.318456055459, 2311.919082832101, 2296.9655455168104, 2326.6975293211945, 2336.7663233676667, 2354.176038386568, 2360.445295355599, 2284.565932472833, 2284.931452056441, 2310.260716570698, 2313.410080429488, 2314.7569505201964, 2275.5221403505284, 2300.723913130435, 2303.1363238785457, 2303.435658263736, 2303.4586872084965, 2287.222344402911, 2315.305408377497, 2316.131450705985, 2316.7567405422355, 2316.895739691718, 8228.588570571448, 8285.337173026144, 8313.168683131698, 8324.0, 8332.62503187358, 4988.326575912241, 5121.923171152435, 5153.2270159476, 5181.818636347747, 5203.9219411708855, 2717.605947137654, 3217.9678203217904, 3537.028895727601, 3555.982220088909, 3557.7153827693724, 902.7201567514026, 1055.4247934875511, 1086.869575650927, 1099.1701265544543, 1100.7468282295038, 10389.0, 10705.625303114353, 10709.625163119332, 10875.401852898009, 10926.726831829188, 4211.7262377945335, 4260.446142001582, 4438.356438316426, 4443.488998765119, 4467.307567327004, 8543.530105844115, 8563.400561960603, 8564.0, 8568.228859402683, 8574.528400938008, 4308.569143085666, 5031.0, 5060.367454068241, 5063.8987220255385, 5069.898602027939, 3743.5694895087413, 4044.373122166069, 4232.238197124547, 4724.551167639069, 4739.715617062987, 3108.3783243350967, 3471.7049050830456, 3502.141975216088, 3631.618680038611, 3638.599754027055, 1114.8383484394717, 1115.2472081345222, 1126.6507382711386, 1141.69174322934, 1141.9429028548539, 857.2070834478083, 867.1328671328671, 874.4622057434759, 895.3463971300856, 918.7840857398506, 5381.461853814587, 5486.643368181056, 5563.332400112013, 5673.687947162863, 5770.538356931435, 901.3960646366819, 968.3608818179968, 1009.8283291840405, 1010.4240582867695, 1030.0935177044153, 3191.776575639683, 3516.9472457913153, 3594.6405359463843, 3723.72072094594, 3794.4118661607495, 8363.62363693623, 10004.899951000396, 10118.696439106838, 10120.139788117945, 10130.746731331628, 10023.799524009479, 10070.748231294276, 10081.899181008243, 10091.798164036678, 10125.797484050277, 7305.342519173194, 7589.772306830804, 7703.882936974107, 7712.383009359238, 7803.219678032265, 5435.83692489226, 5558.24963629921, 5578.748956296895, 5638.21065050885, 5684.658920464785, 9080.63677452921, 9098.317626178195, 9236.953815230881, 9294.349395542247, 9429.104235097655, 9405.341626086109, 9441.527923603655, 9463.479508627091, 9476.33665643426, 9659.46872921996, 6560.737570497126, 6782.626955517494, 7025.964870175821, 7193.352598265972, 7221.4222862169845, 7135.357817796424, 7774.727884524014, 7855.214478552099, 7959.243871832166, 7963.7212697557625, 6813.0, 6843.726250950105, 6938.444924406136, 7000.0, 7055.082839231072, 6922.930770692228, 6926.757563485254, 6952.687129079102, 6985.685644146127, 7039.331263529956, 6288.0, 6477.935220647733, 6582.3746744059235, 6587.505937054644, 6649.501287403561, 4644.535546445329, 4718.292256161603, 4734.21885388907, 4767.141914455431, 4876.366072410564, 4118.402831589463, 4752.9287060694805, 4829.082474329866, 4855.805767769391, 4892.119418504703], "value": 4323.035522549069, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.1973053026299, 298.88642315919947, 305.4227510006088, 311.05904638468627, 313.7474333161804, 4563.543645635435, 5000.59995200384, 5148.691078535286, 5156.639035267533, 5272.683638981659, 4169.228078066817, 4666.323383109456, 4944.258361245815, 4950.900981980359, 5095.312132862063, 3966.2860685076676, 3975.70182236332, 3997.460342853721, 4003.4195041718935, 4005.83976640934, 3577.6601222883914, 3705.8135699937034, 3926.921461570767, 3967.4643923070303, 3984.561698213194, 3897.9025524361978, 3915.4714113594728, 3920.980395098035, 3927.371620540714, 3930.351492003816, 3911.2008476101028, 3914.823832927525, 3919.902002449933, 3924.2151569686175, 3936.134050508898, 3263.624683161443, 3407.6592340765974, 3413.709834664032, 3417.487376893486, 3436.367725330473, 4177.4778152730905, 4597.793099310539, 5032.9245061323745, 5079.6952182869145, 5136.864823816826, 3621.6016238213774, 4125.401816736587, 4357.932306584907, 4494.797549200901, 4510.797014134372, 5160.845174644766, 5391.757370918318, 5399.757010934517, 5459.727013649302, 5497.752601132958, 3677.485152078711, 3697.85208591656, 3701.908421741707, 3702.981485092584, 3748.3440397930526, 4272.764997925113, 4845.588125009378, 5385.899499195317, 5750.95199544238, 5927.992241318986, 3775.6979441644603, 3784.280986612535, 3803.6386543278345, 3805.5243094613174, 3813.580506144322, 3254.8047117173046, 3705.481232627434, 3773.811309434517, 3834.271488417192, 3871.0, 4113.547509773923, 4433.578810013044, 4475.0, 4479.507254202035, 4492.865214043584, 4152.43942067823, 4320.660595215493, 5410.161424979135, 5433.456654334614, 5437.32033495813, 1106.8893110688866, 1189.8869607387285, 1190.6487586162102, 1219.8963088137607, 1248.9812652810215, 713.12642013533, 830.7092517618906, 841.6002398860493, 851.7827953871847, 863.179979019921, 4710.788014539354, 4720.669553131248, 4727.3854398927915, 4749.810007599657, 4757.785899634525, 4477.0, 4574.954250457519, 4798.328234047236, 4945.282933974626, 4948.455669876311, 4241.539906854017, 4790.880227994258, 4793.688410253392, 4800.423949126127, 4828.5412885775795, 2268.4895898422724, 2677.892884284646, 2704.756571908538, 2742.2732975761437, 2755.76575991043, 4815.927761083516, 4857.344258525124, 4939.777710002986, 5326.791834450741, 5417.729113544307, 4378.233809083397, 4909.337239472697, 4957.355543779286, 5288.2596436498925, 5333.626646134733, 4232.661387089025, 5276.709780962007, 5375.516203541543, 5395.919061214085, 5418.8916221675345, 4748.0, 4800.951990480051, 4810.807567697253, 5007.749612519432, 5142.614303927146, 4488.865334039984, 4595.080983803319, 4928.359313289393, 5047.470015648304, 5183.926429428108, 4938.481459446706, 4974.825881094144, 5560.4161563035295, 5717.342505611908, 5792.507636850914, 3281.5898012748407, 3284.786488878215, 3763.811809409464, 3776.4712940187846, 3795.715321350965, 5075.264086707481, 5468.894475626833, 5635.0, 5642.351129620146, 5657.60396772222, 4923.507649235191, 5210.947890521046, 5403.919216156863, 5452.291202143854, 5630.930123276565, 4130.191469800565, 4341.37050127736, 5416.377116631637, 5463.808766693147, 5471.425500322409, 5024.899502009866, 5331.5201631853315, 5336.573074153981, 5384.949934762683, 5390.353157621111, 5514.724263786715, 5520.254765606592, 5535.7785688572, 5547.639403438763, 5558.499735023867, 4516.683832131851, 5302.8939421212135, 5381.623286369917, 5384.811531596375, 5404.297441332759], "value": 3862.9485131034285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.9897401538976, 708.7448518533324, 732.2604169788513, 762.2910693055463, 779.5907148746907, 13969.09200901942, 14813.333399996998, 14890.776638350406, 14907.180105094229, 14918.403263869459, 13358.66603334917, 13469.124506907045, 13475.528356507524, 13491.123076999987, 13507.459701611948, 646.983825404364, 662.4270006444439, 670.1121014655577, 799.564237490569, 816.2898278497686, 777.5179388778965, 796.4902462424025, 799.168864381043, 805.2028491793112, 809.1665584448028, 862.706679728892, 864.9437786543886, 865.909079546648, 865.9480431174118, 866.4108406283724, 684.1004079635263, 860.4579115157442, 863.0463338011532, 863.8833757442759, 864.4942708515463, 522.728181345702, 525.4325328645092, 526.9789208431658, 527.9862663685694, 528.4952870009132, 13277.46890124394, 13734.45062197511, 13778.586642400744, 14127.576172714835, 14194.787078193835, 13168.0, 13526.90195609858, 13545.119567228197, 13619.455221791117, 13697.301728533339, 11063.391513466757, 11123.610673626465, 11166.497507612095, 11243.0, 11546.960773530423, 3656.140806910374, 3656.933038926257, 3658.32321020612, 3694.07648087978, 3822.560405553369, 85989.0, 86689.0, 86752.56623716842, 86991.0, 89029.0, 10689.465526723789, 10806.08148307387, 10843.51204195813, 10890.891091088988, 10905.672829815117, 20856.89571552163, 21000.36998890036, 21025.26411575618, 21064.78935210659, 21082.89458552728, 7416.925830741731, 7522.210167932398, 7637.045369328834, 7640.197779233101, 7650.846983060308, 4160.18876319121, 4251.256030194703, 4261.424707664488, 4261.765602891809, 4275.358696195533, 3197.2646291353117, 3332.8833490827706, 3339.833008349621, 3601.819909004539, 3781.243751249761, 659.3274859643137, 674.130371820356, 675.7364627795164, 688.9276625954203, 691.405391363427, 570.54356514788, 592.3868795796416, 616.6617254669469, 631.5610650597882, 650.2229835346715, 7520.699172033057, 8646.956765216133, 8871.733847984571, 8875.955620221857, 8982.101789820965, 524.6222719641928, 539.6033915072419, 586.571802584116, 610.4048552661209, 666.7857355480195, 4277.422547956048, 4308.590683885026, 4324.913501729948, 4386.407834942242, 4478.888027799331, 72332.63833680798, 106755.46622266839, 110460.4476977626, 115452.0, 121199.39400303118, 67901.0, 78824.63526094226, 83974.0, 98313.0, 99115.50442247743, 87476.5626171865, 88611.0, 89524.552377239, 89825.0, 90293.54853225691, 8393.286570641563, 8444.493330400195, 8518.148185181431, 8653.783655408664, 8757.817694611145, 45938.0, 49219.0, 49303.50696492989, 49979.75010124926, 52260.477395225564, 48799.756001219765, 53779.19331209957, 64127.679361602895, 66763.66618166878, 71744.28255717584, 11950.940245298718, 12255.264684118982, 12500.937495312466, 12635.810462842881, 12790.552330668754, 13799.79300310476, 14087.718245634826, 14251.21618311003, 14335.875893946275, 14518.927405362905, 12227.388630568257, 12637.17858339205, 12811.80782288285, 13129.667209820927, 13366.465341386236, 12821.216917216323, 12940.0, 13156.802647960098, 13326.866731332562, 13559.254241016839, 12533.248005119722, 12590.055745819283, 12662.113652044269, 12896.0, 13425.597232083053, 9773.951130244302, 10496.632617858644, 10541.894581054397, 10545.789084218426, 10627.415492148006, 8416.410851240355, 8775.341849361195, 9609.087136722, 10985.505652245509, 11210.047145992681], "value": 7077.760913385707, "unit": "score"}], "name": "dromaeo_css", "value": 7002.689603685454, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 113.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 142.0, 147.0, 155.0, 114.0, 119.0, 104.0, 132.0, 182.0, 137.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 176.0, 181.0, 185.0, 181.0, 181.0, 183.0, 186.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 88.0, 62.0, 60.0, 58.0, 60.0, 84.0, 59.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 92.0, 70.0, 69.0, 93.0, 125.0, 98.0, 70.0, 94.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 87.0, 85.0, 89.0, 86.0, 89.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 109.0, 153.0, 96.0, 97.0, 105.0, 98.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 134.0, 135.0, 87.0, 86.0, 85.0, 87.0, 84.0, 85.0, 85.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 57.0, 53.0, 54.0, 56.0, 54.0, 53.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 71.0, 81.0, 75.0, 73.0, 70.0, 72.0, 71.0, 72.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 88.0, 86.0, 89.0, 98.0, 106.0, 106.0, 107.0, 88.0], "value": 94.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 148.0, 148.0, 149.0, 150.0, 149.0, 156.0, 192.0, 150.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 172.0, 171.0, 173.0, 176.0, 173.0, 175.0, 164.0, 172.0, 173.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1499.2, "alertThreshold": 2.0}]} 06:04:02 INFO - Return code: 0 06:04:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:04:02 INFO - # TBPL SUCCESS # 06:04:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:04:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:04:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:04:02 INFO - 2016-11-21 06:04:02.459 screenresolution[1788:9794] starting screenresolution argv=screenresolution get 06:04:02 INFO - 2016-11-21 06:04:02.462 screenresolution[1788:9794] Display 0: 1600x1200x32@60 06:04:02 INFO - 2016-11-21 06:04:02.468 screenresolution[1789:9797] starting screenresolution argv=screenresolution list 06:04:02 INFO - Available Modes on Display 0 06:04:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:04:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:04:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:04:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:04:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:04:02 INFO - Intel Iris: 06:04:02 INFO - Chipset Model: Intel Iris 06:04:02 INFO - Type: GPU 06:04:02 INFO - Bus: Built-In 06:04:02 INFO - VRAM (Dynamic, Max): 1536 MB 06:04:02 INFO - Vendor: Intel (0x8086) 06:04:02 INFO - Device ID: 0x0a2e 06:04:02 INFO - Revision ID: 0x0009 06:04:02 INFO - Displays: 06:04:02 INFO - Display: 06:04:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:04:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:04:02 INFO - Display Serial Number: 1600x1200 60 06:04:02 INFO - Main Display: Yes 06:04:02 INFO - Mirror: Off 06:04:02 INFO - Online: Yes 06:04:02 INFO - Rotation: Supported 06:04:02 INFO - Return code: 0 06:04:02 INFO - Running post-action listener: _resource_record_post_action 06:04:02 INFO - [mozharness: 2016-11-21 14:04:02.716068Z] Finished run-tests step (success) 06:04:02 INFO - Running post-run listener: _resource_record_post_run 06:04:02 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37590016; Write bytes: 696826880; Read time: 241; Write time: 2093 06:04:02 INFO - TinderboxPrint: CPU usage
53.6% 06:04:02 INFO - TinderboxPrint: I/O read bytes / time
37,590,016 / 241 06:04:02 INFO - TinderboxPrint: I/O write bytes / time
696,826,880 / 2,093 06:04:02 INFO - TinderboxPrint: CPU idle
2,258.0 (46.4%) 06:04:02 INFO - TinderboxPrint: CPU system
970.6 (20.0%) 06:04:02 INFO - TinderboxPrint: CPU user
1,632.9 (33.6%) 06:04:02 INFO - TinderboxPrint: Swap in / out
421,191,680 / 0 06:04:02 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 366131712; Write bytes: 362153984; Read time: 27514; Write time: 799 06:04:02 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 36635648; Write bytes: 308478976; Read time: 226; Write time: 1226 06:04:03 INFO - Running post-run listener: _upload_blobber_files 06:04:03 INFO - Blob upload gear active. 06:04:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:04:03 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 06:04:03 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:04:03 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:04:03 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:04:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:04:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:04 INFO - (blobuploader) - INFO - Done attempting. 06:04:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:04:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:04:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:05 INFO - (blobuploader) - INFO - Done attempting. 06:04:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:04:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:04:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:08 INFO - (blobuploader) - INFO - Done attempting. 06:04:08 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:08 INFO - Return code: 0 06:04:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:04:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c92773a0a053bc201f6572f6558c961aa128c1cb87d43cf6d436265bccf3d9f89b64684d89df93bca8208212acee6851caa4412d1d28d15de32afa688e1a6aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/66c6074ffcfc2cbdfcf8ba77d700f29aa7319bec0cc280fc1a97172e68426943266cc8aeec0abd131edd22e43e590099de8317ecdbdcb622025fa29c23bcef7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/123b72f37e7a4881f959b3d9e5666cbe827808270f9346a7c6696eef246f69b8479a08b19893b52bd8df84a0d7f480c521943135300329d0a562598389a6ec9d"} 06:04:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:04:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:04:08 INFO - Contents: 06:04:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c92773a0a053bc201f6572f6558c961aa128c1cb87d43cf6d436265bccf3d9f89b64684d89df93bca8208212acee6851caa4412d1d28d15de32afa688e1a6aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/66c6074ffcfc2cbdfcf8ba77d700f29aa7319bec0cc280fc1a97172e68426943266cc8aeec0abd131edd22e43e590099de8317ecdbdcb622025fa29c23bcef7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/123b72f37e7a4881f959b3d9e5666cbe827808270f9346a7c6696eef246f69b8479a08b19893b52bd8df84a0d7f480c521943135300329d0a562598389a6ec9d"} 06:04:08 INFO - Running post-run listener: copy_logs_to_upload_dir 06:04:08 INFO - Copying logs to upload dir... 06:04:08 INFO - mkdir: /builds/slave/test/build/upload/logs 06:04:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.753433 ========= master_lag: -0.23 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-21 06:04:08.341899) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 06:04:08.346595) ========= 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.qX6nBLpinX/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.mix9eykBTW/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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/Cedar/sha512/c92773a0a053bc201f6572f6558c961aa128c1cb87d43cf6d436265bccf3d9f89b64684d89df93bca8208212acee6851caa4412d1d28d15de32afa688e1a6aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/66c6074ffcfc2cbdfcf8ba77d700f29aa7319bec0cc280fc1a97172e68426943266cc8aeec0abd131edd22e43e590099de8317ecdbdcb622025fa29c23bcef7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/123b72f37e7a4881f959b3d9e5666cbe827808270f9346a7c6696eef246f69b8479a08b19893b52bd8df84a0d7f480c521943135300329d0a562598389a6ec9d"} build_url:https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010942 build_url: 'https://queue.taskcluster.net/v1/task/DnJb_DTARvaZ5J1Eo2WrLQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c92773a0a053bc201f6572f6558c961aa128c1cb87d43cf6d436265bccf3d9f89b64684d89df93bca8208212acee6851caa4412d1d28d15de32afa688e1a6aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/66c6074ffcfc2cbdfcf8ba77d700f29aa7319bec0cc280fc1a97172e68426943266cc8aeec0abd131edd22e43e590099de8317ecdbdcb622025fa29c23bcef7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/123b72f37e7a4881f959b3d9e5666cbe827808270f9346a7c6696eef246f69b8479a08b19893b52bd8df84a0d7f480c521943135300329d0a562598389a6ec9d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 06:04:08.378195) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 06:04:08.378492) ========= 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.qX6nBLpinX/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.mix9eykBTW/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.005089 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 06:04:08.426798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 06:04:08.427098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 06:04:08.430412) ========= ========= Total master_lag: -0.09 =========