builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0150 starttime: 1477140806.08 results: success (0) buildid: 20161022030204 builduid: 07445e3160354a56b7e3a05d2eb69015 revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.083849) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.084331) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.084615) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.111839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.112235) ========= 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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-10-22 05:53:26-- 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% 143M=0s 2016-10-22 05:53:26 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.652702 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.784514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.784929) ========= 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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.019581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.835064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 05:53:26.835605) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5639a9f476d08f300c079117e61697f5026b6367 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5639a9f476d08f300c079117e61697f5026b6367 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-10-22 05:53:26,855 truncating revision to first 12 chars 2016-10-22 05:53:26,855 Setting DEBUG logging. 2016-10-22 05:53:26,855 attempt 1/10 2016-10-22 05:53:26,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5639a9f476d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-22 05:53:27,813 unpacking tar archive at: mozilla-central-5639a9f476d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.217651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 05:53:28.077723) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:28.078303) ========= script_repo_revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:28.078902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:28.079294) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:28.096946) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-22 05:53:28.097364) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:53:28 INFO - MultiFileLogger online at 20161022 05:53:28 in /builds/slave/test 05:53:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:53:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:53:28 INFO - {'append_to_log': False, 05:53:28 INFO - 'base_work_dir': '/builds/slave/test', 05:53:28 INFO - 'blob_upload_branch': 'Firefox', 05:53:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:53:28 INFO - 'branch': 'Firefox', 05:53:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:53:28 INFO - 'config_files': ('talos/mac_config.py',), 05:53:28 INFO - 'default_actions': ('clobber', 05:53:28 INFO - 'read-buildbot-config', 05:53:28 INFO - 'download-and-extract', 05:53:28 INFO - 'populate-webroot', 05:53:28 INFO - 'create-virtualenv', 05:53:28 INFO - 'install', 05:53:28 INFO - 'run-tests'), 05:53:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:53:28 INFO - 'download_minidump_stackwalk': True, 05:53:28 INFO - 'download_symbols': 'ondemand', 05:53:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:53:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:53:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:53:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:53:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:53:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:53:28 INFO - 'installer_path': 'installer.exe', 05:53:28 INFO - 'log_level': 'info', 05:53:28 INFO - 'log_name': 'talos', 05:53:28 INFO - 'log_to_console': True, 05:53:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:53:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:53:28 INFO - 'opt_config_files': (), 05:53:28 INFO - 'pip_index': False, 05:53:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:53:28 INFO - 'cmd': ('bash', 05:53:28 INFO - '-c', 05:53:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:53:28 INFO - 'enabled': True, 05:53:28 INFO - 'halt_on_failure': False, 05:53:28 INFO - 'name': 'check_screen_resolution'},), 05:53:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:53:28 INFO - 'cmd': ('bash', 05:53:28 INFO - '-c', 05:53:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:53:28 INFO - 'enabled': True, 05:53:28 INFO - 'halt_on_failure': False, 05:53:28 INFO - 'name': 'check_screen_resolution'},), 05:53:28 INFO - 'run_cmd_checks_enabled': True, 05:53:28 INFO - 'sps_profile': False, 05:53:28 INFO - 'sps_profile_interval': 0, 05:53:28 INFO - 'suite': 'dromaeojs', 05:53:28 INFO - 'system_bits': '32', 05:53:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:53:28 INFO - 'title': 't-yosemite-r7-0150', 05:53:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:53:28 INFO - 'use_talos_json': True, 05:53:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:53:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:53:28 INFO - 'work_dir': 'build'} 05:53:28 INFO - [mozharness: 2016-10-22 12:53:28.246009Z] Running clobber step. 05:53:28 INFO - Running pre-action listener: _resource_record_pre_action 05:53:28 INFO - Running main action method: clobber 05:53:28 INFO - rmtree: /builds/slave/test/build 05:53:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:53:29 INFO - Running post-action listener: _resource_record_post_action 05:53:29 INFO - [mozharness: 2016-10-22 12:53:29.952558Z] Finished clobber step (success) 05:53:29 INFO - [mozharness: 2016-10-22 12:53:29.952769Z] Running read-buildbot-config step. 05:53:29 INFO - Running pre-action listener: _resource_record_pre_action 05:53:29 INFO - Running main action method: read_buildbot_config 05:53:29 INFO - Using buildbot properties: 05:53:29 INFO - { 05:53:29 INFO - "project": "", 05:53:29 INFO - "product": "firefox", 05:53:29 INFO - "script_repo_revision": "production", 05:53:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:53:29 INFO - "repository": "", 05:53:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:53:29 INFO - "buildid": "20161022030204", 05:53:29 INFO - "stage_platform": "macosx64", 05:53:29 INFO - "basedir": "/builds/slave/test", 05:53:29 INFO - "nightly_build": "True", 05:53:29 INFO - "buildnumber": 6, 05:53:29 INFO - "slavename": "t-yosemite-r7-0150", 05:53:29 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:53:29 INFO - "platform": "yosemite_r7", 05:53:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:53:29 INFO - "branch": "mozilla-central", 05:53:29 INFO - "repo_path": "mozilla-central", 05:53:29 INFO - "revision": "5639a9f476d08f300c079117e61697f5026b6367", 05:53:29 INFO - "pgo_build": "False", 05:53:29 INFO - "builduid": "07445e3160354a56b7e3a05d2eb69015", 05:53:29 INFO - "slavebuilddir": "test" 05:53:29 INFO - } 05:53:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:53:29 INFO - Running post-action listener: _resource_record_post_action 05:53:29 INFO - [mozharness: 2016-10-22 12:53:29.957532Z] Finished read-buildbot-config step (success) 05:53:29 INFO - [mozharness: 2016-10-22 12:53:29.957723Z] Running download-and-extract step. 05:53:29 INFO - Running pre-action listener: _resource_record_pre_action 05:53:29 INFO - Running main action method: download_and_extract 05:53:29 INFO - mkdir: /builds/slave/test/build/tests 05:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:29 INFO - trying https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:53:29 INFO - Downloading https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/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 05:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/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 05:53:31 INFO - Downloaded 1199 bytes. 05:53:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:53:31 INFO - Using the following test package requirements: 05:53:31 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:53:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:53:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:53:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'jsshell-mac.zip'], 05:53:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:53:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:53:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:53:31 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:53:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:53:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:53:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:53:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:53:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:53:31 INFO - Fetch https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:53:31 INFO - Http code: 200 05:53:31 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 05:53:31 INFO - x-amz-cf-id: hejkP4CuhYWuxxRpyYlmTHqqeO1-7sqG_h60zb7FNMQAQr2HW5Egsg== 05:53:31 INFO - x-amz-version-id: yFC2jzdh.Svr7vFhwcBta3LSeMs9k2l2 05:53:32 INFO - Expected file size: 16420828 05:53:32 INFO - Obtained file size: 16420828 05:53:38 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 05:53:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:53:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:53:38 INFO - Fetch https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:53:39 INFO - Http code: 200 05:53:39 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 05:53:39 INFO - x-amz-cf-id: QX1qzR0TTDVDCRcxuNf7XCF7yxjMR3drgKauta5G7jYYIu4CH5ds3Q== 05:53:39 INFO - x-amz-version-id: yFC2jzdh.Svr7vFhwcBta3LSeMs9k2l2 05:53:39 INFO - Expected file size: 16420828 05:53:39 INFO - Obtained file size: 16420828 05:53:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:53:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:53:46 INFO - Fetch https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:53:47 INFO - Http code: 200 05:53:47 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 05:53:47 INFO - x-amz-cf-id: CrX1wBt6ZXGZEvScrfyCQiBCKxGsWDKhNWmLd62SfA42_TQ22iRQJA== 05:53:47 INFO - x-amz-version-id: QTWPGwPIcqkl0tF8hLaFox_x_tt_5QEr 05:53:47 INFO - Expected file size: 14409028 05:53:47 INFO - Obtained file size: 14409028 05:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:47 INFO - trying https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:53:47 INFO - Downloading https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/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 05:53:50 INFO - Downloaded 111469529 bytes. 05:53:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:53:50 INFO - mkdir: /builds/slave/test/properties 05:53:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:53:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:53:50 INFO - Contents: 05:53:50 INFO - build_url:https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:53:51 INFO - Running post-action listener: _resource_record_post_action 05:53:51 INFO - Running post-action listener: set_extra_try_arguments 05:53:51 INFO - [mozharness: 2016-10-22 12:53:51.539436Z] Finished download-and-extract step (success) 05:53:51 INFO - [mozharness: 2016-10-22 12:53:51.539599Z] Running populate-webroot step. 05:53:51 INFO - Running pre-action listener: _resource_record_pre_action 05:53:51 INFO - Running main action method: populate_webroot 05:53:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:51 INFO - '--tppagecycles', 05:53:51 INFO - '7'], 05:53:51 INFO - 'tests': ['tsvgm']}}, 05:53:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:53:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:53:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['damp', 'tps']}, 05:53:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'tests': ['damp', 'tps']}, 05:53:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['dromaeo_dom']}, 05:53:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['basic_compositor_video']}, 05:53:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:53:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['tsvgx', 05:53:51 INFO - 'tsvgr_opacity', 05:53:51 INFO - 'tart', 05:53:51 INFO - 'tscrollx', 05:53:51 INFO - 'cart']}, 05:53:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:53:51 INFO - 'tsvgr_opacity', 05:53:51 INFO - 'tart', 05:53:51 INFO - 'tscrollx', 05:53:51 INFO - 'cart']}, 05:53:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['tp5o']}, 05:53:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'tests': ['tp5o']}, 05:53:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--disable-e10s', 05:53:51 INFO - '--xperf_path', 05:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:51 INFO - 'tests': ['tp5n']}, 05:53:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--xperf_path', 05:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:51 INFO - 'tests': ['tp5n']}}, 05:53:51 INFO - 'talos.zip': {'path': '', 05:53:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:51 INFO - Running post-action listener: _resource_record_post_action 05:53:51 INFO - [mozharness: 2016-10-22 12:53:51.558375Z] Finished populate-webroot step (success) 05:53:51 INFO - [mozharness: 2016-10-22 12:53:51.558506Z] Running create-virtualenv step. 05:53:51 INFO - Running pre-action listener: _resource_record_pre_action 05:53:51 INFO - Running main action method: create_virtualenv 05:53:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:53:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:53:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:53:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:51 INFO - Using real prefix '/tools/python27' 05:53:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:53:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:55 INFO - Installing pip.................done. 05:53:55 INFO - Return code: 0 05:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:53:55 INFO - Reading from file tmpfile_stdout 05:53:55 INFO - Output received: 05:53:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:53:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:55 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 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:55 INFO - 'HOME': '/Users/cltbld', 05:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:55 INFO - 'LOGNAME': 'cltbld', 05:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:55 INFO - 'MOZ_NO_REMOTE': '1', 05:53:55 INFO - 'NO_EM_RESTART': '1', 05:53:55 INFO - 'PAGER': '/bin/cat', 05:53:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:55 INFO - 'PWD': '/builds/slave/test', 05:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:55 INFO - 'SHELL': '/bin/bash', 05:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:53:55 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:55 INFO - 'USER': 'cltbld', 05:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:55 INFO - 'XPC_FLAGS': '0x0', 05:53:55 INFO - 'XPC_SERVICE_NAME': '0', 05:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:53:55 INFO - Cleaning up... 05:53:55 INFO - Return code: 0 05:53:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:55 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 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:55 INFO - 'HOME': '/Users/cltbld', 05:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:55 INFO - 'LOGNAME': 'cltbld', 05:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:55 INFO - 'MOZ_NO_REMOTE': '1', 05:53:55 INFO - 'NO_EM_RESTART': '1', 05:53:55 INFO - 'PAGER': '/bin/cat', 05:53:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:55 INFO - 'PWD': '/builds/slave/test', 05:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:55 INFO - 'SHELL': '/bin/bash', 05:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:53:55 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:55 INFO - 'USER': 'cltbld', 05:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:55 INFO - 'XPC_FLAGS': '0x0', 05:53:55 INFO - 'XPC_SERVICE_NAME': '0', 05:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:56 INFO - Downloading/unpacking psutil>=3.1.1 05:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:00 INFO - Installing collected packages: psutil 05:54:00 INFO - Running setup.py install for psutil 05:54:00 INFO - building 'psutil._psutil_osx' extension 05:54:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:54:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:54:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:54:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:54:00 INFO - building 'psutil._psutil_posix' extension 05:54:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:54:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:54:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:54:00 INFO - ^ 05:54:00 INFO - 1 warning generated. 05:54:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:00 INFO - Successfully installed psutil 05:54:00 INFO - Cleaning up... 05:54:00 INFO - Return code: 0 05:54:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:54:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:54:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:00 INFO - 'HOME': '/Users/cltbld', 05:54:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:00 INFO - 'LOGNAME': 'cltbld', 05:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:00 INFO - 'MOZ_NO_REMOTE': '1', 05:54:00 INFO - 'NO_EM_RESTART': '1', 05:54:00 INFO - 'PAGER': '/bin/cat', 05:54:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:00 INFO - 'PWD': '/builds/slave/test', 05:54:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:00 INFO - 'SHELL': '/bin/bash', 05:54:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:54:00 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:54:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:00 INFO - 'USER': 'cltbld', 05:54:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:00 INFO - 'XPC_FLAGS': '0x0', 05:54:00 INFO - 'XPC_SERVICE_NAME': '0', 05:54:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:03 INFO - Installing collected packages: mozsystemmonitor 05:54:03 INFO - Running setup.py install for mozsystemmonitor 05:54:03 INFO - Successfully installed mozsystemmonitor 05:54:03 INFO - Cleaning up... 05:54:03 INFO - Return code: 0 05:54:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:03 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 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:54:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:54:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:04 INFO - 'HOME': '/Users/cltbld', 05:54:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:04 INFO - 'LOGNAME': 'cltbld', 05:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:04 INFO - 'MOZ_NO_REMOTE': '1', 05:54:04 INFO - 'NO_EM_RESTART': '1', 05:54:04 INFO - 'PAGER': '/bin/cat', 05:54:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:04 INFO - 'PWD': '/builds/slave/test', 05:54:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:04 INFO - 'SHELL': '/bin/bash', 05:54:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:54:04 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:54:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:04 INFO - 'USER': 'cltbld', 05:54:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:04 INFO - 'XPC_FLAGS': '0x0', 05:54:04 INFO - 'XPC_SERVICE_NAME': '0', 05:54:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:04 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:07 INFO - warning: no files found matching '*.txt' 05:54:07 INFO - no previously-included directories found matching 'build' 05:54:07 INFO - no previously-included directories found matching 'dist' 05:54:07 INFO - no previously-included directories found matching '.git*' 05:54:07 INFO - Installing collected packages: jsonschema, functools32 05:54:07 INFO - Running setup.py install for functools32 05:54:07 INFO - warning: no files found matching '*.txt' 05:54:07 INFO - no previously-included directories found matching 'build' 05:54:07 INFO - no previously-included directories found matching 'dist' 05:54:07 INFO - no previously-included directories found matching '.git*' 05:54:07 INFO - Successfully installed jsonschema functools32 05:54:07 INFO - Cleaning up... 05:54:07 INFO - Return code: 0 05:54:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:07 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 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:07 INFO - 'HOME': '/Users/cltbld', 05:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:07 INFO - 'LOGNAME': 'cltbld', 05:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:07 INFO - 'MOZ_NO_REMOTE': '1', 05:54:07 INFO - 'NO_EM_RESTART': '1', 05:54:07 INFO - 'PAGER': '/bin/cat', 05:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:07 INFO - 'PWD': '/builds/slave/test', 05:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:07 INFO - 'SHELL': '/bin/bash', 05:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:54:07 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:07 INFO - 'USER': 'cltbld', 05:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:07 INFO - 'XPC_FLAGS': '0x0', 05:54:07 INFO - 'XPC_SERVICE_NAME': '0', 05:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:54:07 INFO - Cleaning up... 05:54:07 INFO - Return code: 0 05:54:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:07 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 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:07 INFO - 'HOME': '/Users/cltbld', 05:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:07 INFO - 'LOGNAME': 'cltbld', 05:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:07 INFO - 'MOZ_NO_REMOTE': '1', 05:54:07 INFO - 'NO_EM_RESTART': '1', 05:54:07 INFO - 'PAGER': '/bin/cat', 05:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:07 INFO - 'PWD': '/builds/slave/test', 05:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:07 INFO - 'SHELL': '/bin/bash', 05:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:54:07 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:07 INFO - 'USER': 'cltbld', 05:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:07 INFO - 'XPC_FLAGS': '0x0', 05:54:07 INFO - 'XPC_SERVICE_NAME': '0', 05:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:11 INFO - Downloading docopt-0.6.1.tar.gz 05:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:11 INFO - Running setup.py install for blobuploader 05:54:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:11 INFO - Running setup.py install for requests 05:54:12 INFO - Running setup.py install for docopt 05:54:12 INFO - Successfully installed blobuploader requests docopt 05:54:12 INFO - Cleaning up... 05:54:12 INFO - Return code: 0 05:54:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:12 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 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:12 INFO - 'HOME': '/Users/cltbld', 05:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:12 INFO - 'LOGNAME': 'cltbld', 05:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:12 INFO - 'MOZ_NO_REMOTE': '1', 05:54:12 INFO - 'NO_EM_RESTART': '1', 05:54:12 INFO - 'PAGER': '/bin/cat', 05:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:12 INFO - 'PWD': '/builds/slave/test', 05:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:12 INFO - 'SHELL': '/bin/bash', 05:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:54:12 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:12 INFO - 'USER': 'cltbld', 05:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:12 INFO - 'XPC_FLAGS': '0x0', 05:54:12 INFO - 'XPC_SERVICE_NAME': '0', 05:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-a71Qq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Mmz_yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-sNipiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-nrkuxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-aV3wbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-af2NtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-FB4Xmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-y1JPp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-eE02se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:13 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-dm5NP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-YnJAYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-yqNEfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-boiE26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-clBjvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-3sZjFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-_3kQvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Wjz2Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:14 INFO - Running setup.py install for manifestparser 05:54:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:14 INFO - Running setup.py install for mozcrash 05:54:15 INFO - Running setup.py install for mozdebug 05:54:15 INFO - Running setup.py install for mozdevice 05:54:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Running setup.py install for mozfile 05:54:15 INFO - Running setup.py install for mozhttpd 05:54:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Running setup.py install for mozinfo 05:54:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Running setup.py install for mozInstall 05:54:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Running setup.py install for mozleak 05:54:16 INFO - Running setup.py install for mozlog 05:54:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Running setup.py install for moznetwork 05:54:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Running setup.py install for mozprocess 05:54:16 INFO - Running setup.py install for mozprofile 05:54:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Running setup.py install for mozrunner 05:54:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Running setup.py install for mozscreenshot 05:54:17 INFO - Running setup.py install for moztest 05:54:17 INFO - Running setup.py install for mozversion 05:54:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:17 INFO - Cleaning up... 05:54:17 INFO - Return code: 0 05:54:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:17 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 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:17 INFO - 'HOME': '/Users/cltbld', 05:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:17 INFO - 'LOGNAME': 'cltbld', 05:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:17 INFO - 'MOZ_NO_REMOTE': '1', 05:54:17 INFO - 'NO_EM_RESTART': '1', 05:54:17 INFO - 'PAGER': '/bin/cat', 05:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:17 INFO - 'PWD': '/builds/slave/test', 05:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:17 INFO - 'SHELL': '/bin/bash', 05:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:54:17 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:17 INFO - 'USER': 'cltbld', 05:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:17 INFO - 'XPC_FLAGS': '0x0', 05:54:17 INFO - 'XPC_SERVICE_NAME': '0', 05:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:17 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-ZZdtD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:17 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-rqGoh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:17 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)) 05:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:17 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-3WYLKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:17 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-tnp8wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:18 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)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:18 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-u9S4Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:18 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-h3EPQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:18 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Zbc5_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:18 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-6tcNCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:18 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-RxLV5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:18 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Bus8lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:18 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Ehj7at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:18 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-bVLSgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:18 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Ql6pNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:19 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-NkUDHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:19 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)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:19 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-x_U37H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:19 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-nwD2KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:19 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-4gDJgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:54:19 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)) 05:54:19 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)) 05:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:19 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)) 05:54:19 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)) 05:54:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:21 INFO - Downloading blessings-1.6.tar.gz 05:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:22 INFO - Installing collected packages: blessings 05:54:22 INFO - Running setup.py install for blessings 05:54:22 INFO - Successfully installed blessings 05:54:22 INFO - Cleaning up... 05:54:22 INFO - Return code: 0 05:54:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:22 INFO - Reading from file tmpfile_stdout 05:54:22 INFO - Current package versions: 05:54:22 INFO - blessings == 1.6 05:54:22 INFO - blobuploader == 1.2.4 05:54:22 INFO - docopt == 0.6.1 05:54:22 INFO - functools32 == 3.2.3-2 05:54:22 INFO - jsonschema == 2.5.1 05:54:22 INFO - manifestparser == 1.1 05:54:22 INFO - mozInstall == 1.12 05:54:22 INFO - mozcrash == 0.17 05:54:22 INFO - mozdebug == 0.1 05:54:22 INFO - mozdevice == 0.48 05:54:22 INFO - mozfile == 1.2 05:54:22 INFO - mozhttpd == 0.7 05:54:22 INFO - mozinfo == 0.9 05:54:22 INFO - mozleak == 0.1 05:54:22 INFO - mozlog == 3.4 05:54:22 INFO - moznetwork == 0.27 05:54:22 INFO - mozprocess == 0.23 05:54:22 INFO - mozprofile == 0.28 05:54:22 INFO - mozrunner == 6.12 05:54:22 INFO - mozscreenshot == 0.1 05:54:22 INFO - mozsystemmonitor == 0.3 05:54:22 INFO - moztest == 0.7 05:54:22 INFO - mozversion == 1.4 05:54:22 INFO - psutil == 3.1.1 05:54:22 INFO - requests == 1.2.3 05:54:22 INFO - wsgiref == 0.1.2 05:54:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:22 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 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:22 INFO - 'HOME': '/Users/cltbld', 05:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:22 INFO - 'LOGNAME': 'cltbld', 05:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:22 INFO - 'MOZ_NO_REMOTE': '1', 05:54:22 INFO - 'NO_EM_RESTART': '1', 05:54:22 INFO - 'PAGER': '/bin/cat', 05:54:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:22 INFO - 'PWD': '/builds/slave/test', 05:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:22 INFO - 'SHELL': '/bin/bash', 05:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:54:22 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:22 INFO - 'USER': 'cltbld', 05:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:22 INFO - 'XPC_FLAGS': '0x0', 05:54:22 INFO - 'XPC_SERVICE_NAME': '0', 05:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:22 INFO - Cleaning up... 05:54:22 INFO - Return code: 0 05:54:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:22 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 0x1089eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108961570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe73adbcf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, '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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:22 INFO - 'HOME': '/Users/cltbld', 05:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:22 INFO - 'LOGNAME': 'cltbld', 05:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:22 INFO - 'MOZ_NO_REMOTE': '1', 05:54:22 INFO - 'NO_EM_RESTART': '1', 05:54:22 INFO - 'PAGER': '/bin/cat', 05:54:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:22 INFO - 'PWD': '/builds/slave/test', 05:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:22 INFO - 'SHELL': '/bin/bash', 05:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:54:22 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:22 INFO - 'USER': 'cltbld', 05:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:22 INFO - 'XPC_FLAGS': '0x0', 05:54:22 INFO - 'XPC_SERVICE_NAME': '0', 05:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:54:23 INFO - Cleaning up... 05:54:23 INFO - Return code: 0 05:54:23 INFO - Running post-action listener: _resource_record_post_action 05:54:23 INFO - Running post-action listener: _start_resource_monitoring 05:54:23 INFO - Starting resource monitoring. 05:54:23 INFO - [mozharness: 2016-10-22 12:54:23.164211Z] Finished create-virtualenv step (success) 05:54:23 INFO - [mozharness: 2016-10-22 12:54:23.165231Z] Running install step. 05:54:23 INFO - Running pre-action listener: _resource_record_pre_action 05:54:23 INFO - Running main action method: install 05:54:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:23 INFO - Reading from file tmpfile_stdout 05:54:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:23 INFO - Reading from file tmpfile_stdout 05:54:23 INFO - Output received: 05:54:23 INFO - Usage: mozinstall [options] installer 05:54:23 INFO - Options: 05:54:23 INFO - -h, --help show this help message and exit 05:54:23 INFO - -d DEST, --destination=DEST 05:54:23 INFO - Directory to install application into. [default: 05:54:23 INFO - "/builds/slave/test"] 05:54:23 INFO - --app=APP Application being installed. [default: firefox] 05:54:23 INFO - mkdir: /builds/slave/test/build/application 05:54:23 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'] 05:54:23 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 05:54:57 INFO - Reading from file tmpfile_stdout 05:54:57 INFO - Output received: 05:54:57 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:54:57 INFO - Running post-action listener: _resource_record_post_action 05:54:57 INFO - [mozharness: 2016-10-22 12:54:57.940108Z] Finished install step (success) 05:54:57 INFO - [mozharness: 2016-10-22 12:54:57.940251Z] Running run-tests step. 05:54:57 INFO - Running pre-action listener: _resource_record_pre_action 05:54:57 INFO - Running main action method: run_tests 05:54:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:54:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:54:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:54:57 INFO - 2016-10-22 05:54:57.955 screenresolution[2271:24283] starting screenresolution argv=screenresolution get 05:54:57 INFO - 2016-10-22 05:54:57.957 screenresolution[2271:24283] Display 0: 1600x1200x32@60 05:54:57 INFO - 2016-10-22 05:54:57.963 screenresolution[2272:24285] starting screenresolution argv=screenresolution list 05:54:57 INFO - Available Modes on Display 0 05:54:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:54:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:54:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:54:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:54:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:54:58 INFO - Intel Iris: 05:54:58 INFO - Chipset Model: Intel Iris 05:54:58 INFO - Type: GPU 05:54:58 INFO - Bus: Built-In 05:54:58 INFO - VRAM (Dynamic, Max): 1536 MB 05:54:58 INFO - Vendor: Intel (0x8086) 05:54:58 INFO - Device ID: 0x0a2e 05:54:58 INFO - Revision ID: 0x0009 05:54:58 INFO - Displays: 05:54:58 INFO - Display: 05:54:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:54:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:54:58 INFO - Display Serial Number: 1600x1200 60 05:54:58 INFO - Main Display: Yes 05:54:58 INFO - Mirror: Off 05:54:58 INFO - Online: Yes 05:54:58 INFO - Rotation: Supported 05:54:58 INFO - Return code: 0 05:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:58 INFO - Python 2.7.3 05:54:58 INFO - Return code: 0 05:54:58 INFO - grabbing minidump binary from tooltool 05:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:58 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 0x1087ffd30>, '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 0x108625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087f7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:54:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:54:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:54:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:58 INFO - Return code: 0 05:54:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:54:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:54:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I3Q1ze4DZ6/Render', 05:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:58 INFO - 'HOME': '/Users/cltbld', 05:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:58 INFO - 'LOGNAME': 'cltbld', 05:54:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:58 INFO - 'MOZ_NO_REMOTE': '1', 05:54:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:58 INFO - 'NO_EM_RESTART': '1', 05:54:58 INFO - 'PAGER': '/bin/cat', 05:54:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:58 INFO - 'PWD': '/builds/slave/test', 05:54:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:58 INFO - 'SHELL': '/bin/bash', 05:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LMQwvrxKbn/Listeners', 05:54:58 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:58 INFO - 'USER': 'cltbld', 05:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:58 INFO - 'XPC_FLAGS': '0x0', 05:54:58 INFO - 'XPC_SERVICE_NAME': '0', 05:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:54:58 INFO - mozversion application_buildid: 20161022030204 05:54:58 INFO - mozversion application_changeset: 5639a9f476d08f300c079117e61697f5026b6367 05:54:58 INFO - mozversion application_display_name: Nightly 05:54:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:58 INFO - mozversion application_name: Firefox 05:54:58 INFO - mozversion application_remotingname: firefox 05:54:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:54:58 INFO - mozversion application_vendor: Mozilla 05:54:58 INFO - mozversion application_version: 52.0a1 05:54:58 INFO - mozversion platform_buildid: 20161022030204 05:54:58 INFO - mozversion platform_changeset: 5639a9f476d08f300c079117e61697f5026b6367 05:54:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:54:58 INFO - mozversion platform_version: 52.0a1 05:54:58 INFO - using testdate: 1477140898 05:54:58 INFO - actual date: 1477140898 05:54:58 INFO - starting webserver on 'localhost:54960' 05:54:58 INFO - SUITE-START | Running 2 tests 05:54:58 INFO - TEST-START | dromaeo_css 05:54:58 INFO - operating with platform_type : mac_ 05:54:58 INFO - Initialising browser for dromaeo_css test... 05:54:58 INFO - TEST-INFO | started process 2282 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpKhA7YO/profile http://localhost:54960/getInfo.html) 05:55:01 INFO - PROCESS | 2282 | __metrics Screen width/height:1600/1200 05:55:01 INFO - PROCESS | 2282 | colorDepth:24 05:55:01 INFO - PROCESS | 2282 | Browser inner width/height: 1024/689 05:55:01 INFO - PROCESS | 2282 | __metrics 05:55:01 INFO - PROCESS | 2282 | 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" 05:55:01 INFO - PROCESS | 2282 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:02 INFO - TEST-INFO | 2282: exit 0 05:55:02 INFO - Browser initialized. 05:55:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:02 INFO - TEST-INFO | started process 2285 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpKhA7YO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:14 INFO - PROCESS | 2285 | RSS: Main: 230653952 05:55:14 INFO - PROCESS | 2285 | 05:56:04 INFO - PROCESS | 2285 | 1477140964893 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:58:17 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:54960/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54960/tests/dromaeo/cssquery-ext.html) 05:58:20 INFO - PROCESS | 2285 | RSS: Main: 515444736 05:58:20 INFO - PROCESS | 2285 | 06:01:23 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:54960/tests/dromaeo/cssquery-ext.html (next: http://localhost:54960/tests/dromaeo/cssquery-jquery.html) 06:01:24 INFO - PROCESS | 2285 | RSS: Main: 389066752 06:01:24 INFO - PROCESS | 2285 | 06:04:26 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:54960/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54960/tests/dromaeo/cssquery-mootools.html) 06:04:27 INFO - PROCESS | 2285 | RSS: Main: 359669760 06:04:27 INFO - PROCESS | 2285 | 06:07:29 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:54960/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54960/tests/dromaeo/cssquery-prototype.html) 06:07:30 INFO - PROCESS | 2285 | RSS: Main: 340185088 06:07:30 INFO - PROCESS | 2285 | 06:10:33 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:54960/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54960/tests/dromaeo/cssquery-yui.html) 06:10:34 INFO - PROCESS | 2285 | RSS: Main: 340951040 06:10:34 INFO - PROCESS | 2285 | 06:13:37 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:54960/tests/dromaeo/cssquery-yui.html (next: http://localhost:54960/tests/dromaeo/cssquery-dojo.html) 06:13:38 INFO - PROCESS | 2285 | RSS: Main: 381743104 06:13:38 INFO - PROCESS | 2285 | 06:13:38 INFO - PROCESS | 2285 | __start_tp_report 06:13:38 INFO - PROCESS | 2285 | _x_x_mozilla_page_load 06:13:38 INFO - PROCESS | 2285 | _x_x_mozilla_page_load_details 06:13:38 INFO - PROCESS | 2285 | |i|pagename|runs| 06:13:38 INFO - PROCESS | 2285 | |0;dojo.html;3265.9020229393113;3283.4254005549037;3299.5710557627513;3338.515915192296;3351.865925362984;4952.579030782388;5488.670679759217;5507.173923911415;5556.444355564441;5639.492445679883;5461.5357694595905;5627.577931655132;5634.4928956393915;5665.886682266352;5680.744366503507;5167.9224811627855;5185.222216667492;5190.636655434121;5192.480751924796;5204.245384419257;5072.74636268187;5177.741112944356;5243.475652434764;5243.554297884684;5251.949610077981;4384.276594361926;5205.661631993928;5220.660657057279;5254.684718916858;5261.631685781997;5062.443131255559;5165.819196328111;5177.275181474596;5239.607029472786;5242.16125419931;5049.217371307416;5077.111505486562;5133.204353325241;5156.535911767959;5160.716160611165;5574.163875418679;5597;5610.074337734269;5613.915791263134;5629.437056294379;6098.420545810142;6109.511239100906;6117.265928088614;6131.294901086388;6182.103594978747;6123.112148738453;6152.661603611799;6160.4455598995855;6170.691465426756;6171.7531298748;5554.944450555524;5578.86052848682;5732.369439361667;5743.798967036176;5753.453421924911;6129.662868542184;6153.538484613582;6163.691815409212;6164.013757798731;6175.752969881244;6127.509799216052;6129.356417576179;6133.26400831903;6133.754649814046;6136.6011209271255;6116.192781602746;6132.448079672851;6153.230846144232;6158.969205153946;6161.106639537332;5927.762889484458;5962.85092872673;5969.492593129546;5973.940260597338;6136.294326152461;6075.149479072933;6075.665838378932;6092.573519853568;6100.847478813065;6102.908456373158;4193.741877436757;4800.567948884617;4853.95146048535;4854.854354369375;4866.586340161126;4294.119705460374;4303.870883873489;4388.71473354231;4410.977945110254;4428.756418397019;5576.693281869455;5588.133839254922;5598.580106491948;5608.747606357723;5609.27079479665;5472.863178420492;6109.009944784285;6117.15760190703;6149.538784591174;6183.84540386485;5739.7704091836695;5744.482996530249;5746.856328591819;5755.1079582663915;5796.652200867961;4602.516735742765;5369.140937449989;5372.516473517402;5394.595405344537;5396.379416367089;6173.56785025044;6215.347388524321;6217.720202590895;6255.812325630239;6274.749010039547;6138.355472675484;6143.60399444226;6153.661548614869;6155.692215389123;6168.444839964424;6219.689015549295;6229.3770622939155;6234.127222188807;6241.625502469867;6253.093301471352;5982.102684597346;6105.877882442237;6137.079438084323;6146.969265153645;6149.2620885494025;4636.83771068011;6054.939450605438;6055.788047418319;6063.363346848694;6098.280951554018;5889.939810834091;5922.200502932049;5922.585419020627;5926.318473375617;5929.199558059607;5849.473547380756;5881.470667639933;5912.793052243151;5914.704264786829;5917.497012753965;5780.653160810365;5784.8553786154;5797.362290147996;5806.187133801355;5811.883762324645;5824.15549745293;5857.384974577779;5923.348431672599;5925.792597259076;6006.099085137264;5843.152742852348;5856;5857.5313974881055;5860.853478663067;5904.350521442724 06:13:38 INFO - PROCESS | 2285 | |1;ext.html;459.12765745084346;474.4377912174074;479.486948964608;492.7708615493797;499.22370713540477;34856.12859678506;40919.79540102299;41559;42579.148417031676;42682.14635707292;43028;43563.346549801696;43582;43623.41954094822;43675.56324436755;8638.524881131536;9483.241340692728;9517.191038761714;9657.46883921384;9663.565139568736;8558.957205213965;8712.956435217815;8713.520756358397;8716.956415217946;8717.7820554486;11568.190226684135;11853.525858965631;11865.64403067905;11983.70040748984;12011.219270747373;11659.183857130005;11770.882291177064;11796.05631549474;11799.705007374798;11817.7636447271;8601;8822.2501087407;8843.77890552735;11594.420278986101;11684.240524365974;32629.347413051604;32973.17567060843;40320.193596127916;41048.58951410477;41060.38409423861;3336.399448099341;3356.7985920844826;3388.7797293176113;3672.485851980725;4056.979715101435;30830.383392332253;31386.744530218763;31541;31642.683573164435;32410.675893241;3178.1930722532948;3213.935721285561;3251.528528363374;3261.836908154583;3294.3246634439884;493046;496269;497442;499452;501117;62130.75738485205;62455;62505.68747156235;62559.37440625626;62575;30134.698653013627;30467.390652186834;30528.694713052584;30555.694443055287;32367.676323236938;15922.044677319398;16067.919660401623;16071.839281607268;16086.35654573804;16170.676586468206;12220.694482638006;12307.815382769266;12316.630501084981;12318.445669944875;12326.95220906215;16928.32286708518;17338.3064677414;19059.80940190608;19257.903710481358;19582.054946482633;6542.658754955222;7694.307252404462;7718.8807622894365;7719.459637825298;7786.454948153575;872.3108744092096;950.8763860698065;954.4893481987242;1018.8217062014118;1026.861373714554;28793.568096478568;29934;30080.398392032035;30691;30714.846425768174;1044.7440377107505;1046.8325067989238;1086.3699054548342;1123.2867129372744;1136.9943150284362;16105.758413623806;16147;16792.748108778378;16909.23908424124;16973.660526789394;633469;635089;637453;638274;639895;59945.10082348768;60342.094868577005;60353;60491;61546;1319.6107148391056;1374.4364810427676;1381.4267079162237;1387.6392138044382;1389.2012093046337;30773.23066923345;31557.36885262328;31905.202369940936;32232.838835806608;32353.51469727909;53315.93368132538;54048.729756350964;54064.91870162496;54361.184582230504;54380.45619543754;586042;588330;588461;588746;589915;26746.59880101761;26938.730612694406;27098.72901271041;27220.591691124253;27322.90708371643;39434.2113157741;40618.78143655695;40620.78137655875;44220.778896105316;51750;38386;40418;40916.18167636571;41237.36922557753;41814.79092604518;39310.2137957245;39543.604563953995;40006;41098.58901410948;41273;39295.214095717354;39923.201535969696;40579.39130913098;40661.98345041398;42117.36823947582;32101.67898320987;32610.67389326171;35383;35776.82111589425;36173.638263617024;25780.484390311714;25859.224223273333;26130.346741331618;26136.477270454863;26426.867865660548 06:13:38 INFO - PROCESS | 2285 | |2;jquery.html;370.1874385723337;370.43323714716485;381.3897763578275;390.9745866518678;400.8116185392864;18653.253869845208;20455.693164602504;20574.48563785906;20589.38231853043;20612;20215;20656.896715516403;20758.792412075913;21010.894945525288;21272.14911403542;1605.1572924214763;1607.5579215715654;1608.9115098669567;1610.042024995132;1897.4212865076147;5592.161175823619;5896.7051647417675;5914.674692891889;5923.88152236955;5924.496417804492;5591.580631452657;5860.443257890493;5879.118132280149;5886.205362276102;5895.675737834417;5720.79977200798;5820.854478638025;5852.122181672783;5852.853678658025;5859.648421094748;5026.497350264981;5045.949540504585;5059.519345662156;5115.155999260118;5115.360579927509;25518.744812551824;25653.743462565322;25690.614640780404;25920.87039564809;25942;2191.9671204931938;2380.5119950410126;2723.904663336774;2963.881444742208;2980.2251414632133;15267.160306183156;15521.301541430663;15598.610034749108;15746.527604171893;15841.841581584153;1511.7203317386318;1698.915054247295;1838.1452624529659;1838.4484654603566;1957.9021048947495;70912.93630595494;77629.22370776277;95090.52454737751;109403.45298273537;112136;10070.69787906364;11006.669799906016;11064.944675276573;11133.276337038067;11154.944225278821;13617.591472255848;13639.659008524866;13670.726585468235;13681.31593420325;13690.93154534241;8483.618237179342;8500.10748871372;8518;8695.695650652196;8730.821339119264;7000.649967501605;8376.748697539084;8385.507492592362;8397.70608028716;8574.528400938008;5646.491815736604;6612.2726500084955;6649.368310010541;6762.898556521656;6780.643871225775;1587.8650314723147;1812.3294381078822;1829.6889528780139;1835.2292037344348;1868.084638527139;915.1260546178383;925.6945208081318;949.3117489819963;974.3325821812082;1058.5871510111062;20966.895165524074;21786.89106554489;22305.776942230696;22353.776462235168;22355.993980270927;861.6725644255143;929.3773171974793;930.3115694386106;940.5609417591097;986.4278718343344;11589.24669896454;11887.28676279426;11966.691476554746;11968;12089.274643521418;562774;564694;567981;579949.1561824124;586314;93122;94759;115700;116656;117475.06312342088;852.6972924611673;942.5051847779833;946.2808265717966;1000.5047501486811;1003.3227571389428;20179.495512611717;20783.272585459436;20860.791392085885;20931.37205883826;20967.685484718048;51289.48710512847;51749.48250517597;51868.74065629799;53249.733751331;54515.72742136264;49263.75368123136;68257.8329275419;69591.65204173946;71272.64363678149;72841.17897052404;7727.227277272228;7935.246151615587;7963.013869798825;8203.364485981308;8251.752447426346;9810.607575696893;13029.934850325688;13231.27228002469;13484.12353197039;13640.181589104686;10920.235583509397;10929.907009299006;10933.070688991525;11196;11262.493187806733;9372.81254374895;10873.782524349626;10924.126069914546;11307.151963602599;11464.541418343506;9382.202512786489;10955.671329860117;11724.765504690029;11832.881671183179;11833.34916579562;7982.920170798217;8056.27493525562;8068.1528439513;8089.069756977788;8204.852396318805;10288.742781430525;10855.751588567417;10975.221731694694;10982.725431864268;11211.887881121085 06:13:38 INFO - PROCESS | 2285 | |3;mootools.html;1364.3928451838933;1560.7892934453848;1767.8408943195109;1903.0484757621189;1976.83196928261;8388.8741668875;8769.34229932756;8782.121787821216;8787.604557794899;8791.296696264299;7793.883091753614;8107.675692972274;8111.310538604226;8444.619992100355;8699.173578510032;2292.209187830196;2327.3134425344565;2328.836981411302;2330;2330.6620540021686;2280.5552917181158;2291.4958709083976;2322.6412548659055;2329.5108027314286;2337.91817286395;2050.456628993318;2122.7983341582603;2132.253711201075;2242.6523888797265;2318.2813327868416;2274.385915802732;2295.2884605772097;2296.9885150574305;2299.4251437140715;2300.401895507172;2248.3704562722464;2288;2294.9426264343356;2296.1733775840685;2300.666403371502;7662.731804386875;8895.955520222422;8944.731658050268;8957.462552246887;8969.327300452493;5108.489151084899;5190.870228244324;5253.238280449352;5256.237845512417;5291.761870715827;3350.5867477972242;3421.726261899042;3561.465780132975;3571.0715214044535;3574.928501429983;1017.2726500552067;1019.4596863662271;1036.212478516333;1038.7558923653012;1042.9947850260776;11639.418029098511;11651.533938642444;11653.533858645644;11669.241499302518;11669.533218671158;4445.644348452116;4531.932021019687;4604.907901841944;4665.836695715634;4718.41019872516;9972.950135249277;9973.750656233507;9975.351602145838;9983.00169982996;10004.849927251096;5148.742562871841;5230.137027390514;5232.319798426181;5239.659422137625;5242.895142097137;4351.8694439166875;4518.502964673883;4650.511696271843;4733.739644319596;4819.036192761391;3795.6014618465215;3853.402722578005;3856.402257650069;3894.4547763313158;3940.074082590589;1119.205364191417;1163.3601519164426;1220.127608759741;1227.3372378915465;1243.9253644781343;622.7664625765339;749.6064566102731;756.6292516666794;817.0767033252506;880.5905254056894;5016.949830501721;5560.916586251209;5623.028587040227;5718.685472299064;6048.727807248684;773.3503856760349;825.7068740597001;875.7898104454885;924.9548010747812;942.3262367407336;3808.124131449782;3878.8836334909997;3911.159100793343;3938.783366914847;4037.2934736421007;10534.104601108838;10737;10799.78400431987;10926.180536459797;10975.067119294948;10900.727481812859;10910.23628346008;10924.071453926346;10927.180461465421;10931.617393391192;7732.999999999887;8227.588620568948;8323.500589964622;8327.250547450758;8335.208155225244;4855.417349918032;5034.219695947134;5882.205902203148;6041.214642096676;6116.981396139175;6950.652467376712;9738.269629777653;10076.143527800219;10107.949460252652;10269.640562580274;9885.703428897144;9918.950405247928;10181.84727229107;10234.33476824004;10309.896901031194;7543.396528277615;7659.425543084402;7762.3790096793255;7766.301032906839;7780.183080776437;8270.394825629908;8376.83246335082;8383.203595658402;8486.61810218554;8488.448250863674;7570.5836179010685;7620.123685776207;7667.11828139771;7728.536287822749;7753.92246077532;7404.96297518509;7430.294122058612;7502.249775022454;7527.548347099191;7591.658375373232;6715.227748808949;6910.343517365842;6970.860582788418;6972.58164510131;6975.686094125675;4950.381202349707;4979.975100124476;5016.849494515171;5064.518870707277;5243.842684719464;4953.653244272867;5013.749312534285;5049;5217.765200566059;5218 06:13:38 INFO - PROCESS | 2285 | |4;prototype.html;259.70523455877577;305.7920613982491;306.32608261823987;311.5591438115066;315.507807819801;5177.482251774821;5180.326557547523;5182.714950677711;5185.792568297268;5198.750780762024;4244.745315281085;5158.896822063566;5171.793488037412;5180.766865491052;5190.2474141249495;3184.4108839864643;3290.3419316136747;3866.3233934061427;3912.3740201567753;3912.4522566840665;3838.2323535293053;3893.5717071122153;3899.122697393092;3916.3929590913453;3955.7033222508285;3351.9329613407717;3491.95241427572;3935;3939.72421930465;3970.285348637244;3628.8589732058213;3871.9612803872164;3893.5717071122153;3916.1776027034357;3918.725689201757;3357.9328413431595;3362.6132994705677;3363.545921300642;3367.1413789483527;3381.661833816623;3836.5396152461603;4347;4520.801987473322;4934.728589927553;5042.210015444501;4421.491528474235;4425.513193548707;4431.889202769924;4449.199144154051;4457.866264012052;5146.6911985281;5342.332208473941;5363.704996225206;5376.8118115865755;5443.782248710047;3063.9846800765854;3088.768342374331;3689.9114761145524;3693.26416584205;3694.722895782827;4666.556677115668;4783.569478746929;5520.530754885839;5614.494695477386;5675.247504960091;3578.5526809148855;3720.9441858372147;3728.142527218755;3744.4383342498845;3756.887293381148;3781.5084039074745;3790.33669107905;3792.7534710243744;3802.239552089593;3802.372608519563;3705.5182826232417;4399.12017596482;4399.548149110786;4405.29515277554;4405.493368262627;4482.932756008662;4552.702479793243;5102.056119617809;5440.047991601454;5445.83662490126;1252.855921569013;1278.1755767530076;1281.4233594882153;1294.779887419141;1333.9733205336033;682.382443888282;714.6748229555644;750.3696894608555;785.7367781793049;803.8392321535599;4395.692301538862;4857.53853383928;4971.6271279654175;5038.246506352717;5141.097793816312;5595.440455954372;5599.404169811665;5617.4271204062925;5619.550435965113;5636.830895073154;4267.637250833714;4460.821567137343;4804.8798780030775;5110.744462776846;5132.615053870974;2406.374342670918;2440.2923152285994;2880.5967164596973;2924.488214562443;2933.530635098374;4780.569748722632;5727.651662818224;5742;5818.825435236865;5819.970900145472;4785.396892041205;5373.919391209135;5530.589010725647;5712.685802280915;5747.626404283708;4846.854594362175;5235.947640523622;5794.942795307774;5807.8548036299435;5825.155352473867;4315.719478233905;5649.293838270216;5673.347565030074;5690.174924635988;5711.714414279352;5207.5833933286;5542.445755424586;5595.188697638738;5601.778977088109;5637.295338082739;4866.474179013551;5877.73550190251;5880.970595146997;5885.90989730395;5904;3624.927501450009;3730.079009310153;3750.9062273443383;3769.8492060318376;3776.678982286536;4654.25531914892;5340.919886201787;5349.358077030781;5576;5576.944230557805;4743.739094349844;5394.2448057272795;5423.074808442946;5434.961724566617;5441.347038355423;4926.704397736147;4971.875703107451;4981.726005069756;5219.5041471060185;5459.39946605881;4668.416447944007;5286.524212820865;5348.973255133699;5353;5362.785488580413;4455;5004.299398084198;5157.6647517911215;5196.73793079331;5476.91784623223;4363.629091527256;4838.201696720002;5256.159014557652;5375.220593013913;5424 06:13:38 INFO - PROCESS | 2285 | |5;yui.html;726.647575925676;728.420905380223;785.2147852147853;836.6444261188993;839.7019058234325;15251.542453726379;15981.041137531756;16013.679726405466;16074.5981350466;16357.672846543077;14472.204028778413;14576.927115364408;14577.125372477632;14587.41650333988;14612.415503379852;695.4540685561835;719.8668246374438;727.1964479250431;804.0190967020226;870.3559366069127;836.4897412578322;880.2561835249236;893.4639216470099;899.3704406915153;900.0189793125492;959.0457494792656;961.7691753979029;962.9422234665907;965.2133511188395;965.7102869139266;733.8495608400318;751.5828715063137;954.6610953111615;956.7082039977804;957.262907561174;684.4866350237322;692.4702602509085;693.4798900824381;695.2630211975322;697.891826766852;14961.251937403087;14976.925115374463;14999.550013499613;15002.24988750569;15006.774898376532;13518.324083795771;13731;13988;14021.228832414214;14167.008309418241;12622;12650.557230496981;12679.683007924783;12903;13013.609591712264;4496.865094047183;4573.885652858705;4586.243269860503;4597.195490789099;4674.560638165275;91082.54458727664;103902;105215.94784052062;116535;117418.65162696784;10532.947335263274;10719;11001.944990274997;11017.779644407226;11287.040601548797;21500.139994400048;21503.784962150177;21519.031643576076;21523.892380537996;21582.244621438174;7673.616319184019;7728.188540203198;7826.647800848976;7848.254415830487;7849.411294152961;4269.359596060615;4299.355096735515;4369.366441865912;4538.160440318552;4551;3467.375872342952;3619.2399596084592;3622.9818850905576;3627.1294889226924;3631.0014745945077;647.543481845298;658.2660333727858;669.7120238297579;670.0786418674322;676.212212772115;572.5391060196582;591.6509259536894;616.5622408090217;641.403494749887;659.1826135591832;7920.169011552078;8422.789430264293;9057.230135438429;9105.362624616346;9334.439933604006;522.9058769421465;594.8780499997576;605.3371558143825;632.6812233165489;635.4598591197538;4375.2679702066835;4395.472543294825;4396;4398.252297109435;4498.685092043591;125968;128375.35812321065;135959.96060059106;157091;158210;123141;124346;125369;125722;127253.36373318074;100590.49704751429;105498;107954;108646;108692;9724.70825875225;9823.21414286841;9980;10097.596096156072;10160.644377446753;46934;53617.7319113402;57884.71057644685;58506;58845.411545883995;70148.64925675339;82112;90449.09550904407;96691;97785.51107244703;13232.338383080614;13271.469141234242;13283.601491955256;13308.334583270991;13817.752828085191;14738.26308684583;14744.63138421548;15057.397704092153;15247.771283430535;15473.148976806384;13795.241261730702;13813.309334533435;14044.438222471395;14122.152670839783;14458.421663133357;11432.885671143182;13793.931030344784;13839.792403114163;13844.653883652587;13937.790933136213;13312.46750129984;13655;13993.370298336396;14197.645058873612;14403.711925761636;11086;11429.142814288794;11585.82621260665;11701.531938722695;12056.51773929033;10813.62152324665;11356.772864542498;11482.841560344297;11579.768404631692;11722.706932326419 06:13:38 INFO - PROCESS | 2285 | __end_tp_report 06:13:38 INFO - PROCESS | 2285 | __start_cc_report 06:13:38 INFO - PROCESS | 2285 | _x_x_mozilla_cycle_collect,3342 06:13:38 INFO - PROCESS | 2285 | __end_cc_report 06:13:38 INFO - PROCESS | 2285 | __startTimestamp1477142018136__endTimestamp 06:13:38 INFO - PROCESS | 2285 | 06:13:38 INFO - PROCESS | 2285 | ------- Summary: start ------- 06:13:38 INFO - PROCESS | 2285 | Number of tests: 6 06:13:38 INFO - PROCESS | 2285 | 06:13:38 INFO - PROCESS | 2285 | [#0] dojo.html Cycles:165 Average:5627.91 Median:5824.16 stddev:638.56 (11.0%) stddev-sans-first:613.05 06:13:38 INFO - PROCESS | 2285 | Values: 3265.9 3283.4 3299.6 3338.5 3351.9 4952.6 5488.7 5507.2 5556.4 5639.5 5461.5 5627.6 5634.5 5665.9 5680.7 5167.9 5185.2 5190.6 5192.5 5204.2 5072.7 5177.7 5243.5 5243.6 5251.9 4384.3 5205.7 5220.7 5254.7 5261.6 5062.4 5165.8 5177.3 5239.6 5242.2 5049.2 5077.1 5133.2 5156.5 5160.7 5574.2 5597.0 5610.1 5613.9 5629.4 6098.4 6109.5 6117.3 6131.3 6182.1 6123.1 6152.7 6160.4 6170.7 6171.8 5554.9 5578.9 5732.4 5743.8 5753.5 6129.7 6153.5 6163.7 6164.0 6175.8 6127.5 6129.4 6133.3 6133.8 6136.6 6116.2 6132.4 6153.2 6159.0 6161.1 5927.8 5962.9 5969.5 5973.9 6136.3 6075.1 6075.7 6092.6 6100.8 6102.9 4193.7 4800.6 4854.0 4854.9 4866.6 4294.1 4303.9 4388.7 4411.0 4428.8 5576.7 5588.1 5598.6 5608.7 5609.3 5472.9 6109.0 6117.2 6149.5 6183.8 5739.8 5744.5 5746.9 5755.1 5796.7 4602.5 5369.1 5372.5 5394.6 5396.4 6173.6 6215.3 6217.7 6255.8 6274.7 6138.4 6143.6 6153.7 6155.7 6168.4 6219.7 6229.4 6234.1 6241.6 6253.1 5982.1 6105.9 6137.1 6147.0 6149.3 4636.8 6054.9 6055.8 6063.4 6098.3 5889.9 5922.2 5922.6 5926.3 5929.2 5849.5 5881.5 5912.8 5914.7 5917.5 5780.7 5784.9 5797.4 5806.2 5811.9 5824.2 5857.4 5923.3 5925.8 6006.1 5843.2 5856.0 5857.5 5860.9 5904.4 06:13:38 INFO - PROCESS | 2285 | 06:13:38 INFO - PROCESS | 2285 | [#1] ext.html Cycles:180 Average:70299.76 Median:21029.24 stddev:154232.67 (733.4%) stddev-sans-first:154576.19 06:13:38 INFO - PROCESS | 2285 | Values: 459.1 474.4 479.5 492.8 499.2 34856.1 40919.8 41559.0 42579.1 42682.1 43028.0 43563.3 43582.0 43623.4 43675.6 8638.5 9483.2 9517.2 9657.5 9663.6 8559.0 8713.0 8713.5 8717.0 8717.8 11568.2 11853.5 11865.6 11983.7 12011.2 11659.2 11770.9 11796.1 11799.7 11817.8 8601.0 8822.3 8843.8 11594.4 11684.2 32629.3 32973.2 40320.2 41048.6 41060.4 3336.4 3356.8 3388.8 3672.5 4057.0 30830.4 31386.7 31541.0 31642.7 32410.7 3178.2 3213.9 3251.5 3261.8 3294.3 493046.0 496269.0 497442.0 499452.0 501117.0 62130.8 62455.0 62505.7 62559.4 62575.0 30134.7 30467.4 30528.7 30555.7 32367.7 15922.0 16067.9 16071.8 16086.4 16170.7 12220.7 12307.8 12316.6 12318.4 12327.0 16928.3 17338.3 19059.8 19257.9 19582.1 6542.7 7694.3 7718.9 7719.5 7786.5 872.3 950.9 954.5 1018.8 1026.9 28793.6 29934.0 30080.4 30691.0 30714.8 1044.7 1046.8 1086.4 1123.3 1137.0 16105.8 16147.0 16792.7 16909.2 16973.7 633469.0 635089.0 637453.0 638274.0 639895.0 59945.1 60342.1 60353.0 60491.0 61546.0 1319.6 1374.4 1381.4 1387.6 1389.2 30773.2 31557.4 31905.2 32232.8 32353.5 53315.9 54048.7 54064.9 54361.2 54380.5 586042.0 588330.0 588461.0 588746.0 589915.0 26746.6 26938.7 27098.7 27220.6 27322.9 39434.2 40618.8 40620.8 44220.8 51750.0 38386.0 40418.0 40916.2 41237.4 41814.8 39310.2 39543.6 40006.0 41098.6 41273.0 39295.2 39923.2 40579.4 40662.0 42117.4 32101.7 32610.7 35383.0 35776.8 36173.6 25780.5 25859.2 26130.3 26136.5 26426.9 06:13:38 INFO - PROCESS | 2285 | 06:13:38 INFO - PROCESS | 2285 | [#2] jquery.html Cycles:180 Average:32850.29 Median:25931.44 stddev:94671.08 (365.1%) stddev-sans-first:94905.24 06:13:38 INFO - PROCESS | 2285 | Values: 370.2 370.4 381.4 391.0 400.8 18653.3 20455.7 20574.5 20589.4 20612.0 20215.0 20656.9 20758.8 21010.9 21272.1 1605.2 1607.6 1608.9 1610.0 1897.4 5592.2 5896.7 5914.7 5923.9 5924.5 5591.6 5860.4 5879.1 5886.2 5895.7 5720.8 5820.9 5852.1 5852.9 5859.6 5026.5 5045.9 5059.5 5115.2 5115.4 25518.7 25653.7 25690.6 25920.9 25942.0 2192.0 2380.5 2723.9 2963.9 2980.2 15267.2 15521.3 15598.6 15746.5 15841.8 1511.7 1698.9 1838.1 1838.4 1957.9 70912.9 77629.2 95090.5 109403.5 112136.0 10070.7 11006.7 11064.9 11133.3 11154.9 13617.6 13639.7 13670.7 13681.3 13690.9 8483.6 8500.1 8518.0 8695.7 8730.8 7000.6 8376.7 8385.5 8397.7 8574.5 5646.5 6612.3 6649.4 6762.9 6780.6 1587.9 1812.3 1829.7 1835.2 1868.1 915.1 925.7 949.3 974.3 1058.6 20966.9 21786.9 22305.8 22353.8 22356.0 861.7 929.4 930.3 940.6 986.4 11589.2 11887.3 11966.7 11968.0 12089.3 562774.0 564694.0 567981.0 579949.2 586314.0 93122.0 94759.0 115700.0 116656.0 117475.1 852.7 942.5 946.3 1000.5 1003.3 20179.5 20783.3 20860.8 20931.4 20967.7 51289.5 51749.5 51868.7 53249.7 54515.7 49263.8 68257.8 69591.7 71272.6 72841.2 7727.2 7935.2 7963.0 8203.4 8251.8 9810.6 13029.9 13231.3 13484.1 13640.2 10920.2 10929.9 10933.1 11196.0 11262.5 9372.8 10873.8 10924.1 11307.2 11464.5 9382.2 10955.7 11724.8 11832.9 11833.3 7982.9 8056.3 8068.2 8089.1 8204.9 10288.7 10855.8 10975.2 10982.7 11211.9 06:13:38 INFO - PROCESS | 2285 | 06:13:38 INFO - PROCESS | 2285 | [#3] mootools.html Cycles:180 Average:5668.79 Median:4996.86 stddev:3226.41 (64.6%) stddev-sans-first:3219.24 06:13:38 INFO - PROCESS | 2285 | Values: 1364.4 1560.8 1767.8 1903.0 1976.8 8388.9 8769.3 8782.1 8787.6 8791.3 7793.9 8107.7 8111.3 8444.6 8699.2 2292.2 2327.3 2328.8 2330.0 2330.7 2280.6 2291.5 2322.6 2329.5 2337.9 2050.5 2122.8 2132.3 2242.7 2318.3 2274.4 2295.3 2297.0 2299.4 2300.4 2248.4 2288.0 2294.9 2296.2 2300.7 7662.7 8896.0 8944.7 8957.5 8969.3 5108.5 5190.9 5253.2 5256.2 5291.8 3350.6 3421.7 3561.5 3571.1 3574.9 1017.3 1019.5 1036.2 1038.8 1043.0 11639.4 11651.5 11653.5 11669.2 11669.5 4445.6 4531.9 4604.9 4665.8 4718.4 9973.0 9973.8 9975.4 9983.0 10004.8 5148.7 5230.1 5232.3 5239.7 5242.9 4351.9 4518.5 4650.5 4733.7 4819.0 3795.6 3853.4 3856.4 3894.5 3940.1 1119.2 1163.4 1220.1 1227.3 1243.9 622.8 749.6 756.6 817.1 880.6 5016.9 5560.9 5623.0 5718.7 6048.7 773.4 825.7 875.8 925.0 942.3 3808.1 3878.9 3911.2 3938.8 4037.3 10534.1 10737.0 10799.8 10926.2 10975.1 10900.7 10910.2 10924.1 10927.2 10931.6 7733.0 8227.6 8323.5 8327.3 8335.2 4855.4 5034.2 5882.2 6041.2 6117.0 6950.7 9738.3 10076.1 10107.9 10269.6 9885.7 9919.0 10181.8 10234.3 10309.9 7543.4 7659.4 7762.4 7766.3 7780.2 8270.4 8376.8 8383.2 8486.6 8488.4 7570.6 7620.1 7667.1 7728.5 7753.9 7405.0 7430.3 7502.2 7527.5 7591.7 6715.2 6910.3 6970.9 6972.6 6975.7 4950.4 4980.0 5016.8 5064.5 5243.8 4953.7 5013.7 5049.0 5217.8 5218.0 06:13:38 INFO - PROCESS | 2285 | 06:13:38 INFO - PROCESS | 2285 | [#4] prototype.html Cycles:180 Average:4349.86 Median:4842.53 stddev:1360.18 (28.1%) stddev-sans-first:1328.90 06:13:38 INFO - PROCESS | 2285 | Values: 259.7 305.8 306.3 311.6 315.5 5177.5 5180.3 5182.7 5185.8 5198.8 4244.7 5158.9 5171.8 5180.8 5190.2 3184.4 3290.3 3866.3 3912.4 3912.5 3838.2 3893.6 3899.1 3916.4 3955.7 3351.9 3492.0 3935.0 3939.7 3970.3 3628.9 3872.0 3893.6 3916.2 3918.7 3357.9 3362.6 3363.5 3367.1 3381.7 3836.5 4347.0 4520.8 4934.7 5042.2 4421.5 4425.5 4431.9 4449.2 4457.9 5146.7 5342.3 5363.7 5376.8 5443.8 3064.0 3088.8 3689.9 3693.3 3694.7 4666.6 4783.6 5520.5 5614.5 5675.2 3578.6 3720.9 3728.1 3744.4 3756.9 3781.5 3790.3 3792.8 3802.2 3802.4 3705.5 4399.1 4399.5 4405.3 4405.5 4482.9 4552.7 5102.1 5440.0 5445.8 1252.9 1278.2 1281.4 1294.8 1334.0 682.4 714.7 750.4 785.7 803.8 4395.7 4857.5 4971.6 5038.2 5141.1 5595.4 5599.4 5617.4 5619.6 5636.8 4267.6 4460.8 4804.9 5110.7 5132.6 2406.4 2440.3 2880.6 2924.5 2933.5 4780.6 5727.7 5742.0 5818.8 5820.0 4785.4 5373.9 5530.6 5712.7 5747.6 4846.9 5235.9 5794.9 5807.9 5825.2 4315.7 5649.3 5673.3 5690.2 5711.7 5207.6 5542.4 5595.2 5601.8 5637.3 4866.5 5877.7 5881.0 5885.9 5904.0 3624.9 3730.1 3750.9 3769.8 3776.7 4654.3 5340.9 5349.4 5576.0 5576.9 4743.7 5394.2 5423.1 5435.0 5441.3 4926.7 4971.9 4981.7 5219.5 5459.4 4668.4 5286.5 5349.0 5353.0 5362.8 4455.0 5004.3 5157.7 5196.7 5476.9 4363.6 4838.2 5256.2 5375.2 5424.0 06:13:38 INFO - PROCESS | 2285 | 06:13:38 INFO - PROCESS | 2285 | [#5] yui.html Cycles:180 Average:24156.79 Median:12524.81 stddev:37956.82 (303.1%) stddev-sans-first:38022.53 06:13:38 INFO - PROCESS | 2285 | Values: 726.6 728.4 785.2 836.6 839.7 15251.5 15981.0 16013.7 16074.6 16357.7 14472.2 14576.9 14577.1 14587.4 14612.4 695.5 719.9 727.2 804.0 870.4 836.5 880.3 893.5 899.4 900.0 959.0 961.8 962.9 965.2 965.7 733.8 751.6 954.7 956.7 957.3 684.5 692.5 693.5 695.3 697.9 14961.3 14976.9 14999.6 15002.2 15006.8 13518.3 13731.0 13988.0 14021.2 14167.0 12622.0 12650.6 12679.7 12903.0 13013.6 4496.9 4573.9 4586.2 4597.2 4674.6 91082.5 103902.0 105215.9 116535.0 117418.7 10532.9 10719.0 11001.9 11017.8 11287.0 21500.1 21503.8 21519.0 21523.9 21582.2 7673.6 7728.2 7826.6 7848.3 7849.4 4269.4 4299.4 4369.4 4538.2 4551.0 3467.4 3619.2 3623.0 3627.1 3631.0 647.5 658.3 669.7 670.1 676.2 572.5 591.7 616.6 641.4 659.2 7920.2 8422.8 9057.2 9105.4 9334.4 522.9 594.9 605.3 632.7 635.5 4375.3 4395.5 4396.0 4398.3 4498.7 125968.0 128375.4 135960.0 157091.0 158210.0 123141.0 124346.0 125369.0 125722.0 127253.4 100590.5 105498.0 107954.0 108646.0 108692.0 9724.7 9823.2 9980.0 10097.6 10160.6 46934.0 53617.7 57884.7 58506.0 58845.4 70148.6 82112.0 90449.1 96691.0 97785.5 13232.3 13271.5 13283.6 13308.3 13817.8 14738.3 14744.6 15057.4 15247.8 15473.1 13795.2 13813.3 14044.4 14122.2 14458.4 11432.9 13793.9 13839.8 13844.7 13937.8 13312.5 13655.0 13993.4 14197.6 14403.7 11086.0 11429.1 11585.8 11701.5 12056.5 10813.6 11356.8 11482.8 11579.8 11722.7 06:13:38 INFO - PROCESS | 2285 | -------- Summary: end -------- 06:13:38 INFO - PROCESS | 2285 | 06:13:38 INFO - TEST-INFO | 2285: exit 0 06:13:38 INFO - TEST-OK | dromaeo_css | took 1120331ms 06:13:38 INFO - TEST-START | kraken 06:13:38 INFO - operating with platform_type : mac_ 06:13:38 INFO - Initialising browser for kraken test... 06:13:38 INFO - TEST-INFO | started process 2290 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmptWSlOR/profile http://localhost:54960/getInfo.html) 06:13:41 INFO - PROCESS | 2290 | __metrics Screen width/height:1600/1200 06:13:41 INFO - PROCESS | 2290 | colorDepth:24 06:13:41 INFO - PROCESS | 2290 | Browser inner width/height: 1024/689 06:13:41 INFO - PROCESS | 2290 | __metrics 06:13:41 INFO - PROCESS | 2290 | 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:13:41 INFO - PROCESS | 2290 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:13:42 INFO - TEST-INFO | 2290: exit 0 06:13:42 INFO - Browser initialized. 06:13:42 INFO - Running cycle 1/1 for kraken test... 06:13:42 INFO - TEST-INFO | started process 2292 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmptWSlOR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:54 INFO - PROCESS | 2292 | RSS: Main: 232292352 06:13:54 INFO - PROCESS | 2292 | 06:13:57 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54960/tests/kraken/driver.html?testName=audio-beat-detection) 06:13:58 INFO - PROCESS | 2292 | RSS: Main: 291225600 06:13:58 INFO - PROCESS | 2292 | 06:14:00 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54960/tests/kraken/driver.html?testName=audio-dft) 06:14:01 INFO - PROCESS | 2292 | RSS: Main: 291975168 06:14:01 INFO - PROCESS | 2292 | 06:14:04 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54960/tests/kraken/driver.html?testName=audio-fft) 06:14:05 INFO - PROCESS | 2292 | RSS: Main: 385642496 06:14:05 INFO - PROCESS | 2292 | 06:14:07 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54960/tests/kraken/driver.html?testName=audio-oscillator) 06:14:08 INFO - PROCESS | 2292 | RSS: Main: 286322688 06:14:08 INFO - PROCESS | 2292 | 06:14:10 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54960/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:10 INFO - PROCESS | 2292 | RSS: Main: 291553280 06:14:10 INFO - PROCESS | 2292 | 06:14:13 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54960/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:14 INFO - PROCESS | 2292 | RSS: Main: 329633792 06:14:14 INFO - PROCESS | 2292 | 06:14:17 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54960/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:17 INFO - PROCESS | 2292 | RSS: Main: 329084928 06:14:17 INFO - PROCESS | 2292 | 06:14:20 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54960/tests/kraken/driver.html?testName=json-parse-financial) 06:14:21 INFO - PROCESS | 2292 | RSS: Main: 329424896 06:14:21 INFO - PROCESS | 2292 | 06:14:22 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54960/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:23 INFO - PROCESS | 2292 | RSS: Main: 303337472 06:14:23 INFO - PROCESS | 2292 | 06:14:25 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54960/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:25 INFO - PROCESS | 2292 | RSS: Main: 306266112 06:14:25 INFO - PROCESS | 2292 | 06:14:28 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54960/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:28 INFO - PROCESS | 2292 | RSS: Main: 308314112 06:14:28 INFO - PROCESS | 2292 | 06:14:31 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54960/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:32 INFO - PROCESS | 2292 | RSS: Main: 317636608 06:14:32 INFO - PROCESS | 2292 | 06:14:35 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54960/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:36 INFO - PROCESS | 2292 | RSS: Main: 317837312 06:14:36 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | Cycle 1(1): loaded http://localhost:54960/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54960/tests/kraken/driver.html?testName=ai-astar) 06:14:38 INFO - PROCESS | 2292 | RSS: Main: 361607168 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | __start_tp_report 06:14:38 INFO - PROCESS | 2292 | _x_x_mozilla_page_load 06:14:38 INFO - PROCESS | 2292 | _x_x_mozilla_page_load_details 06:14:38 INFO - PROCESS | 2292 | |i|pagename|runs| 06:14:38 INFO - PROCESS | 2292 | |0;ai-astar;104;113;113;113;112;116;159;166;113;111 06:14:38 INFO - PROCESS | 2292 | |1;audio-beat-detection;154;113;116;150;112;115;115;112;161;139 06:14:38 INFO - PROCESS | 2292 | |2;audio-dft;184;181;185;186;185;182;184;181;183;184 06:14:38 INFO - PROCESS | 2292 | |3;audio-fft;83;60;59;90;61;59;59;58;83;58 06:14:38 INFO - PROCESS | 2292 | |4;audio-oscillator;84;72;91;70;67;68;93;67;68;89 06:14:38 INFO - PROCESS | 2292 | |5;imaging-gaussian-blur;89;85;87;85;88;84;88;85;88;86 06:14:38 INFO - PROCESS | 2292 | |6;imaging-darkroom;98;97;98;104;97;99;97;113;160;102 06:14:38 INFO - PROCESS | 2292 | |7;imaging-desaturate;80;82;82;80;80;82;84;83;83;81 06:14:38 INFO - PROCESS | 2292 | |8;json-parse-financial;55;54;53;53;53;56;56;53;54;54 06:14:38 INFO - PROCESS | 2292 | |9;json-stringify-tinderbox;66;70;79;81;74;71;78;108;105;87 06:14:38 INFO - PROCESS | 2292 | |10;stanford-crypto-aes;88;87;89;84;85;77;100;96;105;73 06:14:38 INFO - PROCESS | 2292 | |11;stanford-crypto-ccm;146;155;156;136;153;156;163;141;209;163 06:14:38 INFO - PROCESS | 2292 | |12;stanford-crypto-pbkdf2;173;173;180;232;184;173;174;175;172;168 06:14:38 INFO - PROCESS | 2292 | |13;stanford-crypto-sha256-iterative;62;83;84;86;62;77;83;88;87;69 06:14:38 INFO - PROCESS | 2292 | __end_tp_report 06:14:38 INFO - PROCESS | 2292 | __start_cc_report 06:14:38 INFO - PROCESS | 2292 | _x_x_mozilla_cycle_collect,2033 06:14:38 INFO - PROCESS | 2292 | __end_cc_report 06:14:38 INFO - PROCESS | 2292 | __startTimestamp1477142078495__endTimestamp 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | ------- Summary: start ------- 06:14:38 INFO - PROCESS | 2292 | Number of tests: 14 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#0] ai-astar Cycles:10 Average:122.00 Median:113.00 stddev:21.63 (19.1%) stddev-sans-first:21.94 06:14:38 INFO - PROCESS | 2292 | Values: 104.0 113.0 113.0 113.0 112.0 116.0 159.0 166.0 113.0 111.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:127.50 stddev:19.96 (15.7%) stddev-sans-first:18.95 06:14:38 INFO - PROCESS | 2292 | Values: 154.0 113.0 116.0 150.0 112.0 115.0 115.0 112.0 161.0 139.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.72 (0.9%) stddev-sans-first:1.81 06:14:38 INFO - PROCESS | 2292 | Values: 184.0 181.0 185.0 186.0 185.0 182.0 184.0 181.0 183.0 184.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#3] audio-fft Cycles:10 Average:67.00 Median:60.50 stddev:12.82 (21.2%) stddev-sans-first:12.22 06:14:38 INFO - PROCESS | 2292 | Values: 83.0 60.0 59.0 90.0 61.0 59.0 59.0 58.0 83.0 58.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.00 stddev:10.96 (14.1%) stddev-sans-first:11.32 06:14:38 INFO - PROCESS | 2292 | Values: 84.0 72.0 91.0 70.0 67.0 68.0 93.0 67.0 68.0 89.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.50 stddev:1.72 (2.0%) stddev-sans-first:1.56 06:14:38 INFO - PROCESS | 2292 | Values: 89.0 85.0 87.0 85.0 88.0 84.0 88.0 85.0 88.0 86.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#6] imaging-darkroom Cycles:10 Average:106.50 Median:97.00 stddev:19.44 (20.0%) stddev-sans-first:20.38 06:14:38 INFO - PROCESS | 2292 | Values: 98.0 97.0 98.0 104.0 97.0 99.0 97.0 113.0 160.0 102.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#7] imaging-desaturate Cycles:10 Average:81.70 Median:82.00 stddev:1.42 (1.7%) stddev-sans-first:1.36 06:14:38 INFO - PROCESS | 2292 | Values: 80.0 82.0 82.0 80.0 80.0 82.0 84.0 83.0 83.0 81.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.20 (2.2%) stddev-sans-first:1.22 06:14:38 INFO - PROCESS | 2292 | Values: 55.0 54.0 53.0 53.0 53.0 56.0 56.0 53.0 54.0 54.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#9] json-stringify-tinderbox Cycles:10 Average:81.90 Median:76.00 stddev:14.30 (18.8%) stddev-sans-first:13.96 06:14:38 INFO - PROCESS | 2292 | Values: 66.0 70.0 79.0 81.0 74.0 71.0 78.0 108.0 105.0 87.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:86.00 stddev:9.82 (11.4%) stddev-sans-first:10.42 06:14:38 INFO - PROCESS | 2292 | Values: 88.0 87.0 89.0 84.0 85.0 77.0 100.0 96.0 105.0 73.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#11] stanford-crypto-ccm Cycles:10 Average:157.80 Median:156.00 stddev:20.03 (12.8%) stddev-sans-first:20.78 06:14:38 INFO - PROCESS | 2292 | Values: 146.0 155.0 156.0 136.0 153.0 156.0 163.0 141.0 209.0 163.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:174.50 stddev:18.66 (10.7%) stddev-sans-first:19.60 06:14:38 INFO - PROCESS | 2292 | Values: 173.0 173.0 180.0 232.0 184.0 173.0 174.0 175.0 172.0 168.0 06:14:38 INFO - PROCESS | 2292 | 06:14:38 INFO - PROCESS | 2292 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.10 Median:83.50 stddev:10.14 (12.1%) stddev-sans-first:8.92 06:14:38 INFO - PROCESS | 2292 | Values: 62.0 83.0 84.0 86.0 62.0 77.0 83.0 88.0 87.0 69.0 06:14:38 INFO - PROCESS | 2292 | -------- Summary: end -------- 06:14:38 INFO - PROCESS | 2292 | 06:14:39 INFO - TEST-INFO | 2292: exit 0 06:14:39 INFO - TEST-OK | kraken | took 60534ms 06:14:39 INFO - SUITE-END | took 1180s 06:14:39 INFO - Completed test suite (00:19:41) 06:14:39 INFO - javascript benchmark 06:14:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.9020229393113, 3283.4254005549037, 3299.5710557627513, 3338.515915192296, 3351.865925362984, 4952.579030782388, 5488.670679759217, 5507.173923911415, 5556.444355564441, 5639.492445679883, 5461.5357694595905, 5627.577931655132, 5634.4928956393915, 5665.886682266352, 5680.744366503507, 5167.9224811627855, 5185.222216667492, 5190.636655434121, 5192.480751924796, 5204.245384419257, 5072.74636268187, 5177.741112944356, 5243.475652434764, 5243.554297884684, 5251.949610077981, 4384.276594361926, 5205.661631993928, 5220.660657057279, 5254.684718916858, 5261.631685781997, 5062.443131255559, 5165.819196328111, 5177.275181474596, 5239.607029472786, 5242.16125419931, 5049.217371307416, 5077.111505486562, 5133.204353325241, 5156.535911767959, 5160.716160611165, 5574.163875418679, 5597.0, 5610.074337734269, 5613.915791263134, 5629.437056294379, 6098.420545810142, 6109.511239100906, 6117.265928088614, 6131.294901086388, 6182.103594978747, 6123.112148738453, 6152.661603611799, 6160.4455598995855, 6170.691465426756, 6171.7531298748, 5554.944450555524, 5578.86052848682, 5732.369439361667, 5743.798967036176, 5753.453421924911, 6129.662868542184, 6153.538484613582, 6163.691815409212, 6164.013757798731, 6175.752969881244, 6127.509799216052, 6129.356417576179, 6133.26400831903, 6133.754649814046, 6136.6011209271255, 6116.192781602746, 6132.448079672851, 6153.230846144232, 6158.969205153946, 6161.106639537332, 5927.762889484458, 5962.85092872673, 5969.492593129546, 5973.940260597338, 6136.294326152461, 6075.149479072933, 6075.665838378932, 6092.573519853568, 6100.847478813065, 6102.908456373158, 4193.741877436757, 4800.567948884617, 4853.95146048535, 4854.854354369375, 4866.586340161126, 4294.119705460374, 4303.870883873489, 4388.71473354231, 4410.977945110254, 4428.756418397019, 5576.693281869455, 5588.133839254922, 5598.580106491948, 5608.747606357723, 5609.27079479665, 5472.863178420492, 6109.009944784285, 6117.15760190703, 6149.538784591174, 6183.84540386485, 5739.7704091836695, 5744.482996530249, 5746.856328591819, 5755.1079582663915, 5796.652200867961, 4602.516735742765, 5369.140937449989, 5372.516473517402, 5394.595405344537, 5396.379416367089, 6173.56785025044, 6215.347388524321, 6217.720202590895, 6255.812325630239, 6274.749010039547, 6138.355472675484, 6143.60399444226, 6153.661548614869, 6155.692215389123, 6168.444839964424, 6219.689015549295, 6229.3770622939155, 6234.127222188807, 6241.625502469867, 6253.093301471352, 5982.102684597346, 6105.877882442237, 6137.079438084323, 6146.969265153645, 6149.2620885494025, 4636.83771068011, 6054.939450605438, 6055.788047418319, 6063.363346848694, 6098.280951554018, 5889.939810834091, 5922.200502932049, 5922.585419020627, 5926.318473375617, 5929.199558059607, 5849.473547380756, 5881.470667639933, 5912.793052243151, 5914.704264786829, 5917.497012753965, 5780.653160810365, 5784.8553786154, 5797.362290147996, 5806.187133801355, 5811.883762324645, 5824.15549745293, 5857.384974577779, 5923.348431672599, 5925.792597259076, 6006.099085137264, 5843.152742852348, 5856.0, 5857.5313974881055, 5860.853478663067, 5904.350521442724], "value": 5587.578276639995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.12765745084346, 474.4377912174074, 479.486948964608, 492.7708615493797, 499.22370713540477, 34856.12859678506, 40919.79540102299, 41559.0, 42579.148417031676, 42682.14635707292, 43028.0, 43563.346549801696, 43582.0, 43623.41954094822, 43675.56324436755, 8638.524881131536, 9483.241340692728, 9517.191038761714, 9657.46883921384, 9663.565139568736, 8558.957205213965, 8712.956435217815, 8713.520756358397, 8716.956415217946, 8717.7820554486, 11568.190226684135, 11853.525858965631, 11865.64403067905, 11983.70040748984, 12011.219270747373, 11659.183857130005, 11770.882291177064, 11796.05631549474, 11799.705007374798, 11817.7636447271, 8601.0, 8822.2501087407, 8843.77890552735, 11594.420278986101, 11684.240524365974, 32629.347413051604, 32973.17567060843, 40320.193596127916, 41048.58951410477, 41060.38409423861, 3336.399448099341, 3356.7985920844826, 3388.7797293176113, 3672.485851980725, 4056.979715101435, 30830.383392332253, 31386.744530218763, 31541.0, 31642.683573164435, 32410.675893241, 3178.1930722532948, 3213.935721285561, 3251.528528363374, 3261.836908154583, 3294.3246634439884, 493046.0, 496269.0, 497442.0, 499452.0, 501117.0, 62130.75738485205, 62455.0, 62505.68747156235, 62559.37440625626, 62575.0, 30134.698653013627, 30467.390652186834, 30528.694713052584, 30555.694443055287, 32367.676323236938, 15922.044677319398, 16067.919660401623, 16071.839281607268, 16086.35654573804, 16170.676586468206, 12220.694482638006, 12307.815382769266, 12316.630501084981, 12318.445669944875, 12326.95220906215, 16928.32286708518, 17338.3064677414, 19059.80940190608, 19257.903710481358, 19582.054946482633, 6542.658754955222, 7694.307252404462, 7718.8807622894365, 7719.459637825298, 7786.454948153575, 872.3108744092096, 950.8763860698065, 954.4893481987242, 1018.8217062014118, 1026.861373714554, 28793.568096478568, 29934.0, 30080.398392032035, 30691.0, 30714.846425768174, 1044.7440377107505, 1046.8325067989238, 1086.3699054548342, 1123.2867129372744, 1136.9943150284362, 16105.758413623806, 16147.0, 16792.748108778378, 16909.23908424124, 16973.660526789394, 633469.0, 635089.0, 637453.0, 638274.0, 639895.0, 59945.10082348768, 60342.094868577005, 60353.0, 60491.0, 61546.0, 1319.6107148391056, 1374.4364810427676, 1381.4267079162237, 1387.6392138044382, 1389.2012093046337, 30773.23066923345, 31557.36885262328, 31905.202369940936, 32232.838835806608, 32353.51469727909, 53315.93368132538, 54048.729756350964, 54064.91870162496, 54361.184582230504, 54380.45619543754, 586042.0, 588330.0, 588461.0, 588746.0, 589915.0, 26746.59880101761, 26938.730612694406, 27098.72901271041, 27220.591691124253, 27322.90708371643, 39434.2113157741, 40618.78143655695, 40620.78137655875, 44220.778896105316, 51750.0, 38386.0, 40418.0, 40916.18167636571, 41237.36922557753, 41814.79092604518, 39310.2137957245, 39543.604563953995, 40006.0, 41098.58901410948, 41273.0, 39295.214095717354, 39923.201535969696, 40579.39130913098, 40661.98345041398, 42117.36823947582, 32101.67898320987, 32610.67389326171, 35383.0, 35776.82111589425, 36173.638263617024, 25780.484390311714, 25859.224223273333, 26130.346741331618, 26136.477270454863, 26426.867865660548], "value": 19983.19282812634, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.1874385723337, 370.43323714716485, 381.3897763578275, 390.9745866518678, 400.8116185392864, 18653.253869845208, 20455.693164602504, 20574.48563785906, 20589.38231853043, 20612.0, 20215.0, 20656.896715516403, 20758.792412075913, 21010.894945525288, 21272.14911403542, 1605.1572924214763, 1607.5579215715654, 1608.9115098669567, 1610.042024995132, 1897.4212865076147, 5592.161175823619, 5896.7051647417675, 5914.674692891889, 5923.88152236955, 5924.496417804492, 5591.580631452657, 5860.443257890493, 5879.118132280149, 5886.205362276102, 5895.675737834417, 5720.79977200798, 5820.854478638025, 5852.122181672783, 5852.853678658025, 5859.648421094748, 5026.497350264981, 5045.949540504585, 5059.519345662156, 5115.155999260118, 5115.360579927509, 25518.744812551824, 25653.743462565322, 25690.614640780404, 25920.87039564809, 25942.0, 2191.9671204931938, 2380.5119950410126, 2723.904663336774, 2963.881444742208, 2980.2251414632133, 15267.160306183156, 15521.301541430663, 15598.610034749108, 15746.527604171893, 15841.841581584153, 1511.7203317386318, 1698.915054247295, 1838.1452624529659, 1838.4484654603566, 1957.9021048947495, 70912.93630595494, 77629.22370776277, 95090.52454737751, 109403.45298273537, 112136.0, 10070.69787906364, 11006.669799906016, 11064.944675276573, 11133.276337038067, 11154.944225278821, 13617.591472255848, 13639.659008524866, 13670.726585468235, 13681.31593420325, 13690.93154534241, 8483.618237179342, 8500.10748871372, 8518.0, 8695.695650652196, 8730.821339119264, 7000.649967501605, 8376.748697539084, 8385.507492592362, 8397.70608028716, 8574.528400938008, 5646.491815736604, 6612.2726500084955, 6649.368310010541, 6762.898556521656, 6780.643871225775, 1587.8650314723147, 1812.3294381078822, 1829.6889528780139, 1835.2292037344348, 1868.084638527139, 915.1260546178383, 925.6945208081318, 949.3117489819963, 974.3325821812082, 1058.5871510111062, 20966.895165524074, 21786.89106554489, 22305.776942230696, 22353.776462235168, 22355.993980270927, 861.6725644255143, 929.3773171974793, 930.3115694386106, 940.5609417591097, 986.4278718343344, 11589.24669896454, 11887.28676279426, 11966.691476554746, 11968.0, 12089.274643521418, 562774.0, 564694.0, 567981.0, 579949.1561824124, 586314.0, 93122.0, 94759.0, 115700.0, 116656.0, 117475.06312342088, 852.6972924611673, 942.5051847779833, 946.2808265717966, 1000.5047501486811, 1003.3227571389428, 20179.495512611717, 20783.272585459436, 20860.791392085885, 20931.37205883826, 20967.685484718048, 51289.48710512847, 51749.48250517597, 51868.74065629799, 53249.733751331, 54515.72742136264, 49263.75368123136, 68257.8329275419, 69591.65204173946, 71272.64363678149, 72841.17897052404, 7727.227277272228, 7935.246151615587, 7963.013869798825, 8203.364485981308, 8251.752447426346, 9810.607575696893, 13029.934850325688, 13231.27228002469, 13484.12353197039, 13640.181589104686, 10920.235583509397, 10929.907009299006, 10933.070688991525, 11196.0, 11262.493187806733, 9372.81254374895, 10873.782524349626, 10924.126069914546, 11307.151963602599, 11464.541418343506, 9382.202512786489, 10955.671329860117, 11724.765504690029, 11832.881671183179, 11833.34916579562, 7982.920170798217, 8056.27493525562, 8068.1528439513, 8089.069756977788, 8204.852396318805, 10288.742781430525, 10855.751588567417, 10975.221731694694, 10982.725431864268, 11211.887881121085], "value": 9275.429314518757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.3928451838933, 1560.7892934453848, 1767.8408943195109, 1903.0484757621189, 1976.83196928261, 8388.8741668875, 8769.34229932756, 8782.121787821216, 8787.604557794899, 8791.296696264299, 7793.883091753614, 8107.675692972274, 8111.310538604226, 8444.619992100355, 8699.173578510032, 2292.209187830196, 2327.3134425344565, 2328.836981411302, 2330.0, 2330.6620540021686, 2280.5552917181158, 2291.4958709083976, 2322.6412548659055, 2329.5108027314286, 2337.91817286395, 2050.456628993318, 2122.7983341582603, 2132.253711201075, 2242.6523888797265, 2318.2813327868416, 2274.385915802732, 2295.2884605772097, 2296.9885150574305, 2299.4251437140715, 2300.401895507172, 2248.3704562722464, 2288.0, 2294.9426264343356, 2296.1733775840685, 2300.666403371502, 7662.731804386875, 8895.955520222422, 8944.731658050268, 8957.462552246887, 8969.327300452493, 5108.489151084899, 5190.870228244324, 5253.238280449352, 5256.237845512417, 5291.761870715827, 3350.5867477972242, 3421.726261899042, 3561.465780132975, 3571.0715214044535, 3574.928501429983, 1017.2726500552067, 1019.4596863662271, 1036.212478516333, 1038.7558923653012, 1042.9947850260776, 11639.418029098511, 11651.533938642444, 11653.533858645644, 11669.241499302518, 11669.533218671158, 4445.644348452116, 4531.932021019687, 4604.907901841944, 4665.836695715634, 4718.41019872516, 9972.950135249277, 9973.750656233507, 9975.351602145838, 9983.00169982996, 10004.849927251096, 5148.742562871841, 5230.137027390514, 5232.319798426181, 5239.659422137625, 5242.895142097137, 4351.8694439166875, 4518.502964673883, 4650.511696271843, 4733.739644319596, 4819.036192761391, 3795.6014618465215, 3853.402722578005, 3856.402257650069, 3894.4547763313158, 3940.074082590589, 1119.205364191417, 1163.3601519164426, 1220.127608759741, 1227.3372378915465, 1243.9253644781343, 622.7664625765339, 749.6064566102731, 756.6292516666794, 817.0767033252506, 880.5905254056894, 5016.949830501721, 5560.916586251209, 5623.028587040227, 5718.685472299064, 6048.727807248684, 773.3503856760349, 825.7068740597001, 875.7898104454885, 924.9548010747812, 942.3262367407336, 3808.124131449782, 3878.8836334909997, 3911.159100793343, 3938.783366914847, 4037.2934736421007, 10534.104601108838, 10737.0, 10799.78400431987, 10926.180536459797, 10975.067119294948, 10900.727481812859, 10910.23628346008, 10924.071453926346, 10927.180461465421, 10931.617393391192, 7732.999999999887, 8227.588620568948, 8323.500589964622, 8327.250547450758, 8335.208155225244, 4855.417349918032, 5034.219695947134, 5882.205902203148, 6041.214642096676, 6116.981396139175, 6950.652467376712, 9738.269629777653, 10076.143527800219, 10107.949460252652, 10269.640562580274, 9885.703428897144, 9918.950405247928, 10181.84727229107, 10234.33476824004, 10309.896901031194, 7543.396528277615, 7659.425543084402, 7762.3790096793255, 7766.301032906839, 7780.183080776437, 8270.394825629908, 8376.83246335082, 8383.203595658402, 8486.61810218554, 8488.448250863674, 7570.5836179010685, 7620.123685776207, 7667.11828139771, 7728.536287822749, 7753.92246077532, 7404.96297518509, 7430.294122058612, 7502.249775022454, 7527.548347099191, 7591.658375373232, 6715.227748808949, 6910.343517365842, 6970.860582788418, 6972.58164510131, 6975.686094125675, 4950.381202349707, 4979.975100124476, 5016.849494515171, 5064.518870707277, 5243.842684719464, 4953.653244272867, 5013.749312534285, 5049.0, 5217.765200566059, 5218.0], "value": 4512.31964114507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.70523455877577, 305.7920613982491, 306.32608261823987, 311.5591438115066, 315.507807819801, 5177.482251774821, 5180.326557547523, 5182.714950677711, 5185.792568297268, 5198.750780762024, 4244.745315281085, 5158.896822063566, 5171.793488037412, 5180.766865491052, 5190.2474141249495, 3184.4108839864643, 3290.3419316136747, 3866.3233934061427, 3912.3740201567753, 3912.4522566840665, 3838.2323535293053, 3893.5717071122153, 3899.122697393092, 3916.3929590913453, 3955.7033222508285, 3351.9329613407717, 3491.95241427572, 3935.0, 3939.72421930465, 3970.285348637244, 3628.8589732058213, 3871.9612803872164, 3893.5717071122153, 3916.1776027034357, 3918.725689201757, 3357.9328413431595, 3362.6132994705677, 3363.545921300642, 3367.1413789483527, 3381.661833816623, 3836.5396152461603, 4347.0, 4520.801987473322, 4934.728589927553, 5042.210015444501, 4421.491528474235, 4425.513193548707, 4431.889202769924, 4449.199144154051, 4457.866264012052, 5146.6911985281, 5342.332208473941, 5363.704996225206, 5376.8118115865755, 5443.782248710047, 3063.9846800765854, 3088.768342374331, 3689.9114761145524, 3693.26416584205, 3694.722895782827, 4666.556677115668, 4783.569478746929, 5520.530754885839, 5614.494695477386, 5675.247504960091, 3578.5526809148855, 3720.9441858372147, 3728.142527218755, 3744.4383342498845, 3756.887293381148, 3781.5084039074745, 3790.33669107905, 3792.7534710243744, 3802.239552089593, 3802.372608519563, 3705.5182826232417, 4399.12017596482, 4399.548149110786, 4405.29515277554, 4405.493368262627, 4482.932756008662, 4552.702479793243, 5102.056119617809, 5440.047991601454, 5445.83662490126, 1252.855921569013, 1278.1755767530076, 1281.4233594882153, 1294.779887419141, 1333.9733205336033, 682.382443888282, 714.6748229555644, 750.3696894608555, 785.7367781793049, 803.8392321535599, 4395.692301538862, 4857.53853383928, 4971.6271279654175, 5038.246506352717, 5141.097793816312, 5595.440455954372, 5599.404169811665, 5617.4271204062925, 5619.550435965113, 5636.830895073154, 4267.637250833714, 4460.821567137343, 4804.8798780030775, 5110.744462776846, 5132.615053870974, 2406.374342670918, 2440.2923152285994, 2880.5967164596973, 2924.488214562443, 2933.530635098374, 4780.569748722632, 5727.651662818224, 5742.0, 5818.825435236865, 5819.970900145472, 4785.396892041205, 5373.919391209135, 5530.589010725647, 5712.685802280915, 5747.626404283708, 4846.854594362175, 5235.947640523622, 5794.942795307774, 5807.8548036299435, 5825.155352473867, 4315.719478233905, 5649.293838270216, 5673.347565030074, 5690.174924635988, 5711.714414279352, 5207.5833933286, 5542.445755424586, 5595.188697638738, 5601.778977088109, 5637.295338082739, 4866.474179013551, 5877.73550190251, 5880.970595146997, 5885.90989730395, 5904.0, 3624.927501450009, 3730.079009310153, 3750.9062273443383, 3769.8492060318376, 3776.678982286536, 4654.25531914892, 5340.919886201787, 5349.358077030781, 5576.0, 5576.944230557805, 4743.739094349844, 5394.2448057272795, 5423.074808442946, 5434.961724566617, 5441.347038355423, 4926.704397736147, 4971.875703107451, 4981.726005069756, 5219.5041471060185, 5459.39946605881, 4668.416447944007, 5286.524212820865, 5348.973255133699, 5353.0, 5362.785488580413, 4455.0, 5004.299398084198, 5157.6647517911215, 5196.73793079331, 5476.91784623223, 4363.629091527256, 4838.201696720002, 5256.159014557652, 5375.220593013913, 5424.0], "value": 3912.467499291428, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.647575925676, 728.420905380223, 785.2147852147853, 836.6444261188993, 839.7019058234325, 15251.542453726379, 15981.041137531756, 16013.679726405466, 16074.5981350466, 16357.672846543077, 14472.204028778413, 14576.927115364408, 14577.125372477632, 14587.41650333988, 14612.415503379852, 695.4540685561835, 719.8668246374438, 727.1964479250431, 804.0190967020226, 870.3559366069127, 836.4897412578322, 880.2561835249236, 893.4639216470099, 899.3704406915153, 900.0189793125492, 959.0457494792656, 961.7691753979029, 962.9422234665907, 965.2133511188395, 965.7102869139266, 733.8495608400318, 751.5828715063137, 954.6610953111615, 956.7082039977804, 957.262907561174, 684.4866350237322, 692.4702602509085, 693.4798900824381, 695.2630211975322, 697.891826766852, 14961.251937403087, 14976.925115374463, 14999.550013499613, 15002.24988750569, 15006.774898376532, 13518.324083795771, 13731.0, 13988.0, 14021.228832414214, 14167.008309418241, 12622.0, 12650.557230496981, 12679.683007924783, 12903.0, 13013.609591712264, 4496.865094047183, 4573.885652858705, 4586.243269860503, 4597.195490789099, 4674.560638165275, 91082.54458727664, 103902.0, 105215.94784052062, 116535.0, 117418.65162696784, 10532.947335263274, 10719.0, 11001.944990274997, 11017.779644407226, 11287.040601548797, 21500.139994400048, 21503.784962150177, 21519.031643576076, 21523.892380537996, 21582.244621438174, 7673.616319184019, 7728.188540203198, 7826.647800848976, 7848.254415830487, 7849.411294152961, 4269.359596060615, 4299.355096735515, 4369.366441865912, 4538.160440318552, 4551.0, 3467.375872342952, 3619.2399596084592, 3622.9818850905576, 3627.1294889226924, 3631.0014745945077, 647.543481845298, 658.2660333727858, 669.7120238297579, 670.0786418674322, 676.212212772115, 572.5391060196582, 591.6509259536894, 616.5622408090217, 641.403494749887, 659.1826135591832, 7920.169011552078, 8422.789430264293, 9057.230135438429, 9105.362624616346, 9334.439933604006, 522.9058769421465, 594.8780499997576, 605.3371558143825, 632.6812233165489, 635.4598591197538, 4375.2679702066835, 4395.472543294825, 4396.0, 4398.252297109435, 4498.685092043591, 125968.0, 128375.35812321065, 135959.96060059106, 157091.0, 158210.0, 123141.0, 124346.0, 125369.0, 125722.0, 127253.36373318074, 100590.49704751429, 105498.0, 107954.0, 108646.0, 108692.0, 9724.70825875225, 9823.21414286841, 9980.0, 10097.596096156072, 10160.644377446753, 46934.0, 53617.7319113402, 57884.71057644685, 58506.0, 58845.411545883995, 70148.64925675339, 82112.0, 90449.09550904407, 96691.0, 97785.51107244703, 13232.338383080614, 13271.469141234242, 13283.601491955256, 13308.334583270991, 13817.752828085191, 14738.26308684583, 14744.63138421548, 15057.397704092153, 15247.771283430535, 15473.148976806384, 13795.241261730702, 13813.309334533435, 14044.438222471395, 14122.152670839783, 14458.421663133357, 11432.885671143182, 13793.931030344784, 13839.792403114163, 13844.653883652587, 13937.790933136213, 13312.46750129984, 13655.0, 13993.370298336396, 14197.645058873612, 14403.711925761636, 11086.0, 11429.142814288794, 11585.82621260665, 11701.531938722695, 12056.51773929033, 10813.62152324665, 11356.772864542498, 11482.841560344297, 11579.768404631692, 11722.706932326419], "value": 7845.039954707947, "unit": "score"}], "name": "dromaeo_css", "value": 7235.2382058648045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 113.0, 112.0, 116.0, 159.0, 166.0, 113.0, 111.0], "value": 122.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 113.0, 116.0, 150.0, 112.0, 115.0, 115.0, 112.0, 161.0, 139.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 185.0, 186.0, 185.0, 182.0, 184.0, 181.0, 183.0, 184.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 90.0, 61.0, 59.0, 59.0, 58.0, 83.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 91.0, 70.0, 67.0, 68.0, 93.0, 67.0, 68.0, 89.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 87.0, 85.0, 88.0, 84.0, 88.0, 85.0, 88.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 98.0, 104.0, 97.0, 99.0, 97.0, 113.0, 160.0, 102.0], "value": 106.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 82.0, 80.0, 80.0, 82.0, 84.0, 83.0, 83.0, 81.0], "value": 81.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 53.0, 53.0, 56.0, 56.0, 53.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 79.0, 81.0, 74.0, 71.0, 78.0, 108.0, 105.0, 87.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 84.0, 85.0, 77.0, 100.0, 96.0, 105.0, 73.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 155.0, 156.0, 136.0, 153.0, 156.0, 163.0, 141.0, 209.0, 163.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 180.0, 232.0, 184.0, 173.0, 174.0, 175.0, 172.0, 168.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 83.0, 84.0, 86.0, 62.0, 77.0, 83.0, 88.0, 87.0, 69.0], "value": 78.1, "unit": "score"}], "name": "kraken", "value": 1493.5, "alertThreshold": 2.0}]} 06:14:39 INFO - Return code: 0 06:14:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:14:39 INFO - # TBPL SUCCESS # 06:14:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:14:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:14:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:14:39 INFO - 2016-10-22 06:14:39.836 screenresolution[2296:26562] starting screenresolution argv=screenresolution get 06:14:39 INFO - 2016-10-22 06:14:39.838 screenresolution[2296:26562] Display 0: 1600x1200x32@60 06:14:39 INFO - 2016-10-22 06:14:39.845 screenresolution[2297:26565] starting screenresolution argv=screenresolution list 06:14:39 INFO - Available Modes on Display 0 06:14:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:14:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:14:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:14:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:14:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:14:40 INFO - Intel Iris: 06:14:40 INFO - Chipset Model: Intel Iris 06:14:40 INFO - Type: GPU 06:14:40 INFO - Bus: Built-In 06:14:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:14:40 INFO - Vendor: Intel (0x8086) 06:14:40 INFO - Device ID: 0x0a2e 06:14:40 INFO - Revision ID: 0x0009 06:14:40 INFO - Displays: 06:14:40 INFO - Display: 06:14:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:14:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:14:40 INFO - Display Serial Number: 1600x1200 60 06:14:40 INFO - Main Display: Yes 06:14:40 INFO - Mirror: Off 06:14:40 INFO - Online: Yes 06:14:40 INFO - Rotation: Supported 06:14:40 INFO - Return code: 0 06:14:40 INFO - Running post-action listener: _resource_record_post_action 06:14:40 INFO - [mozharness: 2016-10-22 13:14:40.078692Z] Finished run-tests step (success) 06:14:40 INFO - Running post-run listener: _resource_record_post_run 06:14:40 INFO - Total resource usage - Wall time: 1216s; CPU: 53.0%; Read bytes: 581632; Write bytes: 707037696; Read time: 7; Write time: 2394 06:14:40 INFO - TinderboxPrint: CPU usage
53.4% 06:14:40 INFO - TinderboxPrint: I/O read bytes / time
581,632 / 7 06:14:40 INFO - TinderboxPrint: I/O write bytes / time
707,037,696 / 2,394 06:14:40 INFO - TinderboxPrint: CPU idle
2,268.6 (46.6%) 06:14:40 INFO - TinderboxPrint: CPU system
969.2 (19.9%) 06:14:40 INFO - TinderboxPrint: CPU user
1,627.9 (33.5%) 06:14:40 INFO - TinderboxPrint: Swap in / out
404,688,896 / 0 06:14:40 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389388800; Write bytes: 384202752; Read time: 29405; Write time: 755 06:14:40 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 581632; Write bytes: 299078144; Read time: 7; Write time: 1586 06:14:40 INFO - Running post-run listener: _upload_blobber_files 06:14:40 INFO - Blob upload gear active. 06:14:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:40 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:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:14:40 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:41 INFO - (blobuploader) - INFO - Done attempting. 06:14:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:14:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:42 INFO - (blobuploader) - INFO - Done attempting. 06:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:14:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:44 INFO - (blobuploader) - INFO - Done attempting. 06:14:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:44 INFO - Return code: 0 06:14:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d91c9ecf411d1a28782267dc557b128772c8708853b16d3e367fd1191aa61cb37aa33cf00db5de16f10cd1556606fb8baab0e3012be51e8f58f2d2894d0db5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cdbe09b992eab184e3f519e37e39cd6ce2ff30d7628449c3b152a8e6e5a9b4418e8970ac778a6e3454639aa888f5cacf00f4f07ae1487b14ab4dd06ffdefac1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a52dfa5e261a29c59ecf9c4a374e5d45623f5a2110f6e6dc25f935ef3f5877242556701fc956d574504db531cb0f6d95a987de7e3a4caa45ea087bbd3e4cb6de"} 06:14:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:44 INFO - Contents: 06:14:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d91c9ecf411d1a28782267dc557b128772c8708853b16d3e367fd1191aa61cb37aa33cf00db5de16f10cd1556606fb8baab0e3012be51e8f58f2d2894d0db5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cdbe09b992eab184e3f519e37e39cd6ce2ff30d7628449c3b152a8e6e5a9b4418e8970ac778a6e3454639aa888f5cacf00f4f07ae1487b14ab4dd06ffdefac1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a52dfa5e261a29c59ecf9c4a374e5d45623f5a2110f6e6dc25f935ef3f5877242556701fc956d574504db531cb0f6d95a987de7e3a4caa45ea087bbd3e4cb6de"} 06:14:44 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:44 INFO - Copying logs to upload dir... 06:14:44 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.911731 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-22 06:14:45.462056) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 06:14:45.465428) ========= 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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d91c9ecf411d1a28782267dc557b128772c8708853b16d3e367fd1191aa61cb37aa33cf00db5de16f10cd1556606fb8baab0e3012be51e8f58f2d2894d0db5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cdbe09b992eab184e3f519e37e39cd6ce2ff30d7628449c3b152a8e6e5a9b4418e8970ac778a6e3454639aa888f5cacf00f4f07ae1487b14ab4dd06ffdefac1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a52dfa5e261a29c59ecf9c4a374e5d45623f5a2110f6e6dc25f935ef3f5877242556701fc956d574504db531cb0f6d95a987de7e3a4caa45ea087bbd3e4cb6de"} build_url:https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d91c9ecf411d1a28782267dc557b128772c8708853b16d3e367fd1191aa61cb37aa33cf00db5de16f10cd1556606fb8baab0e3012be51e8f58f2d2894d0db5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cdbe09b992eab184e3f519e37e39cd6ce2ff30d7628449c3b152a8e6e5a9b4418e8970ac778a6e3454639aa888f5cacf00f4f07ae1487b14ab4dd06ffdefac1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a52dfa5e261a29c59ecf9c4a374e5d45623f5a2110f6e6dc25f935ef3f5877242556701fc956d574504db531cb0f6d95a987de7e3a4caa45ea087bbd3e4cb6de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 06:14:45.498624) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:14:45.498941) ========= 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.I3Q1ze4DZ6/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.LMQwvrxKbn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.004883 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:14:45.548550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 06:14:45.548875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 06:14:45.549199) ========= ========= Total master_lag: 0.59 =========