builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0304 starttime: 1478701677.94 results: success (0) buildid: 20161109040522 builduid: e85f13a3f7fd4891b3e4f4e43862e7c0 revision: 2a8c3049b464a92b878b23a866649c0fac9cede2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 06:27:57.941365) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 06:27:57.941812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 06:27:57.942087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 06:27:58.024063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:27:58.024399) ========= 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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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-09 06:27:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-11-09 06:27:58 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.513094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:27:58.560446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:27:58.560832) ========= 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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.025063 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:27:58.609888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 06:27:58.610294) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 2a8c3049b464a92b878b23a866649c0fac9cede2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 2a8c3049b464a92b878b23a866649c0fac9cede2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tTL0lYgD6X/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.LMNUJtJzCj/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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-09 06:27:58,696 truncating revision to first 12 chars 2016-11-09 06:27:58,696 Setting DEBUG logging. 2016-11-09 06:27:58,696 attempt 1/10 2016-11-09 06:27:58,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/2a8c3049b464?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-09 06:28:00,039 unpacking tar archive at: larch-2a8c3049b464/testing/mozharness/ program finished with exit code 0 elapsedTime=1.654945 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 06:28:00.288146) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 06:28:00.288459) ========= script_repo_revision: 2a8c3049b464a92b878b23a866649c0fac9cede2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 06:28:00.288832) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 06:28:00.289104) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 06:28:00.305432) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-09 06:28:00.305746) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tTL0lYgD6X/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.LMNUJtJzCj/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:00 INFO - MultiFileLogger online at 20161109 06:28:00 in /builds/slave/test 06:28:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 06:28:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:28:00 INFO - {'append_to_log': False, 06:28:00 INFO - 'base_work_dir': '/builds/slave/test', 06:28:00 INFO - 'blob_upload_branch': 'Larch', 06:28:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:28:00 INFO - 'branch': 'Larch', 06:28:00 INFO - 'buildbot_json_path': 'buildprops.json', 06:28:00 INFO - 'config_files': ('talos/mac_config.py',), 06:28:00 INFO - 'default_actions': ('clobber', 06:28:00 INFO - 'read-buildbot-config', 06:28:00 INFO - 'download-and-extract', 06:28:00 INFO - 'populate-webroot', 06:28:00 INFO - 'create-virtualenv', 06:28:00 INFO - 'install', 06:28:00 INFO - 'run-tests'), 06:28:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:28:00 INFO - 'download_minidump_stackwalk': True, 06:28:00 INFO - 'download_symbols': 'ondemand', 06:28:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:28:00 INFO - 'tooltool.py': '/tools/tooltool.py', 06:28:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:28:00 INFO - '/tools/misc-python/virtualenv.py')}, 06:28:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:28:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:28:00 INFO - 'installer_path': 'installer.exe', 06:28:00 INFO - 'log_level': 'info', 06:28:00 INFO - 'log_name': 'talos', 06:28:00 INFO - 'log_to_console': True, 06:28:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:28:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:28:00 INFO - 'opt_config_files': (), 06:28:00 INFO - 'pip_index': False, 06:28:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:28:00 INFO - 'cmd': ('bash', 06:28:00 INFO - '-c', 06:28:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:28:00 INFO - 'enabled': True, 06:28:00 INFO - 'halt_on_failure': False, 06:28:00 INFO - 'name': 'check_screen_resolution'},), 06:28:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:28:00 INFO - 'cmd': ('bash', 06:28:00 INFO - '-c', 06:28:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:28:00 INFO - 'enabled': True, 06:28:00 INFO - 'halt_on_failure': False, 06:28:00 INFO - 'name': 'check_screen_resolution'},), 06:28:00 INFO - 'run_cmd_checks_enabled': True, 06:28:00 INFO - 'sps_profile': False, 06:28:00 INFO - 'sps_profile_interval': 0, 06:28:00 INFO - 'suite': 'dromaeojs', 06:28:00 INFO - 'system_bits': '32', 06:28:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:28:00 INFO - 'title': 't-yosemite-r7-0304', 06:28:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:28:00 INFO - 'use_talos_json': True, 06:28:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:28:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:28:00 INFO - 'work_dir': 'build'} 06:28:00 INFO - [mozharness: 2016-11-09 14:28:00.511101Z] Running clobber step. 06:28:00 INFO - Running pre-action listener: _resource_record_pre_action 06:28:00 INFO - Running main action method: clobber 06:28:00 INFO - rmtree: /builds/slave/test/build 06:28:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:28:02 INFO - Running post-action listener: _resource_record_post_action 06:28:02 INFO - [mozharness: 2016-11-09 14:28:02.678298Z] Finished clobber step (success) 06:28:02 INFO - [mozharness: 2016-11-09 14:28:02.678460Z] Running read-buildbot-config step. 06:28:02 INFO - Running pre-action listener: _resource_record_pre_action 06:28:02 INFO - Running main action method: read_buildbot_config 06:28:02 INFO - Using buildbot properties: 06:28:02 INFO - { 06:28:02 INFO - "project": "", 06:28:02 INFO - "product": "firefox", 06:28:02 INFO - "script_repo_revision": "production", 06:28:02 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 06:28:02 INFO - "repository": "", 06:28:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 06:28:02 INFO - "buildid": "20161109040522", 06:28:02 INFO - "pgo_build": "False", 06:28:02 INFO - "basedir": "/builds/slave/test", 06:28:02 INFO - "buildnumber": 9, 06:28:02 INFO - "slavename": "t-yosemite-r7-0304", 06:28:02 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:28:02 INFO - "platform": "yosemite_r7", 06:28:02 INFO - "scheduler": "tests-larch-macosx64-talos", 06:28:02 INFO - "branch": "larch", 06:28:02 INFO - "repo_path": "projects/larch", 06:28:02 INFO - "revision": "2a8c3049b464a92b878b23a866649c0fac9cede2", 06:28:02 INFO - "stage_platform": "macosx64", 06:28:02 INFO - "builduid": "e85f13a3f7fd4891b3e4f4e43862e7c0", 06:28:02 INFO - "slavebuilddir": "test" 06:28:02 INFO - } 06:28:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:28:02 INFO - Running post-action listener: _resource_record_post_action 06:28:02 INFO - [mozharness: 2016-11-09 14:28:02.681801Z] Finished read-buildbot-config step (success) 06:28:02 INFO - [mozharness: 2016-11-09 14:28:02.681910Z] Running download-and-extract step. 06:28:02 INFO - Running pre-action listener: _resource_record_pre_action 06:28:02 INFO - Running main action method: download_and_extract 06:28:02 INFO - mkdir: /builds/slave/test/build/tests 06:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:02 INFO - trying https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:28:02 INFO - Downloading https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:28:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 06:28:04 INFO - Downloaded 1199 bytes. 06:28:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:28:04 INFO - Using the following test package requirements: 06:28:04 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:28:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:28:04 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:28:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:28:04 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:28:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:28:04 INFO - u'jsshell-mac.zip'], 06:28:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:28:04 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:28:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:28:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:28:04 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:28:04 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:28:04 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:28:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:28:04 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:28:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:28:04 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:28:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:28:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:28:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:28:04 INFO - Fetch https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:28:04 INFO - Http code: 200 06:28:04 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 06:28:04 INFO - x-amz-cf-id: SH5dOEtPtDUIEwBOBIAD5f2cPyLZ4NfGsJ9VMWillDK3xU5HLS8iAA== 06:28:04 INFO - x-amz-version-id: HKg5VwzilCkZbHlgevDrj8rnx285MMTH 06:28:05 INFO - Expected file size: 16308107 06:28:05 INFO - Obtained file size: 16308107 06:28:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:28:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:28:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:28:11 INFO - Fetch https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:28:12 INFO - Http code: 200 06:28:12 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 06:28:12 INFO - x-amz-cf-id: k44VvLEi-Gz3KexxN-bo1ZV87FV6JvCoSnFB1uzp_PPj71PMVC-Tvg== 06:28:12 INFO - x-amz-version-id: HKg5VwzilCkZbHlgevDrj8rnx285MMTH 06:28:12 INFO - Expected file size: 16308107 06:28:12 INFO - Obtained file size: 16308107 06:28:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:28:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:28:18 INFO - Fetch https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:28:19 INFO - Http code: 200 06:28:19 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 06:28:19 INFO - x-amz-cf-id: p0-fa_T9NpuDxAeO2l_E0pJvuewUTAgjzHJ_IfiydA3-4f2tVYqaXQ== 06:28:19 INFO - x-amz-version-id: 6aN2VlEcKJiknJhL7ft8RsQAGDMQjeAw 06:28:19 INFO - Expected file size: 14409038 06:28:19 INFO - Obtained file size: 14409038 06:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:20 INFO - trying https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:28:20 INFO - Downloading https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 06:28:23 INFO - Downloaded 111581951 bytes. 06:28:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:28:23 INFO - mkdir: /builds/slave/test/properties 06:28:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:28:23 INFO - Writing to file /builds/slave/test/properties/build_url 06:28:23 INFO - Contents: 06:28:23 INFO - build_url:https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:28:24 INFO - Running post-action listener: _resource_record_post_action 06:28:24 INFO - Running post-action listener: set_extra_try_arguments 06:28:24 INFO - [mozharness: 2016-11-09 14:28:24.141959Z] Finished download-and-extract step (success) 06:28:24 INFO - [mozharness: 2016-11-09 14:28:24.142097Z] Running populate-webroot step. 06:28:24 INFO - Running pre-action listener: _resource_record_pre_action 06:28:24 INFO - Running main action method: populate_webroot 06:28:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:28:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:28:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:28:24 INFO - '--tppagecycles', 06:28:24 INFO - '7'], 06:28:24 INFO - 'tests': ['tsvgm']}}, 06:28:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:28:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:28:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:28:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:28:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:24 INFO - 'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:24 INFO - 'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['damp', 'tps']}, 06:28:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:24 INFO - 'tests': ['damp', 'tps']}, 06:28:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['dromaeo_dom']}, 06:28:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:28:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['basic_compositor_video']}, 06:28:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:28:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['a11yr', 06:28:24 INFO - 'ts_paint', 06:28:24 INFO - 'tpaint', 06:28:24 INFO - 'sessionrestore', 06:28:24 INFO - 'sessionrestore_no_auto_restore', 06:28:24 INFO - 'tabpaint']}, 06:28:24 INFO - 'other-e10s': {'tests': ['a11yr', 06:28:24 INFO - 'ts_paint', 06:28:24 INFO - 'tpaint', 06:28:24 INFO - 'sessionrestore', 06:28:24 INFO - 'sessionrestore_no_auto_restore', 06:28:24 INFO - 'tabpaint']}, 06:28:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:28:24 INFO - 'ts_paint', 06:28:24 INFO - 'tpaint', 06:28:24 INFO - 'sessionrestore', 06:28:24 INFO - 'sessionrestore_no_auto_restore', 06:28:24 INFO - 'tabpaint']}, 06:28:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:28:24 INFO - 'ts_paint', 06:28:24 INFO - 'tpaint', 06:28:24 INFO - 'sessionrestore', 06:28:24 INFO - 'sessionrestore_no_auto_restore', 06:28:24 INFO - 'tabpaint']}, 06:28:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['a11yr', 06:28:24 INFO - 'ts_paint', 06:28:24 INFO - 'tpaint', 06:28:24 INFO - 'sessionrestore', 06:28:24 INFO - 'sessionrestore_no_auto_restore', 06:28:24 INFO - 'tabpaint']}, 06:28:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['a11yr', 06:28:24 INFO - 'ts_paint', 06:28:24 INFO - 'tpaint', 06:28:24 INFO - 'sessionrestore', 06:28:24 INFO - 'sessionrestore_no_auto_restore', 06:28:24 INFO - 'tabpaint']}, 06:28:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['tsvgx', 06:28:24 INFO - 'tsvgr_opacity', 06:28:24 INFO - 'tart', 06:28:24 INFO - 'tscrollx', 06:28:24 INFO - 'cart']}, 06:28:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:28:24 INFO - 'tsvgr_opacity', 06:28:24 INFO - 'tart', 06:28:24 INFO - 'tscrollx', 06:28:24 INFO - 'cart']}, 06:28:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:24 INFO - 'talos_options': ['--disable-e10s'], 06:28:24 INFO - 'tests': ['tp5o']}, 06:28:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:24 INFO - 'tests': ['tp5o']}, 06:28:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:24 INFO - 'talos_options': ['--disable-e10s', 06:28:24 INFO - '--xperf_path', 06:28:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:24 INFO - 'tests': ['tp5n']}, 06:28:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:24 INFO - 'talos_options': ['--xperf_path', 06:28:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:24 INFO - 'tests': ['tp5n']}}, 06:28:24 INFO - 'talos.zip': {'path': '', 06:28:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:28:24 INFO - Running post-action listener: _resource_record_post_action 06:28:24 INFO - [mozharness: 2016-11-09 14:28:24.161169Z] Finished populate-webroot step (success) 06:28:24 INFO - [mozharness: 2016-11-09 14:28:24.161300Z] Running create-virtualenv step. 06:28:24 INFO - Running pre-action listener: _resource_record_pre_action 06:28:24 INFO - Running main action method: create_virtualenv 06:28:24 INFO - Creating virtualenv /builds/slave/test/build/venv 06:28:24 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 06:28:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:28:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:28:24 INFO - Using real prefix '/tools/python27' 06:28:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:28:25 INFO - Installing distribute.............................................................................................................................................................................................done. 06:28:27 INFO - Installing pip.................done. 06:28:27 INFO - Return code: 0 06:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:28:28 INFO - Reading from file tmpfile_stdout 06:28:28 INFO - Output received: 06:28:28 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) 06:28:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28: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', 'pip>=1.5'] in /builds/slave/test/build 06:28: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 pip>=1.5 06:28:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:28 INFO - 'HOME': '/Users/cltbld', 06:28:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:28 INFO - 'LOGNAME': 'cltbld', 06:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:28 INFO - 'MOZ_NO_REMOTE': '1', 06:28:28 INFO - 'NO_EM_RESTART': '1', 06:28:28 INFO - 'PAGER': '/bin/cat', 06:28:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:28 INFO - 'PWD': '/builds/slave/test', 06:28:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:28 INFO - 'SHELL': '/bin/bash', 06:28:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:28 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:28 INFO - 'USER': 'cltbld', 06:28:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:28 INFO - 'XPC_FLAGS': '0x0', 06:28:28 INFO - 'XPC_SERVICE_NAME': '0', 06:28:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:28 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 06:28:28 INFO - Cleaning up... 06:28:28 INFO - Return code: 0 06:28:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:28:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:28 INFO - 'HOME': '/Users/cltbld', 06:28:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:28 INFO - 'LOGNAME': 'cltbld', 06:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:28 INFO - 'MOZ_NO_REMOTE': '1', 06:28:28 INFO - 'NO_EM_RESTART': '1', 06:28:28 INFO - 'PAGER': '/bin/cat', 06:28:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:28 INFO - 'PWD': '/builds/slave/test', 06:28:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:28 INFO - 'SHELL': '/bin/bash', 06:28:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:28 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:28 INFO - 'USER': 'cltbld', 06:28:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:28 INFO - 'XPC_FLAGS': '0x0', 06:28:28 INFO - 'XPC_SERVICE_NAME': '0', 06:28:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:28 INFO - Downloading/unpacking psutil>=3.1.1 06:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:28:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:32 INFO - Installing collected packages: psutil 06:28:32 INFO - Running setup.py install for psutil 06:28:32 INFO - building 'psutil._psutil_osx' extension 06:28:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:28:33 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 06:28:33 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 06:28:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:28:33 INFO - building 'psutil._psutil_posix' extension 06:28:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:28:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:28:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:28:33 INFO - ^ 06:28:33 INFO - 1 warning generated. 06:28:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:28:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:33 INFO - Successfully installed psutil 06:28:33 INFO - Cleaning up... 06:28:33 INFO - Return code: 0 06:28:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:33 INFO - 'HOME': '/Users/cltbld', 06:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:33 INFO - 'LOGNAME': 'cltbld', 06:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:33 INFO - 'MOZ_NO_REMOTE': '1', 06:28:33 INFO - 'NO_EM_RESTART': '1', 06:28:33 INFO - 'PAGER': '/bin/cat', 06:28:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:33 INFO - 'PWD': '/builds/slave/test', 06:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:33 INFO - 'SHELL': '/bin/bash', 06:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:33 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:33 INFO - 'USER': 'cltbld', 06:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:33 INFO - 'XPC_FLAGS': '0x0', 06:28:33 INFO - 'XPC_SERVICE_NAME': '0', 06:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:28:36 INFO - Installing collected packages: mozsystemmonitor 06:28:36 INFO - Running setup.py install for mozsystemmonitor 06:28:37 INFO - Successfully installed mozsystemmonitor 06:28:37 INFO - Cleaning up... 06:28:37 INFO - Return code: 0 06:28:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:28:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:37 INFO - 'HOME': '/Users/cltbld', 06:28:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:37 INFO - 'LOGNAME': 'cltbld', 06:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:37 INFO - 'MOZ_NO_REMOTE': '1', 06:28:37 INFO - 'NO_EM_RESTART': '1', 06:28:37 INFO - 'PAGER': '/bin/cat', 06:28:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:37 INFO - 'PWD': '/builds/slave/test', 06:28:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:37 INFO - 'SHELL': '/bin/bash', 06:28:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:37 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:37 INFO - 'USER': 'cltbld', 06:28:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:37 INFO - 'XPC_FLAGS': '0x0', 06:28:37 INFO - 'XPC_SERVICE_NAME': '0', 06:28:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:37 INFO - Downloading/unpacking jsonschema==2.5.1 06:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:40 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:40 INFO - warning: no files found matching '*.txt' 06:28:40 INFO - no previously-included directories found matching 'build' 06:28:40 INFO - no previously-included directories found matching 'dist' 06:28:40 INFO - no previously-included directories found matching '.git*' 06:28:40 INFO - Installing collected packages: jsonschema, functools32 06:28:40 INFO - Running setup.py install for functools32 06:28:40 INFO - warning: no files found matching '*.txt' 06:28:40 INFO - no previously-included directories found matching 'build' 06:28:40 INFO - no previously-included directories found matching 'dist' 06:28:40 INFO - no previously-included directories found matching '.git*' 06:28:40 INFO - Successfully installed jsonschema functools32 06:28:40 INFO - Cleaning up... 06:28:40 INFO - Return code: 0 06:28:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:28:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:40 INFO - 'HOME': '/Users/cltbld', 06:28:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:40 INFO - 'LOGNAME': 'cltbld', 06:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:40 INFO - 'MOZ_NO_REMOTE': '1', 06:28:40 INFO - 'NO_EM_RESTART': '1', 06:28:40 INFO - 'PAGER': '/bin/cat', 06:28:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:40 INFO - 'PWD': '/builds/slave/test', 06:28:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:40 INFO - 'SHELL': '/bin/bash', 06:28:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:40 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:40 INFO - 'USER': 'cltbld', 06:28:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:40 INFO - 'XPC_FLAGS': '0x0', 06:28:40 INFO - 'XPC_SERVICE_NAME': '0', 06:28:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:28:41 INFO - Cleaning up... 06:28:41 INFO - Return code: 0 06:28:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:41 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 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:41 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 06:28:41 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 06:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:41 INFO - 'HOME': '/Users/cltbld', 06:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:41 INFO - 'LOGNAME': 'cltbld', 06:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:41 INFO - 'MOZ_NO_REMOTE': '1', 06:28:41 INFO - 'NO_EM_RESTART': '1', 06:28:41 INFO - 'PAGER': '/bin/cat', 06:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:41 INFO - 'PWD': '/builds/slave/test', 06:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:41 INFO - 'SHELL': '/bin/bash', 06:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:41 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:41 INFO - 'USER': 'cltbld', 06:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:41 INFO - 'XPC_FLAGS': '0x0', 06:28:41 INFO - 'XPC_SERVICE_NAME': '0', 06:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:41 INFO - Downloading/unpacking blobuploader==1.2.4 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:43 INFO - Downloading blobuploader-1.2.4.tar.gz 06:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:28:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:28:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:45 INFO - Downloading docopt-0.6.1.tar.gz 06:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:28:45 INFO - Installing collected packages: blobuploader, requests, docopt 06:28:45 INFO - Running setup.py install for blobuploader 06:28:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:28:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:28:45 INFO - Running setup.py install for requests 06:28:45 INFO - Running setup.py install for docopt 06:28:45 INFO - Successfully installed blobuploader requests docopt 06:28:45 INFO - Cleaning up... 06:28:46 INFO - Return code: 0 06:28:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:46 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')]} 06:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:46 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')]} 06:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:46 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 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:46 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 06:28:46 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 06:28:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:46 INFO - 'HOME': '/Users/cltbld', 06:28:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:46 INFO - 'LOGNAME': 'cltbld', 06:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:46 INFO - 'MOZ_NO_REMOTE': '1', 06:28:46 INFO - 'NO_EM_RESTART': '1', 06:28:46 INFO - 'PAGER': '/bin/cat', 06:28:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:46 INFO - 'PWD': '/builds/slave/test', 06:28:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:46 INFO - 'SHELL': '/bin/bash', 06:28:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:46 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:46 INFO - 'USER': 'cltbld', 06:28:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:46 INFO - 'XPC_FLAGS': '0x0', 06:28:46 INFO - 'XPC_SERVICE_NAME': '0', 06:28:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:46 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-71jWuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:46 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-qQn1Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:46 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-mIGsHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:46 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-g3VgO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:46 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-4hr_Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:46 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-G1yG5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:46 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-lR24cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:47 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-WCN6gD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:47 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-RO9Gbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:47 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-jsqMud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:47 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-uLJyi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:47 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-sWq4up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:47 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-ZJLRkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:47 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-a1ep0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:47 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-Rr1HeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:47 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-vThxoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:48 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-5D4ChT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:28:48 INFO - Running setup.py install for manifestparser 06:28:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:28:48 INFO - Running setup.py install for mozcrash 06:28:48 INFO - Running setup.py install for mozdebug 06:28:48 INFO - Running setup.py install for mozdevice 06:28:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:28:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:28:48 INFO - Running setup.py install for mozfile 06:28:48 INFO - Running setup.py install for mozhttpd 06:28:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:28:49 INFO - Running setup.py install for mozinfo 06:28:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:28:49 INFO - Running setup.py install for mozInstall 06:28:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:28:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:28:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:28:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:28:49 INFO - Running setup.py install for mozleak 06:28:49 INFO - Running setup.py install for mozlog 06:28:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:28:49 INFO - Running setup.py install for moznetwork 06:28:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:28:49 INFO - Running setup.py install for mozprocess 06:28:49 INFO - Running setup.py install for mozprofile 06:28:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:28:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:28:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:28:50 INFO - Running setup.py install for mozrunner 06:28:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:28:50 INFO - Running setup.py install for mozscreenshot 06:28:50 INFO - Running setup.py install for moztest 06:28:50 INFO - Running setup.py install for mozversion 06:28:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:28:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:28:50 INFO - Cleaning up... 06:28:50 INFO - Return code: 0 06:28:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:28:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:50 INFO - 'HOME': '/Users/cltbld', 06:28:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:50 INFO - 'LOGNAME': 'cltbld', 06:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:50 INFO - 'MOZ_NO_REMOTE': '1', 06:28:50 INFO - 'NO_EM_RESTART': '1', 06:28:50 INFO - 'PAGER': '/bin/cat', 06:28:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:50 INFO - 'PWD': '/builds/slave/test', 06:28:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:50 INFO - 'SHELL': '/bin/bash', 06:28:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:50 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:50 INFO - 'USER': 'cltbld', 06:28:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:50 INFO - 'XPC_FLAGS': '0x0', 06:28:50 INFO - 'XPC_SERVICE_NAME': '0', 06:28:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-yx1xBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:51 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)) 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-2l4_tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-uA3OWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:51 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)) 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-nfGFsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-FcCBiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-Mi9shw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-1OOIok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-a2X1Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-lWDx2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:51 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-P3NoX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:52 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)) 06:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:52 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-Wkd6HF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:52 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)) 06:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:52 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-zThpku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:52 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)) 06:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:52 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-ql1KRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:52 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)) 06:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:52 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-gp1C1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:52 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-hZmiqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:52 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-kBy4ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:52 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)) 06:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:52 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-F9K6Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:28:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:55 INFO - Downloading blessings-1.6.tar.gz 06:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:28:55 INFO - Installing collected packages: blessings 06:28:55 INFO - Running setup.py install for blessings 06:28:55 INFO - Successfully installed blessings 06:28:55 INFO - Cleaning up... 06:28:55 INFO - Return code: 0 06:28:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:28:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:56 INFO - Reading from file tmpfile_stdout 06:28:56 INFO - Current package versions: 06:28:56 INFO - blessings == 1.6 06:28:56 INFO - blobuploader == 1.2.4 06:28:56 INFO - docopt == 0.6.1 06:28:56 INFO - functools32 == 3.2.3-2 06:28:56 INFO - jsonschema == 2.5.1 06:28:56 INFO - manifestparser == 1.1 06:28:56 INFO - mozInstall == 1.12 06:28:56 INFO - mozcrash == 0.17 06:28:56 INFO - mozdebug == 0.1 06:28:56 INFO - mozdevice == 0.48 06:28:56 INFO - mozfile == 1.2 06:28:56 INFO - mozhttpd == 0.7 06:28:56 INFO - mozinfo == 0.9 06:28:56 INFO - mozleak == 0.1 06:28:56 INFO - mozlog == 3.4 06:28:56 INFO - moznetwork == 0.27 06:28:56 INFO - mozprocess == 0.23 06:28:56 INFO - mozprofile == 0.28 06:28:56 INFO - mozrunner == 6.12 06:28:56 INFO - mozscreenshot == 0.1 06:28:56 INFO - mozsystemmonitor == 0.3 06:28:56 INFO - moztest == 0.7 06:28:56 INFO - mozversion == 1.4 06:28:56 INFO - psutil == 3.1.1 06:28:56 INFO - requests == 1.2.3 06:28:56 INFO - wsgiref == 0.1.2 06:28:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:56 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')]} 06:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:56 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')]} 06:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:56 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 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:56 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 06:28:56 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 06:28:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:56 INFO - 'HOME': '/Users/cltbld', 06:28:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:56 INFO - 'LOGNAME': 'cltbld', 06:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:56 INFO - 'MOZ_NO_REMOTE': '1', 06:28:56 INFO - 'NO_EM_RESTART': '1', 06:28:56 INFO - 'PAGER': '/bin/cat', 06:28:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:56 INFO - 'PWD': '/builds/slave/test', 06:28:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:56 INFO - 'SHELL': '/bin/bash', 06:28:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:56 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:56 INFO - 'USER': 'cltbld', 06:28:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:56 INFO - 'XPC_FLAGS': '0x0', 06:28:56 INFO - 'XPC_SERVICE_NAME': '0', 06:28:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:56 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)) 06:28:56 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)) 06:28:56 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)) 06:28:56 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)) 06:28:56 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)) 06:28:56 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)) 06:28:56 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)) 06:28:56 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)) 06:28:56 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)) 06:28:56 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)) 06:28:56 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)) 06:28:56 INFO - Cleaning up... 06:28:56 INFO - Return code: 0 06:28:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28:56 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')]} 06:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:56 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')]} 06:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:56 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 0x1075b3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa033595530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, '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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 06:28:56 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 06:28:56 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 06:28:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:28:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:56 INFO - 'HOME': '/Users/cltbld', 06:28:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:56 INFO - 'LOGNAME': 'cltbld', 06:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:56 INFO - 'MOZ_NO_REMOTE': '1', 06:28:56 INFO - 'NO_EM_RESTART': '1', 06:28:56 INFO - 'PAGER': '/bin/cat', 06:28:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:56 INFO - 'PWD': '/builds/slave/test', 06:28:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:56 INFO - 'SHELL': '/bin/bash', 06:28:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:28:56 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:28:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:56 INFO - 'USER': 'cltbld', 06:28:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:56 INFO - 'XPC_FLAGS': '0x0', 06:28:56 INFO - 'XPC_SERVICE_NAME': '0', 06:28:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:28:56 INFO - Cleaning up... 06:28:56 INFO - Return code: 0 06:28:56 INFO - Running post-action listener: _resource_record_post_action 06:28:56 INFO - Running post-action listener: _start_resource_monitoring 06:28:56 INFO - Starting resource monitoring. 06:28:56 INFO - [mozharness: 2016-11-09 14:28:56.604142Z] Finished create-virtualenv step (success) 06:28:56 INFO - [mozharness: 2016-11-09 14:28:56.605196Z] Running install step. 06:28:56 INFO - Running pre-action listener: _resource_record_pre_action 06:28:56 INFO - Running main action method: install 06:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:56 INFO - Reading from file tmpfile_stdout 06:28:56 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:56 INFO - Reading from file tmpfile_stdout 06:28:56 INFO - Output received: 06:28:56 INFO - Usage: mozinstall [options] installer 06:28:56 INFO - Options: 06:28:56 INFO - -h, --help show this help message and exit 06:28:56 INFO - -d DEST, --destination=DEST 06:28:56 INFO - Directory to install application into. [default: 06:28:56 INFO - "/builds/slave/test"] 06:28:56 INFO - --app=APP Application being installed. [default: firefox] 06:28:56 INFO - mkdir: /builds/slave/test/build/application 06:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:29:31 INFO - Reading from file tmpfile_stdout 06:29:31 INFO - Output received: 06:29:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:29:31 INFO - Running post-action listener: _resource_record_post_action 06:29:31 INFO - [mozharness: 2016-11-09 14:29:31.267548Z] Finished install step (success) 06:29:31 INFO - [mozharness: 2016-11-09 14:29:31.267673Z] Running run-tests step. 06:29:31 INFO - Running pre-action listener: _resource_record_pre_action 06:29:31 INFO - Running main action method: run_tests 06:29:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:29:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:29:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:29:31 INFO - 2016-11-09 06:29:31.282 screenresolution[1647:8445] starting screenresolution argv=screenresolution get 06:29:31 INFO - 2016-11-09 06:29:31.284 screenresolution[1647:8445] Display 0: 1600x1200x32@60 06:29:31 INFO - 2016-11-09 06:29:31.290 screenresolution[1648:8447] starting screenresolution argv=screenresolution list 06:29:31 INFO - Available Modes on Display 0 06:29:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:29:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:29:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:29:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:29:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:29:31 INFO - Intel Iris: 06:29:31 INFO - Chipset Model: Intel Iris 06:29:31 INFO - Type: GPU 06:29:31 INFO - Bus: Built-In 06:29:31 INFO - VRAM (Dynamic, Max): 1536 MB 06:29:31 INFO - Vendor: Intel (0x8086) 06:29:31 INFO - Device ID: 0x0a2e 06:29:31 INFO - Revision ID: 0x0009 06:29:31 INFO - Displays: 06:29:31 INFO - Display: 06:29:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:29:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:29:31 INFO - Display Serial Number: 1600x1200 60 06:29:31 INFO - Main Display: Yes 06:29:31 INFO - Mirror: Off 06:29:31 INFO - Online: Yes 06:29:31 INFO - Rotation: Supported 06:29:31 INFO - Return code: 0 06:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:29:31 INFO - Python 2.7.3 06:29:31 INFO - Return code: 0 06:29:31 INFO - grabbing minidump binary from tooltool 06:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:31 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 0x1073c7d30>, '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 0x1071eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073bfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:29:31 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 06:29:31 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 06:29:31 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 06:29:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:29:31 INFO - Return code: 0 06:29:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:29:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:29:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:29:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:29:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--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 06:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0304 --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 06:29:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tTL0lYgD6X/Render', 06:29:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:31 INFO - 'HOME': '/Users/cltbld', 06:29:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:31 INFO - 'LOGNAME': 'cltbld', 06:29:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:29:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:31 INFO - 'MOZ_NO_REMOTE': '1', 06:29:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:29:31 INFO - 'NO_EM_RESTART': '1', 06:29:31 INFO - 'PAGER': '/bin/cat', 06:29:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:31 INFO - 'PWD': '/builds/slave/test', 06:29:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:29:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:31 INFO - 'SHELL': '/bin/bash', 06:29:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMNUJtJzCj/Listeners', 06:29:31 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 06:29:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:31 INFO - 'USER': 'cltbld', 06:29:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:31 INFO - 'XPC_FLAGS': '0x0', 06:29:31 INFO - 'XPC_SERVICE_NAME': '0', 06:29:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--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 06:29:31 INFO - mozversion application_buildid: 20161109040522 06:29:31 INFO - mozversion application_changeset: 2a8c3049b464a92b878b23a866649c0fac9cede2 06:29:31 INFO - mozversion application_display_name: Nightly 06:29:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:29:31 INFO - mozversion application_name: Firefox 06:29:31 INFO - mozversion application_remotingname: firefox 06:29:31 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 06:29:31 INFO - mozversion application_vendor: Mozilla 06:29:31 INFO - mozversion application_version: 52.0a1 06:29:31 INFO - mozversion platform_buildid: 20161109040522 06:29:31 INFO - mozversion platform_changeset: 2a8c3049b464a92b878b23a866649c0fac9cede2 06:29:31 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 06:29:31 INFO - mozversion platform_version: 52.0a1 06:29:31 INFO - using testdate: 1478701771 06:29:31 INFO - actual date: 1478701771 06:29:31 INFO - starting webserver on 'localhost:49279' 06:29:31 INFO - SUITE-START | Running 2 tests 06:29:31 INFO - TEST-START | dromaeo_css 06:29:31 INFO - operating with platform_type : mac_ 06:29:31 INFO - Initialising browser for dromaeo_css test... 06:29:31 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmp7xEjPb/profile http://localhost:49279/getInfo.html) 06:29:34 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 06:29:34 INFO - PROCESS | 1658 | colorDepth:24 06:29:34 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 06:29:34 INFO - PROCESS | 1658 | __metrics 06:29:34 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:29:34 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:29:35 INFO - TEST-INFO | 1658: exit 0 06:29:35 INFO - Browser initialized. 06:29:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:29:35 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmp7xEjPb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:47 INFO - PROCESS | 1661 | RSS: Main: 241713152 06:29:47 INFO - PROCESS | 1661 | 06:30:38 INFO - PROCESS | 1661 | 1478701838722 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] 06:32:51 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 06:32:54 INFO - PROCESS | 1661 | RSS: Main: 477405184 06:32:54 INFO - PROCESS | 1661 | 06:35:57 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 06:35:58 INFO - PROCESS | 1661 | RSS: Main: 378003456 06:35:58 INFO - PROCESS | 1661 | 06:39:00 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 06:39:01 INFO - PROCESS | 1661 | RSS: Main: 339460096 06:39:01 INFO - PROCESS | 1661 | 06:42:03 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 06:42:04 INFO - PROCESS | 1661 | RSS: Main: 338739200 06:42:04 INFO - PROCESS | 1661 | 06:45:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 06:45:08 INFO - PROCESS | 1661 | RSS: Main: 330817536 06:45:08 INFO - PROCESS | 1661 | 06:48:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 06:48:12 INFO - PROCESS | 1661 | RSS: Main: 471359488 06:48:12 INFO - PROCESS | 1661 | 06:48:12 INFO - PROCESS | 1661 | __start_tp_report 06:48:12 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 06:48:12 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 06:48:12 INFO - PROCESS | 1661 | |i|pagename|runs| 06:48:12 INFO - PROCESS | 1661 | |0;dojo.html;3360.5463262459566;3371.4774209997445;3376.4766461198515;3387.237871478916;3433.7123578658;5668.064769313069;5721.656700597961;5791.536677065835;5815.214945982291;5834.154047663097;5699.914501282474;5745.569082318832;5759.913601295984;5760.4815566599;5761.625494342865;5169.896602067947;5211;5218;5234.842954711365;5240.109181439165;5292.02097611943;5322.33470816148;5322.946770532303;5331.920021199666;5332.093544097494;5190.584753219752;5240.737963101848;5247.370315562138;5269.973650131744;5316.20256961455;5270.710110943896;5289.338832645919;5294;5304.336957880265;5360.785568577252;5120.539151476348;5133.101707201225;5204.557612602934;5221.738913054332;5234.214867769827;5635.436456354331;5662.8301150965535;5728.283964504437;5738;5748.7987920423;6265.248170219557;6284.591501552384;6288.213973253343;6288.811335659938;6318;6162.137300777895;6248.593841400295;6266.3420340864;6322.367763223687;6343.175387199681;5748.367679555246;5758.510526605201;5762.711864406763;5772.047612144033;5840.59115861894;6308.558400911984;6316.715747791361;6327.683615819191;6339.334369891095;6373.776917807947;6118.663473509;6121.387861213932;6145.907811382833;6174.25908890936;6197.628142311476;6146.477549408351;6217.906731399033;6279;6279.372062793684;6305.716242769086;6149.477294429934;6165.599236049732;6234.376562343729;6245.125682404467;6277.86998340294;6225.221847269091;6283;6297.086922396227;6302.1492098566105;6316.589421687576;4952.529509696573;4953.380827396575;4956.975215123901;4959.380077490314;4980.028894365564;4379.824807007684;4406.889827754332;4422.601965823092;4426.778661066934;4450.532694067141;5822.097574875901;5822.737976791054;5826.251604941959;5867.178594996704;5878.764849405976;6273.686315684197;6310.9368906311265;6317.936820631827;6326.49388048955;6336.144620476177;5677.120046392815;5747.195392645033;5766.452187042224;5811.82564523065;5848.619839710405;5374.489423504839;5377.300950876361;5386.59600529954;5437.238786569884;5457.754401051962;5421.295231619864;6316.05259211122;6345.428911397997;6352.047192921099;6357.713902874474;6230.844228894314;6310.337414571404;6321.051842223703;6341.4292713656;6359.841003974938;5138.229265610188;6224.035274532454;6257.1552840367785;6291.842703932438;6319.873602527831;6182.289036760651;6207.906881396692;6224.253089629274;6224.844378890564;6231.657258850807;6274.933261345674;6287.779927702509;6289.213848268966;6303.054541818764;6306.653134077486;5968.015277479168;6063.999440092512;6066.241719785027;6158.261008678987;6181.412765787243;5891.351951285441;6036.3058248302;6057.273127224761;6080.300765412034;6086.269647642312;4922.483139270325;5898.262717160355;5908.261467316585;5919.171316015675;5923.170756094237;6026.487748541423;6050.092486127116;6092.421219984094;6093.512518998558;6098.993666045053;5878.941210587839;5883.470487656132;5887.116932459994;5902.2622172228475;5910.7635694573455 06:48:12 INFO - PROCESS | 1661 | |1;ext.html;456.4910125210391;497.9841124106822;500.88479649680573;527.9472052794719;577.832428595707;29192.562111568317;30606.69393306069;37797.244055118914;38538.61461385385;38882.02794930121;39020.41469377962;39492.80253598728;39596.80201598995;39752.80123599378;39773.40339894897;9207.723768286962;9347.439153650803;9356.29827762917;9362.344635875492;9365.81268374632;8348.540830254333;8556.828863422728;8587.484750914966;8645.135486451336;8656;11019.393933333704;11281.32312061275;11295.20933534653;11426;11466.541338346457;11115.944420277887;11207.189555551151;11218.719532011683;11221.551137954471;11223.719407014809;7068.257832927571;8419.915800841974;10845.403502807343;11006.174536909684;11072.114230861513;36277.818610906776;38035;38059.61940380588;38093.23813523714;38125.80937095297;3233.692799184097;3282.606087269519;3383.204946837491;3385.238321377695;3582.9430318056234;23686.644700329507;28145.01492447775;29272.121836344944;29550.85224573885;29828;2911.170316459799;2923.92690182745;2925.7513111385556;2925.7951943363973;3022.591950086732;456470;458210;459407;460441;460986;54325;54603.72698136484;54648.45351546513;54718;54754;56964.71517642385;57038.859222815314;57157.714211429506;57165.42834571684;57226.41603759386;14798.260086995608;15176;15193.696126077637;15238.847611523965;15246.542603721906;11872.287662740264;11908.225965312227;11930.22453540517;11962.581309654295;11977.64067077989;11132.888671113347;13090.280034597998;14320.856791432161;14392.568222953329;14640.414383424757;5360.463953604686;6688.4649228061635;6810.8421568332515;6830.7609233676585;6903.585784852925;744.709563270325;835.3317346123077;902.3593248793298;1009.1876039788041;1042.8540004399238;28593.42813143767;28736.856315718287;28900.710992889803;29372.85313573461;29400.705992940224;956.9090936361034;975.7853272280087;993.9751506212402;999.5901680311183;1015.918726501878;12244.714304997848;13100.570839610009;13938.37277322523;14282.785758213427;15007.849921500863;627446;632669;633225;634298;635254;53066.46933530615;53110.17461769508;53296.934061318556;53326.7333663337;53449;1329.2157626999924;1347.6024572751062;1357.4705864712967;1359.4086572341064;1363.1275983370651;22612;26012.739872601032;27593.17220483389;28208.29479263035;29116.70883291225;46128.308075379566;46622;46711.29933050939;46753;46800.297995529414;555209;559215.6313747567;559581;559690;561596;37085.62914370822;37086.072848179014;37149;37543.43684844675;37572.812135939144;42825.715228543195;43419.782901085295;43889.905321775535;44532.77733611311;44885.326720099874;35958.28083438369;36207.818960905024;36277.637223627426;37120;37372.06569835667;35935.82032089823;35951.101222469646;36949.63050369462;37143.44284835675;37185;35213.64786352206;35515.93452196438;36457.45313820348;36532.269354613294;36624;30882;32166.195845103124;32166.35667286688;32416.513752293264;32659.85690500821;23650.645240321064;23848.807559622295;24351.634725479485;24495.38761530976;24715.752842471346 06:48:12 INFO - PROCESS | 1661 | |2;jquery.html;345.7337849855613;364.06798595595274;365.5832351119722;372.8955892350142;395.7229939042669;14473.78289325661;14961.925190374046;15285.006474579144;19689.917054561993;20301.59396812063;15539.689206215897;19118.904405477988;19712.211511539557;20390.796092039076;20643.483912902186;5290.2064690296575;5526.143447765603;6018.458338749511;6018.6689732064715;6027.246594175728;3493.458513930332;4530.592246697796;4973.626977976648;5960;6030.246219222598;3649.4525821126776;3671.6511931366613;6256.718447669843;6666.100076489661;6677.499187560952;6455.096286519891;6540.869182616345;6609.933900661028;6715.496337774686;6729.831754206184;5847.502962248214;5853.85365365865;5867.266591676041;5872.823815285548;5873;25532.23403297904;25617;26083;26394.472110557872;26412.207633771017;2300.7814257645496;2336;2360.280114565074;2482.739312372211;2969.420962912233;14920;14980.625484362869;15196.696066078726;15550.222488875512;15763.448279310169;1787.2493552707895;1806.6296409236074;1883.3220040785307;1885.1139964216795;1902.5243689077731;106219;108263.91736082618;129381;129488;129870;18899;20877.143885179623;20901.89549052245;21079.365079365078;21103.472413189793;33586;33813.830930845186;34669;34839.65160348415;34866.9539913803;8504.872426913602;10346.793064138676;10520.473976301155;10540.736481588021;10684;8563;8571.400001999926;8576.44253123545;8766.60550275239;8772.649094036167;9298.256139508823;9338.813223735624;9423.6701715441;9656.468894210746;9670.854937175947;2940.9264768380963;3719.3119272934596;3735.5143831301757;3735.6637902588895;3767.56672982605;830.9127541608165;862.0991064337782;873.2926329672986;889.5285498685578;927.3462209142539;15579.844201557838;15881.967672101508;19429.902850485658;20460.38618841437;20586.382408527767;848.6732607945985;896.3680605173337;903.9276857851356;921.2675922641382;953.3850666320185;10429.165666746641;11249.212555121063;11252.943735281435;11257.662270131908;11287.887121128848;586031;593686;594270;595330;610407;116445;118352;120267;120887.31179811482;120960.3951980252;895.3956079646213;913.5751875377981;944.3625552751865;945.4516380499294;950.135376807116;13875.514356997457;18587.721184181977;18847.811521885153;18999.620007600046;19198.8480691159;51625.741871290404;52012.73993630007;52849;53382;54775;66010.66994664996;72426;74991.25008750061;76603.46793063996;79506.04939506235;7886.44794864354;8054.114047454893;8084.595770211584;8111.728715959541;8256.009278886571;9005.819883602422;11550.48022838991;12279.324637145042;12551.686207844878;12670.493180273055;10631.787364252517;10908.181886358396;11156.832647510457;11201.551937922392;11245.100391968459;9042.773930651787;10734.302270352402;10932.398718070583;11094.722631934266;11127.664680238424;11077.390743509184;11440.084793216356;11463.713407164887;11487.25332853362;11589.420528973349;7350.264973502607;7624.275693809301;7881.2118788123025;8060.073091594541;8354.373421993254;10300.896991029993;10710.089642380484;11083.279586826831;11102.555897764;11177.161712871404 06:48:12 INFO - PROCESS | 1661 | |3;mootools.html;1463.1659953826318;1479.1199236454308;1615.3377115382696;1774.4321817018558;1793.5964408008192;7963;8179.959100204498;8253.752387428387;8326.666933322675;8339.416240863142;7407.518511296762;7620.466567340289;7633.358827852011;7959.920400795991;8128.59357032149;2259.751427342991;2298.195631528968;2301.873396963166;2306.238941149417;2307.042577330406;2262.1177740681146;2306.884655767205;2320.5010922651627;2321.698179236697;2325.4418939454495;1631.9673606527863;2052.302217246136;2058.8147066763986;2221.4779526811185;2269.0810221860174;2214.966775498369;2224.0103154096514;2225.8553194042333;2228.465168359598;2228.832837537191;2252.3805953362794;2282.4065742906796;2294.5181511882524;2304.193532263711;2305.988470057656;6964.721411143599;8138;8277.95861020691;8279.337652987746;8296.751097467026;4970.751462426864;5137.33214682089;5138.229265610151;5138.948610513922;5139.794408223666;3260.119767662718;3490.5462289902152;3527.065327688165;3534.5935217450065;3539.80531070791;992.3103443107043;1065.5844220753913;1069.0859315285397;1092.792369449802;1095.0473088413132;10816.567337306498;10862.402567858764;10867.40229287381;10881.401522916236;10905.83641245382;4379.715318504287;4472.396226509444;4565.657575681837;4623.214053610895;4631.120087183424;9369.718908432758;9373.578188981512;9384.155426011692;9391.530423478798;9395.389299695498;5061.569766569883;5153.222138362259;5164.690118592896;5170.71561064145;5177.689338639693;4581.830534213849;4638.466576343696;4645.535446455395;4700.059988002413;4755.286706993909;3622.7464077514846;3673.797941113211;3707.610700876423;3741.5136032315627;3784.810759462016;1236.4683186229827;1238.3065483329365;1238.993805030969;1250.662321173278;1256.0767835640797;780.7696729464822;810.7784670004146;822.8847961285425;876.4784952952983;883.779055236191;4767.856964291077;5062.190049592047;5690.630109042899;5695.117256825199;6073.423024812636;840.5587066789984;854.9358798090168;870.56906831119;893.7854914820526;911.6535716427715;3784.1863999239745;3829.1384438501113;3831.394681557107;3912.0415498203124;3915.451836742858;9612.99063598312;10104.393736375841;10105.848412273675;10129;10150.390976541432;10094.343867648578;10096.990300969845;10097.444640544694;10105.191584673208;10106.989301069834;7388.926110738931;7655.387568994467;7783.209861731833;7798.766037018899;7805.102413222552;5677.148427735872;5810.94189058104;5906.852328691645;5917.349091600006;5931.822045338647;9173.266138708754;9286.257099432165;9328.253739700944;9412.341136120405;9495.47774872361;9229.077092290718;9501.61993520279;9503.334766566273;9579.425234485952;9587.616495340108;7013.579185248901;7167.104111986002;7176.06711127571;7184.568925864256;7240.094988126484;7557.622118894144;7733.381329493514;7808.804779880548;7835.686572537034;7847.372210223054;6924.896126558005;6940.479464040116;7042.084529011196;7076;7115.893261601183;6712.597244165366;6778.593284402951;6861.176658800776;6866.141732283465;6931.306869313028;6471.417572418505;6521.282658907611;6622.867542649216;6625.503087268377;6631.403173714196;4739.905201895874;4767.261074533453;4821.252705830602;4891.266310053378;4994.200927851672;4774.1883879739835;4851.442084160367;4878.487758785276;4907.68100073494;4973.079980203674 06:48:12 INFO - PROCESS | 1661 | |4;prototype.html;282.34777663597106;298.8207075754547;299.9100269919025;307.18136167114636;314.0687860493637;5249.790008399665;5358.142697168454;5385;5434.8913021739545;5481.725913704318;5078.974605126969;5224.8693782655455;5337.7598008089635;5381.569474442035;5384.757685904134;4113.979430102852;4114.6091121343425;4130.224003678417;4136.855210067648;4158.209940111385;3858.9807050964705;4014.498187726534;4068.206699693561;4119.176164767044;4174.436451079096;3571.607123216444;3791.488149099878;4008.739431936929;4008.7795171265716;4071.307877660805;4001.6398524132824;4035.9798201009103;4042.110735638155;4045.170739998308;4066.9389959150635;3336.182635254354;3511.719062474996;3513.1568423578415;3519.2961407718303;3529.4882242074755;4132.772697501636;4989.65072444929;5228.947710522884;5245.318108645852;5282.894342113174;3861.691064714816;4544.159330523864;4590.472095709003;4593.26507758757;4636.768161591941;4655.371524844137;5079.923801142986;5175.585953123741;5547.645098597582;5597.80407685729;2706.6481357423604;3477.6522347765276;3827.9808600957094;3854.2676891390547;3885.30064588374;4957.975210123998;5892.616979896293;5939.316978547436;5986.551008674367;6004.5796794224425;3892.2410130024373;3892.5718171001167;3895.454636350913;3900.7322620148566;3920.8039598019986;3453.8618455262013;3622.822582660646;3889.649931506178;3921.5490218624655;3938.5667576566557;4399.73601583906;4479.552044795494;4485.093835120061;4498.6626003049905;4593.989322349078;4594.540545945446;5117.104506711311;5166.844994650167;5405.135178371442;5669.773209071674;1166.7433164703752;1265.8607253471764;1292.662094731948;1294.2558029133286;1298.2016060122955;790.6165509727778;812.8699408094676;821.6918655504186;823.6664151018847;833.9124391938759;4980.975095124573;4986.6010719143105;5012.974935125301;5017.641708397047;5026.89946201074;4570.81716731327;4603.654725895572;5462;5508.91736623951;5546.334439867161;4076.9796151019054;5062.7468626568525;5113;5378.757955891994;5472.288602481652;2926.6049083373896;2948.5871977923107;2964.214483161964;2964.5256758918467;2968.317287023953;5049.5707864831165;5503.697296648643;5769.509591684669;5838.7080645967535;5848.2689663792025;5305.495977882095;5653.943460565424;6050.969745151246;6098.207233059763;6105.298919831705;4899.240617704261;5468.316460442525;5634.859128521738;6081;6149.907751383733;5119.948800511947;5610.551155907599;5848.502877255481;5909.261342332208;5918.73365698536;5777.480026797609;5860.2967643883;5862.091375836752;5870.354261031198;5887.411258874078;5890.293164820249;6079.726412311368;6107.511399087974;6141.692915354125;6169.475594574332;3561.4863682935165;3757.793321367351;3843.442700808423;3866.903327416837;3915.47141135943;5159.432462429205;5598.468145526169;5840.007198776133;5881.705914704333;5888.381719919346;5398.568114550748;5513.283273174622;5646.520045795989;5726.8568285791525;5736.799212027559;4509.616682581886;4793.592544633745;4824.469308376006;5692.7722891083895;5730.561663002165;4898.951010489992;5586.636868603528;5610.5231055360755;5628.099504079328;5639.91106447822;4537.523560026149;5633.802816901389;5672.744726487401;5768.019436695856;5777.508911742549;4358.4769827620885;4936.333594964777;5538.47384498472;5598.608097433141;5618.4662457066515 06:48:12 INFO - PROCESS | 1661 | |5;yui.html;623.7037407231566;733.5671953547406;762.881753328234;791.9791052321171;798.7084714079363;14099.67941697696;14675.486357977474;15005.84994150058;15211.087334759923;15245.69508609827;11614.373987641737;13696.931515342409;13756.724865502683;14436.711265774678;14945.028573142765;807.4065561812049;833.7957200485889;834.3283656656389;834.5326617094447;835.51122593283;641.9903701444482;666.4967949198349;830.6096134816656;831.9833603327929;834.1033389106705;706.5195666946474;707.4587940225706;708.9964550177268;709.3332267668401;837.924586787189;859.9828003439927;864.5763575847852;864.8875646166022;868.2923417414787;868.7393781865416;635.7107516080173;640.903864420336;641.3650486018854;642.6272761798145;644.664774317357;11936.820947685792;12919.547815826494;14771.926140369336;14805.851941480554;14823.481178158821;13126.474941002349;13181.538646147339;13312.201267923956;13343.933280333633;13629.25039122848;11257.54969801207;11415.657530274106;11428.200025998183;11433.42832858362;11634.30194188343;3001.864916078782;3589.407747721649;3727.7763334200035;3773.3585290500682;3808.847646094153;94328.05671943261;94333.52833235859;94621.5268923651;98281.50859245729;98486.5227021588;10399.636012739518;10419.739506512245;10457.059214371755;10579.735506612396;10597.470126493645;19520.219191232474;20249.291274805604;20424.897875510527;20426.795732042785;20461;7449.813754656068;7509.586972716553;7535.962320188364;7592.278733520307;7651.120121186023;3975.6223158799867;4023.4769479968004;4034.8789536313957;4078.775667338325;4213.578642135762;3342.9498557521656;3453.188500702333;3458.8270586470576;3463.9134021649156;3465.5668041494814;569.5073761196618;607.6232735703892;617.9505639548826;622.1290193728815;624.8437890527368;511.93856737191777;526.689253340531;608.5314307982917;645.5965021861336;657.1358663357765;8538.18887205727;8899.599518021705;9049.954750226207;9058.637654493878;9063.954680226556;590.2091197794975;618.9876202475925;648.9422241745924;661.7220767277659;664.570459347135;4177.4778152730905;4415.845445409395;4432.623227025739;4437.889052773642;4559.202139625552;108522;111608.88391116148;115292;115298;118067;98117;100345.49827250816;102691;103004;103325;89068.6639700405;89100.663490049;89823;90754.54622726976;92680;8610.741677749678;8648.351373646876;8649.697260595849;8768.342374321825;8892.73321800347;50251.74874125606;51440.94236230509;51694.67373968105;55725;56692;73630;76993;78460.60769696115;78569;79810.60094699489;12240.510379584717;12307.507699691912;12315.076369272161;12652.11435199564;13016.414261358072;13488.662783430493;13528.526501572398;13575.86424135746;14041.648958775704;14151;10791.730206744895;13017.21896686202;13050.934745326213;13545.932270338586;13677.589672309847;12027.518899243933;12928.612141635766;12959.546415875398;13233.404496797475;13328.067035307824;11353.602623908124;12163.148579599698;12594.559190428292;12698.019065379945;12816.231026138461;10510.894891050992;10633.468326583794;10845.837312440162;11105.333679979227;11444.656660300205;10620.734481638021;11129;11271.661850144508;11279.7744045117;11287.887121129012 06:48:12 INFO - PROCESS | 1661 | __end_tp_report 06:48:12 INFO - PROCESS | 1661 | __start_cc_report 06:48:12 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,3017 06:48:12 INFO - PROCESS | 1661 | __end_cc_report 06:48:12 INFO - PROCESS | 1661 | __startTimestamp1478702892251__endTimestamp 06:48:12 INFO - PROCESS | 1661 | 06:48:12 INFO - PROCESS | 1661 | ------- Summary: start ------- 06:48:12 INFO - PROCESS | 1661 | Number of tests: 6 06:48:12 INFO - PROCESS | 1661 | 06:48:12 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5756.69 Median:5898.26 stddev:639.82 (10.8%) stddev-sans-first:613.54 06:48:12 INFO - PROCESS | 1661 | Values: 3360.5 3371.5 3376.5 3387.2 3433.7 5668.1 5721.7 5791.5 5815.2 5834.2 5699.9 5745.6 5759.9 5760.5 5761.6 5169.9 5211.0 5218.0 5234.8 5240.1 5292.0 5322.3 5322.9 5331.9 5332.1 5190.6 5240.7 5247.4 5270.0 5316.2 5270.7 5289.3 5294.0 5304.3 5360.8 5120.5 5133.1 5204.6 5221.7 5234.2 5635.4 5662.8 5728.3 5738.0 5748.8 6265.2 6284.6 6288.2 6288.8 6318.0 6162.1 6248.6 6266.3 6322.4 6343.2 5748.4 5758.5 5762.7 5772.0 5840.6 6308.6 6316.7 6327.7 6339.3 6373.8 6118.7 6121.4 6145.9 6174.3 6197.6 6146.5 6217.9 6279.0 6279.4 6305.7 6149.5 6165.6 6234.4 6245.1 6277.9 6225.2 6283.0 6297.1 6302.1 6316.6 4952.5 4953.4 4957.0 4959.4 4980.0 4379.8 4406.9 4422.6 4426.8 4450.5 5822.1 5822.7 5826.3 5867.2 5878.8 6273.7 6310.9 6317.9 6326.5 6336.1 5677.1 5747.2 5766.5 5811.8 5848.6 5374.5 5377.3 5386.6 5437.2 5457.8 5421.3 6316.1 6345.4 6352.0 6357.7 6230.8 6310.3 6321.1 6341.4 6359.8 5138.2 6224.0 6257.2 6291.8 6319.9 6182.3 6207.9 6224.3 6224.8 6231.7 6274.9 6287.8 6289.2 6303.1 6306.7 5968.0 6064.0 6066.2 6158.3 6181.4 5891.4 6036.3 6057.3 6080.3 6086.3 4922.5 5898.3 5908.3 5919.2 5923.2 6026.5 6050.1 6092.4 6093.5 6099.0 5878.9 5883.5 5887.1 5902.3 5910.8 06:48:12 INFO - PROCESS | 1661 | 06:48:12 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:67390.94 Median:37085.85 stddev:148368.00 (400.1%) stddev-sans-first:148699.10 06:48:12 INFO - PROCESS | 1661 | Values: 456.5 498.0 500.9 527.9 577.8 29192.6 30606.7 37797.2 38538.6 38882.0 39020.4 39492.8 39596.8 39752.8 39773.4 9207.7 9347.4 9356.3 9362.3 9365.8 8348.5 8556.8 8587.5 8645.1 8656.0 11019.4 11281.3 11295.2 11426.0 11466.5 11115.9 11207.2 11218.7 11221.6 11223.7 7068.3 8419.9 10845.4 11006.2 11072.1 36277.8 38035.0 38059.6 38093.2 38125.8 3233.7 3282.6 3383.2 3385.2 3582.9 23686.6 28145.0 29272.1 29550.9 29828.0 2911.2 2923.9 2925.8 2925.8 3022.6 456470.0 458210.0 459407.0 460441.0 460986.0 54325.0 54603.7 54648.5 54718.0 54754.0 56964.7 57038.9 57157.7 57165.4 57226.4 14798.3 15176.0 15193.7 15238.8 15246.5 11872.3 11908.2 11930.2 11962.6 11977.6 11132.9 13090.3 14320.9 14392.6 14640.4 5360.5 6688.5 6810.8 6830.8 6903.6 744.7 835.3 902.4 1009.2 1042.9 28593.4 28736.9 28900.7 29372.9 29400.7 956.9 975.8 994.0 999.6 1015.9 12244.7 13100.6 13938.4 14282.8 15007.8 627446.0 632669.0 633225.0 634298.0 635254.0 53066.5 53110.2 53296.9 53326.7 53449.0 1329.2 1347.6 1357.5 1359.4 1363.1 22612.0 26012.7 27593.2 28208.3 29116.7 46128.3 46622.0 46711.3 46753.0 46800.3 555209.0 559215.6 559581.0 559690.0 561596.0 37085.6 37086.1 37149.0 37543.4 37572.8 42825.7 43419.8 43889.9 44532.8 44885.3 35958.3 36207.8 36277.6 37120.0 37372.1 35935.8 35951.1 36949.6 37143.4 37185.0 35213.6 35515.9 36457.5 36532.3 36624.0 30882.0 32166.2 32166.4 32416.5 32659.9 23650.6 23848.8 24351.6 24495.4 24715.8 06:48:12 INFO - PROCESS | 1661 | 06:48:12 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35604.44 Median:17507.37 stddev:99153.93 (566.4%) stddev-sans-first:99396.74 06:48:12 INFO - PROCESS | 1661 | Values: 345.7 364.1 365.6 372.9 395.7 14473.8 14961.9 15285.0 19689.9 20301.6 15539.7 19118.9 19712.2 20390.8 20643.5 5290.2 5526.1 6018.5 6018.7 6027.2 3493.5 4530.6 4973.6 5960.0 6030.2 3649.5 3671.7 6256.7 6666.1 6677.5 6455.1 6540.9 6609.9 6715.5 6729.8 5847.5 5853.9 5867.3 5872.8 5873.0 25532.2 25617.0 26083.0 26394.5 26412.2 2300.8 2336.0 2360.3 2482.7 2969.4 14920.0 14980.6 15196.7 15550.2 15763.4 1787.2 1806.6 1883.3 1885.1 1902.5 106219.0 108263.9 129381.0 129488.0 129870.0 18899.0 20877.1 20901.9 21079.4 21103.5 33586.0 33813.8 34669.0 34839.7 34867.0 8504.9 10346.8 10520.5 10540.7 10684.0 8563.0 8571.4 8576.4 8766.6 8772.6 9298.3 9338.8 9423.7 9656.5 9670.9 2940.9 3719.3 3735.5 3735.7 3767.6 830.9 862.1 873.3 889.5 927.3 15579.8 15882.0 19429.9 20460.4 20586.4 848.7 896.4 903.9 921.3 953.4 10429.2 11249.2 11252.9 11257.7 11287.9 586031.0 593686.0 594270.0 595330.0 610407.0 116445.0 118352.0 120267.0 120887.3 120960.4 895.4 913.6 944.4 945.5 950.1 13875.5 18587.7 18847.8 18999.6 19198.8 51625.7 52012.7 52849.0 53382.0 54775.0 66010.7 72426.0 74991.3 76603.5 79506.0 7886.4 8054.1 8084.6 8111.7 8256.0 9005.8 11550.5 12279.3 12551.7 12670.5 10631.8 10908.2 11156.8 11201.6 11245.1 9042.8 10734.3 10932.4 11094.7 11127.7 11077.4 11440.1 11463.7 11487.3 11589.4 7350.3 7624.3 7881.2 8060.1 8354.4 10300.9 10710.1 11083.3 11102.6 11177.2 06:48:12 INFO - PROCESS | 1661 | 06:48:12 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5402.11 Median:5061.88 stddev:2967.90 (58.6%) stddev-sans-first:2961.47 06:48:12 INFO - PROCESS | 1661 | Values: 1463.2 1479.1 1615.3 1774.4 1793.6 7963.0 8180.0 8253.8 8326.7 8339.4 7407.5 7620.5 7633.4 7959.9 8128.6 2259.8 2298.2 2301.9 2306.2 2307.0 2262.1 2306.9 2320.5 2321.7 2325.4 1632.0 2052.3 2058.8 2221.5 2269.1 2215.0 2224.0 2225.9 2228.5 2228.8 2252.4 2282.4 2294.5 2304.2 2306.0 6964.7 8138.0 8278.0 8279.3 8296.8 4970.8 5137.3 5138.2 5138.9 5139.8 3260.1 3490.5 3527.1 3534.6 3539.8 992.3 1065.6 1069.1 1092.8 1095.0 10816.6 10862.4 10867.4 10881.4 10905.8 4379.7 4472.4 4565.7 4623.2 4631.1 9369.7 9373.6 9384.2 9391.5 9395.4 5061.6 5153.2 5164.7 5170.7 5177.7 4581.8 4638.5 4645.5 4700.1 4755.3 3622.7 3673.8 3707.6 3741.5 3784.8 1236.5 1238.3 1239.0 1250.7 1256.1 780.8 810.8 822.9 876.5 883.8 4767.9 5062.2 5690.6 5695.1 6073.4 840.6 854.9 870.6 893.8 911.7 3784.2 3829.1 3831.4 3912.0 3915.5 9613.0 10104.4 10105.8 10129.0 10150.4 10094.3 10097.0 10097.4 10105.2 10107.0 7388.9 7655.4 7783.2 7798.8 7805.1 5677.1 5810.9 5906.9 5917.3 5931.8 9173.3 9286.3 9328.3 9412.3 9495.5 9229.1 9501.6 9503.3 9579.4 9587.6 7013.6 7167.1 7176.1 7184.6 7240.1 7557.6 7733.4 7808.8 7835.7 7847.4 6924.9 6940.5 7042.1 7076.0 7115.9 6712.6 6778.6 6861.2 6866.1 6931.3 6471.4 6521.3 6622.9 6625.5 6631.4 4739.9 4767.3 4821.3 4891.3 4994.2 4774.2 4851.4 4878.5 4907.7 4973.1 06:48:12 INFO - PROCESS | 1661 | 06:48:12 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4529.95 Median:5038.24 stddev:1415.21 (28.1%) stddev-sans-first:1382.80 06:48:12 INFO - PROCESS | 1661 | Values: 282.3 298.8 299.9 307.2 314.1 5249.8 5358.1 5385.0 5434.9 5481.7 5079.0 5224.9 5337.8 5381.6 5384.8 4114.0 4114.6 4130.2 4136.9 4158.2 3859.0 4014.5 4068.2 4119.2 4174.4 3571.6 3791.5 4008.7 4008.8 4071.3 4001.6 4036.0 4042.1 4045.2 4066.9 3336.2 3511.7 3513.2 3519.3 3529.5 4132.8 4989.7 5228.9 5245.3 5282.9 3861.7 4544.2 4590.5 4593.3 4636.8 4655.4 5079.9 5175.6 5547.6 5597.8 2706.6 3477.7 3828.0 3854.3 3885.3 4958.0 5892.6 5939.3 5986.6 6004.6 3892.2 3892.6 3895.5 3900.7 3920.8 3453.9 3622.8 3889.6 3921.5 3938.6 4399.7 4479.6 4485.1 4498.7 4594.0 4594.5 5117.1 5166.8 5405.1 5669.8 1166.7 1265.9 1292.7 1294.3 1298.2 790.6 812.9 821.7 823.7 833.9 4981.0 4986.6 5013.0 5017.6 5026.9 4570.8 4603.7 5462.0 5508.9 5546.3 4077.0 5062.7 5113.0 5378.8 5472.3 2926.6 2948.6 2964.2 2964.5 2968.3 5049.6 5503.7 5769.5 5838.7 5848.3 5305.5 5653.9 6051.0 6098.2 6105.3 4899.2 5468.3 5634.9 6081.0 6149.9 5119.9 5610.6 5848.5 5909.3 5918.7 5777.5 5860.3 5862.1 5870.4 5887.4 5890.3 6079.7 6107.5 6141.7 6169.5 3561.5 3757.8 3843.4 3866.9 3915.5 5159.4 5598.5 5840.0 5881.7 5888.4 5398.6 5513.3 5646.5 5726.9 5736.8 4509.6 4793.6 4824.5 5692.8 5730.6 4899.0 5586.6 5610.5 5628.1 5639.9 4537.5 5633.8 5672.7 5768.0 5777.5 4358.5 4936.3 5538.5 5598.6 5618.5 06:48:12 INFO - PROCESS | 1661 | 06:48:12 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:21207.15 Median:4029.18 stddev:31739.20 (787.7%) stddev-sans-first:31790.61 06:48:12 INFO - PROCESS | 1661 | Values: 623.7 733.6 762.9 792.0 798.7 14099.7 14675.5 15005.8 15211.1 15245.7 11614.4 13696.9 13756.7 14436.7 14945.0 807.4 833.8 834.3 834.5 835.5 642.0 666.5 830.6 832.0 834.1 706.5 707.5 709.0 709.3 837.9 860.0 864.6 864.9 868.3 868.7 635.7 640.9 641.4 642.6 644.7 11936.8 12919.5 14771.9 14805.9 14823.5 13126.5 13181.5 13312.2 13343.9 13629.3 11257.5 11415.7 11428.2 11433.4 11634.3 3001.9 3589.4 3727.8 3773.4 3808.8 94328.1 94333.5 94621.5 98281.5 98486.5 10399.6 10419.7 10457.1 10579.7 10597.5 19520.2 20249.3 20424.9 20426.8 20461.0 7449.8 7509.6 7536.0 7592.3 7651.1 3975.6 4023.5 4034.9 4078.8 4213.6 3342.9 3453.2 3458.8 3463.9 3465.6 569.5 607.6 618.0 622.1 624.8 511.9 526.7 608.5 645.6 657.1 8538.2 8899.6 9050.0 9058.6 9064.0 590.2 619.0 648.9 661.7 664.6 4177.5 4415.8 4432.6 4437.9 4559.2 108522.0 111608.9 115292.0 115298.0 118067.0 98117.0 100345.5 102691.0 103004.0 103325.0 89068.7 89100.7 89823.0 90754.5 92680.0 8610.7 8648.4 8649.7 8768.3 8892.7 50251.7 51440.9 51694.7 55725.0 56692.0 73630.0 76993.0 78460.6 78569.0 79810.6 12240.5 12307.5 12315.1 12652.1 13016.4 13488.7 13528.5 13575.9 14041.6 14151.0 10791.7 13017.2 13050.9 13545.9 13677.6 12027.5 12928.6 12959.5 13233.4 13328.1 11353.6 12163.1 12594.6 12698.0 12816.2 10510.9 10633.5 10845.8 11105.3 11444.7 10620.7 11129.0 11271.7 11279.8 11287.9 06:48:12 INFO - PROCESS | 1661 | -------- Summary: end -------- 06:48:12 INFO - PROCESS | 1661 | 06:48:12 INFO - TEST-INFO | 1661: exit 0 06:48:12 INFO - TEST-OK | dromaeo_css | took 1121074ms 06:48:12 INFO - TEST-START | kraken 06:48:12 INFO - operating with platform_type : mac_ 06:48:12 INFO - Initialising browser for kraken test... 06:48:12 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpwH9hJY/profile http://localhost:49279/getInfo.html) 06:48:15 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 06:48:15 INFO - PROCESS | 1668 | colorDepth:24 06:48:15 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 06:48:15 INFO - PROCESS | 1668 | __metrics 06:48:15 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:48:15 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:48:16 INFO - TEST-INFO | 1668: exit 0 06:48:16 INFO - Browser initialized. 06:48:16 INFO - Running cycle 1/1 for kraken test... 06:48:16 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpwH9hJY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:28 INFO - PROCESS | 1669 | RSS: Main: 233189376 06:48:28 INFO - PROCESS | 1669 | 06:48:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 06:48:31 INFO - PROCESS | 1669 | RSS: Main: 292610048 06:48:31 INFO - PROCESS | 1669 | 06:48:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 06:48:34 INFO - PROCESS | 1669 | RSS: Main: 294768640 06:48:34 INFO - PROCESS | 1669 | 06:48:38 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 06:48:39 INFO - PROCESS | 1669 | RSS: Main: 385597440 06:48:39 INFO - PROCESS | 1669 | 06:48:41 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 06:48:41 INFO - PROCESS | 1669 | RSS: Main: 288038912 06:48:41 INFO - PROCESS | 1669 | 06:48:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:48:44 INFO - PROCESS | 1669 | RSS: Main: 290246656 06:48:44 INFO - PROCESS | 1669 | 06:48:47 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 06:48:47 INFO - PROCESS | 1669 | RSS: Main: 328937472 06:48:47 INFO - PROCESS | 1669 | 06:48:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 06:48:51 INFO - PROCESS | 1669 | RSS: Main: 329904128 06:48:51 INFO - PROCESS | 1669 | 06:48:54 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 06:48:54 INFO - PROCESS | 1669 | RSS: Main: 326332416 06:48:54 INFO - PROCESS | 1669 | 06:48:56 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:48:57 INFO - PROCESS | 1669 | RSS: Main: 301568000 06:48:57 INFO - PROCESS | 1669 | 06:48:59 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:48:59 INFO - PROCESS | 1669 | RSS: Main: 304734208 06:48:59 INFO - PROCESS | 1669 | 06:49:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:49:02 INFO - PROCESS | 1669 | RSS: Main: 312610816 06:49:02 INFO - PROCESS | 1669 | 06:49:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:49:06 INFO - PROCESS | 1669 | RSS: Main: 325079040 06:49:06 INFO - PROCESS | 1669 | 06:49:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:49:09 INFO - PROCESS | 1669 | RSS: Main: 319082496 06:49:09 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 06:49:11 INFO - PROCESS | 1669 | RSS: Main: 362455040 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | __start_tp_report 06:49:11 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 06:49:11 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 06:49:11 INFO - PROCESS | 1669 | |i|pagename|runs| 06:49:11 INFO - PROCESS | 1669 | |0;ai-astar;111;114;116;114;115;116;114;114;115;114 06:49:11 INFO - PROCESS | 1669 | |1;audio-beat-detection;149;115;115;143;113;115;115;108;143;112 06:49:11 INFO - PROCESS | 1669 | |2;audio-dft;183;184;182;184;182;182;182;182;183;181 06:49:11 INFO - PROCESS | 1669 | |3;audio-fft;82;75;83;112;62;60;59;59;84;59 06:49:11 INFO - PROCESS | 1669 | |4;audio-oscillator;88;70;93;71;69;70;90;67;69;92 06:49:11 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;89;86;93;131;119;86;90;87;89;86 06:49:11 INFO - PROCESS | 1669 | |6;imaging-darkroom;96;97;97;103;95;98;97;98;97;97 06:49:11 INFO - PROCESS | 1669 | |7;imaging-desaturate;81;94;108;118;123;81;85;83;92;126 06:49:11 INFO - PROCESS | 1669 | |8;json-parse-financial;55;56;53;54;53;54;55;54;54;55 06:49:11 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;64;72;67;81;74;73;67;75;70;69 06:49:11 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;85;86;86;91;86;89;86;88;93;85 06:49:11 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;144;147;162;165;155;146;146;150;185;161 06:49:11 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;222;243;187;175;176;175;173;173;177;173 06:49:11 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;67;67;68;68;66;67;69;67;65;67 06:49:11 INFO - PROCESS | 1669 | __end_tp_report 06:49:11 INFO - PROCESS | 1669 | __start_cc_report 06:49:11 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2041 06:49:11 INFO - PROCESS | 1669 | __end_cc_report 06:49:11 INFO - PROCESS | 1669 | __startTimestamp1478702951953__endTimestamp 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | ------- Summary: start ------- 06:49:11 INFO - PROCESS | 1669 | Number of tests: 14 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.50 stddev:1.42 (1.2%) stddev-sans-first:0.87 06:49:11 INFO - PROCESS | 1669 | Values: 111.0 114.0 116.0 114.0 115.0 116.0 114.0 114.0 115.0 114.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:115.00 stddev:15.55 (13.5%) stddev-sans-first:13.30 06:49:11 INFO - PROCESS | 1669 | Values: 149.0 115.0 115.0 143.0 113.0 115.0 115.0 108.0 143.0 112.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:182.50 Median:182.50 stddev:0.97 (0.5%) stddev-sans-first:1.01 06:49:11 INFO - PROCESS | 1669 | Values: 183.0 184.0 182.0 184.0 182.0 182.0 182.0 182.0 183.0 181.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:73.50 Median:68.50 stddev:17.33 (25.3%) stddev-sans-first:18.10 06:49:11 INFO - PROCESS | 1669 | Values: 82.0 75.0 83.0 112.0 62.0 60.0 59.0 59.0 84.0 59.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.50 stddev:11.18 (14.1%) stddev-sans-first:11.24 06:49:11 INFO - PROCESS | 1669 | Values: 88.0 70.0 93.0 71.0 69.0 70.0 90.0 67.0 69.0 92.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:88.00 stddev:15.90 (18.1%) stddev-sans-first:16.69 06:49:11 INFO - PROCESS | 1669 | Values: 89.0 86.0 93.0 131.0 119.0 86.0 90.0 87.0 89.0 86.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:97.50 Median:97.00 stddev:2.12 (2.2%) stddev-sans-first:2.18 06:49:11 INFO - PROCESS | 1669 | Values: 96.0 97.0 97.0 103.0 95.0 98.0 97.0 98.0 97.0 97.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:99.10 Median:82.00 stddev:18.02 (22.0%) stddev-sans-first:17.88 06:49:11 INFO - PROCESS | 1669 | Values: 81.0 94.0 108.0 118.0 123.0 81.0 85.0 83.0 92.0 126.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:0.95 (1.7%) stddev-sans-first:0.97 06:49:11 INFO - PROCESS | 1669 | Values: 55.0 56.0 53.0 54.0 53.0 54.0 55.0 54.0 54.0 55.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:72.50 stddev:4.89 (6.8%) stddev-sans-first:4.44 06:49:11 INFO - PROCESS | 1669 | Values: 64.0 72.0 67.0 81.0 74.0 73.0 67.0 75.0 70.0 69.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.00 stddev:2.72 (3.1%) stddev-sans-first:2.73 06:49:11 INFO - PROCESS | 1669 | Values: 85.0 86.0 86.0 91.0 86.0 89.0 86.0 88.0 93.0 85.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:156.10 Median:158.00 stddev:12.67 (8.0%) stddev-sans-first:12.66 06:49:11 INFO - PROCESS | 1669 | Values: 144.0 147.0 162.0 165.0 155.0 146.0 146.0 150.0 185.0 161.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.40 Median:176.50 stddev:24.62 (14.0%) stddev-sans-first:22.71 06:49:11 INFO - PROCESS | 1669 | Values: 222.0 243.0 187.0 175.0 176.0 175.0 173.0 173.0 177.0 173.0 06:49:11 INFO - PROCESS | 1669 | 06:49:11 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 06:49:11 INFO - PROCESS | 1669 | Values: 67.0 67.0 68.0 68.0 66.0 67.0 69.0 67.0 65.0 67.0 06:49:11 INFO - PROCESS | 1669 | -------- Summary: end -------- 06:49:11 INFO - PROCESS | 1669 | 06:49:12 INFO - TEST-INFO | 1669: exit 0 06:49:12 INFO - TEST-OK | kraken | took 59939ms 06:49:12 INFO - SUITE-END | took 1181s 06:49:13 INFO - Completed test suite (00:19:41) 06:49:13 INFO - javascript benchmark 06:49:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.5463262459566, 3371.4774209997445, 3376.4766461198515, 3387.237871478916, 3433.7123578658, 5668.064769313069, 5721.656700597961, 5791.536677065835, 5815.214945982291, 5834.154047663097, 5699.914501282474, 5745.569082318832, 5759.913601295984, 5760.4815566599, 5761.625494342865, 5169.896602067947, 5211.0, 5218.0, 5234.842954711365, 5240.109181439165, 5292.02097611943, 5322.33470816148, 5322.946770532303, 5331.920021199666, 5332.093544097494, 5190.584753219752, 5240.737963101848, 5247.370315562138, 5269.973650131744, 5316.20256961455, 5270.710110943896, 5289.338832645919, 5294.0, 5304.336957880265, 5360.785568577252, 5120.539151476348, 5133.101707201225, 5204.557612602934, 5221.738913054332, 5234.214867769827, 5635.436456354331, 5662.8301150965535, 5728.283964504437, 5738.0, 5748.7987920423, 6265.248170219557, 6284.591501552384, 6288.213973253343, 6288.811335659938, 6318.0, 6162.137300777895, 6248.593841400295, 6266.3420340864, 6322.367763223687, 6343.175387199681, 5748.367679555246, 5758.510526605201, 5762.711864406763, 5772.047612144033, 5840.59115861894, 6308.558400911984, 6316.715747791361, 6327.683615819191, 6339.334369891095, 6373.776917807947, 6118.663473509, 6121.387861213932, 6145.907811382833, 6174.25908890936, 6197.628142311476, 6146.477549408351, 6217.906731399033, 6279.0, 6279.372062793684, 6305.716242769086, 6149.477294429934, 6165.599236049732, 6234.376562343729, 6245.125682404467, 6277.86998340294, 6225.221847269091, 6283.0, 6297.086922396227, 6302.1492098566105, 6316.589421687576, 4952.529509696573, 4953.380827396575, 4956.975215123901, 4959.380077490314, 4980.028894365564, 4379.824807007684, 4406.889827754332, 4422.601965823092, 4426.778661066934, 4450.532694067141, 5822.097574875901, 5822.737976791054, 5826.251604941959, 5867.178594996704, 5878.764849405976, 6273.686315684197, 6310.9368906311265, 6317.936820631827, 6326.49388048955, 6336.144620476177, 5677.120046392815, 5747.195392645033, 5766.452187042224, 5811.82564523065, 5848.619839710405, 5374.489423504839, 5377.300950876361, 5386.59600529954, 5437.238786569884, 5457.754401051962, 5421.295231619864, 6316.05259211122, 6345.428911397997, 6352.047192921099, 6357.713902874474, 6230.844228894314, 6310.337414571404, 6321.051842223703, 6341.4292713656, 6359.841003974938, 5138.229265610188, 6224.035274532454, 6257.1552840367785, 6291.842703932438, 6319.873602527831, 6182.289036760651, 6207.906881396692, 6224.253089629274, 6224.844378890564, 6231.657258850807, 6274.933261345674, 6287.779927702509, 6289.213848268966, 6303.054541818764, 6306.653134077486, 5968.015277479168, 6063.999440092512, 6066.241719785027, 6158.261008678987, 6181.412765787243, 5891.351951285441, 6036.3058248302, 6057.273127224761, 6080.300765412034, 6086.269647642312, 4922.483139270325, 5898.262717160355, 5908.261467316585, 5919.171316015675, 5923.170756094237, 6026.487748541423, 6050.092486127116, 6092.421219984094, 6093.512518998558, 6098.993666045053, 5878.941210587839, 5883.470487656132, 5887.116932459994, 5902.2622172228475, 5910.7635694573455], "value": 5716.17783139655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.4910125210391, 497.9841124106822, 500.88479649680573, 527.9472052794719, 577.832428595707, 29192.562111568317, 30606.69393306069, 37797.244055118914, 38538.61461385385, 38882.02794930121, 39020.41469377962, 39492.80253598728, 39596.80201598995, 39752.80123599378, 39773.40339894897, 9207.723768286962, 9347.439153650803, 9356.29827762917, 9362.344635875492, 9365.81268374632, 8348.540830254333, 8556.828863422728, 8587.484750914966, 8645.135486451336, 8656.0, 11019.393933333704, 11281.32312061275, 11295.20933534653, 11426.0, 11466.541338346457, 11115.944420277887, 11207.189555551151, 11218.719532011683, 11221.551137954471, 11223.719407014809, 7068.257832927571, 8419.915800841974, 10845.403502807343, 11006.174536909684, 11072.114230861513, 36277.818610906776, 38035.0, 38059.61940380588, 38093.23813523714, 38125.80937095297, 3233.692799184097, 3282.606087269519, 3383.204946837491, 3385.238321377695, 3582.9430318056234, 23686.644700329507, 28145.01492447775, 29272.121836344944, 29550.85224573885, 29828.0, 2911.170316459799, 2923.92690182745, 2925.7513111385556, 2925.7951943363973, 3022.591950086732, 456470.0, 458210.0, 459407.0, 460441.0, 460986.0, 54325.0, 54603.72698136484, 54648.45351546513, 54718.0, 54754.0, 56964.71517642385, 57038.859222815314, 57157.714211429506, 57165.42834571684, 57226.41603759386, 14798.260086995608, 15176.0, 15193.696126077637, 15238.847611523965, 15246.542603721906, 11872.287662740264, 11908.225965312227, 11930.22453540517, 11962.581309654295, 11977.64067077989, 11132.888671113347, 13090.280034597998, 14320.856791432161, 14392.568222953329, 14640.414383424757, 5360.463953604686, 6688.4649228061635, 6810.8421568332515, 6830.7609233676585, 6903.585784852925, 744.709563270325, 835.3317346123077, 902.3593248793298, 1009.1876039788041, 1042.8540004399238, 28593.42813143767, 28736.856315718287, 28900.710992889803, 29372.85313573461, 29400.705992940224, 956.9090936361034, 975.7853272280087, 993.9751506212402, 999.5901680311183, 1015.918726501878, 12244.714304997848, 13100.570839610009, 13938.37277322523, 14282.785758213427, 15007.849921500863, 627446.0, 632669.0, 633225.0, 634298.0, 635254.0, 53066.46933530615, 53110.17461769508, 53296.934061318556, 53326.7333663337, 53449.0, 1329.2157626999924, 1347.6024572751062, 1357.4705864712967, 1359.4086572341064, 1363.1275983370651, 22612.0, 26012.739872601032, 27593.17220483389, 28208.29479263035, 29116.70883291225, 46128.308075379566, 46622.0, 46711.29933050939, 46753.0, 46800.297995529414, 555209.0, 559215.6313747567, 559581.0, 559690.0, 561596.0, 37085.62914370822, 37086.072848179014, 37149.0, 37543.43684844675, 37572.812135939144, 42825.715228543195, 43419.782901085295, 43889.905321775535, 44532.77733611311, 44885.326720099874, 35958.28083438369, 36207.818960905024, 36277.637223627426, 37120.0, 37372.06569835667, 35935.82032089823, 35951.101222469646, 36949.63050369462, 37143.44284835675, 37185.0, 35213.64786352206, 35515.93452196438, 36457.45313820348, 36532.269354613294, 36624.0, 30882.0, 32166.195845103124, 32166.35667286688, 32416.513752293264, 32659.85690500821, 23650.645240321064, 23848.807559622295, 24351.634725479485, 24495.38761530976, 24715.752842471346], "value": 19034.51457834926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.7337849855613, 364.06798595595274, 365.5832351119722, 372.8955892350142, 395.7229939042669, 14473.78289325661, 14961.925190374046, 15285.006474579144, 19689.917054561993, 20301.59396812063, 15539.689206215897, 19118.904405477988, 19712.211511539557, 20390.796092039076, 20643.483912902186, 5290.2064690296575, 5526.143447765603, 6018.458338749511, 6018.6689732064715, 6027.246594175728, 3493.458513930332, 4530.592246697796, 4973.626977976648, 5960.0, 6030.246219222598, 3649.4525821126776, 3671.6511931366613, 6256.718447669843, 6666.100076489661, 6677.499187560952, 6455.096286519891, 6540.869182616345, 6609.933900661028, 6715.496337774686, 6729.831754206184, 5847.502962248214, 5853.85365365865, 5867.266591676041, 5872.823815285548, 5873.0, 25532.23403297904, 25617.0, 26083.0, 26394.472110557872, 26412.207633771017, 2300.7814257645496, 2336.0, 2360.280114565074, 2482.739312372211, 2969.420962912233, 14920.0, 14980.625484362869, 15196.696066078726, 15550.222488875512, 15763.448279310169, 1787.2493552707895, 1806.6296409236074, 1883.3220040785307, 1885.1139964216795, 1902.5243689077731, 106219.0, 108263.91736082618, 129381.0, 129488.0, 129870.0, 18899.0, 20877.143885179623, 20901.89549052245, 21079.365079365078, 21103.472413189793, 33586.0, 33813.830930845186, 34669.0, 34839.65160348415, 34866.9539913803, 8504.872426913602, 10346.793064138676, 10520.473976301155, 10540.736481588021, 10684.0, 8563.0, 8571.400001999926, 8576.44253123545, 8766.60550275239, 8772.649094036167, 9298.256139508823, 9338.813223735624, 9423.6701715441, 9656.468894210746, 9670.854937175947, 2940.9264768380963, 3719.3119272934596, 3735.5143831301757, 3735.6637902588895, 3767.56672982605, 830.9127541608165, 862.0991064337782, 873.2926329672986, 889.5285498685578, 927.3462209142539, 15579.844201557838, 15881.967672101508, 19429.902850485658, 20460.38618841437, 20586.382408527767, 848.6732607945985, 896.3680605173337, 903.9276857851356, 921.2675922641382, 953.3850666320185, 10429.165666746641, 11249.212555121063, 11252.943735281435, 11257.662270131908, 11287.887121128848, 586031.0, 593686.0, 594270.0, 595330.0, 610407.0, 116445.0, 118352.0, 120267.0, 120887.31179811482, 120960.3951980252, 895.3956079646213, 913.5751875377981, 944.3625552751865, 945.4516380499294, 950.135376807116, 13875.514356997457, 18587.721184181977, 18847.811521885153, 18999.620007600046, 19198.8480691159, 51625.741871290404, 52012.73993630007, 52849.0, 53382.0, 54775.0, 66010.66994664996, 72426.0, 74991.25008750061, 76603.46793063996, 79506.04939506235, 7886.44794864354, 8054.114047454893, 8084.595770211584, 8111.728715959541, 8256.009278886571, 9005.819883602422, 11550.48022838991, 12279.324637145042, 12551.686207844878, 12670.493180273055, 10631.787364252517, 10908.181886358396, 11156.832647510457, 11201.551937922392, 11245.100391968459, 9042.773930651787, 10734.302270352402, 10932.398718070583, 11094.722631934266, 11127.664680238424, 11077.390743509184, 11440.084793216356, 11463.713407164887, 11487.25332853362, 11589.420528973349, 7350.264973502607, 7624.275693809301, 7881.2118788123025, 8060.073091594541, 8354.373421993254, 10300.896991029993, 10710.089642380484, 11083.279586826831, 11102.555897764, 11177.161712871404], "value": 10278.137876886096, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.1659953826318, 1479.1199236454308, 1615.3377115382696, 1774.4321817018558, 1793.5964408008192, 7963.0, 8179.959100204498, 8253.752387428387, 8326.666933322675, 8339.416240863142, 7407.518511296762, 7620.466567340289, 7633.358827852011, 7959.920400795991, 8128.59357032149, 2259.751427342991, 2298.195631528968, 2301.873396963166, 2306.238941149417, 2307.042577330406, 2262.1177740681146, 2306.884655767205, 2320.5010922651627, 2321.698179236697, 2325.4418939454495, 1631.9673606527863, 2052.302217246136, 2058.8147066763986, 2221.4779526811185, 2269.0810221860174, 2214.966775498369, 2224.0103154096514, 2225.8553194042333, 2228.465168359598, 2228.832837537191, 2252.3805953362794, 2282.4065742906796, 2294.5181511882524, 2304.193532263711, 2305.988470057656, 6964.721411143599, 8138.0, 8277.95861020691, 8279.337652987746, 8296.751097467026, 4970.751462426864, 5137.33214682089, 5138.229265610151, 5138.948610513922, 5139.794408223666, 3260.119767662718, 3490.5462289902152, 3527.065327688165, 3534.5935217450065, 3539.80531070791, 992.3103443107043, 1065.5844220753913, 1069.0859315285397, 1092.792369449802, 1095.0473088413132, 10816.567337306498, 10862.402567858764, 10867.40229287381, 10881.401522916236, 10905.83641245382, 4379.715318504287, 4472.396226509444, 4565.657575681837, 4623.214053610895, 4631.120087183424, 9369.718908432758, 9373.578188981512, 9384.155426011692, 9391.530423478798, 9395.389299695498, 5061.569766569883, 5153.222138362259, 5164.690118592896, 5170.71561064145, 5177.689338639693, 4581.830534213849, 4638.466576343696, 4645.535446455395, 4700.059988002413, 4755.286706993909, 3622.7464077514846, 3673.797941113211, 3707.610700876423, 3741.5136032315627, 3784.810759462016, 1236.4683186229827, 1238.3065483329365, 1238.993805030969, 1250.662321173278, 1256.0767835640797, 780.7696729464822, 810.7784670004146, 822.8847961285425, 876.4784952952983, 883.779055236191, 4767.856964291077, 5062.190049592047, 5690.630109042899, 5695.117256825199, 6073.423024812636, 840.5587066789984, 854.9358798090168, 870.56906831119, 893.7854914820526, 911.6535716427715, 3784.1863999239745, 3829.1384438501113, 3831.394681557107, 3912.0415498203124, 3915.451836742858, 9612.99063598312, 10104.393736375841, 10105.848412273675, 10129.0, 10150.390976541432, 10094.343867648578, 10096.990300969845, 10097.444640544694, 10105.191584673208, 10106.989301069834, 7388.926110738931, 7655.387568994467, 7783.209861731833, 7798.766037018899, 7805.102413222552, 5677.148427735872, 5810.94189058104, 5906.852328691645, 5917.349091600006, 5931.822045338647, 9173.266138708754, 9286.257099432165, 9328.253739700944, 9412.341136120405, 9495.47774872361, 9229.077092290718, 9501.61993520279, 9503.334766566273, 9579.425234485952, 9587.616495340108, 7013.579185248901, 7167.104111986002, 7176.06711127571, 7184.568925864256, 7240.094988126484, 7557.622118894144, 7733.381329493514, 7808.804779880548, 7835.686572537034, 7847.372210223054, 6924.896126558005, 6940.479464040116, 7042.084529011196, 7076.0, 7115.893261601183, 6712.597244165366, 6778.593284402951, 6861.176658800776, 6866.141732283465, 6931.306869313028, 6471.417572418505, 6521.282658907611, 6622.867542649216, 6625.503087268377, 6631.403173714196, 4739.905201895874, 4767.261074533453, 4821.252705830602, 4891.266310053378, 4994.200927851672, 4774.1883879739835, 4851.442084160367, 4878.487758785276, 4907.68100073494, 4973.079980203674], "value": 4368.392036796048, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.34777663597106, 298.8207075754547, 299.9100269919025, 307.18136167114636, 314.0687860493637, 5249.790008399665, 5358.142697168454, 5385.0, 5434.8913021739545, 5481.725913704318, 5078.974605126969, 5224.8693782655455, 5337.7598008089635, 5381.569474442035, 5384.757685904134, 4113.979430102852, 4114.6091121343425, 4130.224003678417, 4136.855210067648, 4158.209940111385, 3858.9807050964705, 4014.498187726534, 4068.206699693561, 4119.176164767044, 4174.436451079096, 3571.607123216444, 3791.488149099878, 4008.739431936929, 4008.7795171265716, 4071.307877660805, 4001.6398524132824, 4035.9798201009103, 4042.110735638155, 4045.170739998308, 4066.9389959150635, 3336.182635254354, 3511.719062474996, 3513.1568423578415, 3519.2961407718303, 3529.4882242074755, 4132.772697501636, 4989.65072444929, 5228.947710522884, 5245.318108645852, 5282.894342113174, 3861.691064714816, 4544.159330523864, 4590.472095709003, 4593.26507758757, 4636.768161591941, 4655.371524844137, 5079.923801142986, 5175.585953123741, 5547.645098597582, 5597.80407685729, 2706.6481357423604, 3477.6522347765276, 3827.9808600957094, 3854.2676891390547, 3885.30064588374, 4957.975210123998, 5892.616979896293, 5939.316978547436, 5986.551008674367, 6004.5796794224425, 3892.2410130024373, 3892.5718171001167, 3895.454636350913, 3900.7322620148566, 3920.8039598019986, 3453.8618455262013, 3622.822582660646, 3889.649931506178, 3921.5490218624655, 3938.5667576566557, 4399.73601583906, 4479.552044795494, 4485.093835120061, 4498.6626003049905, 4593.989322349078, 4594.540545945446, 5117.104506711311, 5166.844994650167, 5405.135178371442, 5669.773209071674, 1166.7433164703752, 1265.8607253471764, 1292.662094731948, 1294.2558029133286, 1298.2016060122955, 790.6165509727778, 812.8699408094676, 821.6918655504186, 823.6664151018847, 833.9124391938759, 4980.975095124573, 4986.6010719143105, 5012.974935125301, 5017.641708397047, 5026.89946201074, 4570.81716731327, 4603.654725895572, 5462.0, 5508.91736623951, 5546.334439867161, 4076.9796151019054, 5062.7468626568525, 5113.0, 5378.757955891994, 5472.288602481652, 2926.6049083373896, 2948.5871977923107, 2964.214483161964, 2964.5256758918467, 2968.317287023953, 5049.5707864831165, 5503.697296648643, 5769.509591684669, 5838.7080645967535, 5848.2689663792025, 5305.495977882095, 5653.943460565424, 6050.969745151246, 6098.207233059763, 6105.298919831705, 4899.240617704261, 5468.316460442525, 5634.859128521738, 6081.0, 6149.907751383733, 5119.948800511947, 5610.551155907599, 5848.502877255481, 5909.261342332208, 5918.73365698536, 5777.480026797609, 5860.2967643883, 5862.091375836752, 5870.354261031198, 5887.411258874078, 5890.293164820249, 6079.726412311368, 6107.511399087974, 6141.692915354125, 6169.475594574332, 3561.4863682935165, 3757.793321367351, 3843.442700808423, 3866.903327416837, 3915.47141135943, 5159.432462429205, 5598.468145526169, 5840.007198776133, 5881.705914704333, 5888.381719919346, 5398.568114550748, 5513.283273174622, 5646.520045795989, 5726.8568285791525, 5736.799212027559, 4509.616682581886, 4793.592544633745, 4824.469308376006, 5692.7722891083895, 5730.561663002165, 4898.951010489992, 5586.636868603528, 5610.5231055360755, 5628.099504079328, 5639.91106447822, 4537.523560026149, 5633.802816901389, 5672.744726487401, 5768.019436695856, 5777.508911742549, 4358.4769827620885, 4936.333594964777, 5538.47384498472, 5598.608097433141, 5618.4662457066515], "value": 4071.4940941601367, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.7037407231566, 733.5671953547406, 762.881753328234, 791.9791052321171, 798.7084714079363, 14099.67941697696, 14675.486357977474, 15005.84994150058, 15211.087334759923, 15245.69508609827, 11614.373987641737, 13696.931515342409, 13756.724865502683, 14436.711265774678, 14945.028573142765, 807.4065561812049, 833.7957200485889, 834.3283656656389, 834.5326617094447, 835.51122593283, 641.9903701444482, 666.4967949198349, 830.6096134816656, 831.9833603327929, 834.1033389106705, 706.5195666946474, 707.4587940225706, 708.9964550177268, 709.3332267668401, 837.924586787189, 859.9828003439927, 864.5763575847852, 864.8875646166022, 868.2923417414787, 868.7393781865416, 635.7107516080173, 640.903864420336, 641.3650486018854, 642.6272761798145, 644.664774317357, 11936.820947685792, 12919.547815826494, 14771.926140369336, 14805.851941480554, 14823.481178158821, 13126.474941002349, 13181.538646147339, 13312.201267923956, 13343.933280333633, 13629.25039122848, 11257.54969801207, 11415.657530274106, 11428.200025998183, 11433.42832858362, 11634.30194188343, 3001.864916078782, 3589.407747721649, 3727.7763334200035, 3773.3585290500682, 3808.847646094153, 94328.05671943261, 94333.52833235859, 94621.5268923651, 98281.50859245729, 98486.5227021588, 10399.636012739518, 10419.739506512245, 10457.059214371755, 10579.735506612396, 10597.470126493645, 19520.219191232474, 20249.291274805604, 20424.897875510527, 20426.795732042785, 20461.0, 7449.813754656068, 7509.586972716553, 7535.962320188364, 7592.278733520307, 7651.120121186023, 3975.6223158799867, 4023.4769479968004, 4034.8789536313957, 4078.775667338325, 4213.578642135762, 3342.9498557521656, 3453.188500702333, 3458.8270586470576, 3463.9134021649156, 3465.5668041494814, 569.5073761196618, 607.6232735703892, 617.9505639548826, 622.1290193728815, 624.8437890527368, 511.93856737191777, 526.689253340531, 608.5314307982917, 645.5965021861336, 657.1358663357765, 8538.18887205727, 8899.599518021705, 9049.954750226207, 9058.637654493878, 9063.954680226556, 590.2091197794975, 618.9876202475925, 648.9422241745924, 661.7220767277659, 664.570459347135, 4177.4778152730905, 4415.845445409395, 4432.623227025739, 4437.889052773642, 4559.202139625552, 108522.0, 111608.88391116148, 115292.0, 115298.0, 118067.0, 98117.0, 100345.49827250816, 102691.0, 103004.0, 103325.0, 89068.6639700405, 89100.663490049, 89823.0, 90754.54622726976, 92680.0, 8610.741677749678, 8648.351373646876, 8649.697260595849, 8768.342374321825, 8892.73321800347, 50251.74874125606, 51440.94236230509, 51694.67373968105, 55725.0, 56692.0, 73630.0, 76993.0, 78460.60769696115, 78569.0, 79810.60094699489, 12240.510379584717, 12307.507699691912, 12315.076369272161, 12652.11435199564, 13016.414261358072, 13488.662783430493, 13528.526501572398, 13575.86424135746, 14041.648958775704, 14151.0, 10791.730206744895, 13017.21896686202, 13050.934745326213, 13545.932270338586, 13677.589672309847, 12027.518899243933, 12928.612141635766, 12959.546415875398, 13233.404496797475, 13328.067035307824, 11353.602623908124, 12163.148579599698, 12594.559190428292, 12698.019065379945, 12816.231026138461, 10510.894891050992, 10633.468326583794, 10845.837312440162, 11105.333679979227, 11444.656660300205, 10620.734481638021, 11129.0, 11271.661850144508, 11279.7744045117, 11287.887121129012], "value": 7243.373641740229, "unit": "score"}], "name": "dromaeo_css", "value": 7240.539244210889, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 116.0, 114.0, 115.0, 116.0, 114.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 115.0, 115.0, 143.0, 113.0, 115.0, 115.0, 108.0, 143.0, 112.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 182.0, 184.0, 182.0, 182.0, 182.0, 182.0, 183.0, 181.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 83.0, 112.0, 62.0, 60.0, 59.0, 59.0, 84.0, 59.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 93.0, 71.0, 69.0, 70.0, 90.0, 67.0, 69.0, 92.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 93.0, 131.0, 119.0, 86.0, 90.0, 87.0, 89.0, 86.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 103.0, 95.0, 98.0, 97.0, 98.0, 97.0, 97.0], "value": 97.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 94.0, 108.0, 118.0, 123.0, 81.0, 85.0, 83.0, 92.0, 126.0], "value": 99.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 53.0, 54.0, 53.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 67.0, 81.0, 74.0, 73.0, 67.0, 75.0, 70.0, 69.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 91.0, 86.0, 89.0, 86.0, 88.0, 93.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 147.0, 162.0, 165.0, 155.0, 146.0, 146.0, 150.0, 185.0, 161.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 243.0, 187.0, 175.0, 176.0, 175.0, 173.0, 173.0, 177.0, 173.0], "value": 187.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 66.0, 67.0, 69.0, 67.0, 65.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1486.8, "alertThreshold": 2.0}]} 06:49:13 INFO - Return code: 0 06:49:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:49:13 INFO - # TBPL SUCCESS # 06:49:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:49:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:49:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:49:13 INFO - 2016-11-09 06:49:13.289 screenresolution[1673:10787] starting screenresolution argv=screenresolution get 06:49:13 INFO - 2016-11-09 06:49:13.292 screenresolution[1673:10787] Display 0: 1600x1200x32@60 06:49:13 INFO - 2016-11-09 06:49:13.298 screenresolution[1674:10797] starting screenresolution argv=screenresolution list 06:49:13 INFO - Available Modes on Display 0 06:49:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:49:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:49:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:49:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:49:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:49:13 INFO - Intel Iris: 06:49:13 INFO - Chipset Model: Intel Iris 06:49:13 INFO - Type: GPU 06:49:13 INFO - Bus: Built-In 06:49:13 INFO - VRAM (Dynamic, Max): 1536 MB 06:49:13 INFO - Vendor: Intel (0x8086) 06:49:13 INFO - Device ID: 0x0a2e 06:49:13 INFO - Revision ID: 0x0009 06:49:13 INFO - Displays: 06:49:13 INFO - Display: 06:49:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:49:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:49:13 INFO - Display Serial Number: 1600x1200 60 06:49:13 INFO - Main Display: Yes 06:49:13 INFO - Mirror: Off 06:49:13 INFO - Online: Yes 06:49:13 INFO - Rotation: Supported 06:49:13 INFO - Return code: 0 06:49:13 INFO - Running post-action listener: _resource_record_post_action 06:49:13 INFO - [mozharness: 2016-11-09 14:49:13.538463Z] Finished run-tests step (success) 06:49:13 INFO - Running post-run listener: _resource_record_post_run 06:49:13 INFO - Total resource usage - Wall time: 1216s; CPU: 53.0%; Read bytes: 32300032; Write bytes: 707226112; Read time: 200; Write time: 2000 06:49:13 INFO - TinderboxPrint: CPU usage
53.5% 06:49:13 INFO - TinderboxPrint: I/O read bytes / time
32,300,032 / 200 06:49:13 INFO - TinderboxPrint: I/O write bytes / time
707,226,112 / 2,000 06:49:13 INFO - TinderboxPrint: CPU idle
2,263.7 (46.5%) 06:49:13 INFO - TinderboxPrint: CPU system
971.5 (20.0%) 06:49:13 INFO - TinderboxPrint: CPU user
1,630.5 (33.5%) 06:49:13 INFO - TinderboxPrint: Swap in / out
432,123,904 / 0 06:49:13 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390345216; Write bytes: 385193472; Read time: 29157; Write time: 826 06:49:13 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 30510080; Write bytes: 299623424; Read time: 185; Write time: 1114 06:49:14 INFO - Running post-run listener: _upload_blobber_files 06:49:14 INFO - Blob upload gear active. 06:49:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:49:14 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:49:14 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:49:14 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:49:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:49:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:49:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:49:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:15 INFO - (blobuploader) - INFO - Done attempting. 06:49:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:49:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:49:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:16 INFO - (blobuploader) - INFO - Done attempting. 06:49:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:49:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:49:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:18 INFO - (blobuploader) - INFO - Done attempting. 06:49:18 INFO - (blobuploader) - INFO - Iteration through files over. 06:49:18 INFO - Return code: 0 06:49:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:49:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:49:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/99fbe576cd5bf678afd937e7aaa8fb0d5a8c998daccad5898a53230d76f4950073617ba38dad06392e9bad8cbd8d7047f7ecc405f9033c975e6fdc0eb0ec7c83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/bb08f9bbae4ca1c2ab0212341a69350db30baef96eee40556f2be7abf6ccf75162a3bc34cc828e4c1fe5f2d3d70f6ebf2a94194332a73506130c4fcd20540d50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/be2bfe2586937ded35bace2585f5800a14e5452045f15fe4f213269c11520563ce303f3e4c6cdac8cd540fed1ae24bcfb98121407c117bfdd49483288916f50c"} 06:49:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:49:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:49:18 INFO - Contents: 06:49:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/99fbe576cd5bf678afd937e7aaa8fb0d5a8c998daccad5898a53230d76f4950073617ba38dad06392e9bad8cbd8d7047f7ecc405f9033c975e6fdc0eb0ec7c83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/bb08f9bbae4ca1c2ab0212341a69350db30baef96eee40556f2be7abf6ccf75162a3bc34cc828e4c1fe5f2d3d70f6ebf2a94194332a73506130c4fcd20540d50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/be2bfe2586937ded35bace2585f5800a14e5452045f15fe4f213269c11520563ce303f3e4c6cdac8cd540fed1ae24bcfb98121407c117bfdd49483288916f50c"} 06:49:18 INFO - Running post-run listener: copy_logs_to_upload_dir 06:49:18 INFO - Copying logs to upload dir... 06:49:18 INFO - mkdir: /builds/slave/test/build/upload/logs 06:49:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.369512 ========= master_lag: 2.36 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-09 06:49:21.035492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 06:49:21.039700) ========= 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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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/Larch/sha512/99fbe576cd5bf678afd937e7aaa8fb0d5a8c998daccad5898a53230d76f4950073617ba38dad06392e9bad8cbd8d7047f7ecc405f9033c975e6fdc0eb0ec7c83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/bb08f9bbae4ca1c2ab0212341a69350db30baef96eee40556f2be7abf6ccf75162a3bc34cc828e4c1fe5f2d3d70f6ebf2a94194332a73506130c4fcd20540d50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/be2bfe2586937ded35bace2585f5800a14e5452045f15fe4f213269c11520563ce303f3e4c6cdac8cd540fed1ae24bcfb98121407c117bfdd49483288916f50c"} build_url:https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/QwfCtdFnR_m5c9jURsUNrw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/99fbe576cd5bf678afd937e7aaa8fb0d5a8c998daccad5898a53230d76f4950073617ba38dad06392e9bad8cbd8d7047f7ecc405f9033c975e6fdc0eb0ec7c83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/bb08f9bbae4ca1c2ab0212341a69350db30baef96eee40556f2be7abf6ccf75162a3bc34cc828e4c1fe5f2d3d70f6ebf2a94194332a73506130c4fcd20540d50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/be2bfe2586937ded35bace2585f5800a14e5452045f15fe4f213269c11520563ce303f3e4c6cdac8cd540fed1ae24bcfb98121407c117bfdd49483288916f50c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 06:49:21.082772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:49:21.083120) ========= 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.tTL0lYgD6X/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.LMNUJtJzCj/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.005291 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:49:21.130821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 06:49:21.131144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 06:49:21.133457) ========= ========= Total master_lag: 2.50 =========