builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0271 starttime: 1480617979.65 results: success (0) buildid: 20161201091144 builduid: 4a09680c7e534382aaaf923733878e90 revision: 1a3356dc409f1e6813ac395a717b7f271c26861e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:19.651095) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:19.651504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:19.651786) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:19.677344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:19.677631) ========= 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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-01 10:46:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-12-01 10:46:19 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:19.818346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:19.818709) ========= 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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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.024789 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:19.866665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-01 10:46:19.866993) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 1a3356dc409f1e6813ac395a717b7f271c26861e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 1a3356dc409f1e6813ac395a717b7f271c26861e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cnZVrAdFqz/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.lLAo6wAYj3/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-01 10:46:19,965 truncating revision to first 12 chars 2016-12-01 10:46:19,965 Setting DEBUG logging. 2016-12-01 10:46:19,965 attempt 1/10 2016-12-01 10:46:19,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/1a3356dc409f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 10:46:20,946 unpacking tar archive at: graphics-1a3356dc409f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.259396 ========= master_lag: 2.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-01 10:46:23.300642) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:23.300970) ========= script_repo_revision: 1a3356dc409f1e6813ac395a717b7f271c26861e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:23.301373) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:23.301643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 10:46:23.323351) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-12-01 10:46:23.323687) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cnZVrAdFqz/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.lLAo6wAYj3/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:46:23 INFO - MultiFileLogger online at 20161201 10:46:23 in /builds/slave/test 10:46:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 10:46:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:46:23 INFO - {'append_to_log': False, 10:46:23 INFO - 'base_work_dir': '/builds/slave/test', 10:46:23 INFO - 'blob_upload_branch': 'Graphics', 10:46:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:46:23 INFO - 'branch': 'Graphics', 10:46:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:46:23 INFO - 'config_files': ('talos/mac_config.py',), 10:46:23 INFO - 'default_actions': ('clobber', 10:46:23 INFO - 'read-buildbot-config', 10:46:23 INFO - 'download-and-extract', 10:46:23 INFO - 'populate-webroot', 10:46:23 INFO - 'create-virtualenv', 10:46:23 INFO - 'install', 10:46:23 INFO - 'run-tests'), 10:46:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:46:23 INFO - 'download_minidump_stackwalk': True, 10:46:23 INFO - 'download_symbols': 'ondemand', 10:46:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:46:23 INFO - 'tooltool.py': '/tools/tooltool.py', 10:46:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:46:23 INFO - '/tools/misc-python/virtualenv.py')}, 10:46:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:46:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:46:23 INFO - 'installer_path': 'installer.exe', 10:46:23 INFO - 'log_level': 'info', 10:46:23 INFO - 'log_name': 'talos', 10:46:23 INFO - 'log_to_console': True, 10:46:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:46:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:46:23 INFO - 'opt_config_files': (), 10:46:23 INFO - 'pip_index': False, 10:46:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:46:23 INFO - 'cmd': ('bash', 10:46:23 INFO - '-c', 10:46:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:46:23 INFO - 'enabled': True, 10:46:23 INFO - 'halt_on_failure': False, 10:46:23 INFO - 'name': 'check_screen_resolution'},), 10:46:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:46:23 INFO - 'cmd': ('bash', 10:46:23 INFO - '-c', 10:46:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:46:23 INFO - 'enabled': True, 10:46:23 INFO - 'halt_on_failure': False, 10:46:23 INFO - 'name': 'check_screen_resolution'},), 10:46:23 INFO - 'run_cmd_checks_enabled': True, 10:46:23 INFO - 'sps_profile': False, 10:46:23 INFO - 'sps_profile_interval': 0, 10:46:23 INFO - 'suite': 'dromaeojs', 10:46:23 INFO - 'system_bits': '32', 10:46:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:46:23 INFO - 'title': 't-yosemite-r7-0271', 10:46:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:46:23 INFO - 'use_talos_json': True, 10:46:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:46:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:46:23 INFO - 'work_dir': 'build'} 10:46:23 INFO - [mozharness: 2016-12-01 18:46:23.529731Z] Running clobber step. 10:46:23 INFO - Running pre-action listener: _resource_record_pre_action 10:46:23 INFO - Running main action method: clobber 10:46:23 INFO - rmtree: /builds/slave/test/build 10:46:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:46:25 INFO - Running post-action listener: _resource_record_post_action 10:46:25 INFO - [mozharness: 2016-12-01 18:46:25.914026Z] Finished clobber step (success) 10:46:25 INFO - [mozharness: 2016-12-01 18:46:25.914181Z] Running read-buildbot-config step. 10:46:25 INFO - Running pre-action listener: _resource_record_pre_action 10:46:25 INFO - Running main action method: read_buildbot_config 10:46:25 INFO - Using buildbot properties: 10:46:25 INFO - { 10:46:25 INFO - "project": "", 10:46:25 INFO - "product": "firefox", 10:46:25 INFO - "script_repo_revision": "default", 10:46:25 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 10:46:25 INFO - "repository": "", 10:46:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 10:46:25 INFO - "buildid": "20161201091144", 10:46:25 INFO - "pgo_build": "False", 10:46:25 INFO - "basedir": "/builds/slave/test", 10:46:25 INFO - "buildnumber": 6, 10:46:25 INFO - "slavename": "t-yosemite-r7-0271", 10:46:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:46:25 INFO - "platform": "yosemite_r7", 10:46:25 INFO - "scheduler": "tests-graphics-macosx64-talos", 10:46:25 INFO - "branch": "graphics", 10:46:25 INFO - "repo_path": "projects/graphics", 10:46:25 INFO - "revision": "1a3356dc409f1e6813ac395a717b7f271c26861e", 10:46:25 INFO - "stage_platform": "macosx64", 10:46:25 INFO - "builduid": "4a09680c7e534382aaaf923733878e90", 10:46:25 INFO - "slavebuilddir": "test" 10:46:25 INFO - } 10:46:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 10:46:25 INFO - Running post-action listener: _resource_record_post_action 10:46:25 INFO - [mozharness: 2016-12-01 18:46:25.917652Z] Finished read-buildbot-config step (success) 10:46:25 INFO - [mozharness: 2016-12-01 18:46:25.917743Z] Running download-and-extract step. 10:46:25 INFO - Running pre-action listener: _resource_record_pre_action 10:46:25 INFO - Running main action method: download_and_extract 10:46:25 INFO - mkdir: /builds/slave/test/build/tests 10:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:25 INFO - trying https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 10:46:25 INFO - Downloading https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 10:46:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 10:46:27 INFO - Downloaded 1199 bytes. 10:46:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 10:46:27 INFO - Using the following test package requirements: 10:46:27 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 10:46:27 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:46:27 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 10:46:27 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:46:27 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 10:46:27 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:46:27 INFO - u'jsshell-mac.zip'], 10:46:27 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:46:27 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 10:46:27 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 10:46:27 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:46:27 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 10:46:27 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:46:27 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 10:46:27 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:46:27 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 10:46:27 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:46:27 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 10:46:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:46:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 10:46:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:46:27 INFO - Fetch https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 10:46:27 INFO - Http code: 200 10:46:27 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 10:46:27 INFO - x-amz-cf-id: eMHmYZuxKn-5bengGZvH4INhGiIF9jl0Cms6711ALXhXxzGcjcy6hw== 10:46:27 INFO - x-amz-version-id: 0h3Gy9errXzwFofaGz7RP_DvVrh7KPC8 10:46:28 INFO - Expected file size: 16282518 10:46:28 INFO - Obtained file size: 16282518 10:46:34 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:46:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 10:46:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:46:34 INFO - Fetch https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 10:46:35 INFO - Http code: 200 10:46:35 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 10:46:35 INFO - x-amz-cf-id: 4qwKuMq6vHQkFlTbZmM6vU15NLwV3lz6NSCEK_I3tN9M10MwDDc_Ww== 10:46:35 INFO - x-amz-version-id: 0h3Gy9errXzwFofaGz7RP_DvVrh7KPC8 10:46:35 INFO - Expected file size: 16282518 10:46:35 INFO - Obtained file size: 16282518 10:46:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 10:46:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:46:42 INFO - Fetch https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 10:46:42 INFO - Http code: 200 10:46:42 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 10:46:42 INFO - x-amz-cf-id: yIQaujRZUE8SlduXvXXrI65dnZ1HsfDlHw64_K9zcwCVebngWvjOWg== 10:46:42 INFO - x-amz-version-id: IW7cw27Zngemo8rs7oyDWzvr3nAXNT57 10:46:43 INFO - Expected file size: 14409702 10:46:43 INFO - Obtained file size: 14409702 10:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:43 INFO - trying https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:46:43 INFO - Downloading https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 10:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 10:46:46 INFO - Downloaded 107603765 bytes. 10:46:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:46:46 INFO - mkdir: /builds/slave/test/properties 10:46:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:46:46 INFO - Writing to file /builds/slave/test/properties/build_url 10:46:46 INFO - Contents: 10:46:46 INFO - build_url:https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:46:46 INFO - Running post-action listener: _resource_record_post_action 10:46:46 INFO - Running post-action listener: set_extra_try_arguments 10:46:46 INFO - [mozharness: 2016-12-01 18:46:46.802597Z] Finished download-and-extract step (success) 10:46:46 INFO - [mozharness: 2016-12-01 18:46:46.802722Z] Running populate-webroot step. 10:46:46 INFO - Running pre-action listener: _resource_record_pre_action 10:46:46 INFO - Running main action method: populate_webroot 10:46:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:46:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:46:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:46:46 INFO - '--tppagecycles', 10:46:46 INFO - '7'], 10:46:46 INFO - 'tests': ['tsvgm']}}, 10:46:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:46:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:46:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:46:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:46:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:46:46 INFO - 'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:46:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:46:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:46:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:46:46 INFO - 'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['damp', 'tps']}, 10:46:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:46:46 INFO - 'tests': ['damp', 'tps']}, 10:46:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['dromaeo_dom']}, 10:46:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:46:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['basic_compositor_video']}, 10:46:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:46:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['a11yr', 10:46:46 INFO - 'ts_paint', 10:46:46 INFO - 'tpaint', 10:46:46 INFO - 'sessionrestore', 10:46:46 INFO - 'sessionrestore_no_auto_restore', 10:46:46 INFO - 'tabpaint']}, 10:46:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:46:46 INFO - 'ts_paint', 10:46:46 INFO - 'tpaint', 10:46:46 INFO - 'sessionrestore', 10:46:46 INFO - 'sessionrestore_no_auto_restore', 10:46:46 INFO - 'tabpaint']}, 10:46:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:46:46 INFO - 'ts_paint', 10:46:46 INFO - 'tpaint', 10:46:46 INFO - 'sessionrestore', 10:46:46 INFO - 'sessionrestore_no_auto_restore', 10:46:46 INFO - 'tabpaint']}, 10:46:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:46:46 INFO - 'ts_paint', 10:46:46 INFO - 'tpaint', 10:46:46 INFO - 'sessionrestore', 10:46:46 INFO - 'sessionrestore_no_auto_restore', 10:46:46 INFO - 'tabpaint']}, 10:46:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['a11yr', 10:46:46 INFO - 'ts_paint', 10:46:46 INFO - 'tpaint', 10:46:46 INFO - 'sessionrestore', 10:46:46 INFO - 'sessionrestore_no_auto_restore', 10:46:46 INFO - 'tabpaint']}, 10:46:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['a11yr', 10:46:46 INFO - 'ts_paint', 10:46:46 INFO - 'tpaint', 10:46:46 INFO - 'sessionrestore', 10:46:46 INFO - 'sessionrestore_no_auto_restore', 10:46:46 INFO - 'tabpaint']}, 10:46:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['tsvgx', 10:46:46 INFO - 'tsvgr_opacity', 10:46:46 INFO - 'tart', 10:46:46 INFO - 'tscrollx', 10:46:46 INFO - 'cart', 10:46:46 INFO - 'tsvg_static']}, 10:46:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:46:46 INFO - 'tsvgr_opacity', 10:46:46 INFO - 'tart', 10:46:46 INFO - 'tscrollx', 10:46:46 INFO - 'cart', 10:46:46 INFO - 'tsvg_static']}, 10:46:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:46:46 INFO - 'talos_options': ['--disable-e10s'], 10:46:46 INFO - 'tests': ['tp5o']}, 10:46:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:46:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:46:46 INFO - 'talos_options': ['--disable-e10s', 10:46:46 INFO - '--xperf_path', 10:46:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:46:46 INFO - 'tests': ['tp5n']}, 10:46:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:46:46 INFO - 'talos_options': ['--xperf_path', 10:46:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:46:46 INFO - 'tests': ['tp5n']}}, 10:46:46 INFO - 'talos.zip': {'path': '', 10:46:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:46:46 INFO - Running post-action listener: _resource_record_post_action 10:46:46 INFO - [mozharness: 2016-12-01 18:46:46.821372Z] Finished populate-webroot step (success) 10:46:46 INFO - [mozharness: 2016-12-01 18:46:46.821503Z] Running create-virtualenv step. 10:46:46 INFO - Running pre-action listener: _resource_record_pre_action 10:46:46 INFO - Running main action method: create_virtualenv 10:46:46 INFO - Creating virtualenv /builds/slave/test/build/venv 10:46:46 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 10:46:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:46:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:46:46 INFO - Using real prefix '/tools/python27' 10:46:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:46:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:46:50 INFO - Installing pip.................done. 10:46:50 INFO - Return code: 0 10:46:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:46:50 INFO - Reading from file tmpfile_stdout 10:46:50 INFO - Output received: 10:46:50 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) 10:46:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:50 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 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:46:50 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 10:46:50 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 10:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:50 INFO - 'HOME': '/Users/cltbld', 10:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:50 INFO - 'LOGNAME': 'cltbld', 10:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:50 INFO - 'MOZ_NO_REMOTE': '1', 10:46:50 INFO - 'NO_EM_RESTART': '1', 10:46:50 INFO - 'PAGER': '/bin/cat', 10:46:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:50 INFO - 'PWD': '/builds/slave/test', 10:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:50 INFO - 'SHELL': '/bin/bash', 10:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:46:50 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:50 INFO - 'USER': 'cltbld', 10:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:50 INFO - 'XPC_FLAGS': '0x0', 10:46:50 INFO - 'XPC_SERVICE_NAME': '0', 10:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:51 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 10:46:51 INFO - Cleaning up... 10:46:51 INFO - Return code: 0 10:46:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:51 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 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:46:51 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 10:46:51 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 10:46:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:46:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:51 INFO - 'HOME': '/Users/cltbld', 10:46:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:51 INFO - 'LOGNAME': 'cltbld', 10:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:51 INFO - 'MOZ_NO_REMOTE': '1', 10:46:51 INFO - 'NO_EM_RESTART': '1', 10:46:51 INFO - 'PAGER': '/bin/cat', 10:46:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:51 INFO - 'PWD': '/builds/slave/test', 10:46:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:51 INFO - 'SHELL': '/bin/bash', 10:46:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:46:51 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:46:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:51 INFO - 'USER': 'cltbld', 10:46:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:51 INFO - 'XPC_FLAGS': '0x0', 10:46:51 INFO - 'XPC_SERVICE_NAME': '0', 10:46:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:51 INFO - Downloading/unpacking psutil>=3.1.1 10:46:51 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 10:46:51 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 10:46:51 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 10:46:51 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 10:46:51 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 10:46:51 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 10:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:46:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:46:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:46:54 INFO - Installing collected packages: psutil 10:46:54 INFO - Running setup.py install for psutil 10:46:54 INFO - building 'psutil._psutil_osx' extension 10:46:54 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 10:46:55 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 10:46:55 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 10:46:55 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 10:46:55 INFO - building 'psutil._psutil_posix' extension 10:46:55 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 10:46:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:46:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:46:55 INFO - ^ 10:46:55 INFO - 1 warning generated. 10:46:55 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 10:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:46:55 INFO - Successfully installed psutil 10:46:55 INFO - Cleaning up... 10:46:56 INFO - Return code: 0 10:46:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:46:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:46:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:56 INFO - 'HOME': '/Users/cltbld', 10:46:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:56 INFO - 'LOGNAME': 'cltbld', 10:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:56 INFO - 'MOZ_NO_REMOTE': '1', 10:46:56 INFO - 'NO_EM_RESTART': '1', 10:46:56 INFO - 'PAGER': '/bin/cat', 10:46:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:56 INFO - 'PWD': '/builds/slave/test', 10:46:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:56 INFO - 'SHELL': '/bin/bash', 10:46:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:46:56 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:46:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:56 INFO - 'USER': 'cltbld', 10:46:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:56 INFO - 'XPC_FLAGS': '0x0', 10:46:56 INFO - 'XPC_SERVICE_NAME': '0', 10:46:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:46:58 INFO - Installing collected packages: mozsystemmonitor 10:46:58 INFO - Running setup.py install for mozsystemmonitor 10:46:59 INFO - Successfully installed mozsystemmonitor 10:46:59 INFO - Cleaning up... 10:46:59 INFO - Return code: 0 10:46:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:46:59 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')]} 10:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:59 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')]} 10:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:59 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 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:46:59 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 10:46:59 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 10:46:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:46:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:59 INFO - 'HOME': '/Users/cltbld', 10:46:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:59 INFO - 'LOGNAME': 'cltbld', 10:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:59 INFO - 'MOZ_NO_REMOTE': '1', 10:46:59 INFO - 'NO_EM_RESTART': '1', 10:46:59 INFO - 'PAGER': '/bin/cat', 10:46:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:59 INFO - 'PWD': '/builds/slave/test', 10:46:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:59 INFO - 'SHELL': '/bin/bash', 10:46:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:46:59 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:46:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:59 INFO - 'USER': 'cltbld', 10:46:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:59 INFO - 'XPC_FLAGS': '0x0', 10:46:59 INFO - 'XPC_SERVICE_NAME': '0', 10:46:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:59 INFO - Downloading/unpacking jsonschema==2.5.1 10:46:59 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 10:46:59 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 10:46:59 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 10:46:59 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 10:46:59 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 10:46:59 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 10:47:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:47:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:47:02 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 10:47:02 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 10:47:02 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 10:47:02 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 10:47:02 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 10:47:02 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 10:47:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:47:02 INFO - warning: no files found matching '*.txt' 10:47:02 INFO - no previously-included directories found matching 'build' 10:47:02 INFO - no previously-included directories found matching 'dist' 10:47:02 INFO - no previously-included directories found matching '.git*' 10:47:02 INFO - Installing collected packages: jsonschema, functools32 10:47:02 INFO - Running setup.py install for functools32 10:47:02 INFO - warning: no files found matching '*.txt' 10:47:02 INFO - no previously-included directories found matching 'build' 10:47:02 INFO - no previously-included directories found matching 'dist' 10:47:02 INFO - no previously-included directories found matching '.git*' 10:47:02 INFO - Successfully installed jsonschema functools32 10:47:02 INFO - Cleaning up... 10:47:02 INFO - Return code: 0 10:47:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:02 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 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:47:02 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 10:47:02 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 10:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:02 INFO - 'HOME': '/Users/cltbld', 10:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:02 INFO - 'LOGNAME': 'cltbld', 10:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:02 INFO - 'MOZ_NO_REMOTE': '1', 10:47:02 INFO - 'NO_EM_RESTART': '1', 10:47:02 INFO - 'PAGER': '/bin/cat', 10:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:02 INFO - 'PWD': '/builds/slave/test', 10:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:02 INFO - 'SHELL': '/bin/bash', 10:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:47:02 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:02 INFO - 'USER': 'cltbld', 10:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:02 INFO - 'XPC_FLAGS': '0x0', 10:47:02 INFO - 'XPC_SERVICE_NAME': '0', 10:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:47:03 INFO - Cleaning up... 10:47:03 INFO - Return code: 0 10:47:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:47: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')]} 10:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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', '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 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:47: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 blobuploader==1.2.4 10:47:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:47:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:03 INFO - 'HOME': '/Users/cltbld', 10:47:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:03 INFO - 'LOGNAME': 'cltbld', 10:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:03 INFO - 'MOZ_NO_REMOTE': '1', 10:47:03 INFO - 'NO_EM_RESTART': '1', 10:47:03 INFO - 'PAGER': '/bin/cat', 10:47:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:03 INFO - 'PWD': '/builds/slave/test', 10:47:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:03 INFO - 'SHELL': '/bin/bash', 10:47:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:47:03 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:47:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:03 INFO - 'USER': 'cltbld', 10:47:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:03 INFO - 'XPC_FLAGS': '0x0', 10:47:03 INFO - 'XPC_SERVICE_NAME': '0', 10:47:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:47:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:47:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:07 INFO - Downloading docopt-0.6.1.tar.gz 10:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:07 INFO - Running setup.py install for blobuploader 10:47:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:47:07 INFO - Running setup.py install for requests 10:47:07 INFO - Running setup.py install for docopt 10:47:08 INFO - Successfully installed blobuploader requests docopt 10:47:08 INFO - Cleaning up... 10:47:08 INFO - Return code: 0 10:47:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:08 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')]} 10:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:08 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')]} 10:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:08 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 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:47:08 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 10:47:08 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 10:47:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:47:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:08 INFO - 'HOME': '/Users/cltbld', 10:47:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:08 INFO - 'LOGNAME': 'cltbld', 10:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:08 INFO - 'MOZ_NO_REMOTE': '1', 10:47:08 INFO - 'NO_EM_RESTART': '1', 10:47:08 INFO - 'PAGER': '/bin/cat', 10:47:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:08 INFO - 'PWD': '/builds/slave/test', 10:47:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:08 INFO - 'SHELL': '/bin/bash', 10:47:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:47:08 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:47:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:08 INFO - 'USER': 'cltbld', 10:47:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:08 INFO - 'XPC_FLAGS': '0x0', 10:47:08 INFO - 'XPC_SERVICE_NAME': '0', 10:47:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-eJ7hZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-D3sUkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-sj1Isd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-iscWRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-V4P9oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Y0dqaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-L0WwXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:09 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-mwsqIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:09 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-fUcttP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:09 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-n9D6I1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:09 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-spgMW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:09 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-aI1_Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:09 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-xOLxCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:09 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-5D5xjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:09 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-jBdoqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:09 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-xqdE0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:10 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-egSvCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:10 INFO - Running setup.py install for manifestparser 10:47:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:47:10 INFO - Running setup.py install for mozcrash 10:47:10 INFO - Running setup.py install for mozdebug 10:47:10 INFO - Running setup.py install for mozdevice 10:47:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:47:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:47:10 INFO - Running setup.py install for mozfile 10:47:10 INFO - Running setup.py install for mozhttpd 10:47:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:47:11 INFO - Running setup.py install for mozinfo 10:47:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:47:11 INFO - Running setup.py install for mozInstall 10:47:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:47:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:47:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:47:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:47:11 INFO - Running setup.py install for mozleak 10:47:11 INFO - Running setup.py install for mozlog 10:47:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:47:11 INFO - Running setup.py install for moznetwork 10:47:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:47:11 INFO - Running setup.py install for mozprocess 10:47:11 INFO - Running setup.py install for mozprofile 10:47:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:47:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:47:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:47:12 INFO - Running setup.py install for mozrunner 10:47:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:47:12 INFO - Running setup.py install for mozscreenshot 10:47:12 INFO - Running setup.py install for moztest 10:47:12 INFO - Running setup.py install for mozversion 10:47:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:47:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:12 INFO - Cleaning up... 10:47:12 INFO - Return code: 0 10:47:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47: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')]} 10:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:12 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 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:47:12 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 10:47:12 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 10:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:12 INFO - 'HOME': '/Users/cltbld', 10:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:12 INFO - 'LOGNAME': 'cltbld', 10:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:12 INFO - 'MOZ_NO_REMOTE': '1', 10:47:12 INFO - 'NO_EM_RESTART': '1', 10:47:12 INFO - 'PAGER': '/bin/cat', 10:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:12 INFO - 'PWD': '/builds/slave/test', 10:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:12 INFO - 'SHELL': '/bin/bash', 10:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:47:12 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:12 INFO - 'USER': 'cltbld', 10:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:12 INFO - 'XPC_FLAGS': '0x0', 10:47:12 INFO - 'XPC_SERVICE_NAME': '0', 10:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-dHN9je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:13 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)) 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-sfUXew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-5Pmi7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:13 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)) 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-ozBQ71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-WkhKgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:13 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)) 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-gkVgBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:13 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)) 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-vLglOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:13 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)) 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-n9JTRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:13 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)) 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-T9mtV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:13 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)) 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-FrSYym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:14 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)) 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:14 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-K8vVEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:14 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)) 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:14 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Mniqjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:14 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)) 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:14 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-K87uZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:14 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)) 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:14 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-CzPXVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:14 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-gtoNzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:14 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)) 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:14 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-RWfDBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:14 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)) 10:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:14 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-ij1jqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:14 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)) 10:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:47:14 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)) 10:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:47:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:14 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 10:47:14 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 10:47:14 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 10:47:14 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 10:47:14 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 10:47:14 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 10:47:17 INFO - Downloading blessings-1.6.tar.gz 10:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:47:17 INFO - Installing collected packages: blessings 10:47:17 INFO - Running setup.py install for blessings 10:47:17 INFO - Successfully installed blessings 10:47:17 INFO - Cleaning up... 10:47:17 INFO - Return code: 0 10:47:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:18 INFO - Reading from file tmpfile_stdout 10:47:18 INFO - Current package versions: 10:47:18 INFO - blessings == 1.6 10:47:18 INFO - blobuploader == 1.2.4 10:47:18 INFO - docopt == 0.6.1 10:47:18 INFO - functools32 == 3.2.3-2 10:47:18 INFO - jsonschema == 2.5.1 10:47:18 INFO - manifestparser == 1.1 10:47:18 INFO - mozInstall == 1.12 10:47:18 INFO - mozcrash == 1.0 10:47:18 INFO - mozdebug == 0.1 10:47:18 INFO - mozdevice == 0.49 10:47:18 INFO - mozfile == 1.2 10:47:18 INFO - mozhttpd == 0.7 10:47:18 INFO - mozinfo == 0.9 10:47:18 INFO - mozleak == 0.1 10:47:18 INFO - mozlog == 3.4 10:47:18 INFO - moznetwork == 0.27 10:47:18 INFO - mozprocess == 0.23 10:47:18 INFO - mozprofile == 0.28 10:47:18 INFO - mozrunner == 6.13 10:47:18 INFO - mozscreenshot == 0.1 10:47:18 INFO - mozsystemmonitor == 0.3 10:47:18 INFO - moztest == 0.7 10:47:18 INFO - mozversion == 1.4 10:47:18 INFO - psutil == 3.1.1 10:47:18 INFO - requests == 1.2.3 10:47:18 INFO - wsgiref == 0.1.2 10:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:18 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')]} 10:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 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')]} 10:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 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 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:47:18 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 10:47:18 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 10:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:18 INFO - 'HOME': '/Users/cltbld', 10:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:18 INFO - 'LOGNAME': 'cltbld', 10:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:18 INFO - 'MOZ_NO_REMOTE': '1', 10:47:18 INFO - 'NO_EM_RESTART': '1', 10:47:18 INFO - 'PAGER': '/bin/cat', 10:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:18 INFO - 'PWD': '/builds/slave/test', 10:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:18 INFO - 'SHELL': '/bin/bash', 10:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:47:18 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:18 INFO - 'USER': 'cltbld', 10:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:18 INFO - 'XPC_FLAGS': '0x0', 10:47:18 INFO - 'XPC_SERVICE_NAME': '0', 10:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:47:19 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)) 10:47:19 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)) 10:47:19 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)) 10:47:19 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)) 10:47:19 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)) 10:47:19 INFO - Cleaning up... 10:47:19 INFO - Return code: 0 10:47:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:19 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 0x10b9983f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe162ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, '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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 10:47:19 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 10:47:19 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 10:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:19 INFO - 'HOME': '/Users/cltbld', 10:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:19 INFO - 'LOGNAME': 'cltbld', 10:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:19 INFO - 'MOZ_NO_REMOTE': '1', 10:47:19 INFO - 'NO_EM_RESTART': '1', 10:47:19 INFO - 'PAGER': '/bin/cat', 10:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:19 INFO - 'PWD': '/builds/slave/test', 10:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:19 INFO - 'SHELL': '/bin/bash', 10:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:47:19 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:19 INFO - 'USER': 'cltbld', 10:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:19 INFO - 'XPC_FLAGS': '0x0', 10:47:19 INFO - 'XPC_SERVICE_NAME': '0', 10:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:47:19 INFO - Cleaning up... 10:47:19 INFO - Return code: 0 10:47:19 INFO - Running post-action listener: _resource_record_post_action 10:47:19 INFO - Running post-action listener: _start_resource_monitoring 10:47:19 INFO - Starting resource monitoring. 10:47:19 INFO - [mozharness: 2016-12-01 18:47:19.743669Z] Finished create-virtualenv step (success) 10:47:19 INFO - [mozharness: 2016-12-01 18:47:19.744642Z] Running install step. 10:47:19 INFO - Running pre-action listener: _resource_record_pre_action 10:47:19 INFO - Running main action method: install 10:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:20 INFO - Reading from file tmpfile_stdout 10:47:20 INFO - Detecting whether we're running mozinstall >=1.0... 10:47:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:47:20 INFO - Reading from file tmpfile_stdout 10:47:20 INFO - Output received: 10:47:20 INFO - Usage: mozinstall [options] installer 10:47:20 INFO - Options: 10:47:20 INFO - -h, --help show this help message and exit 10:47:20 INFO - -d DEST, --destination=DEST 10:47:20 INFO - Directory to install application into. [default: 10:47:20 INFO - "/builds/slave/test"] 10:47:20 INFO - --app=APP Application being installed. [default: firefox] 10:47:20 INFO - mkdir: /builds/slave/test/build/application 10:47:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:47:52 INFO - Reading from file tmpfile_stdout 10:47:52 INFO - Output received: 10:47:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:47:52 INFO - Running post-action listener: _resource_record_post_action 10:47:52 INFO - [mozharness: 2016-12-01 18:47:52.969307Z] Finished install step (success) 10:47:52 INFO - [mozharness: 2016-12-01 18:47:52.969453Z] Running run-tests step. 10:47:52 INFO - Running pre-action listener: _resource_record_pre_action 10:47:52 INFO - Running main action method: run_tests 10:47:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:47:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:47:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:47:52 INFO - 2016-12-01 10:47:52.984 screenresolution[1628:7396] starting screenresolution argv=screenresolution get 10:47:52 INFO - 2016-12-01 10:47:52.986 screenresolution[1628:7396] Display 0: 1600x1200x32@60 10:47:52 INFO - 2016-12-01 10:47:52.992 screenresolution[1629:7398] starting screenresolution argv=screenresolution list 10:47:52 INFO - Available Modes on Display 0 10:47:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:47:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:47:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:47:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:47:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:47:53 INFO - Intel Iris: 10:47:53 INFO - Chipset Model: Intel Iris 10:47:53 INFO - Type: GPU 10:47:53 INFO - Bus: Built-In 10:47:53 INFO - VRAM (Dynamic, Max): 1536 MB 10:47:53 INFO - Vendor: Intel (0x8086) 10:47:53 INFO - Device ID: 0x0a2e 10:47:53 INFO - Revision ID: 0x0009 10:47:53 INFO - Displays: 10:47:53 INFO - Display: 10:47:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:47:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:47:53 INFO - Display Serial Number: 1600x1200 60 10:47:53 INFO - Main Display: Yes 10:47:53 INFO - Mirror: Off 10:47:53 INFO - Online: Yes 10:47:53 INFO - Rotation: Supported 10:47:53 INFO - Return code: 0 10:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:47:53 INFO - Python 2.7.3 10:47:53 INFO - Return code: 0 10:47:53 INFO - grabbing minidump binary from tooltool 10:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:53 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 0x10b7aed30>, '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 0x10b615db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7a6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:47:53 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 10:47:53 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 10:47:53 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 10:47:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:47:53 INFO - Return code: 0 10:47:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:47:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:47:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:47:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:47:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--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 10:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0271 --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 10:47:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cnZVrAdFqz/Render', 10:47:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:53 INFO - 'HOME': '/Users/cltbld', 10:47:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:53 INFO - 'LOGNAME': 'cltbld', 10:47:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:47:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:53 INFO - 'MOZ_NO_REMOTE': '1', 10:47:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:47:53 INFO - 'NO_EM_RESTART': '1', 10:47:53 INFO - 'PAGER': '/bin/cat', 10:47:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:53 INFO - 'PWD': '/builds/slave/test', 10:47:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:47:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:53 INFO - 'SHELL': '/bin/bash', 10:47:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLAo6wAYj3/Listeners', 10:47:53 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 10:47:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:53 INFO - 'USER': 'cltbld', 10:47:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:53 INFO - 'XPC_FLAGS': '0x0', 10:47:53 INFO - 'XPC_SERVICE_NAME': '0', 10:47:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--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 10:47:53 INFO - mozversion application_buildid: 20161201091144 10:47:53 INFO - mozversion application_changeset: 1a3356dc409f1e6813ac395a717b7f271c26861e 10:47:53 INFO - mozversion application_display_name: Nightly 10:47:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:47:53 INFO - mozversion application_name: Firefox 10:47:53 INFO - mozversion application_remotingname: firefox 10:47:53 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 10:47:53 INFO - mozversion application_vendor: Mozilla 10:47:53 INFO - mozversion application_version: 53.0a1 10:47:53 INFO - mozversion platform_buildid: 20161201091144 10:47:53 INFO - mozversion platform_changeset: 1a3356dc409f1e6813ac395a717b7f271c26861e 10:47:53 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 10:47:53 INFO - mozversion platform_version: 53.0a1 10:47:53 INFO - using testdate: 1480618073 10:47:53 INFO - actual date: 1480618073 10:47:53 INFO - starting webserver on 'localhost:49241' 10:47:53 INFO - SUITE-START | Running 2 tests 10:47:53 INFO - TEST-START | dromaeo_css 10:47:53 INFO - operating with platform_type : mac_ 10:47:53 INFO - Initialising browser for dromaeo_css test... 10:47:53 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpVu_bSl/profile http://localhost:49241/getInfo.html) 10:47:56 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 10:47:56 INFO - PROCESS | 1639 | colorDepth:24 10:47:56 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 10:47:56 INFO - PROCESS | 1639 | __metrics 10:47:56 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:47:56 INFO - PROCESS | 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:57 INFO - TEST-INFO | 1639: exit 0 10:47:57 INFO - Browser initialized. 10:47:57 INFO - Running cycle 1/1 for dromaeo_css test... 10:47:57 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpVu_bSl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:48:09 INFO - PROCESS | 1641 | RSS: Main: 244117504 10:48:09 INFO - PROCESS | 1641 | 10:49:00 INFO - PROCESS | 1641 | 1480618140843 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] 10:51:14 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 10:51:16 INFO - PROCESS | 1641 | RSS: Main: 366198784 10:51:16 INFO - PROCESS | 1641 | 10:54:19 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 10:54:19 INFO - PROCESS | 1641 | RSS: Main: 373092352 10:54:19 INFO - PROCESS | 1641 | 10:57:22 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 10:57:22 INFO - PROCESS | 1641 | RSS: Main: 348090368 10:57:22 INFO - PROCESS | 1641 | 11:00:25 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 11:00:25 INFO - PROCESS | 1641 | RSS: Main: 357642240 11:00:25 INFO - PROCESS | 1641 | 11:03:29 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 11:03:30 INFO - PROCESS | 1641 | RSS: Main: 338853888 11:03:30 INFO - PROCESS | 1641 | 11:06:33 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 11:06:33 INFO - PROCESS | 1641 | RSS: Main: 438124544 11:06:33 INFO - PROCESS | 1641 | 11:06:33 INFO - PROCESS | 1641 | __start_tp_report 11:06:33 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 11:06:33 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 11:06:33 INFO - PROCESS | 1641 | |i|pagename|runs| 11:06:33 INFO - PROCESS | 1641 | |0;dojo.html;3332.9666703332973;3345.247319353146;3347.447671134263;3367.9326413471717;3397.8810741624047;4586.266197408415;5513.696746678941;5578.2748242728385;5683.3464151622575;5702.315722113347;4792.305115758213;5620.943790562093;5659.971700141504;5717.313922329316;5726.226959360485;5080.983803239348;5093.286939828427;5104.744762761866;5162.716050617215;5163.7418129093585;5159.71621560814;5251.317328747257;5258.973705131469;5283.682979021271;5325.866853328678;5057.241413787924;5198.428172900978;5211.687298762086;5226.3989641191365;5308.389535203443;5098.311727916758;5123.641345105844;5162.148245539482;5193.870153246199;5201.55786758126;5134.332536770234;5160.045391602565;5160.432352441228;5174.172132458826;5225.477452254744;5670.5463562914865;5696.23100881384;5698.629589076697;5714.457126572969;5722.427757224286;6059.848503787396;6091.847703807396;6104.511639068864;6109.594897568601;6169.198004259418;6163.445289923883;6168.352323006065;6171.845703857394;6182.165407669997;6188.412100850412;5645.689487078209;5648.983183027012;5693.715314234271;5703.116017017286;5740.913886291751;6150.630962142286;6227.314995350508;6229.127922090911;6237;6239.438450539383;6022.09668549721;6049.697515124226;6050.727518486105;6057.939420605826;6108.511319094462;6103.6948152592195;6104.428839602234;6108.52420400844;6117.370705100174;6149.446549810538;6110.64906348202;6121.449069583669;6150.477209437248;6150.708351246199;6153.29237137726;6139.7988032087915;6180.536459765535;6184.5052395808225;6187.226596675416;6193.783217587363;4790.9938912828;4837.201861692782;4872.707637541759;4887.877803054881;4923.384576927884;4365.738055716667;4380.058287468146;4390.319500477431;4437.267850804581;4467.084247729208;5164.431912489623;5737.196792449061;5755.1367294906095;5758.510526605201;5771.451712087345;5836;6185.381461853869;6246.750649869953;6254.9687251563455;6268.749250030039;5603.495685388335;5648.604597678123;5651.9152212716845;5683.886322273532;5763;4509.706869053501;5363.678179309254;5363.973180134152;5368.355797304271;5371.086915224421;6280.309165991737;6296.874062518632;6312.652804095819;6313.842153946004;6318.684065796784;6109.7861574844665;6167.136600875791;6181.072839073995;6186.752529898754;6189.81430557084;6248.937510624835;6261;6277.497800175884;6288.402601752826;6294.559380843297;6096.573239873166;6110.602810817282;6128.387161283836;6132.5707200495535;6133.018717005258;6078.939210607838;6133.662648554372;6146.248319228998;6207.131001659681;6215.689215539295;5999.940000599938;6073.149759033827;6077.908831367445;6095.75616975316;6134.754609815557;6043.879122417439;6058.848528786815;6084.39156084388;6086.7260973255425;6089.939100608937;5745;5820.70896455184;5896.292444906639;5918.585699001029;5928.021876390348;4888.535589119028;5111.744412779421;5802.4197580241635;6112.388761123852;6135.693215339126;5907.202527658711;5910.911336330045;5917.822465326047;5919.852003699942;5994.940050599613 11:06:33 INFO - PROCESS | 1641 | |1;ext.html;478.7654049515737;503.8513638476649;514.0387475420963;514.1311184098874;540.9775524259151;29592.704072959263;37843.621563784385;38827.223455530875;38949.8052509737;40602;39516.40725389114;39718.602813971855;39863;39882.60117398825;39927.800360998226;9098.95450522748;9297.302702297355;9301.86047209289;9303.627854885797;9328.580213890356;8376.329893608527;8595.968483781955;10811;11040.834387484194;11067.446627668583;10949.562017519329;10981.61564345248;11061.336319820797;11084.556617735321;11194.944025279861;8347.123552027071;10978.066864316543;11047.116230701524;11071.778564428707;11076.501557429934;8357.83284334316;8486.024107227686;8511.446755960842;8516.446430982029;10705.304155229886;30816.8459157705;37402.625973740185;38501.61498385036;38514.61485385138;38564;3222.113918672384;3293.423650861114;3396.9660303396895;3521.4893840393;3578.159132603836;28545.000924967528;28744.281392965342;29008.564871526945;29027.46881951544;29158;3076.738477229438;3087.4905640569277;3117.0960421477744;3124.140861263148;3235.288236587947;438140;453082.4691753073;459666;462350.6882465566;462450;51284.74357628188;52273.47726522762;52785.47214527882;52826.471735282925;53082.93834123296;56009.71995139998;56013.159802603;56053.719731401085;56130;56331.43668563344;14772.113673179643;15217.467388641344;15265.465708700365;15269.312880920384;15280.31238594266;10778.353298802096;11057.281276716987;11920.880791191978;12005.91946724799;12016.63950081499;13087;14061;14320.856791431952;14451.060681055698;14540.345684444226;5770.16332631766;5794.391588883191;5840.2991641003355;5860.853478663067;5868.735906884115;827.8923739913772;851.3912552524974;919.3977944446399;957.4733896356976;1012.3773879064322;24908.50548967068;27249.591256131174;27785.72214277872;28314.92746607828;28719.42561148765;976.3653625143713;1018.5467466977273;1043.8642976413018;1090.6564432203832;1170.5785917069848;12748.936255318664;13952;14354.856451435351;14743.483978060716;14776.039557428732;575993;576005;576439;578559;581521;50952.74523627432;51158.74420627947;51272.718182045;51445.713857153125;51469;1318.4726109556254;1343.2142196814973;1367.7264547090422;1367.9452821887412;1370.1915869636762;27586.448271034868;27755.722442775314;28007.57988630213;28291.009814656387;28412.857935710188;43666.34500482432;43944.34083488814;43994.78002609967;44080.559194407644;44118.558814411444;510702.4464877652;511248;513431;514730;517069;35266;35718.392097462056;35902.820485897406;35957.741479048105;36250.4562431569;41161.97095072647;41296;41956.48261104344;42140.78929605332;42301.03892727479;34641;34907;34909.65090349064;36256.63743362533;36274.4558831623;32574.837125814218;34918.30163396667;36077.45883811692;36272.81863590665;37286.813565931996;33830.32339353248;33887.491687625195;34854.65145348514;35200;35478.29043419169;22876;30324.69675303219;31448.685513144577;31594.578243978616;31690;23615.963953007787;23756.762432375453;23965.76034239705;24041;24044.51910961806 11:06:33 INFO - PROCESS | 1641 | |2;jquery.html;317.9173414912123;341.95191737325115;352.22510476950697;366.82025807354404;392.0375478201015;14933.477328293498;15575.454859079935;16390.344386224537;18632.627347453043;19210.231590736388;19277;19458.805411945912;19656.901715491404;19993.400197994048;20205.696914546294;4943.802247910079;5410.594205434579;5790.623609465371;5826.300843898738;5890;4095.26285268653;4330.047389574289;5756.769729210827;5884.117382392633;5884.794032208873;6125.356837532062;6495.675216239193;6539.117219175422;6571.014347847813;6598.670066496656;6342.9365706342805;6499.93500064998;6551.279359270477;6558.836029099263;6627.436667883236;5691.242184945573;5753.741081651336;5756.453136951983;5757.136429535562;5765.682887441189;25032.374190645198;25259.87370063138;25833.612495812577;25849.353766155808;26175;2196.4948061945684;2281.281396360141;2313.4910319729634;2599.090318388568;2768.1557125076843;14922.925385373112;15264.38942442301;15308.617284567863;15535.533933981998;15876.047437153693;1736.4096207289456;1852.148011914521;1853.7682789651294;1872.7565416495768;1884.745559349484;89105;116633;116740;116984.41507792492;117143.41428292889;7857.882131768028;9162.954185229164;9851.359661621971;10424.322419042737;10703.1437485001;11473.598424055119;12163.2702037878;12208.389580521116;12267.325297108744;12311.384430778604;7614.961925190339;7632.885506717404;7845.882311765328;7927.603619818986;7961.761147165595;8071.757847264592;8110.918890811135;8114.472559283628;8245.79385515367;8256.793580160544;3828.5979972103087;3839.884803455901;3903.785291808921;3908.218356328746;3912.8043597819997;1868.1230904407332;1891.290765962764;1895.4882181810833;1896.6491199128207;1934.9613007739767;771.2942657468353;828.9668413263402;879.3404946290283;987.2792861211356;992.3378341278474;19616.41150765451;20107.39677809668;20154.992250387422;20162.495937601383;20271.898640507;745.9813504662318;888.8800011998427;895.9641614335353;920.1074957291416;925.9861102083474;9979;10765;10781.353118812896;10817.350958942488;10818.56725730962;487733;489808;496442;497973;501329;115702.42148789202;122898;129669;130731.34634326957;130829;929.6049179098856;964.5129209749032;973.7906350134614;1001.7345403468087;1057.434272664121;18612.720809187602;18904.52738681489;19187.520311992314;19222.423327300203;19348;52291.47708522866;52318.738406307726;52852.735736321076;53000;53620.73189634027;71261.64369178121;74106.62946685232;74797.6260118696;75421.62289188518;77007.61496192707;7660.233976602518;7897.289243968071;7930.286274235346;7935.84128317442;8201.22088401601;11213.439328033402;12108.394580270775;12465.688357790765;12614.36928153607;12622.747545048864;10483.37099774016;10551.41728740695;10867.402292873969;11000.284981476178;11063.170262230204;10435.739106522398;10448.843267351147;10658.573657053632;10842.078423334106;10876.23866329381;10461;10724.088452481627;11071.225014248925;11166.944165279121;11255.930686584761;7802.882956755539;7896.210378962058;7905.407094467823;7957.920420795949;7978.760637180894;8982.86525702102;10111.797764044824;10456.647254367706;10785.730356741144;10960.342379456939 11:06:33 INFO - PROCESS | 1641 | |3;mootools.html;1324.1260767893193;1452.2012892908904;1491.4332553629622;1622.310518029837;1801.77477815273;7374.594397308146;7723.845523089535;7732.806679833007;7736.34241089508;7738.80652983675;7348.081489813773;7858.803529911741;8058.395620328484;8059.274665280138;8195.71315003975;2255.616545187314;2295.1622657729977;2296.8047715944167;2298.678185054094;2299.620562607168;2037.9898100509552;2254.785795349439;2323.256557901472;2337.1118974789556;2338.4270853640883;2086.3010891351414;2115.206797450956;2221.4779526811185;2284.0521183708743;2292.197730794225;1898.7626546681665;2259.6610508423705;2275.7155355580553;2280.04238219948;2283.7373702024147;2275.8293128015466;2296.517731276434;2301.4361481437154;2312.8496647717843;2315.953680926389;8165.510069395856;8208.876866846942;8250.339972802161;8287.254147126787;8289.005319361655;4983.501649834988;5141;5150.510701483353;5156.226566015091;5156.535911767959;3183.8248896310693;3252.333271679324;3498.1079824644553;3500.649935006479;3511.2450823073164;1040.8074506216374;1043.6726100795192;1069.8983596558314;1079.5357996061691;1083.544911137324;10601.363918164934;10722.731931701692;10753.03222709952;10773;10774.5690172393;4131.442255295557;4547.567981041796;4571.085782843445;4621;4658.95341046592;9291.581878815334;9297.767555811024;9300.90699093014;9302.767430814283;9326.860097098548;5116.846494605168;5121.61587880903;5130.717810520383;5143.974280128576;5155.329807125125;4677.929831052537;4686.929696054562;4690.507496712864;4699.600533954652;4713;3679;3683.7421380503106;3741.513603231617;3783.4703141560203;3792.50697409335;1226.5277868020876;1227.4844565282424;1229.5204870100667;1244.6141696074246;1247.7130260040242;624.8437890527368;767.6795911033014;872.8385248729005;909.9899111985691;935.6023689931752;5069.898602028013;5132.639850439637;5630.577706672016;5632.690202038927;5710.885782284331;913.8949020862686;914.6158613382262;917.4862077236769;948.0614191950058;958.6357184269933;3683.981580092136;3797.3354662933875;3873.86441474547;3888.4361767543546;3925.92148157041;9151.816963660822;9615.03849615033;9726.2705297103;9883.703488895344;9913.801723965624;9553.856692149624;9616.807663846685;9640.325177237526;9852.211823054138;9874.851877221847;7491.363234125051;7686.846263074819;7687.461877668621;7688.615569221516;7692.999999999888;5382.973085134706;5384.569234461312;5470.9179362308805;5490;5531.474509921551;9038.728838134866;9086.273098152264;9158.129977652112;9219.400738951947;9272.211861991806;7948.8807667886185;9171.724848254564;9218.262538996998;9298.72103836886;9372.625094996123;6918.51570390088;7038.718451262097;7047.682854271673;7049.753258635923;7064.152301723826;7543.924560754542;7606.733764318223;7707.383409327128;7730;7731.226877312224;6901.723931042903;6934.098567186234;6966;7003.964980175067;7106.893396599158;6287.559870808999;6670.866582668223;6678.599284042973;6826.488013398915;6949.339812717783;6425.8714825704155;6625.768098116543;6629.138212032405;6634.137562117087;6636.13730215069;4095.508538975342;4562.771861406983;4731.952680473151;4861.076395484846;4896.6572339935865;4706.247000479907;4812.951870481251;4906.8773280668265;4929.580985616263;5061.114304996685 11:06:33 INFO - PROCESS | 1641 | |4;prototype.html;280.2084112382519;301.589837820564;306.8051787115181;312.02803267820747;316.06287357983575;5261.447548007457;5332.946670533293;5337.89324213516;5349.1649425804335;5359.356877174744;3943.921121577574;4693.507181745918;4956.231784073474;5151.304573882525;5162.277281180638;3506.9123271918215;3886.455896174538;3964.5440774311037;4054.533728621202;4076.9592304076878;3369.0582019037784;3639.981800090996;3809.1144883282677;4027.5771044040393;4097.242010228102;3334.8828142572265;3804.809759512027;3911.941320880189;4014.5784692607294;4057.69567282455;3349.79407413331;3843.2889915365745;4036.8788936331957;4047.2107938951917;4071.5521292657786;3185.4584720597554;3499.273273963221;3549.7870127792157;3560.4659301104784;3569.625189355106;4456.242438785382;5032.7735251913755;5045.495450454961;5129.0767661820855;5145;4418.889527761799;4559.449787072378;4606.456836959589;4617.353570500132;4647.442306923191;5463.371712253102;5523.072771431148;5527.281453411071;5532.695701736403;5547.972260138674;3907.824147913322;3915.883973067662;3922.823472943696;3923.058465968176;3925.2738243425056;4981.775820088104;5442.510174084351;5747.798827041033;5774.084087535852;5813.738381772788;3539.5752509698486;3748.3815170496564;3814.065553939303;3939.9606003940166;3952.6047395260243;3698.6116457772087;4013.715611004509;4024.162965109591;4044.4742183515955;4049.5950404959267;3536.734744894143;4316.093620339701;4616.114928169894;4646.558576935186;4652.302154676826;5201.427842937273;5468.9726551367785;5517.724113794375;5543.417941116125;5645.717714114277;1063.7500187455942;1138.5047504335641;1251.2805137046234;1252.2861968677767;1275.4133098774482;738.918718940916;753.9057617797775;770.938324934004;819.7868554175957;837.1042984007054;4295.613394794484;4792.9281060784115;4812.398450193726;4890.039068354644;4940.2342636891335;4241.7879106044575;4460.5057305802275;4489.1021795641;4556.521565235669;5275.340582427197;3920.334172762549;4145.3781932710335;4240.639545638655;4346.391505189276;4841.491643377465;2451.2841011292167;2524.4446221831167;2667.879945402423;2681.3052881854;2736.931576710558;4921.901561968741;5350.853088856167;5382.596305277041;5516.372670062341;5622.57830662702;4531.818727250873;5473.698946557898;5501.559875209973;5542.473465020817;5907.527397808165;5148.940423830423;5235.298527978498;5538.335399752055;5546.195801608744;5893.346125402192;4768.427788665383;4779.283107533898;5588.860278492907;5808.332041815076;5808.477237048686;5347.251384806053;5660.839527896854;5683.829485115453;5737.08206686928;5755.165501002415;5211.791528338976;5860.750955557187;5950.5305298302455;5959.970200148971;5997.370276120944;3225.951610725794;3602.405603075463;3860.189360234382;3870.4968354113785;3909.257241124177;4830.444498882533;5525.944740552543;5673.461021202979;5708.543316534584;5752.597318187687;5501.614886958035;5568.96974059784;5571.693556854412;5574.303212098488;5590.608657393944;4602.859670253349;4872.634552408513;5197.688138711689;5571.66570005801;5580.553555715452;5363.5595803908345;5443.891122177613;5449.782008719765;5499.642523235977;5501.3948465667945;5301.787928482971;5421.430749771217;5436.6194366393975;5446.509814116748;5581.553475722014;5018.425862120488;5413.186582494908;5423.376311724202;5445.809396671098;5463.459491336547 11:06:33 INFO - PROCESS | 1641 | |5;yui.html;666.3270097201827;677.8508728079821;690.927452617475;709.184437896419;799.4164260090131;14628.4880029199;14927.955043146983;15417.768733468993;15472.381104755796;15709.685806283896;13809.24049177295;14241.430342786276;14254.216018119025;14262.1442713437;14288.857111428882;662.496502657981;817.4890693316677;837.9622916968751;841.7685136587456;842.3682238321259;680.3094858718405;681.7034589953362;688.0573614148624;689.393333866197;805.2551389964289;872.9127087291283;885.8361203177401;890.5992303463435;890.9688160914369;892.1034360467721;882.7837179890904;883.3683916000026;883.4787475389487;883.9425437346551;884.1556313720382;463.390641306684;509.0252167099999;525.9211118332242;649.5680372552247;652.1717418877998;13743.656408589764;14296.92851535746;14308.785368219485;14313.355898984571;14338.211398373085;13300;13367.933160334136;13493.2578708171;13600.523981660594;13707.040507164502;12166.695832604168;12309.630711078682;12513.687157821127;12572;12991.285479298635;4281.12236991416;4423.867283981485;4453.599176074169;4471.9776401118115;4559.863204103882;118011.40994295059;120913.39543302315;121590.78409215884;121747;121842.39078804638;10334.121599663962;10342.689719308433;10415.739606509898;10488.73778155537;10514.474276286155;18330.358437454626;19199.52001199981;19239.326623568108;19967;19993;7176.174739904978;7666.463347565728;7686.461947663722;7799.766007019798;7849.803754906173;4054.432379466877;4066.369712694537;4130.277201489727;4224.978875105605;4281.785910704514;3388.186835159544;3476.617572067071;3492.825358732104;3521.542199514047;3533.434650455915;638.789199564152;639.280809089774;648.1412128929188;651.6025224612982;657.0571230284557;559.3767511517312;570.0480198069234;599.2748773983528;606.4026933470528;686.9038334633156;8882.733517994342;9017.81964360709;9159.129882661136;9240.576193483377;9310.534473276444;532.9846642146716;582.6474982635444;614.7817524778728;626.1953389893964;628.1708145248228;4262.872113836528;4331.198728235287;4386.692931494765;4470.508244093147;4619.514950930104;91757;100266.4986675062;104167.91664166674;113014.43492782484;113655;96879.51560242154;97214.02785972191;97217.5139124314;97365.5131724351;99019.50490247503;69157.65421172962;88639;89029;92513;92970.53514732383;8432;8758.781030474289;8816.955915220382;8863.585510777313;8989.595468203815;56239.71880140573;56526.71736641291;57735.422645773004;58598.14110435668;58825;77289.61355193188;80783.78824317522;81427;82759.17240827756;83094;11344.546218151181;11488.54045838157;11584.47869845842;11869.525218991144;12081.51673933068;12378;12530;12609;12617.495300188257;12631;11614.593489227836;11828.23116497425;11875.82186267224;11886.34625095628;12116.151869369412;11552.768944621228;11641.767164656829;11931.642050738492;12140.089493287862;12457.06572007085;11292.378919159524;11438.199326047097;11538.94230528842;11602.76794464123;12303.569375072188;7987.361011119213;9672.95163524178;9737.610495580097;9859.507024648883;9869.654562090293;9656.275779316438;9953.253505986935;9993.850092248476;10024.649137280161;10026.598936042477 11:06:33 INFO - PROCESS | 1641 | __end_tp_report 11:06:33 INFO - PROCESS | 1641 | __start_cc_report 11:06:33 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1827 11:06:33 INFO - PROCESS | 1641 | __end_cc_report 11:06:33 INFO - PROCESS | 1641 | __startTimestamp1480619193712__endTimestamp 11:06:33 INFO - PROCESS | 1641 | 11:06:33 INFO - PROCESS | 1641 | ------- Summary: start ------- 11:06:33 INFO - PROCESS | 1641 | Number of tests: 6 11:06:33 INFO - PROCESS | 1641 | 11:06:33 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5668.42 Median:5907.20 stddev:644.47 (10.9%) stddev-sans-first:619.86 11:06:33 INFO - PROCESS | 1641 | Values: 3333.0 3345.2 3347.4 3367.9 3397.9 4586.3 5513.7 5578.3 5683.3 5702.3 4792.3 5620.9 5660.0 5717.3 5726.2 5081.0 5093.3 5104.7 5162.7 5163.7 5159.7 5251.3 5259.0 5283.7 5325.9 5057.2 5198.4 5211.7 5226.4 5308.4 5098.3 5123.6 5162.1 5193.9 5201.6 5134.3 5160.0 5160.4 5174.2 5225.5 5670.5 5696.2 5698.6 5714.5 5722.4 6059.8 6091.8 6104.5 6109.6 6169.2 6163.4 6168.4 6171.8 6182.2 6188.4 5645.7 5649.0 5693.7 5703.1 5740.9 6150.6 6227.3 6229.1 6237.0 6239.4 6022.1 6049.7 6050.7 6057.9 6108.5 6103.7 6104.4 6108.5 6117.4 6149.4 6110.6 6121.4 6150.5 6150.7 6153.3 6139.8 6180.5 6184.5 6187.2 6193.8 4791.0 4837.2 4872.7 4887.9 4923.4 4365.7 4380.1 4390.3 4437.3 4467.1 5164.4 5737.2 5755.1 5758.5 5771.5 5836.0 6185.4 6246.8 6255.0 6268.7 5603.5 5648.6 5651.9 5683.9 5763.0 4509.7 5363.7 5364.0 5368.4 5371.1 6280.3 6296.9 6312.7 6313.8 6318.7 6109.8 6167.1 6181.1 6186.8 6189.8 6248.9 6261.0 6277.5 6288.4 6294.6 6096.6 6110.6 6128.4 6132.6 6133.0 6078.9 6133.7 6146.2 6207.1 6215.7 5999.9 6073.1 6077.9 6095.8 6134.8 6043.9 6058.8 6084.4 6086.7 6089.9 5745.0 5820.7 5896.3 5918.6 5928.0 4888.5 5111.7 5802.4 6112.4 6135.7 5907.2 5910.9 5917.8 5919.9 5994.9 11:06:33 INFO - PROCESS | 1641 | 11:06:33 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:64039.92 Median:19648.28 stddev:138189.96 (703.3%) stddev-sans-first:138495.22 11:06:33 INFO - PROCESS | 1641 | Values: 478.8 503.9 514.0 514.1 541.0 29592.7 37843.6 38827.2 38949.8 40602.0 39516.4 39718.6 39863.0 39882.6 39927.8 9099.0 9297.3 9301.9 9303.6 9328.6 8376.3 8596.0 10811.0 11040.8 11067.4 10949.6 10981.6 11061.3 11084.6 11194.9 8347.1 10978.1 11047.1 11071.8 11076.5 8357.8 8486.0 8511.4 8516.4 10705.3 30816.8 37402.6 38501.6 38514.6 38564.0 3222.1 3293.4 3397.0 3521.5 3578.2 28545.0 28744.3 29008.6 29027.5 29158.0 3076.7 3087.5 3117.1 3124.1 3235.3 438140.0 453082.5 459666.0 462350.7 462450.0 51284.7 52273.5 52785.5 52826.5 53082.9 56009.7 56013.2 56053.7 56130.0 56331.4 14772.1 15217.5 15265.5 15269.3 15280.3 10778.4 11057.3 11920.9 12005.9 12016.6 13087.0 14061.0 14320.9 14451.1 14540.3 5770.2 5794.4 5840.3 5860.9 5868.7 827.9 851.4 919.4 957.5 1012.4 24908.5 27249.6 27785.7 28314.9 28719.4 976.4 1018.5 1043.9 1090.7 1170.6 12748.9 13952.0 14354.9 14743.5 14776.0 575993.0 576005.0 576439.0 578559.0 581521.0 50952.7 51158.7 51272.7 51445.7 51469.0 1318.5 1343.2 1367.7 1367.9 1370.2 27586.4 27755.7 28007.6 28291.0 28412.9 43666.3 43944.3 43994.8 44080.6 44118.6 510702.4 511248.0 513431.0 514730.0 517069.0 35266.0 35718.4 35902.8 35957.7 36250.5 41162.0 41296.0 41956.5 42140.8 42301.0 34641.0 34907.0 34909.7 36256.6 36274.5 32574.8 34918.3 36077.5 36272.8 37286.8 33830.3 33887.5 34854.7 35200.0 35478.3 22876.0 30324.7 31448.7 31594.6 31690.0 23616.0 23756.8 23965.8 24041.0 24044.5 11:06:33 INFO - PROCESS | 1641 | 11:06:33 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:31602.00 Median:1543.04 stddev:83445.16 (5407.9%) stddev-sans-first:83646.19 11:06:33 INFO - PROCESS | 1641 | Values: 317.9 342.0 352.2 366.8 392.0 14933.5 15575.5 16390.3 18632.6 19210.2 19277.0 19458.8 19656.9 19993.4 20205.7 4943.8 5410.6 5790.6 5826.3 5890.0 4095.3 4330.0 5756.8 5884.1 5884.8 6125.4 6495.7 6539.1 6571.0 6598.7 6342.9 6499.9 6551.3 6558.8 6627.4 5691.2 5753.7 5756.5 5757.1 5765.7 25032.4 25259.9 25833.6 25849.4 26175.0 2196.5 2281.3 2313.5 2599.1 2768.2 14922.9 15264.4 15308.6 15535.5 15876.0 1736.4 1852.1 1853.8 1872.8 1884.7 89105.0 116633.0 116740.0 116984.4 117143.4 7857.9 9163.0 9851.4 10424.3 10703.1 11473.6 12163.3 12208.4 12267.3 12311.4 7615.0 7632.9 7845.9 7927.6 7961.8 8071.8 8110.9 8114.5 8245.8 8256.8 3828.6 3839.9 3903.8 3908.2 3912.8 1868.1 1891.3 1895.5 1896.6 1935.0 771.3 829.0 879.3 987.3 992.3 19616.4 20107.4 20155.0 20162.5 20271.9 746.0 888.9 896.0 920.1 926.0 9979.0 10765.0 10781.4 10817.4 10818.6 487733.0 489808.0 496442.0 497973.0 501329.0 115702.4 122898.0 129669.0 130731.3 130829.0 929.6 964.5 973.8 1001.7 1057.4 18612.7 18904.5 19187.5 19222.4 19348.0 52291.5 52318.7 52852.7 53000.0 53620.7 71261.6 74106.6 74797.6 75421.6 77007.6 7660.2 7897.3 7930.3 7935.8 8201.2 11213.4 12108.4 12465.7 12614.4 12622.7 10483.4 10551.4 10867.4 11000.3 11063.2 10435.7 10448.8 10658.6 10842.1 10876.2 10461.0 10724.1 11071.2 11166.9 11255.9 7802.9 7896.2 7905.4 7957.9 7978.8 8982.9 10111.8 10456.6 10785.7 10960.3 11:06:33 INFO - PROCESS | 1641 | 11:06:33 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5322.14 Median:5156.38 stddev:2890.44 (56.1%) stddev-sans-first:2882.93 11:06:33 INFO - PROCESS | 1641 | Values: 1324.1 1452.2 1491.4 1622.3 1801.8 7374.6 7723.8 7732.8 7736.3 7738.8 7348.1 7858.8 8058.4 8059.3 8195.7 2255.6 2295.2 2296.8 2298.7 2299.6 2038.0 2254.8 2323.3 2337.1 2338.4 2086.3 2115.2 2221.5 2284.1 2292.2 1898.8 2259.7 2275.7 2280.0 2283.7 2275.8 2296.5 2301.4 2312.8 2316.0 8165.5 8208.9 8250.3 8287.3 8289.0 4983.5 5141.0 5150.5 5156.2 5156.5 3183.8 3252.3 3498.1 3500.6 3511.2 1040.8 1043.7 1069.9 1079.5 1083.5 10601.4 10722.7 10753.0 10773.0 10774.6 4131.4 4547.6 4571.1 4621.0 4659.0 9291.6 9297.8 9300.9 9302.8 9326.9 5116.8 5121.6 5130.7 5144.0 5155.3 4677.9 4686.9 4690.5 4699.6 4713.0 3679.0 3683.7 3741.5 3783.5 3792.5 1226.5 1227.5 1229.5 1244.6 1247.7 624.8 767.7 872.8 910.0 935.6 5069.9 5132.6 5630.6 5632.7 5710.9 913.9 914.6 917.5 948.1 958.6 3684.0 3797.3 3873.9 3888.4 3925.9 9151.8 9615.0 9726.3 9883.7 9913.8 9553.9 9616.8 9640.3 9852.2 9874.9 7491.4 7686.8 7687.5 7688.6 7693.0 5383.0 5384.6 5470.9 5490.0 5531.5 9038.7 9086.3 9158.1 9219.4 9272.2 7948.9 9171.7 9218.3 9298.7 9372.6 6918.5 7038.7 7047.7 7049.8 7064.2 7543.9 7606.7 7707.4 7730.0 7731.2 6901.7 6934.1 6966.0 7004.0 7106.9 6287.6 6670.9 6678.6 6826.5 6949.3 6425.9 6625.8 6629.1 6634.1 6636.1 4095.5 4562.8 4732.0 4861.1 4896.7 4706.2 4813.0 4906.9 4929.6 5061.1 11:06:33 INFO - PROCESS | 1641 | 11:06:33 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4410.88 Median:4881.34 stddev:1376.70 (28.2%) stddev-sans-first:1345.19 11:06:33 INFO - PROCESS | 1641 | Values: 280.2 301.6 306.8 312.0 316.1 5261.4 5332.9 5337.9 5349.2 5359.4 3943.9 4693.5 4956.2 5151.3 5162.3 3506.9 3886.5 3964.5 4054.5 4077.0 3369.1 3640.0 3809.1 4027.6 4097.2 3334.9 3804.8 3911.9 4014.6 4057.7 3349.8 3843.3 4036.9 4047.2 4071.6 3185.5 3499.3 3549.8 3560.5 3569.6 4456.2 5032.8 5045.5 5129.1 5145.0 4418.9 4559.4 4606.5 4617.4 4647.4 5463.4 5523.1 5527.3 5532.7 5548.0 3907.8 3915.9 3922.8 3923.1 3925.3 4981.8 5442.5 5747.8 5774.1 5813.7 3539.6 3748.4 3814.1 3940.0 3952.6 3698.6 4013.7 4024.2 4044.5 4049.6 3536.7 4316.1 4616.1 4646.6 4652.3 5201.4 5469.0 5517.7 5543.4 5645.7 1063.8 1138.5 1251.3 1252.3 1275.4 738.9 753.9 770.9 819.8 837.1 4295.6 4792.9 4812.4 4890.0 4940.2 4241.8 4460.5 4489.1 4556.5 5275.3 3920.3 4145.4 4240.6 4346.4 4841.5 2451.3 2524.4 2667.9 2681.3 2736.9 4921.9 5350.9 5382.6 5516.4 5622.6 4531.8 5473.7 5501.6 5542.5 5907.5 5148.9 5235.3 5538.3 5546.2 5893.3 4768.4 4779.3 5588.9 5808.3 5808.5 5347.3 5660.8 5683.8 5737.1 5755.2 5211.8 5860.8 5950.5 5960.0 5997.4 3226.0 3602.4 3860.2 3870.5 3909.3 4830.4 5525.9 5673.5 5708.5 5752.6 5501.6 5569.0 5571.7 5574.3 5590.6 4602.9 4872.6 5197.7 5571.7 5580.6 5363.6 5443.9 5449.8 5499.6 5501.4 5301.8 5421.4 5436.6 5446.5 5581.6 5018.4 5413.2 5423.4 5445.8 5463.5 11:06:33 INFO - PROCESS | 1641 | 11:06:33 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:21523.95 Median:2541.45 stddev:32808.82 (1290.9%) stddev-sans-first:32863.48 11:06:33 INFO - PROCESS | 1641 | Values: 666.3 677.9 690.9 709.2 799.4 14628.5 14928.0 15417.8 15472.4 15709.7 13809.2 14241.4 14254.2 14262.1 14288.9 662.5 817.5 838.0 841.8 842.4 680.3 681.7 688.1 689.4 805.3 872.9 885.8 890.6 891.0 892.1 882.8 883.4 883.5 883.9 884.2 463.4 509.0 525.9 649.6 652.2 13743.7 14296.9 14308.8 14313.4 14338.2 13300.0 13367.9 13493.3 13600.5 13707.0 12166.7 12309.6 12513.7 12572.0 12991.3 4281.1 4423.9 4453.6 4472.0 4559.9 118011.4 120913.4 121590.8 121747.0 121842.4 10334.1 10342.7 10415.7 10488.7 10514.5 18330.4 19199.5 19239.3 19967.0 19993.0 7176.2 7666.5 7686.5 7799.8 7849.8 4054.4 4066.4 4130.3 4225.0 4281.8 3388.2 3476.6 3492.8 3521.5 3533.4 638.8 639.3 648.1 651.6 657.1 559.4 570.0 599.3 606.4 686.9 8882.7 9017.8 9159.1 9240.6 9310.5 533.0 582.6 614.8 626.2 628.2 4262.9 4331.2 4386.7 4470.5 4619.5 91757.0 100266.5 104167.9 113014.4 113655.0 96879.5 97214.0 97217.5 97365.5 99019.5 69157.7 88639.0 89029.0 92513.0 92970.5 8432.0 8758.8 8817.0 8863.6 8989.6 56239.7 56526.7 57735.4 58598.1 58825.0 77289.6 80783.8 81427.0 82759.2 83094.0 11344.5 11488.5 11584.5 11869.5 12081.5 12378.0 12530.0 12609.0 12617.5 12631.0 11614.6 11828.2 11875.8 11886.3 12116.2 11552.8 11641.8 11931.6 12140.1 12457.1 11292.4 11438.2 11538.9 11602.8 12303.6 7987.4 9673.0 9737.6 9859.5 9869.7 9656.3 9953.3 9993.9 10024.6 10026.6 11:06:33 INFO - PROCESS | 1641 | -------- Summary: end -------- 11:06:33 INFO - PROCESS | 1641 | 11:06:34 INFO - TEST-INFO | 1641: exit 0 11:06:34 INFO - TEST-OK | dromaeo_css | took 1120783ms 11:06:34 INFO - TEST-START | kraken 11:06:34 INFO - operating with platform_type : mac_ 11:06:34 INFO - Initialising browser for kraken test... 11:06:34 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpRdCgy_/profile http://localhost:49241/getInfo.html) 11:06:37 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 11:06:37 INFO - PROCESS | 1652 | colorDepth:24 11:06:37 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 11:06:37 INFO - PROCESS | 1652 | __metrics 11:06:37 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:06:37 INFO - PROCESS | 1652 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:38 INFO - TEST-INFO | 1652: exit 0 11:06:38 INFO - Browser initialized. 11:06:38 INFO - Running cycle 1/1 for kraken test... 11:06:38 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpRdCgy_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:50 INFO - PROCESS | 1653 | RSS: Main: 244482048 11:06:50 INFO - PROCESS | 1653 | 11:06:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:54 INFO - PROCESS | 1653 | RSS: Main: 295170048 11:06:54 INFO - PROCESS | 1653 | 11:06:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 11:06:57 INFO - PROCESS | 1653 | RSS: Main: 296165376 11:06:57 INFO - PROCESS | 1653 | 11:07:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 11:07:01 INFO - PROCESS | 1653 | RSS: Main: 388595712 11:07:01 INFO - PROCESS | 1653 | 11:07:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 11:07:03 INFO - PROCESS | 1653 | RSS: Main: 290566144 11:07:03 INFO - PROCESS | 1653 | 11:07:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:07:06 INFO - PROCESS | 1653 | RSS: Main: 294150144 11:07:06 INFO - PROCESS | 1653 | 11:07:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 11:07:09 INFO - PROCESS | 1653 | RSS: Main: 335548416 11:07:09 INFO - PROCESS | 1653 | 11:07:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 11:07:13 INFO - PROCESS | 1653 | RSS: Main: 339804160 11:07:13 INFO - PROCESS | 1653 | 11:07:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 11:07:16 INFO - PROCESS | 1653 | RSS: Main: 333955072 11:07:16 INFO - PROCESS | 1653 | 11:07:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:07:19 INFO - PROCESS | 1653 | RSS: Main: 310685696 11:07:19 INFO - PROCESS | 1653 | 11:07:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:07:21 INFO - PROCESS | 1653 | RSS: Main: 314494976 11:07:21 INFO - PROCESS | 1653 | 11:07:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:07:24 INFO - PROCESS | 1653 | RSS: Main: 316424192 11:07:24 INFO - PROCESS | 1653 | 11:07:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:07:28 INFO - PROCESS | 1653 | RSS: Main: 335216640 11:07:28 INFO - PROCESS | 1653 | 11:07:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:07:31 INFO - PROCESS | 1653 | RSS: Main: 328577024 11:07:31 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 11:07:33 INFO - PROCESS | 1653 | RSS: Main: 372461568 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | __start_tp_report 11:07:33 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 11:07:33 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 11:07:33 INFO - PROCESS | 1653 | |i|pagename|runs| 11:07:33 INFO - PROCESS | 1653 | |0;ai-astar;112;115;115;113;114;115;112;112;114;113 11:07:33 INFO - PROCESS | 1653 | |1;audio-beat-detection;149;118;113;155;116;115;114;113;135;113 11:07:33 INFO - PROCESS | 1653 | |2;audio-dft;183;181;184;183;185;182;180;183;184;184 11:07:33 INFO - PROCESS | 1653 | |3;audio-fft;78;63;59;106;78;59;60;60;73;59 11:07:33 INFO - PROCESS | 1653 | |4;audio-oscillator;88;72;85;70;68;70;83;67;68;83 11:07:33 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;87;89;86;86;86;84;87;86;86;83 11:07:33 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;94;94;95;94;93;103;149;125;93 11:07:33 INFO - PROCESS | 1653 | |7;imaging-desaturate;85;68;139;133;134;85;86;86;88;87 11:07:33 INFO - PROCESS | 1653 | |8;json-parse-financial;55;56;56;54;54;55;56;56;55;55 11:07:33 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;73;70;76;72;68;68;71;69;70 11:07:33 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;88;88;89;89;88;86;88;87;88;88 11:07:33 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;149;147;150;168;142;147;146;149;185;156 11:07:33 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;174;175;174;173;174;173;171;172;173;171 11:07:33 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;68;70;70;69;70;68;68;68;68;68 11:07:33 INFO - PROCESS | 1653 | __end_tp_report 11:07:33 INFO - PROCESS | 1653 | __start_cc_report 11:07:33 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2004 11:07:33 INFO - PROCESS | 1653 | __end_cc_report 11:07:33 INFO - PROCESS | 1653 | __startTimestamp1480619253711__endTimestamp 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | ------- Summary: start ------- 11:07:33 INFO - PROCESS | 1653 | Number of tests: 14 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.27 (1.1%) stddev-sans-first:1.22 11:07:33 INFO - PROCESS | 1653 | Values: 112.0 115.0 115.0 113.0 114.0 115.0 112.0 112.0 114.0 113.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:117.00 stddev:16.16 (13.8%) stddev-sans-first:14.41 11:07:33 INFO - PROCESS | 1653 | Values: 149.0 118.0 113.0 155.0 116.0 115.0 114.0 113.0 135.0 113.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:1.52 (0.8%) stddev-sans-first:1.62 11:07:33 INFO - PROCESS | 1653 | Values: 183.0 181.0 184.0 183.0 185.0 182.0 180.0 183.0 184.0 184.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:69.50 Median:61.50 stddev:15.06 (24.5%) stddev-sans-first:15.66 11:07:33 INFO - PROCESS | 1653 | Values: 78.0 63.0 59.0 106.0 78.0 59.0 60.0 60.0 73.0 59.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.50 stddev:8.28 (10.7%) stddev-sans-first:7.42 11:07:33 INFO - PROCESS | 1653 | Values: 88.0 72.0 85.0 70.0 68.0 70.0 83.0 67.0 68.0 83.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.00 stddev:1.63 (1.9%) stddev-sans-first:1.69 11:07:33 INFO - PROCESS | 1653 | Values: 87.0 89.0 86.0 86.0 86.0 84.0 87.0 86.0 86.0 83.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:94.00 stddev:18.82 (20.0%) stddev-sans-first:19.65 11:07:33 INFO - PROCESS | 1653 | Values: 94.0 94.0 94.0 95.0 94.0 93.0 103.0 149.0 125.0 93.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:99.10 Median:85.50 stddev:25.68 (30.0%) stddev-sans-first:26.73 11:07:33 INFO - PROCESS | 1653 | Values: 85.0 68.0 139.0 133.0 134.0 85.0 86.0 86.0 88.0 87.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:0.79 (1.4%) stddev-sans-first:0.83 11:07:33 INFO - PROCESS | 1653 | Values: 55.0 56.0 56.0 54.0 54.0 55.0 56.0 56.0 55.0 55.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.50 stddev:3.05 (4.3%) stddev-sans-first:2.59 11:07:33 INFO - PROCESS | 1653 | Values: 65.0 73.0 70.0 76.0 72.0 68.0 68.0 71.0 69.0 70.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.00 stddev:0.88 (1.0%) stddev-sans-first:0.93 11:07:33 INFO - PROCESS | 1653 | Values: 88.0 88.0 89.0 89.0 88.0 86.0 88.0 87.0 88.0 88.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:149.50 stddev:13.05 (8.7%) stddev-sans-first:13.72 11:07:33 INFO - PROCESS | 1653 | Values: 149.0 147.0 150.0 168.0 142.0 147.0 146.0 149.0 185.0 156.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.50 stddev:1.33 (0.8%) stddev-sans-first:1.36 11:07:33 INFO - PROCESS | 1653 | Values: 174.0 175.0 174.0 173.0 174.0 173.0 171.0 172.0 173.0 171.0 11:07:33 INFO - PROCESS | 1653 | 11:07:33 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 11:07:33 INFO - PROCESS | 1653 | Values: 68.0 70.0 70.0 69.0 70.0 68.0 68.0 68.0 68.0 68.0 11:07:33 INFO - PROCESS | 1653 | -------- Summary: end -------- 11:07:33 INFO - PROCESS | 1653 | 11:07:34 INFO - TEST-INFO | 1653: exit 0 11:07:34 INFO - TEST-OK | kraken | took 60419ms 11:07:34 INFO - SUITE-END | took 1181s 11:07:34 INFO - Completed test suite (00:19:41) 11:07:34 INFO - javascript benchmark 11:07:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3332.9666703332973, 3345.247319353146, 3347.447671134263, 3367.9326413471717, 3397.8810741624047, 4586.266197408415, 5513.696746678941, 5578.2748242728385, 5683.3464151622575, 5702.315722113347, 4792.305115758213, 5620.943790562093, 5659.971700141504, 5717.313922329316, 5726.226959360485, 5080.983803239348, 5093.286939828427, 5104.744762761866, 5162.716050617215, 5163.7418129093585, 5159.71621560814, 5251.317328747257, 5258.973705131469, 5283.682979021271, 5325.866853328678, 5057.241413787924, 5198.428172900978, 5211.687298762086, 5226.3989641191365, 5308.389535203443, 5098.311727916758, 5123.641345105844, 5162.148245539482, 5193.870153246199, 5201.55786758126, 5134.332536770234, 5160.045391602565, 5160.432352441228, 5174.172132458826, 5225.477452254744, 5670.5463562914865, 5696.23100881384, 5698.629589076697, 5714.457126572969, 5722.427757224286, 6059.848503787396, 6091.847703807396, 6104.511639068864, 6109.594897568601, 6169.198004259418, 6163.445289923883, 6168.352323006065, 6171.845703857394, 6182.165407669997, 6188.412100850412, 5645.689487078209, 5648.983183027012, 5693.715314234271, 5703.116017017286, 5740.913886291751, 6150.630962142286, 6227.314995350508, 6229.127922090911, 6237.0, 6239.438450539383, 6022.09668549721, 6049.697515124226, 6050.727518486105, 6057.939420605826, 6108.511319094462, 6103.6948152592195, 6104.428839602234, 6108.52420400844, 6117.370705100174, 6149.446549810538, 6110.64906348202, 6121.449069583669, 6150.477209437248, 6150.708351246199, 6153.29237137726, 6139.7988032087915, 6180.536459765535, 6184.5052395808225, 6187.226596675416, 6193.783217587363, 4790.9938912828, 4837.201861692782, 4872.707637541759, 4887.877803054881, 4923.384576927884, 4365.738055716667, 4380.058287468146, 4390.319500477431, 4437.267850804581, 4467.084247729208, 5164.431912489623, 5737.196792449061, 5755.1367294906095, 5758.510526605201, 5771.451712087345, 5836.0, 6185.381461853869, 6246.750649869953, 6254.9687251563455, 6268.749250030039, 5603.495685388335, 5648.604597678123, 5651.9152212716845, 5683.886322273532, 5763.0, 4509.706869053501, 5363.678179309254, 5363.973180134152, 5368.355797304271, 5371.086915224421, 6280.309165991737, 6296.874062518632, 6312.652804095819, 6313.842153946004, 6318.684065796784, 6109.7861574844665, 6167.136600875791, 6181.072839073995, 6186.752529898754, 6189.81430557084, 6248.937510624835, 6261.0, 6277.497800175884, 6288.402601752826, 6294.559380843297, 6096.573239873166, 6110.602810817282, 6128.387161283836, 6132.5707200495535, 6133.018717005258, 6078.939210607838, 6133.662648554372, 6146.248319228998, 6207.131001659681, 6215.689215539295, 5999.940000599938, 6073.149759033827, 6077.908831367445, 6095.75616975316, 6134.754609815557, 6043.879122417439, 6058.848528786815, 6084.39156084388, 6086.7260973255425, 6089.939100608937, 5745.0, 5820.70896455184, 5896.292444906639, 5918.585699001029, 5928.021876390348, 4888.535589119028, 5111.744412779421, 5802.4197580241635, 6112.388761123852, 6135.693215339126, 5907.202527658711, 5910.911336330045, 5917.822465326047, 5919.852003699942, 5994.940050599613], "value": 5628.03757330828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.7654049515737, 503.8513638476649, 514.0387475420963, 514.1311184098874, 540.9775524259151, 29592.704072959263, 37843.621563784385, 38827.223455530875, 38949.8052509737, 40602.0, 39516.40725389114, 39718.602813971855, 39863.0, 39882.60117398825, 39927.800360998226, 9098.95450522748, 9297.302702297355, 9301.86047209289, 9303.627854885797, 9328.580213890356, 8376.329893608527, 8595.968483781955, 10811.0, 11040.834387484194, 11067.446627668583, 10949.562017519329, 10981.61564345248, 11061.336319820797, 11084.556617735321, 11194.944025279861, 8347.123552027071, 10978.066864316543, 11047.116230701524, 11071.778564428707, 11076.501557429934, 8357.83284334316, 8486.024107227686, 8511.446755960842, 8516.446430982029, 10705.304155229886, 30816.8459157705, 37402.625973740185, 38501.61498385036, 38514.61485385138, 38564.0, 3222.113918672384, 3293.423650861114, 3396.9660303396895, 3521.4893840393, 3578.159132603836, 28545.000924967528, 28744.281392965342, 29008.564871526945, 29027.46881951544, 29158.0, 3076.738477229438, 3087.4905640569277, 3117.0960421477744, 3124.140861263148, 3235.288236587947, 438140.0, 453082.4691753073, 459666.0, 462350.6882465566, 462450.0, 51284.74357628188, 52273.47726522762, 52785.47214527882, 52826.471735282925, 53082.93834123296, 56009.71995139998, 56013.159802603, 56053.719731401085, 56130.0, 56331.43668563344, 14772.113673179643, 15217.467388641344, 15265.465708700365, 15269.312880920384, 15280.31238594266, 10778.353298802096, 11057.281276716987, 11920.880791191978, 12005.91946724799, 12016.63950081499, 13087.0, 14061.0, 14320.856791431952, 14451.060681055698, 14540.345684444226, 5770.16332631766, 5794.391588883191, 5840.2991641003355, 5860.853478663067, 5868.735906884115, 827.8923739913772, 851.3912552524974, 919.3977944446399, 957.4733896356976, 1012.3773879064322, 24908.50548967068, 27249.591256131174, 27785.72214277872, 28314.92746607828, 28719.42561148765, 976.3653625143713, 1018.5467466977273, 1043.8642976413018, 1090.6564432203832, 1170.5785917069848, 12748.936255318664, 13952.0, 14354.856451435351, 14743.483978060716, 14776.039557428732, 575993.0, 576005.0, 576439.0, 578559.0, 581521.0, 50952.74523627432, 51158.74420627947, 51272.718182045, 51445.713857153125, 51469.0, 1318.4726109556254, 1343.2142196814973, 1367.7264547090422, 1367.9452821887412, 1370.1915869636762, 27586.448271034868, 27755.722442775314, 28007.57988630213, 28291.009814656387, 28412.857935710188, 43666.34500482432, 43944.34083488814, 43994.78002609967, 44080.559194407644, 44118.558814411444, 510702.4464877652, 511248.0, 513431.0, 514730.0, 517069.0, 35266.0, 35718.392097462056, 35902.820485897406, 35957.741479048105, 36250.4562431569, 41161.97095072647, 41296.0, 41956.48261104344, 42140.78929605332, 42301.03892727479, 34641.0, 34907.0, 34909.65090349064, 36256.63743362533, 36274.4558831623, 32574.837125814218, 34918.30163396667, 36077.45883811692, 36272.81863590665, 37286.813565931996, 33830.32339353248, 33887.491687625195, 34854.65145348514, 35200.0, 35478.29043419169, 22876.0, 30324.69675303219, 31448.685513144577, 31594.578243978616, 31690.0, 23615.963953007787, 23756.762432375453, 23965.76034239705, 24041.0, 24044.51910961806], "value": 18762.470118993217, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.9173414912123, 341.95191737325115, 352.22510476950697, 366.82025807354404, 392.0375478201015, 14933.477328293498, 15575.454859079935, 16390.344386224537, 18632.627347453043, 19210.231590736388, 19277.0, 19458.805411945912, 19656.901715491404, 19993.400197994048, 20205.696914546294, 4943.802247910079, 5410.594205434579, 5790.623609465371, 5826.300843898738, 5890.0, 4095.26285268653, 4330.047389574289, 5756.769729210827, 5884.117382392633, 5884.794032208873, 6125.356837532062, 6495.675216239193, 6539.117219175422, 6571.014347847813, 6598.670066496656, 6342.9365706342805, 6499.93500064998, 6551.279359270477, 6558.836029099263, 6627.436667883236, 5691.242184945573, 5753.741081651336, 5756.453136951983, 5757.136429535562, 5765.682887441189, 25032.374190645198, 25259.87370063138, 25833.612495812577, 25849.353766155808, 26175.0, 2196.4948061945684, 2281.281396360141, 2313.4910319729634, 2599.090318388568, 2768.1557125076843, 14922.925385373112, 15264.38942442301, 15308.617284567863, 15535.533933981998, 15876.047437153693, 1736.4096207289456, 1852.148011914521, 1853.7682789651294, 1872.7565416495768, 1884.745559349484, 89105.0, 116633.0, 116740.0, 116984.41507792492, 117143.41428292889, 7857.882131768028, 9162.954185229164, 9851.359661621971, 10424.322419042737, 10703.1437485001, 11473.598424055119, 12163.2702037878, 12208.389580521116, 12267.325297108744, 12311.384430778604, 7614.961925190339, 7632.885506717404, 7845.882311765328, 7927.603619818986, 7961.761147165595, 8071.757847264592, 8110.918890811135, 8114.472559283628, 8245.79385515367, 8256.793580160544, 3828.5979972103087, 3839.884803455901, 3903.785291808921, 3908.218356328746, 3912.8043597819997, 1868.1230904407332, 1891.290765962764, 1895.4882181810833, 1896.6491199128207, 1934.9613007739767, 771.2942657468353, 828.9668413263402, 879.3404946290283, 987.2792861211356, 992.3378341278474, 19616.41150765451, 20107.39677809668, 20154.992250387422, 20162.495937601383, 20271.898640507, 745.9813504662318, 888.8800011998427, 895.9641614335353, 920.1074957291416, 925.9861102083474, 9979.0, 10765.0, 10781.353118812896, 10817.350958942488, 10818.56725730962, 487733.0, 489808.0, 496442.0, 497973.0, 501329.0, 115702.42148789202, 122898.0, 129669.0, 130731.34634326957, 130829.0, 929.6049179098856, 964.5129209749032, 973.7906350134614, 1001.7345403468087, 1057.434272664121, 18612.720809187602, 18904.52738681489, 19187.520311992314, 19222.423327300203, 19348.0, 52291.47708522866, 52318.738406307726, 52852.735736321076, 53000.0, 53620.73189634027, 71261.64369178121, 74106.62946685232, 74797.6260118696, 75421.62289188518, 77007.61496192707, 7660.233976602518, 7897.289243968071, 7930.286274235346, 7935.84128317442, 8201.22088401601, 11213.439328033402, 12108.394580270775, 12465.688357790765, 12614.36928153607, 12622.747545048864, 10483.37099774016, 10551.41728740695, 10867.402292873969, 11000.284981476178, 11063.170262230204, 10435.739106522398, 10448.843267351147, 10658.573657053632, 10842.078423334106, 10876.23866329381, 10461.0, 10724.088452481627, 11071.225014248925, 11166.944165279121, 11255.930686584761, 7802.882956755539, 7896.210378962058, 7905.407094467823, 7957.920420795949, 7978.760637180894, 8982.86525702102, 10111.797764044824, 10456.647254367706, 10785.730356741144, 10960.342379456939], "value": 9277.794437476283, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.1260767893193, 1452.2012892908904, 1491.4332553629622, 1622.310518029837, 1801.77477815273, 7374.594397308146, 7723.845523089535, 7732.806679833007, 7736.34241089508, 7738.80652983675, 7348.081489813773, 7858.803529911741, 8058.395620328484, 8059.274665280138, 8195.71315003975, 2255.616545187314, 2295.1622657729977, 2296.8047715944167, 2298.678185054094, 2299.620562607168, 2037.9898100509552, 2254.785795349439, 2323.256557901472, 2337.1118974789556, 2338.4270853640883, 2086.3010891351414, 2115.206797450956, 2221.4779526811185, 2284.0521183708743, 2292.197730794225, 1898.7626546681665, 2259.6610508423705, 2275.7155355580553, 2280.04238219948, 2283.7373702024147, 2275.8293128015466, 2296.517731276434, 2301.4361481437154, 2312.8496647717843, 2315.953680926389, 8165.510069395856, 8208.876866846942, 8250.339972802161, 8287.254147126787, 8289.005319361655, 4983.501649834988, 5141.0, 5150.510701483353, 5156.226566015091, 5156.535911767959, 3183.8248896310693, 3252.333271679324, 3498.1079824644553, 3500.649935006479, 3511.2450823073164, 1040.8074506216374, 1043.6726100795192, 1069.8983596558314, 1079.5357996061691, 1083.544911137324, 10601.363918164934, 10722.731931701692, 10753.03222709952, 10773.0, 10774.5690172393, 4131.442255295557, 4547.567981041796, 4571.085782843445, 4621.0, 4658.95341046592, 9291.581878815334, 9297.767555811024, 9300.90699093014, 9302.767430814283, 9326.860097098548, 5116.846494605168, 5121.61587880903, 5130.717810520383, 5143.974280128576, 5155.329807125125, 4677.929831052537, 4686.929696054562, 4690.507496712864, 4699.600533954652, 4713.0, 3679.0, 3683.7421380503106, 3741.513603231617, 3783.4703141560203, 3792.50697409335, 1226.5277868020876, 1227.4844565282424, 1229.5204870100667, 1244.6141696074246, 1247.7130260040242, 624.8437890527368, 767.6795911033014, 872.8385248729005, 909.9899111985691, 935.6023689931752, 5069.898602028013, 5132.639850439637, 5630.577706672016, 5632.690202038927, 5710.885782284331, 913.8949020862686, 914.6158613382262, 917.4862077236769, 948.0614191950058, 958.6357184269933, 3683.981580092136, 3797.3354662933875, 3873.86441474547, 3888.4361767543546, 3925.92148157041, 9151.816963660822, 9615.03849615033, 9726.2705297103, 9883.703488895344, 9913.801723965624, 9553.856692149624, 9616.807663846685, 9640.325177237526, 9852.211823054138, 9874.851877221847, 7491.363234125051, 7686.846263074819, 7687.461877668621, 7688.615569221516, 7692.999999999888, 5382.973085134706, 5384.569234461312, 5470.9179362308805, 5490.0, 5531.474509921551, 9038.728838134866, 9086.273098152264, 9158.129977652112, 9219.400738951947, 9272.211861991806, 7948.8807667886185, 9171.724848254564, 9218.262538996998, 9298.72103836886, 9372.625094996123, 6918.51570390088, 7038.718451262097, 7047.682854271673, 7049.753258635923, 7064.152301723826, 7543.924560754542, 7606.733764318223, 7707.383409327128, 7730.0, 7731.226877312224, 6901.723931042903, 6934.098567186234, 6966.0, 7003.964980175067, 7106.893396599158, 6287.559870808999, 6670.866582668223, 6678.599284042973, 6826.488013398915, 6949.339812717783, 6425.8714825704155, 6625.768098116543, 6629.138212032405, 6634.137562117087, 6636.13730215069, 4095.508538975342, 4562.771861406983, 4731.952680473151, 4861.076395484846, 4896.6572339935865, 4706.247000479907, 4812.951870481251, 4906.8773280668265, 4929.580985616263, 5061.114304996685], "value": 4324.902716310733, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.2084112382519, 301.589837820564, 306.8051787115181, 312.02803267820747, 316.06287357983575, 5261.447548007457, 5332.946670533293, 5337.89324213516, 5349.1649425804335, 5359.356877174744, 3943.921121577574, 4693.507181745918, 4956.231784073474, 5151.304573882525, 5162.277281180638, 3506.9123271918215, 3886.455896174538, 3964.5440774311037, 4054.533728621202, 4076.9592304076878, 3369.0582019037784, 3639.981800090996, 3809.1144883282677, 4027.5771044040393, 4097.242010228102, 3334.8828142572265, 3804.809759512027, 3911.941320880189, 4014.5784692607294, 4057.69567282455, 3349.79407413331, 3843.2889915365745, 4036.8788936331957, 4047.2107938951917, 4071.5521292657786, 3185.4584720597554, 3499.273273963221, 3549.7870127792157, 3560.4659301104784, 3569.625189355106, 4456.242438785382, 5032.7735251913755, 5045.495450454961, 5129.0767661820855, 5145.0, 4418.889527761799, 4559.449787072378, 4606.456836959589, 4617.353570500132, 4647.442306923191, 5463.371712253102, 5523.072771431148, 5527.281453411071, 5532.695701736403, 5547.972260138674, 3907.824147913322, 3915.883973067662, 3922.823472943696, 3923.058465968176, 3925.2738243425056, 4981.775820088104, 5442.510174084351, 5747.798827041033, 5774.084087535852, 5813.738381772788, 3539.5752509698486, 3748.3815170496564, 3814.065553939303, 3939.9606003940166, 3952.6047395260243, 3698.6116457772087, 4013.715611004509, 4024.162965109591, 4044.4742183515955, 4049.5950404959267, 3536.734744894143, 4316.093620339701, 4616.114928169894, 4646.558576935186, 4652.302154676826, 5201.427842937273, 5468.9726551367785, 5517.724113794375, 5543.417941116125, 5645.717714114277, 1063.7500187455942, 1138.5047504335641, 1251.2805137046234, 1252.2861968677767, 1275.4133098774482, 738.918718940916, 753.9057617797775, 770.938324934004, 819.7868554175957, 837.1042984007054, 4295.613394794484, 4792.9281060784115, 4812.398450193726, 4890.039068354644, 4940.2342636891335, 4241.7879106044575, 4460.5057305802275, 4489.1021795641, 4556.521565235669, 5275.340582427197, 3920.334172762549, 4145.3781932710335, 4240.639545638655, 4346.391505189276, 4841.491643377465, 2451.2841011292167, 2524.4446221831167, 2667.879945402423, 2681.3052881854, 2736.931576710558, 4921.901561968741, 5350.853088856167, 5382.596305277041, 5516.372670062341, 5622.57830662702, 4531.818727250873, 5473.698946557898, 5501.559875209973, 5542.473465020817, 5907.527397808165, 5148.940423830423, 5235.298527978498, 5538.335399752055, 5546.195801608744, 5893.346125402192, 4768.427788665383, 4779.283107533898, 5588.860278492907, 5808.332041815076, 5808.477237048686, 5347.251384806053, 5660.839527896854, 5683.829485115453, 5737.08206686928, 5755.165501002415, 5211.791528338976, 5860.750955557187, 5950.5305298302455, 5959.970200148971, 5997.370276120944, 3225.951610725794, 3602.405603075463, 3860.189360234382, 3870.4968354113785, 3909.257241124177, 4830.444498882533, 5525.944740552543, 5673.461021202979, 5708.543316534584, 5752.597318187687, 5501.614886958035, 5568.96974059784, 5571.693556854412, 5574.303212098488, 5590.608657393944, 4602.859670253349, 4872.634552408513, 5197.688138711689, 5571.66570005801, 5580.553555715452, 5363.5595803908345, 5443.891122177613, 5449.782008719765, 5499.642523235977, 5501.3948465667945, 5301.787928482971, 5421.430749771217, 5436.6194366393975, 5446.509814116748, 5581.553475722014, 5018.425862120488, 5413.186582494908, 5423.376311724202, 5445.809396671098, 5463.459491336547], "value": 3963.3693024287954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.3270097201827, 677.8508728079821, 690.927452617475, 709.184437896419, 799.4164260090131, 14628.4880029199, 14927.955043146983, 15417.768733468993, 15472.381104755796, 15709.685806283896, 13809.24049177295, 14241.430342786276, 14254.216018119025, 14262.1442713437, 14288.857111428882, 662.496502657981, 817.4890693316677, 837.9622916968751, 841.7685136587456, 842.3682238321259, 680.3094858718405, 681.7034589953362, 688.0573614148624, 689.393333866197, 805.2551389964289, 872.9127087291283, 885.8361203177401, 890.5992303463435, 890.9688160914369, 892.1034360467721, 882.7837179890904, 883.3683916000026, 883.4787475389487, 883.9425437346551, 884.1556313720382, 463.390641306684, 509.0252167099999, 525.9211118332242, 649.5680372552247, 652.1717418877998, 13743.656408589764, 14296.92851535746, 14308.785368219485, 14313.355898984571, 14338.211398373085, 13300.0, 13367.933160334136, 13493.2578708171, 13600.523981660594, 13707.040507164502, 12166.695832604168, 12309.630711078682, 12513.687157821127, 12572.0, 12991.285479298635, 4281.12236991416, 4423.867283981485, 4453.599176074169, 4471.9776401118115, 4559.863204103882, 118011.40994295059, 120913.39543302315, 121590.78409215884, 121747.0, 121842.39078804638, 10334.121599663962, 10342.689719308433, 10415.739606509898, 10488.73778155537, 10514.474276286155, 18330.358437454626, 19199.52001199981, 19239.326623568108, 19967.0, 19993.0, 7176.174739904978, 7666.463347565728, 7686.461947663722, 7799.766007019798, 7849.803754906173, 4054.432379466877, 4066.369712694537, 4130.277201489727, 4224.978875105605, 4281.785910704514, 3388.186835159544, 3476.617572067071, 3492.825358732104, 3521.542199514047, 3533.434650455915, 638.789199564152, 639.280809089774, 648.1412128929188, 651.6025224612982, 657.0571230284557, 559.3767511517312, 570.0480198069234, 599.2748773983528, 606.4026933470528, 686.9038334633156, 8882.733517994342, 9017.81964360709, 9159.129882661136, 9240.576193483377, 9310.534473276444, 532.9846642146716, 582.6474982635444, 614.7817524778728, 626.1953389893964, 628.1708145248228, 4262.872113836528, 4331.198728235287, 4386.692931494765, 4470.508244093147, 4619.514950930104, 91757.0, 100266.4986675062, 104167.91664166674, 113014.43492782484, 113655.0, 96879.51560242154, 97214.02785972191, 97217.5139124314, 97365.5131724351, 99019.50490247503, 69157.65421172962, 88639.0, 89029.0, 92513.0, 92970.53514732383, 8432.0, 8758.781030474289, 8816.955915220382, 8863.585510777313, 8989.595468203815, 56239.71880140573, 56526.71736641291, 57735.422645773004, 58598.14110435668, 58825.0, 77289.61355193188, 80783.78824317522, 81427.0, 82759.17240827756, 83094.0, 11344.546218151181, 11488.54045838157, 11584.47869845842, 11869.525218991144, 12081.51673933068, 12378.0, 12530.0, 12609.0, 12617.495300188257, 12631.0, 11614.593489227836, 11828.23116497425, 11875.82186267224, 11886.34625095628, 12116.151869369412, 11552.768944621228, 11641.767164656829, 11931.642050738492, 12140.089493287862, 12457.06572007085, 11292.378919159524, 11438.199326047097, 11538.94230528842, 11602.76794464123, 12303.569375072188, 7987.361011119213, 9672.95163524178, 9737.610495580097, 9859.507024648883, 9869.654562090293, 9656.275779316438, 9953.253505986935, 9993.850092248476, 10024.649137280161, 10026.598936042477], "value": 7229.036440523007, "unit": "score"}], "name": "dromaeo_css", "value": 7036.823429521858, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 115.0, 113.0, 114.0, 115.0, 112.0, 112.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 113.0, 155.0, 116.0, 115.0, 114.0, 113.0, 135.0, 113.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 184.0, 183.0, 185.0, 182.0, 180.0, 183.0, 184.0, 184.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 63.0, 59.0, 106.0, 78.0, 59.0, 60.0, 60.0, 73.0, 59.0], "value": 69.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 85.0, 70.0, 68.0, 70.0, 83.0, 67.0, 68.0, 83.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 86.0, 86.0, 86.0, 84.0, 87.0, 86.0, 86.0, 83.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 103.0, 149.0, 125.0, 93.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 68.0, 139.0, 133.0, 134.0, 85.0, 86.0, 86.0, 88.0, 87.0], "value": 99.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 54.0, 54.0, 55.0, 56.0, 56.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 70.0, 76.0, 72.0, 68.0, 68.0, 71.0, 69.0, 70.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 89.0, 88.0, 86.0, 88.0, 87.0, 88.0, 88.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 150.0, 168.0, 142.0, 147.0, 146.0, 149.0, 185.0, 156.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 174.0, 173.0, 174.0, 173.0, 171.0, 172.0, 173.0, 171.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 70.0, 69.0, 70.0, 68.0, 68.0, 68.0, 68.0, 68.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1462.8000000000002, "alertThreshold": 2.0}]} 11:07:34 INFO - Return code: 0 11:07:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:07:35 INFO - # TBPL SUCCESS # 11:07:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:07:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:07:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:07:35 INFO - 2016-12-01 11:07:35.049 screenresolution[1657:9794] starting screenresolution argv=screenresolution get 11:07:35 INFO - 2016-12-01 11:07:35.052 screenresolution[1657:9794] Display 0: 1600x1200x32@60 11:07:35 INFO - 2016-12-01 11:07:35.058 screenresolution[1658:9797] starting screenresolution argv=screenresolution list 11:07:35 INFO - Available Modes on Display 0 11:07:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:07:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:07:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:07:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:07:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:07:35 INFO - Intel Iris: 11:07:35 INFO - Chipset Model: Intel Iris 11:07:35 INFO - Type: GPU 11:07:35 INFO - Bus: Built-In 11:07:35 INFO - VRAM (Dynamic, Max): 1536 MB 11:07:35 INFO - Vendor: Intel (0x8086) 11:07:35 INFO - Device ID: 0x0a2e 11:07:35 INFO - Revision ID: 0x0009 11:07:35 INFO - Displays: 11:07:35 INFO - Display: 11:07:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:07:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:07:35 INFO - Display Serial Number: 1600x1200 60 11:07:35 INFO - Main Display: Yes 11:07:35 INFO - Mirror: Off 11:07:35 INFO - Online: Yes 11:07:35 INFO - Rotation: Supported 11:07:35 INFO - Return code: 0 11:07:35 INFO - Running post-action listener: _resource_record_post_action 11:07:35 INFO - [mozharness: 2016-12-01 19:07:35.309102Z] Finished run-tests step (success) 11:07:35 INFO - Running post-run listener: _resource_record_post_run 11:07:35 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 37942272; Write bytes: 697256960; Read time: 243; Write time: 2007 11:07:35 INFO - TinderboxPrint: CPU usage
53.5% 11:07:35 INFO - TinderboxPrint: I/O read bytes / time
37,942,272 / 243 11:07:35 INFO - TinderboxPrint: I/O write bytes / time
697,256,960 / 2,007 11:07:35 INFO - TinderboxPrint: CPU idle
2,261.2 (46.5%) 11:07:35 INFO - TinderboxPrint: CPU system
969.4 (19.9%) 11:07:35 INFO - TinderboxPrint: CPU user
1,631.1 (33.5%) 11:07:35 INFO - TinderboxPrint: Swap in / out
421,572,608 / 0 11:07:35 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 383300096; Write bytes: 378644480; Read time: 29180; Write time: 797 11:07:35 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 34784256; Write bytes: 308220928; Read time: 221; Write time: 1173 11:07:35 INFO - Running post-run listener: _upload_blobber_files 11:07:35 INFO - Blob upload gear active. 11:07:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:07:35 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 11:07:35 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:07:35 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:07:36 INFO - (blobuploader) - INFO - Open directory for files ... 11:07:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:07:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:07:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:37 INFO - (blobuploader) - INFO - Done attempting. 11:07:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:07:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:07:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:38 INFO - (blobuploader) - INFO - Done attempting. 11:07:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:07:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:42 INFO - (blobuploader) - INFO - Done attempting. 11:07:42 INFO - (blobuploader) - INFO - Iteration through files over. 11:07:42 INFO - Return code: 0 11:07:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:07:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:07:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6fb9fad59c17686da835683b9a3692eb587228a31a038fcb2dad0318b5b93ac69fc4103570ba364c462583443837e7b82a800b712baaf834a2aacc585cd71d19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7506652c6b4277625d981111762edf9bc3c23d5f1509a6d0f9b55d11edab8083d7c8ac26a374a088011328c604213fd0f0181c137ac2975f597d68daf72c9238", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5cdd4f3842e1b2e2acd9995a192eecb416e01378d692de23eb1ccd772a23896f3f67d397d32ba92dabdd32bb1fd66093116e7edee7e0ea313bf474bf8fae82fd"} 11:07:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:07:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:07:42 INFO - Contents: 11:07:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6fb9fad59c17686da835683b9a3692eb587228a31a038fcb2dad0318b5b93ac69fc4103570ba364c462583443837e7b82a800b712baaf834a2aacc585cd71d19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7506652c6b4277625d981111762edf9bc3c23d5f1509a6d0f9b55d11edab8083d7c8ac26a374a088011328c604213fd0f0181c137ac2975f597d68daf72c9238", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5cdd4f3842e1b2e2acd9995a192eecb416e01378d692de23eb1ccd772a23896f3f67d397d32ba92dabdd32bb1fd66093116e7edee7e0ea313bf474bf8fae82fd"} 11:07:42 INFO - Running post-run listener: copy_logs_to_upload_dir 11:07:42 INFO - Copying logs to upload dir... 11:07:42 INFO - mkdir: /builds/slave/test/build/upload/logs 11:07:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.995063 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-12-01 11:07:42.357737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 11:07:42.361614) ========= 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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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/Graphics/sha512/6fb9fad59c17686da835683b9a3692eb587228a31a038fcb2dad0318b5b93ac69fc4103570ba364c462583443837e7b82a800b712baaf834a2aacc585cd71d19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7506652c6b4277625d981111762edf9bc3c23d5f1509a6d0f9b55d11edab8083d7c8ac26a374a088011328c604213fd0f0181c137ac2975f597d68daf72c9238", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5cdd4f3842e1b2e2acd9995a192eecb416e01378d692de23eb1ccd772a23896f3f67d397d32ba92dabdd32bb1fd66093116e7edee7e0ea313bf474bf8fae82fd"} build_url:https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/RmTIhlxpQSKjQY76NkkMDw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6fb9fad59c17686da835683b9a3692eb587228a31a038fcb2dad0318b5b93ac69fc4103570ba364c462583443837e7b82a800b712baaf834a2aacc585cd71d19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7506652c6b4277625d981111762edf9bc3c23d5f1509a6d0f9b55d11edab8083d7c8ac26a374a088011328c604213fd0f0181c137ac2975f597d68daf72c9238", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5cdd4f3842e1b2e2acd9995a192eecb416e01378d692de23eb1ccd772a23896f3f67d397d32ba92dabdd32bb1fd66093116e7edee7e0ea313bf474bf8fae82fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 11:07:42.395596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 11:07:42.395923) ========= 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.cnZVrAdFqz/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.lLAo6wAYj3/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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.005241 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 11:07:42.445196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 11:07:42.445515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 11:07:42.445847) ========= ========= Total master_lag: 2.33 =========