builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0155 starttime: 1480442200.97 results: success (0) buildid: 20161129074826 builduid: f9a7f2c7463e45eeb758d07455aa42e7 revision: 8d8846f63b74eb930e48b410730ae088e9bdbee8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 09:56:40.971375) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 09:56:40.971769) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-11-29 09:56:40.972058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-11-29 09:56:44.375377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-29 09:56:44.375798) ========= 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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-29 09:56:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.3M=0.001s 2016-11-29 09:56:46 (13.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118374 ========= master_lag: 2.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-29 09:56:46.727205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:56:46.727495) ========= 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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.028932 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:56:46.785438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-11-29 09:56:46.787810) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8d8846f63b74eb930e48b410730ae088e9bdbee8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8d8846f63b74eb930e48b410730ae088e9bdbee8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tEPPcBzj8f/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.NH6AUtBHEN/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-29 09:56:46,880 truncating revision to first 12 chars 2016-11-29 09:56:46,880 Setting DEBUG logging. 2016-11-29 09:56:46,880 attempt 1/10 2016-11-29 09:56:46,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8d8846f63b74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 09:56:47,947 unpacking tar archive at: mozilla-central-8d8846f63b74/testing/mozharness/ program finished with exit code 0 elapsedTime=1.334415 ========= master_lag: 2.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-11-29 09:56:50.628075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 09:56:50.628425) ========= script_repo_revision: 8d8846f63b74eb930e48b410730ae088e9bdbee8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 09:56:50.628841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-11-29 09:56:50.629106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-11-29 09:56:51.894449) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-29 09:56:51.894831) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tEPPcBzj8f/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.NH6AUtBHEN/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:56:52 INFO - MultiFileLogger online at 20161129 09:56:52 in /builds/slave/test 09:56:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:56:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:52 INFO - {'append_to_log': False, 09:56:52 INFO - 'base_work_dir': '/builds/slave/test', 09:56:52 INFO - 'blob_upload_branch': 'Firefox', 09:56:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:52 INFO - 'branch': 'Firefox', 09:56:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:52 INFO - 'config_files': ('talos/mac_config.py',), 09:56:52 INFO - 'default_actions': ('clobber', 09:56:52 INFO - 'read-buildbot-config', 09:56:52 INFO - 'download-and-extract', 09:56:52 INFO - 'populate-webroot', 09:56:52 INFO - 'create-virtualenv', 09:56:52 INFO - 'install', 09:56:52 INFO - 'run-tests'), 09:56:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:52 INFO - 'download_minidump_stackwalk': True, 09:56:52 INFO - 'download_symbols': 'ondemand', 09:56:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:52 INFO - 'installer_path': 'installer.exe', 09:56:52 INFO - 'log_level': 'info', 09:56:52 INFO - 'log_name': 'talos', 09:56:52 INFO - 'log_to_console': True, 09:56:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:56:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:56:52 INFO - 'opt_config_files': (), 09:56:52 INFO - 'pip_index': False, 09:56:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:52 INFO - 'cmd': ('bash', 09:56:52 INFO - '-c', 09:56:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:52 INFO - 'enabled': True, 09:56:52 INFO - 'halt_on_failure': False, 09:56:52 INFO - 'name': 'check_screen_resolution'},), 09:56:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:52 INFO - 'cmd': ('bash', 09:56:52 INFO - '-c', 09:56:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:52 INFO - 'enabled': True, 09:56:52 INFO - 'halt_on_failure': False, 09:56:52 INFO - 'name': 'check_screen_resolution'},), 09:56:52 INFO - 'run_cmd_checks_enabled': True, 09:56:52 INFO - 'sps_profile': False, 09:56:52 INFO - 'sps_profile_interval': 0, 09:56:52 INFO - 'suite': 'dromaeojs', 09:56:52 INFO - 'system_bits': '32', 09:56:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:52 INFO - 'title': 't-yosemite-r7-0155', 09:56:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:52 INFO - 'use_talos_json': True, 09:56:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:52 INFO - 'work_dir': 'build'} 09:56:52 INFO - [mozharness: 2016-11-29 17:56:52.101142Z] Running clobber step. 09:56:52 INFO - Running pre-action listener: _resource_record_pre_action 09:56:52 INFO - Running main action method: clobber 09:56:52 INFO - rmtree: /builds/slave/test/build 09:56:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:54 INFO - Running post-action listener: _resource_record_post_action 09:56:54 INFO - [mozharness: 2016-11-29 17:56:54.369267Z] Finished clobber step (success) 09:56:54 INFO - [mozharness: 2016-11-29 17:56:54.369481Z] Running read-buildbot-config step. 09:56:54 INFO - Running pre-action listener: _resource_record_pre_action 09:56:54 INFO - Running main action method: read_buildbot_config 09:56:54 INFO - Using buildbot properties: 09:56:54 INFO - { 09:56:54 INFO - "project": "", 09:56:54 INFO - "product": "firefox", 09:56:54 INFO - "script_repo_revision": "production", 09:56:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:56:54 INFO - "repository": "", 09:56:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:56:54 INFO - "buildid": "20161129074826", 09:56:54 INFO - "pgo_build": "False", 09:56:54 INFO - "basedir": "/builds/slave/test", 09:56:54 INFO - "buildnumber": 26, 09:56:54 INFO - "slavename": "t-yosemite-r7-0155", 09:56:54 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:56:54 INFO - "platform": "yosemite_r7", 09:56:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:56:54 INFO - "branch": "mozilla-central", 09:56:54 INFO - "repo_path": "mozilla-central", 09:56:54 INFO - "revision": "8d8846f63b74eb930e48b410730ae088e9bdbee8", 09:56:54 INFO - "stage_platform": "macosx64", 09:56:54 INFO - "builduid": "f9a7f2c7463e45eeb758d07455aa42e7", 09:56:54 INFO - "slavebuilddir": "test" 09:56:54 INFO - } 09:56:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:56:54 INFO - Running post-action listener: _resource_record_post_action 09:56:54 INFO - [mozharness: 2016-11-29 17:56:54.375276Z] Finished read-buildbot-config step (success) 09:56:54 INFO - [mozharness: 2016-11-29 17:56:54.375500Z] Running download-and-extract step. 09:56:54 INFO - Running pre-action listener: _resource_record_pre_action 09:56:54 INFO - Running main action method: download_and_extract 09:56:54 INFO - mkdir: /builds/slave/test/build/tests 09:56:54 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')]} 09:56:54 INFO - trying https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:56:54 INFO - Downloading https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/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 09:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/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 09:56:55 INFO - Downloaded 1199 bytes. 09:56:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:56:55 INFO - Using the following test package requirements: 09:56:55 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:56:55 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:56:55 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:56:55 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:56:55 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:56:55 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:56:55 INFO - u'jsshell-mac.zip'], 09:56:55 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:56:55 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:56:55 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:56:55 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:56:55 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:56:55 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:56:55 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:56:55 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:56:55 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:56:55 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:56:55 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:56:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:56:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:56:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:56:55 INFO - Fetch https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:56:55 INFO - Http code: 200 09:56:55 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 09:56:55 INFO - x-amz-cf-id: 1eK-OUedWGh32VslbjtAsJLBIpC9gx_fBThpaCo28z81oGuEghEs9g== 09:56:55 INFO - x-amz-version-id: 8q6mBmsOWls_xusaoj8f3YXc8srRCl67 09:56:56 INFO - Expected file size: 16285069 09:56:56 INFO - Obtained file size: 16285069 09:57:02 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 09:57:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:57:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:57:02 INFO - Fetch https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:57:03 INFO - Http code: 200 09:57:03 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 09:57:03 INFO - x-amz-cf-id: rL8ptFC4IpaxKAfatq6FqVAxKpzV6sG7CFBMvPVM360W2oQ3gFXU8Q== 09:57:03 INFO - x-amz-version-id: 8q6mBmsOWls_xusaoj8f3YXc8srRCl67 09:57:03 INFO - Expected file size: 16285069 09:57:03 INFO - Obtained file size: 16285069 09:57:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:57:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:57:10 INFO - Fetch https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:57:10 INFO - Http code: 200 09:57:10 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:57:10 INFO - x-amz-cf-id: qDuYJwk0HVdJ9Zcfx0IIQTxtnumCeYlMOJJlkrzfe4o4IXG0jDfXug== 09:57:10 INFO - x-amz-version-id: fW4ZJeW.UStZu8v4dhpx.tBzQRRRzeVu 09:57:11 INFO - Expected file size: 14409702 09:57:11 INFO - Obtained file size: 14409702 09:57:11 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')]} 09:57:11 INFO - trying https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:57:11 INFO - Downloading https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:57:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/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 09:57:14 INFO - Downloaded 107607445 bytes. 09:57:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:57:14 INFO - mkdir: /builds/slave/test/properties 09:57:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:14 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:14 INFO - Contents: 09:57:14 INFO - build_url:https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:57:14 INFO - Running post-action listener: _resource_record_post_action 09:57:14 INFO - Running post-action listener: set_extra_try_arguments 09:57:14 INFO - [mozharness: 2016-11-29 17:57:14.927461Z] Finished download-and-extract step (success) 09:57:14 INFO - [mozharness: 2016-11-29 17:57:14.927608Z] Running populate-webroot step. 09:57:14 INFO - Running pre-action listener: _resource_record_pre_action 09:57:14 INFO - Running main action method: populate_webroot 09:57:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:14 INFO - '--tppagecycles', 09:57:14 INFO - '7'], 09:57:14 INFO - 'tests': ['tsvgm']}}, 09:57:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:57:14 INFO - 'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:57:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:57:14 INFO - 'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['damp', 'tps']}, 09:57:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:57:14 INFO - 'tests': ['damp', 'tps']}, 09:57:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['dromaeo_dom']}, 09:57:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['basic_compositor_video']}, 09:57:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:57:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['a11yr', 09:57:14 INFO - 'ts_paint', 09:57:14 INFO - 'tpaint', 09:57:14 INFO - 'sessionrestore', 09:57:14 INFO - 'sessionrestore_no_auto_restore', 09:57:14 INFO - 'tabpaint']}, 09:57:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:14 INFO - 'ts_paint', 09:57:14 INFO - 'tpaint', 09:57:14 INFO - 'sessionrestore', 09:57:14 INFO - 'sessionrestore_no_auto_restore', 09:57:14 INFO - 'tabpaint']}, 09:57:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:14 INFO - 'ts_paint', 09:57:14 INFO - 'tpaint', 09:57:14 INFO - 'sessionrestore', 09:57:14 INFO - 'sessionrestore_no_auto_restore', 09:57:14 INFO - 'tabpaint']}, 09:57:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:14 INFO - 'ts_paint', 09:57:14 INFO - 'tpaint', 09:57:14 INFO - 'sessionrestore', 09:57:14 INFO - 'sessionrestore_no_auto_restore', 09:57:14 INFO - 'tabpaint']}, 09:57:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['a11yr', 09:57:14 INFO - 'ts_paint', 09:57:14 INFO - 'tpaint', 09:57:14 INFO - 'sessionrestore', 09:57:14 INFO - 'sessionrestore_no_auto_restore', 09:57:14 INFO - 'tabpaint']}, 09:57:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['a11yr', 09:57:14 INFO - 'ts_paint', 09:57:14 INFO - 'tpaint', 09:57:14 INFO - 'sessionrestore', 09:57:14 INFO - 'sessionrestore_no_auto_restore', 09:57:14 INFO - 'tabpaint']}, 09:57:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['tsvgx', 09:57:14 INFO - 'tsvgr_opacity', 09:57:14 INFO - 'tart', 09:57:14 INFO - 'tscrollx', 09:57:14 INFO - 'cart', 09:57:14 INFO - 'tsvg_static']}, 09:57:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:14 INFO - 'tsvgr_opacity', 09:57:14 INFO - 'tart', 09:57:14 INFO - 'tscrollx', 09:57:14 INFO - 'cart', 09:57:14 INFO - 'tsvg_static']}, 09:57:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:57:14 INFO - 'talos_options': ['--disable-e10s'], 09:57:14 INFO - 'tests': ['tp5o']}, 09:57:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:57:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:57:14 INFO - 'talos_options': ['--disable-e10s', 09:57:14 INFO - '--xperf_path', 09:57:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:14 INFO - 'tests': ['tp5n']}, 09:57:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:57:14 INFO - 'talos_options': ['--xperf_path', 09:57:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:14 INFO - 'tests': ['tp5n']}}, 09:57:14 INFO - 'talos.zip': {'path': '', 09:57:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:14 INFO - Running post-action listener: _resource_record_post_action 09:57:14 INFO - [mozharness: 2016-11-29 17:57:14.946351Z] Finished populate-webroot step (success) 09:57:14 INFO - [mozharness: 2016-11-29 17:57:14.946460Z] Running create-virtualenv step. 09:57:14 INFO - Running pre-action listener: _resource_record_pre_action 09:57:14 INFO - Running main action method: create_virtualenv 09:57:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:14 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 09:57:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:15 INFO - Using real prefix '/tools/python27' 09:57:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:18 INFO - Installing pip.................done. 09:57:18 INFO - Return code: 0 09:57:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:57:18 INFO - Reading from file tmpfile_stdout 09:57:18 INFO - Output received: 09:57:18 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) 09:57:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:18 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 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57:18 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 09:57:18 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 09:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:18 INFO - 'HOME': '/Users/cltbld', 09:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:18 INFO - 'LOGNAME': 'cltbld', 09:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:18 INFO - 'MOZ_NO_REMOTE': '1', 09:57:18 INFO - 'NO_EM_RESTART': '1', 09:57:18 INFO - 'PAGER': '/bin/cat', 09:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:18 INFO - 'PWD': '/builds/slave/test', 09:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:18 INFO - 'SHELL': '/bin/bash', 09:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:18 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:18 INFO - 'USER': 'cltbld', 09:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:18 INFO - 'XPC_FLAGS': '0x0', 09:57:18 INFO - 'XPC_SERVICE_NAME': '0', 09:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:19 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 09:57:19 INFO - Cleaning up... 09:57:19 INFO - Return code: 0 09:57:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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', '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 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:57: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 psutil>=3.1.1 09:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:19 INFO - 'HOME': '/Users/cltbld', 09:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:19 INFO - 'LOGNAME': 'cltbld', 09:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:19 INFO - 'MOZ_NO_REMOTE': '1', 09:57:19 INFO - 'NO_EM_RESTART': '1', 09:57:19 INFO - 'PAGER': '/bin/cat', 09:57:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:19 INFO - 'PWD': '/builds/slave/test', 09:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:19 INFO - 'SHELL': '/bin/bash', 09:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:19 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:19 INFO - 'USER': 'cltbld', 09:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:19 INFO - 'XPC_FLAGS': '0x0', 09:57:19 INFO - 'XPC_SERVICE_NAME': '0', 09:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:19 INFO - Downloading/unpacking psutil>=3.1.1 09:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:22 INFO - Installing collected packages: psutil 09:57:22 INFO - Running setup.py install for psutil 09:57:22 INFO - building 'psutil._psutil_osx' extension 09:57:22 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 09:57:23 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 09:57:23 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 09:57:23 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 09:57:23 INFO - building 'psutil._psutil_posix' extension 09:57:23 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 09:57:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:57:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:57:23 INFO - ^ 09:57:23 INFO - 1 warning generated. 09:57:23 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 09:57:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:24 INFO - Successfully installed psutil 09:57:24 INFO - Cleaning up... 09:57:24 INFO - Return code: 0 09:57:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:24 INFO - 'HOME': '/Users/cltbld', 09:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:24 INFO - 'LOGNAME': 'cltbld', 09:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:24 INFO - 'MOZ_NO_REMOTE': '1', 09:57:24 INFO - 'NO_EM_RESTART': '1', 09:57:24 INFO - 'PAGER': '/bin/cat', 09:57:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:24 INFO - 'PWD': '/builds/slave/test', 09:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:24 INFO - 'SHELL': '/bin/bash', 09:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:24 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:24 INFO - 'USER': 'cltbld', 09:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:24 INFO - 'XPC_FLAGS': '0x0', 09:57:24 INFO - 'XPC_SERVICE_NAME': '0', 09:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57:24 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 09:57:24 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 09:57:24 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 09:57:24 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 09:57:24 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 09:57:24 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 09:57:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:57:27 INFO - Installing collected packages: mozsystemmonitor 09:57:27 INFO - Running setup.py install for mozsystemmonitor 09:57:27 INFO - Successfully installed mozsystemmonitor 09:57:27 INFO - Cleaning up... 09:57:27 INFO - Return code: 0 09:57:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:57:27 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')]} 09:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:27 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')]} 09:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:27 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 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57:27 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 09:57:27 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 09:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:27 INFO - 'HOME': '/Users/cltbld', 09:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:27 INFO - 'LOGNAME': 'cltbld', 09:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:27 INFO - 'MOZ_NO_REMOTE': '1', 09:57:27 INFO - 'NO_EM_RESTART': '1', 09:57:27 INFO - 'PAGER': '/bin/cat', 09:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:27 INFO - 'PWD': '/builds/slave/test', 09:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:27 INFO - 'SHELL': '/bin/bash', 09:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:27 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:27 INFO - 'USER': 'cltbld', 09:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:27 INFO - 'XPC_FLAGS': '0x0', 09:57:27 INFO - 'XPC_SERVICE_NAME': '0', 09:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:27 INFO - Downloading/unpacking jsonschema==2.5.1 09:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:57:30 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 09:57:30 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 09:57:30 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 09:57:30 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 09:57:30 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 09:57:30 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 09:57:30 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:30 INFO - warning: no files found matching '*.txt' 09:57:30 INFO - no previously-included directories found matching 'build' 09:57:30 INFO - no previously-included directories found matching 'dist' 09:57:30 INFO - no previously-included directories found matching '.git*' 09:57:30 INFO - Installing collected packages: jsonschema, functools32 09:57:30 INFO - Running setup.py install for functools32 09:57:30 INFO - warning: no files found matching '*.txt' 09:57:30 INFO - no previously-included directories found matching 'build' 09:57:30 INFO - no previously-included directories found matching 'dist' 09:57:30 INFO - no previously-included directories found matching '.git*' 09:57:30 INFO - Successfully installed jsonschema functools32 09:57:30 INFO - Cleaning up... 09:57:30 INFO - Return code: 0 09:57:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:57:30 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')]} 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:31 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 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57:31 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 09:57:31 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 09:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:31 INFO - 'HOME': '/Users/cltbld', 09:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:31 INFO - 'LOGNAME': 'cltbld', 09:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:31 INFO - 'MOZ_NO_REMOTE': '1', 09:57:31 INFO - 'NO_EM_RESTART': '1', 09:57:31 INFO - 'PAGER': '/bin/cat', 09:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:31 INFO - 'PWD': '/builds/slave/test', 09:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:31 INFO - 'SHELL': '/bin/bash', 09:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:31 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:31 INFO - 'USER': 'cltbld', 09:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:31 INFO - 'XPC_FLAGS': '0x0', 09:57:31 INFO - 'XPC_SERVICE_NAME': '0', 09:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:57:31 INFO - Cleaning up... 09:57:31 INFO - Return code: 0 09:57:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:32 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 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57:32 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 09:57:32 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 09:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:32 INFO - 'HOME': '/Users/cltbld', 09:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:32 INFO - 'LOGNAME': 'cltbld', 09:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:32 INFO - 'MOZ_NO_REMOTE': '1', 09:57:32 INFO - 'NO_EM_RESTART': '1', 09:57:32 INFO - 'PAGER': '/bin/cat', 09:57:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:32 INFO - 'PWD': '/builds/slave/test', 09:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:32 INFO - 'SHELL': '/bin/bash', 09:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:32 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:32 INFO - 'USER': 'cltbld', 09:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:32 INFO - 'XPC_FLAGS': '0x0', 09:57:32 INFO - 'XPC_SERVICE_NAME': '0', 09:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:35 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 09:57:35 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 09:57:35 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 09:57:35 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 09:57:35 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 09:57:35 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 09:57:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:36 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 09:57:36 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 09:57:36 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 09:57:36 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 09:57:36 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 09:57:36 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 09:57:36 INFO - Downloading docopt-0.6.1.tar.gz 09:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:36 INFO - Running setup.py install for blobuploader 09:57:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:36 INFO - Running setup.py install for requests 09:57:37 INFO - Running setup.py install for docopt 09:57:37 INFO - Successfully installed blobuploader requests docopt 09:57:37 INFO - Cleaning up... 09:57:37 INFO - Return code: 0 09:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:37 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 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57:37 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 09:57:37 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 09:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:37 INFO - 'HOME': '/Users/cltbld', 09:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:37 INFO - 'LOGNAME': 'cltbld', 09:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:37 INFO - 'MOZ_NO_REMOTE': '1', 09:57:37 INFO - 'NO_EM_RESTART': '1', 09:57:37 INFO - 'PAGER': '/bin/cat', 09:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:37 INFO - 'PWD': '/builds/slave/test', 09:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:37 INFO - 'SHELL': '/bin/bash', 09:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:37 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:37 INFO - 'USER': 'cltbld', 09:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:37 INFO - 'XPC_FLAGS': '0x0', 09:57:37 INFO - 'XPC_SERVICE_NAME': '0', 09:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:37 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-8V9pGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:37 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-DAlEGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:38 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-p4j5zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:38 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-h05sKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:38 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-v_u4O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:38 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-qKns4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:38 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-HIOzSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:38 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-M6VWn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:38 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-BmG4Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:38 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-8TR2RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:38 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-E_9YP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:39 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-26fXuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:39 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Hh7_nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:39 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-yPIRak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:39 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-ZprCRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:39 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-fkEd3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:39 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-lASaul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:39 INFO - Running setup.py install for manifestparser 09:57:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:39 INFO - Running setup.py install for mozcrash 09:57:39 INFO - Running setup.py install for mozdebug 09:57:40 INFO - Running setup.py install for mozdevice 09:57:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Running setup.py install for mozfile 09:57:40 INFO - Running setup.py install for mozhttpd 09:57:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Running setup.py install for mozinfo 09:57:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Running setup.py install for mozInstall 09:57:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:40 INFO - Running setup.py install for mozleak 09:57:40 INFO - Running setup.py install for mozlog 09:57:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Running setup.py install for moznetwork 09:57:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Running setup.py install for mozprocess 09:57:41 INFO - Running setup.py install for mozprofile 09:57:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Running setup.py install for mozrunner 09:57:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:41 INFO - Running setup.py install for mozscreenshot 09:57:41 INFO - Running setup.py install for moztest 09:57:42 INFO - Running setup.py install for mozversion 09:57:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:42 INFO - Cleaning up... 09:57:42 INFO - Return code: 0 09:57:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:42 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')]} 09:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:42 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')]} 09:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:42 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 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57:42 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 09:57:42 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 09:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:42 INFO - 'HOME': '/Users/cltbld', 09:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:42 INFO - 'LOGNAME': 'cltbld', 09:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:42 INFO - 'MOZ_NO_REMOTE': '1', 09:57:42 INFO - 'NO_EM_RESTART': '1', 09:57:42 INFO - 'PAGER': '/bin/cat', 09:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:42 INFO - 'PWD': '/builds/slave/test', 09:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:42 INFO - 'SHELL': '/bin/bash', 09:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:42 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:42 INFO - 'USER': 'cltbld', 09:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:42 INFO - 'XPC_FLAGS': '0x0', 09:57:42 INFO - 'XPC_SERVICE_NAME': '0', 09:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:42 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-G8jIPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:42 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-9xD7Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:42 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-sDg9uF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:42 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-aLHfan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:42 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)) 09:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:42 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-qumau1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-G4PfnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-SXaxio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-6NAZ_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-9IhJmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-P9nQ4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-CiIadi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-1i9w8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-42Hah0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-nqb9Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:43 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)) 09:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:43 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-JIw4if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:44 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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:44 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Scamxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:44 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)) 09:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:44 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Z7rGoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:46 INFO - Downloading blessings-1.6.tar.gz 09:57:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:46 INFO - Installing collected packages: blessings 09:57:46 INFO - Running setup.py install for blessings 09:57:47 INFO - Successfully installed blessings 09:57:47 INFO - Cleaning up... 09:57:47 INFO - Return code: 0 09:57:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:47 INFO - Reading from file tmpfile_stdout 09:57:47 INFO - Current package versions: 09:57:47 INFO - blessings == 1.6 09:57:47 INFO - blobuploader == 1.2.4 09:57:47 INFO - docopt == 0.6.1 09:57:47 INFO - functools32 == 3.2.3-2 09:57:47 INFO - jsonschema == 2.5.1 09:57:47 INFO - manifestparser == 1.1 09:57:47 INFO - mozInstall == 1.12 09:57:47 INFO - mozcrash == 1.0 09:57:47 INFO - mozdebug == 0.1 09:57:47 INFO - mozdevice == 0.49 09:57:47 INFO - mozfile == 1.2 09:57:47 INFO - mozhttpd == 0.7 09:57:47 INFO - mozinfo == 0.9 09:57:47 INFO - mozleak == 0.1 09:57:47 INFO - mozlog == 3.4 09:57:47 INFO - moznetwork == 0.27 09:57:47 INFO - mozprocess == 0.23 09:57:47 INFO - mozprofile == 0.28 09:57:47 INFO - mozrunner == 6.13 09:57:47 INFO - mozscreenshot == 0.1 09:57:47 INFO - mozsystemmonitor == 0.3 09:57:47 INFO - moztest == 0.7 09:57:47 INFO - mozversion == 1.4 09:57:47 INFO - psutil == 3.1.1 09:57:47 INFO - requests == 1.2.3 09:57:47 INFO - wsgiref == 0.1.2 09:57:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:47 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 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57:47 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 09:57:47 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 09:57:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:47 INFO - 'HOME': '/Users/cltbld', 09:57:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:47 INFO - 'LOGNAME': 'cltbld', 09:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:47 INFO - 'MOZ_NO_REMOTE': '1', 09:57:47 INFO - 'NO_EM_RESTART': '1', 09:57:47 INFO - 'PAGER': '/bin/cat', 09:57:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:47 INFO - 'PWD': '/builds/slave/test', 09:57:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:47 INFO - 'SHELL': '/bin/bash', 09:57:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:47 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:47 INFO - 'USER': 'cltbld', 09:57:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:47 INFO - 'XPC_FLAGS': '0x0', 09:57:47 INFO - 'XPC_SERVICE_NAME': '0', 09:57:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:47 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)) 09:57:47 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)) 09:57:47 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)) 09:57:47 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)) 09:57:47 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)) 09:57:47 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)) 09:57:47 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)) 09:57:47 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)) 09:57:47 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)) 09:57:47 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)) 09:57:47 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)) 09:57:47 INFO - Cleaning up... 09:57:47 INFO - Return code: 0 09:57:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:47 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 0x10c0ab3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c021570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5a4cf370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, '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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 09:57:47 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 09:57:47 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 09:57:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:57:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:47 INFO - 'HOME': '/Users/cltbld', 09:57:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:47 INFO - 'LOGNAME': 'cltbld', 09:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:47 INFO - 'MOZ_NO_REMOTE': '1', 09:57:47 INFO - 'NO_EM_RESTART': '1', 09:57:47 INFO - 'PAGER': '/bin/cat', 09:57:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:47 INFO - 'PWD': '/builds/slave/test', 09:57:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:47 INFO - 'SHELL': '/bin/bash', 09:57:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:57:47 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:57:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:47 INFO - 'USER': 'cltbld', 09:57:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:47 INFO - 'XPC_FLAGS': '0x0', 09:57:47 INFO - 'XPC_SERVICE_NAME': '0', 09:57:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:57:47 INFO - Cleaning up... 09:57:48 INFO - Return code: 0 09:57:48 INFO - Running post-action listener: _resource_record_post_action 09:57:48 INFO - Running post-action listener: _start_resource_monitoring 09:57:48 INFO - Starting resource monitoring. 09:57:48 INFO - [mozharness: 2016-11-29 17:57:48.030156Z] Finished create-virtualenv step (success) 09:57:48 INFO - [mozharness: 2016-11-29 17:57:48.031128Z] Running install step. 09:57:48 INFO - Running pre-action listener: _resource_record_pre_action 09:57:48 INFO - Running main action method: install 09:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:48 INFO - Reading from file tmpfile_stdout 09:57:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:48 INFO - Reading from file tmpfile_stdout 09:57:48 INFO - Output received: 09:57:48 INFO - Usage: mozinstall [options] installer 09:57:48 INFO - Options: 09:57:48 INFO - -h, --help show this help message and exit 09:57:48 INFO - -d DEST, --destination=DEST 09:57:48 INFO - Directory to install application into. [default: 09:57:48 INFO - "/builds/slave/test"] 09:57:48 INFO - --app=APP Application being installed. [default: firefox] 09:57:48 INFO - mkdir: /builds/slave/test/build/application 09:57:48 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'] 09:57:48 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 09:58:20 INFO - Reading from file tmpfile_stdout 09:58:20 INFO - Output received: 09:58:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:58:20 INFO - Running post-action listener: _resource_record_post_action 09:58:20 INFO - [mozharness: 2016-11-29 17:58:20.870008Z] Finished install step (success) 09:58:20 INFO - [mozharness: 2016-11-29 17:58:20.870138Z] Running run-tests step. 09:58:20 INFO - Running pre-action listener: _resource_record_pre_action 09:58:20 INFO - Running main action method: run_tests 09:58:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:20 INFO - 2016-11-29 09:58:20.884 screenresolution[1619:7910] starting screenresolution argv=screenresolution get 09:58:20 INFO - 2016-11-29 09:58:20.887 screenresolution[1619:7910] Display 0: 1600x1200x32@60 09:58:20 INFO - 2016-11-29 09:58:20.892 screenresolution[1620:7912] starting screenresolution argv=screenresolution list 09:58:20 INFO - Available Modes on Display 0 09:58:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:21 INFO - Intel Iris: 09:58:21 INFO - Chipset Model: Intel Iris 09:58:21 INFO - Type: GPU 09:58:21 INFO - Bus: Built-In 09:58:21 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:21 INFO - Vendor: Intel (0x8086) 09:58:21 INFO - Device ID: 0x0a2e 09:58:21 INFO - Revision ID: 0x0009 09:58:21 INFO - Displays: 09:58:21 INFO - Display: 09:58:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:21 INFO - Display Serial Number: 1600x1200 60 09:58:21 INFO - Main Display: Yes 09:58:21 INFO - Mirror: Off 09:58:21 INFO - Online: Yes 09:58:21 INFO - Rotation: Supported 09:58:21 INFO - Return code: 0 09:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:21 INFO - Python 2.7.3 09:58:21 INFO - Return code: 0 09:58:21 INFO - grabbing minidump binary from tooltool 09:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:21 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 0x10bec1d30>, '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 0x10bd28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10beb9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:21 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 09:58:21 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 09:58:21 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 09:58:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:21 INFO - Return code: 0 09:58:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:58:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:58:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 09:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0155 --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 09:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEPPcBzj8f/Render', 09:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:21 INFO - 'HOME': '/Users/cltbld', 09:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:21 INFO - 'LOGNAME': 'cltbld', 09:58:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:21 INFO - 'MOZ_NO_REMOTE': '1', 09:58:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:21 INFO - 'NO_EM_RESTART': '1', 09:58:21 INFO - 'PAGER': '/bin/cat', 09:58:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:21 INFO - 'PWD': '/builds/slave/test', 09:58:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:21 INFO - 'SHELL': '/bin/bash', 09:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NH6AUtBHEN/Listeners', 09:58:21 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 09:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:21 INFO - 'USER': 'cltbld', 09:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:21 INFO - 'XPC_FLAGS': '0x0', 09:58:21 INFO - 'XPC_SERVICE_NAME': '0', 09:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 09:58:21 INFO - mozversion application_buildid: 20161129074826 09:58:21 INFO - mozversion application_changeset: 8d8846f63b74eb930e48b410730ae088e9bdbee8 09:58:21 INFO - mozversion application_display_name: Nightly 09:58:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:21 INFO - mozversion application_name: Firefox 09:58:21 INFO - mozversion application_remotingname: firefox 09:58:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:58:21 INFO - mozversion application_vendor: Mozilla 09:58:21 INFO - mozversion application_version: 53.0a1 09:58:21 INFO - mozversion platform_buildid: 20161129074826 09:58:21 INFO - mozversion platform_changeset: 8d8846f63b74eb930e48b410730ae088e9bdbee8 09:58:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:58:21 INFO - mozversion platform_version: 53.0a1 09:58:21 INFO - using testdate: 1480442301 09:58:21 INFO - actual date: 1480442301 09:58:21 INFO - starting webserver on 'localhost:49241' 09:58:21 INFO - SUITE-START | Running 2 tests 09:58:21 INFO - TEST-START | dromaeo_css 09:58:21 INFO - operating with platform_type : mac_ 09:58:21 INFO - Initialising browser for dromaeo_css test... 09:58:21 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpZNNfdv/profile http://localhost:49241/getInfo.html) 09:58:24 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 09:58:24 INFO - PROCESS | 1630 | colorDepth:24 09:58:24 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 09:58:24 INFO - PROCESS | 1630 | __metrics 09:58:24 INFO - PROCESS | 1630 | 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" 09:58:24 INFO - PROCESS | 1630 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:25 INFO - TEST-INFO | 1630: exit 0 09:58:25 INFO - Browser initialized. 09:58:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:25 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpZNNfdv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:37 INFO - PROCESS | 1632 | RSS: Main: 236011520 09:58:37 INFO - PROCESS | 1632 | 09:59:29 INFO - PROCESS | 1632 | 1480442369133 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:01:42 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 10:01:44 INFO - PROCESS | 1632 | RSS: Main: 391680000 10:01:44 INFO - PROCESS | 1632 | 10:04:47 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 10:04:48 INFO - PROCESS | 1632 | RSS: Main: 374865920 10:04:48 INFO - PROCESS | 1632 | 10:07:50 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 10:07:51 INFO - PROCESS | 1632 | RSS: Main: 350945280 10:07:51 INFO - PROCESS | 1632 | 10:10:53 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:10:54 INFO - PROCESS | 1632 | RSS: Main: 334401536 10:10:54 INFO - PROCESS | 1632 | 10:13:57 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:13:58 INFO - PROCESS | 1632 | RSS: Main: 328138752 10:13:58 INFO - PROCESS | 1632 | 10:17:01 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:17:02 INFO - PROCESS | 1632 | RSS: Main: 512000000 10:17:02 INFO - PROCESS | 1632 | 10:17:02 INFO - PROCESS | 1632 | __start_tp_report 10:17:02 INFO - PROCESS | 1632 | _x_x_mozilla_page_load 10:17:02 INFO - PROCESS | 1632 | _x_x_mozilla_page_load_details 10:17:02 INFO - PROCESS | 1632 | |i|pagename|runs| 10:17:02 INFO - PROCESS | 1632 | |0;dojo.html;3243.82158981256;3272.8527216275265;3286.129175768421;3322.983385083074;3346.180185854466;5495.835124946258;5529.585281103913;5607.551395888329;5617.185508101323;5643.802466913664;5596.58025648077;5627.943720562793;5674.00704876646;5701.857453563663;5732.5987180897455;4384.649228061748;5006.499350065001;5077.949220507785;5104;5177.792888284464;5139.15203991341;5215.791368345281;5237.166991552964;5246;5287.603429742765;4243.236217480852;5051.0150520648485;5191.117510023305;5204.583633309327;5266.315379000744;4874.317595536592;5085.821996230151;5086.18621020635;5108.386993560796;5145.536901678867;4946.183879659852;5099.031184075014;5128.999845030221;5130.384353877558;5139.229115632647;5621.690807005613;5631.099024156157;5634.014047541664;5658.490735833795;5686.715664216773;5963.98612235921;6024.819255422344;6037.064255040432;6078.604890682136;6202.503799696058;6234.501239900843;6257.249130104371;6258.092576576417;6270.372962703739;6272.121902933547;4818.59041981432;5760.539156867399;5766.769329226784;5780.219670344533;5784.739686714024;5662.556048207681;5942.227510423617;6097.288715798892;6302.464290535356;6353.205849268841;5854.941450585525;5904.202932604129;5980.252468441445;6098.14625952367;6133;5637.605367624227;6231.22109736283;6233.906491402633;6238.064290356483;6241.126242326078;5767.653940763567;6023.6385816851125;6140.688304616564;6148.723307451175;6168.907466388007;5976.641401515923;6057.061155520902;6057.545684073712;6112.0171844544475;6192.009278515416;4857.53853383928;4861.465238823726;4865.270209468537;4870.488598697086;4877.268409738496;4203.768792716369;4380.189664911938;4421.115776844644;4422.778861056999;4441.000774825703;5677.858053548612;5704.372519022904;5735.996200664867;5771.711414429262;5774.538036957033;6158.199434073542;6236.002239641635;6254.6247225166635;6268.529860260499;6272.18461599989;5543.085390910454;5602.943970560243;5722.713864306768;5727.455891690282;5739.799107031234;4884.780184891689;4971.477994810565;5303.04545181871;5351.678899266057;5406.189071639285;6291.307956124822;6319.52603554726;6321.462675672619;6340.048992651139;6345.0482427636225;6077.331493535619;6256.374362563707;6257.2804127525915;6270.937290627217;6279.120923070683;6191.628502289697;6251.34360892118;6274.968625156845;6290.056491526125;6333.334999824952;6033.064874944391;6111.227117700271;6134.589663226307;6137.346341658241;6142.7136481981925;6176.135341052166;6210.347913469202;6215.689215539114;6216.316205217332;6233.719482623384;5798.855028624318;5869.148973398918;6007.158997740407;6035.525942304;6044.90932636002;5927.347991720993;5945.464908158287;5999.040153575407;6054.848628784315;6090.2996155440915;5894.469497745224;5897.469227769521;5904.173415721888;5914.556408269483;5916.674582897982;5836.766529338779;6009.819705408845;6019.578629495893;6024.036154215304;6027.30685971119;5771.769129234784;5795.971020145041;5798.739056742541;5841.357450680507;5847.766089356378 10:17:02 INFO - PROCESS | 1632 | |1;ext.html;465.17895913712294;476.8174926183066;480.7812445337372;484.1430667718139;527.7809708970777;29249;29753.40493190135;30904.845475772618;40614.59385406145;41276.79361603195;40463.79768101163;40824;40834.97912552187;41048.76853694386;41087.178256434854;9206.49364284964;9349.2988025898;9361.57872895718;9365.906340936572;9390.765230869214;8383.664653413887;8627.741167764945;9222.769430764218;9333.579988900481;10961.177911656618;10967.232293739442;11195.888041119606;11212.495437705282;11216.439178041106;11221.438928053605;11093.112550995982;11193.7201569961;11256.831147532794;11259.1555633327;11270.154738394653;7293.963530182368;8224.136465671138;10781.191410644233;11042.006219440289;11086.722831929186;36597.451038234445;38492;38569;38616.03459913497;38660.420093698616;3276.1318250663594;3276.6068071831533;3276.639569647337;3354.8658053677823;3527.717067355459;28691.56962645562;29086;29900.10299690991;29947.850260748775;29967.250818729488;3117.173948903542;3182.0931034655014;3223.516472529116;3261.119497735598;3295.2091498040536;422416;425801.8709906462;426343.86828065664;428652;429424;56581.43418565844;56798.43201568014;56826.7158664204;56857.14714279289;56859.43140568624;58741.11888321678;58763.412365875796;58787.118193227136;58799;59025.81948361009;14533.27333633314;14715.55853324402;14733;14742.189179595225;14753.631159221106;11863.822042669366;11914.868087531671;11915.88084119165;11923.642290731292;11934.880651193376;11211.327320360804;14238.572842814732;14257.928710356382;15928.123953182454;16061.277242524115;4856.211088052207;5799.507041901401;6480.675966201671;6590.681863627294;6596.637184954778;833.7082021292621;848.274725110022;871.507598207011;921.1433366968649;959.3907868503551;25163.62254566183;28671.56992645112;28756.568651470243;29386.853065734962;29660.851695741814;986.2061040862175;992.7021893431942;1022.4529876516177;1027.1936529824052;1078.8112080385902;14668.486602969058;15097.641212290728;15173.848261517243;15196.544103676908;15526.378944842305;549222;549721;550068;551395.4860451344;551885;56257.43742562604;56428.87142257132;56462.717686411306;56694.43305566974;56699.71650141806;1278.8145718870712;1322.7486777512242;1338.7456383287144;1340.5844188301853;1345.387848528917;24922.376940575905;26117.608235876858;28699.699534553794;29575.556366654087;29651.258718532208;50013.74993125011;50193.4941951742;50222;50299.49101526813;50411.74794126006;499213;499487;501060;501132;502198;38740.6125938737;39287.60712392954;39681.2063758729;39811.60188398079;39889.20221595494;44997.32504012377;45270.868228293235;45336;46506.767466162455;48753.75623121862;35620.64379356277;37728.81135594304;38311.80844095762;38687.226255475296;39814.40278395768;32106.83946580252;36585.45121823122;38136.04659883414;38286.80856595699;38601.6139838598;34178.82910585431;36915.26169476542;37393;37632.871013869626;37971.24057518779;30946.381072378877;33366.666333336354;33471.33057338791;33534.826281080044;33688;19474.415767526996;24305.288257259177;24337.878310608332;25026.499470010134;25157.622635660846 10:17:02 INFO - PROCESS | 1632 | |2;jquery.html;352.276072670662;371.4094589602532;373.24604299315365;382.93872980323135;401.14155706787477;14521;14762.483313084043;15293.541193764177;16352.918235408806;19539.12073956672;18787.24851005958;19805.504862378446;19937.003149842487;19944;20149.395518134443;5787.421257874211;5919.2009078774245;5964.821055368346;5967.075103358986;5969.477783165286;5176.974115129438;5345.7059861707785;5931.703414829241;5977.521798256129;5995.1906492623375;5027.974860125694;5901.409859014086;5909.852253693671;5915.911261331084;5916.26046744157;4842.61259099273;5483.232347471358;5826.854328641775;5859.062549992023;5864.354920958691;5485.4640700603895;5646.237757902672;5666.461686139852;5679.488846003838;5850.64896106235;12778.169418987736;13102.148360356641;13123.60629181126;13137.802932955918;15433.691326173526;1892.3565987564157;2145.6030634332697;2164.7943445372666;2183.9235626753148;2296.1045192374986;7906.486078404942;9784;9784.364016338986;10244.733090448264;10320.174386049173;1532.716447457224;1745.1623220853935;1791.2118667786133;1825.6348730254003;1862.2737132518328;107131;107586;107900.92099078988;107907;108635.45682271617;11353.886461135447;11380.658580242605;11460.94269528647;11529.250598711056;11662.416879156008;14526.782098268535;14568.344424500923;14599.92700036493;14608.707825843636;14617.196054216907;7954.960225198837;8031.196880311922;8248.876266856001;8414.957925210334;8432.988041434945;7918.564478953713;8025.277725004661;8053.355731541463;8180.222878826621;8182;4508.346289787963;4515.029268707178;4526.506252936589;4530.161920044802;4599;1623.2857542681184;1703.8807283490037;1854.4871698848137;1906.4852489827947;1937.4768812420568;630.7035693224177;834.8539005673982;862.7109918177356;897.6409436225562;957.3203025851724;19337.903310483358;19486.415407537796;20924.686129708065;21322.14711411557;21422.89288553547;877.2674816528271;889.2930120554175;900.9098990221773;913.6162811619135;944.2493217891792;7987.121416644164;9423.246140308758;10820.72948176286;10829.29609575375;10836.970487803803;518817;531161;534049;534859;534992;115246;117227;121384;122113;123614.38192808979;721.3904250907974;890.7773056735816;955.5699935029264;958.4441024205944;958.7363475044418;18157.27370905149;18198.181081851082;18236.544086397946;18311.816881831543;18371.265149393876;30126;49492;50049.74975125101;51132.97734045224;51136;70223.94664080146;71200.64399678176;71249.28750712426;71270.64364678143;72204.27795722186;7684.11632662251;7887.092984306878;8027.8795818063945;8077.192280771876;8175.713850015459;9165.816683666157;12387.380630968235;12500.686329807837;12739.363031848185;12751.298678572768;10921.453927303763;11190.776184476103;11262.324260544394;11291.43542822872;11340.979311861973;10414.594029806181;10706.464676766287;10740.462976851282;11103.50034248477;11220.495077721358;10313.690589282334;11167.329960202414;11211.327320360479;11396.202265841312;11455.885441145481;7972.960135199287;8152.755417337252;8196.221358970888;8392.244697977212;8416.4950102994;10406.323588966692;10960.068394186583;11232.3260604364;11254.043406310228;11324.886751132382 10:17:02 INFO - PROCESS | 1632 | |3;mootools.html;1445.956621301361;1526.358929249715;1637.3941641592605;1773.6630040292334;1824.8905065696067;7415.814604634887;7665.5783931883725;7969.840603187933;8375.246227839501;8396.328293736495;7530.171681115073;7991.280784729373;8227.712030078934;8232.1356257593;8242.29940455062;2249.6288112461466;2289.473421113145;2290.1526435218993;2292.6904867842795;2294.6902168207243;2043.3767700851236;2141.68945502902;2180.3023032629567;2287.3938406322336;2305;2052.568960518293;2094.8219401350902;2125.95748085039;2222.4443889027743;2295.2081531871563;2103.4110449074283;2254;2279.168103642175;2279.384566167142;2280.429892526868;2282.5206706591634;2303.55080759252;2303.781140791622;2308.549832782608;2310.722713274401;8218.013838339377;8306.08633050364;8391.874121888177;8394.412391132622;8401.201885820838;4952.356193694796;5109.4379618241965;5113.309703190059;5126.615503837227;5131.7690703918415;2743.3004583830993;3192.5952580864346;3525.6298088700573;3527.1182204448887;3531.8057506837113;1040.1055092620416;1047.6699839550593;1058.0636137018716;1075.0324707763075;1079.5142186016246;10451.84322235167;10475.423851688154;10618.097461715763;10619.628313009007;10624.203184761096;3924.3328634132267;4396;4607.76961151941;4616.422947131608;4648.140094082605;9248.7687807804;9254.398464099811;9258.768530786649;9272.72181834546;9274.768130796783;5125.103106956342;5133.512316329943;5136.897262054738;5142.562882155059;5149;4573.47405048417;4611.723296602215;4651.162790697707;4713.575778179912;4726.834560790356;3664.6152154023976;3671.5227020487164;3684;3791.109089363997;3805.6194380562274;1055.4247934875511;1254.6612414647993;1257.937103144839;1263.8925691316342;1274.2927675140386;623.9594426362272;759.3976709143702;811.4198348180961;862.9816816156995;909.4770506958394;5359.410464848864;5524.254225679482;5701.600887937804;5793.362730099686;5803.709814509258;934.514052692596;936.7470782888719;959.3428501476511;959.3764053365229;988.7676396046924;3343.832808359621;3639.1629925117372;3805.7335986481235;3831.5402151741414;3923.4114882767244;9531.761705957268;9972.202223822076;9977.650782222587;9982.550785214682;10007.499625018865;9923.156531694742;9924.553395097239;9925.950370248103;9928.453935033642;9935.304528683067;7305.525140865827;7615.352695020985;7617.466777325534;7621.618919054136;7702.460827742004;5697.259356283656;5741.363711342247;5816.167907109247;5891.440313170242;5946.821595352147;7814.335781458412;8144.226298501633;9020.59407326685;9228.538573071186;9305.302102342215;9284.257259419095;9383.577739001625;9430.62277508892;9455.669051583161;9526.761830954281;6818.897716534157;7073.115860517435;7147.249538798559;7228.674709637974;7228.96385518069;7842.64708088126;7922.960385198037;7923.405744569296;7932.405069619686;7936.920630793849;5987;6928.896066558905;6977.33715297046;6999.895001574879;7144.24985376528;6866.416354609914;6868.107146070979;6880.724771009103;6899.827504312432;6934.791956241321;6538.248101468392;6545.345465453416;6552.57408268461;6609.339066093352;6616.338366163538;4778.426588809365;4784.856454306377;4802.255650374198;4858.684185527929;4938.259261110862;4750.952490475051;4758.738269395217;4838.491958344323;4906.509349065208;5015.322931404214 10:17:02 INFO - PROCESS | 1632 | |4;prototype.html;297.0923827706357;300.4126931848237;303.67961800300674;311.3989999301347;314.19722608734673;4550.886227844306;5010.323606313146;5193.298904647876;5275.788968441262;5282.603804714642;4420.336949457583;4896.608271338293;5089.541941225289;5133;5176.240078373352;3966.643002129808;3969.483967084275;3973.165635216608;3990.3216453202954;4001.7398869073563;3757.1546402059453;3790.9810450947707;3949.4273330367078;3985.7608543487486;4014.4179094031347;2955.660099088611;3287.1920443755957;3596.766210196342;3783.413570896502;3945.4673619061346;2959.4525012872473;3245.8701651933893;3553.466979953002;3679.4664773607947;3789.1853251550774;3088.7065728755733;3454.740894432902;3454.913627159316;3461.6019157796923;3473.1838018065732;4365.650747940157;4787.832425865113;4810.591099756525;4958.206686930074;4961.875953101166;4398.7580683062415;4491.573300536444;4559.244690794035;4578.839740609063;4592.7933243004145;5368.818859850827;5391.676499410048;5402.91895621566;5413.621046526745;5425.403205647375;3242.367738291034;3599.1182160370613;3830.693544516432;3844.3464611015916;3859.286032084073;5519.862003449946;5676.801311954103;5772.278465191893;5800.796972106041;5810.535157187457;3287.8656863382093;3711.1278849470355;3955.5055618047745;3974.205158968218;3981.1838573092446;3605.4952306677087;3832.885013449601;4021.9798901005306;4049.331860243086;4073.837046518165;4014.759114453142;4019.5578486366476;4527.909441811211;4616.76916154191;4630.448799652154;5444.727763611882;5536.916946245809;5554.389017208104;5557.972210139004;5564.4991950724625;1147.449224372306;1188.6434069779032;1211.6425654431964;1298.435385360657;1303.4069498378215;816.6243527977078;820.4257020085963;842.5955541340192;847.3729440214197;889.7330800759746;4047.8988025299013;4242.490901091827;4341.782910854445;4824.863838505;4877.902441951142;4735.976320118446;4893.437254715682;5200.947990520122;5275.340582427197;5361.705106219196;4281.379200016043;4563.95436045642;4619.838305659286;4705.731945380067;4751.788293985081;2326.674265602817;2401.903923843062;2655.1636234586044;2670.4230417647063;2774.834569480823;5115.5396014358885;5305.116683577275;5357.651752636144;5414.485623865727;5516.365617953987;4428.276609884898;4558.014500502177;4844.370231869834;5334.279872217278;5496.735750777344;4672.8504887752015;4815.133276010351;5086.465921078234;5276.525112739795;5471.917921231265;4240.533541310391;4454.985769211538;4663.603593694438;5238.476152384731;5246.275144647343;3821.770693758272;5557.44425557441;5654.971725141512;5657.209669521349;5670.489655930986;5107.591392688501;5752.367239603556;5812.912806307824;5908.497777688773;5929.288485381781;3066.034199227236;3792.35529959913;3817.580066192661;3830.4062870255157;3833.348330783829;4668.486466488752;5353.063213937623;5470.863228419322;5696.686682232351;5739.9139012915675;4561.475430325422;5029.74851257443;5478.45215478449;5535.723213839211;5555;5065.3161823153405;5239.135542635422;5448.318960129984;5471.173200541411;5526.806561770319;4827.165677042702;4951.10880041596;5182.559482443884;5276.973615131899;5464.896015034161;4468.597826195658;4604.401427814362;4996;5021.07110184617;5415.1047133504535;4983.476734942924;5395.785948161632;5405.324334458192;5418.349798024262;5448.427915068861 10:17:02 INFO - PROCESS | 1632 | |5;yui.html;588.8115802943058;679.3206793206793;704.7533363322838;718.8885722712978;775.383570061801;14725.852741472581;15338.693226135485;15342.693146137084;15602.921985390085;15614.453494127707;13813.447462101529;14077.50728724495;14221.933354998391;14359.497417590386;14373.856261437382;818.758466252454;835.1773503099442;836.9539675317855;840.315143158324;841.5203334099566;645.4771634975662;665.2482694555146;817.3706246190429;830.1656834880936;833.4832403909554;867.9218870301671;887.7780554861284;887.9200871921526;888.320434867327;889.2263730554427;877.9824403511926;879.3668558637803;881.3213825354442;883.4522595990463;884.650563027607;497.5223785166245;503.7179179659366;620.6865532905899;653.8921078022169;656.6979189572802;13997.510087147002;14412.711745765026;14422.350994205286;14423.495177668836;14425.206613636246;13682.931585342109;13808.585742427744;13983.65040873976;13989.510367137204;14156.150630962073;12529.93735031319;12628.81056784149;12863.871361286454;12908.741825163444;13103.410346534429;4413.139437809628;4521.095780843812;4555.430571178603;4555.658325625592;4575.633949284049;99979.0002099977;100902;101394.49302753512;108009;113384.29923551236;10776.461176941279;11015.339079655247;11023;11291.983721464943;11439;18386.632267354846;21159.259425920325;21850.781492185193;21951.890240548695;21965;7519.661615227218;7643.694252229849;7759.18528554505;7783.143854176036;7810.453268271166;4044.656204222615;4192.580741925783;4199;4366.772945797666;4369.257226271541;3285.704286614216;3391.0674564494466;3423.5720534933134;3424.366492198951;3429.3655673700446;593.3650993437067;609.4971648390007;609.7256234694316;618.6844709198251;623.557274335218;446.6154919748753;509.8731802716039;554.5406123840779;597.7698586044318;614.4500671898626;8477.74566762998;8612.440191387539;8686.478811271343;8732.781680457912;9120.81758364829;529.4969778710164;568.3492401200602;609.9024156134997;617.6911544227886;633.7845132654919;3674.632536746304;4005.7997100144876;4207.284253334153;4314.50383205929;4346.978265108717;84427.15572844316;87210.56394717986;94393;98344;102115;89517.10482895219;92827;93038;96069.03930960741;98651.01348986563;87150.12849871546;87908.24183516421;88628;89306.55346723225;89777.75555611162;8329.6668133274;8404.159584041792;8406.915930840858;8451.408401411842;8525.531095789544;40612.96935153171;51254.487455126466;51738;53623.73188134035;53784.193237102256;69293;71253.643731781;73787.89318160339;74753.87869181858;75465;12424.440900159696;12614.117011809452;12878;12940.094193406747;13519.932400337935;14610.050346727428;14788.260586970393;14899.553013409615;14935.775963360342;15096.320665570296;13252.447510617541;13430;13475.32623368808;14034.578962631138;14272.072315299472;9986.850197246902;12280.956118729651;12692.238465692088;13433.932830336176;13604.183748975092;13108.475660973454;13404.396802143732;13579.660508487366;13686.110402823784;13731.862681373059;10039.203247277816;10189.74525636865;10248.294190543034;10466.581336746445;10542;10316.793664126826;11163.901420342396;11289.048832908746;11297.039751620876;11574.131940104695 10:17:02 INFO - PROCESS | 1632 | __end_tp_report 10:17:02 INFO - PROCESS | 1632 | __start_cc_report 10:17:02 INFO - PROCESS | 1632 | _x_x_mozilla_cycle_collect,1658 10:17:02 INFO - PROCESS | 1632 | __end_cc_report 10:17:02 INFO - PROCESS | 1632 | __startTimestamp1480443422146__endTimestamp 10:17:02 INFO - PROCESS | 1632 | 10:17:02 INFO - PROCESS | 1632 | ------- Summary: start ------- 10:17:02 INFO - PROCESS | 1632 | Number of tests: 6 10:17:02 INFO - PROCESS | 1632 | 10:17:02 INFO - PROCESS | 1632 | [#0] dojo.html Cycles:165 Average:5653.73 Median:5836.77 stddev:660.48 (11.3%) stddev-sans-first:634.87 10:17:02 INFO - PROCESS | 1632 | Values: 3243.8 3272.9 3286.1 3323.0 3346.2 5495.8 5529.6 5607.6 5617.2 5643.8 5596.6 5627.9 5674.0 5701.9 5732.6 4384.6 5006.5 5077.9 5104.0 5177.8 5139.2 5215.8 5237.2 5246.0 5287.6 4243.2 5051.0 5191.1 5204.6 5266.3 4874.3 5085.8 5086.2 5108.4 5145.5 4946.2 5099.0 5129.0 5130.4 5139.2 5621.7 5631.1 5634.0 5658.5 5686.7 5964.0 6024.8 6037.1 6078.6 6202.5 6234.5 6257.2 6258.1 6270.4 6272.1 4818.6 5760.5 5766.8 5780.2 5784.7 5662.6 5942.2 6097.3 6302.5 6353.2 5854.9 5904.2 5980.3 6098.1 6133.0 5637.6 6231.2 6233.9 6238.1 6241.1 5767.7 6023.6 6140.7 6148.7 6168.9 5976.6 6057.1 6057.5 6112.0 6192.0 4857.5 4861.5 4865.3 4870.5 4877.3 4203.8 4380.2 4421.1 4422.8 4441.0 5677.9 5704.4 5736.0 5771.7 5774.5 6158.2 6236.0 6254.6 6268.5 6272.2 5543.1 5602.9 5722.7 5727.5 5739.8 4884.8 4971.5 5303.0 5351.7 5406.2 6291.3 6319.5 6321.5 6340.0 6345.0 6077.3 6256.4 6257.3 6270.9 6279.1 6191.6 6251.3 6275.0 6290.1 6333.3 6033.1 6111.2 6134.6 6137.3 6142.7 6176.1 6210.3 6215.7 6216.3 6233.7 5798.9 5869.1 6007.2 6035.5 6044.9 5927.3 5945.5 5999.0 6054.8 6090.3 5894.5 5897.5 5904.2 5914.6 5916.7 5836.8 6009.8 6019.6 6024.0 6027.3 5771.8 5796.0 5798.7 5841.4 5847.8 10:17:02 INFO - PROCESS | 1632 | 10:17:02 INFO - PROCESS | 1632 | [#1] ext.html Cycles:180 Average:63222.85 Median:38211.43 stddev:131784.08 (344.9%) stddev-sans-first:132069.53 10:17:02 INFO - PROCESS | 1632 | Values: 465.2 476.8 480.8 484.1 527.8 29249.0 29753.4 30904.8 40614.6 41276.8 40463.8 40824.0 40835.0 41048.8 41087.2 9206.5 9349.3 9361.6 9365.9 9390.8 8383.7 8627.7 9222.8 9333.6 10961.2 10967.2 11195.9 11212.5 11216.4 11221.4 11093.1 11193.7 11256.8 11259.2 11270.2 7294.0 8224.1 10781.2 11042.0 11086.7 36597.5 38492.0 38569.0 38616.0 38660.4 3276.1 3276.6 3276.6 3354.9 3527.7 28691.6 29086.0 29900.1 29947.9 29967.3 3117.2 3182.1 3223.5 3261.1 3295.2 422416.0 425801.9 426343.9 428652.0 429424.0 56581.4 56798.4 56826.7 56857.1 56859.4 58741.1 58763.4 58787.1 58799.0 59025.8 14533.3 14715.6 14733.0 14742.2 14753.6 11863.8 11914.9 11915.9 11923.6 11934.9 11211.3 14238.6 14257.9 15928.1 16061.3 4856.2 5799.5 6480.7 6590.7 6596.6 833.7 848.3 871.5 921.1 959.4 25163.6 28671.6 28756.6 29386.9 29660.9 986.2 992.7 1022.5 1027.2 1078.8 14668.5 15097.6 15173.8 15196.5 15526.4 549222.0 549721.0 550068.0 551395.5 551885.0 56257.4 56428.9 56462.7 56694.4 56699.7 1278.8 1322.7 1338.7 1340.6 1345.4 24922.4 26117.6 28699.7 29575.6 29651.3 50013.7 50193.5 50222.0 50299.5 50411.7 499213.0 499487.0 501060.0 501132.0 502198.0 38740.6 39287.6 39681.2 39811.6 39889.2 44997.3 45270.9 45336.0 46506.8 48753.8 35620.6 37728.8 38311.8 38687.2 39814.4 32106.8 36585.5 38136.0 38286.8 38601.6 34178.8 36915.3 37393.0 37632.9 37971.2 30946.4 33366.7 33471.3 33534.8 33688.0 19474.4 24305.3 24337.9 25026.5 25157.6 10:17:02 INFO - PROCESS | 1632 | 10:17:02 INFO - PROCESS | 1632 | [#2] jquery.html Cycles:180 Average:31674.47 Median:361.84 stddev:88780.53 (24535.7%) stddev-sans-first:88998.43 10:17:02 INFO - PROCESS | 1632 | Values: 352.3 371.4 373.2 382.9 401.1 14521.0 14762.5 15293.5 16352.9 19539.1 18787.2 19805.5 19937.0 19944.0 20149.4 5787.4 5919.2 5964.8 5967.1 5969.5 5177.0 5345.7 5931.7 5977.5 5995.2 5028.0 5901.4 5909.9 5915.9 5916.3 4842.6 5483.2 5826.9 5859.1 5864.4 5485.5 5646.2 5666.5 5679.5 5850.6 12778.2 13102.1 13123.6 13137.8 15433.7 1892.4 2145.6 2164.8 2183.9 2296.1 7906.5 9784.0 9784.4 10244.7 10320.2 1532.7 1745.2 1791.2 1825.6 1862.3 107131.0 107586.0 107900.9 107907.0 108635.5 11353.9 11380.7 11460.9 11529.3 11662.4 14526.8 14568.3 14599.9 14608.7 14617.2 7955.0 8031.2 8248.9 8415.0 8433.0 7918.6 8025.3 8053.4 8180.2 8182.0 4508.3 4515.0 4526.5 4530.2 4599.0 1623.3 1703.9 1854.5 1906.5 1937.5 630.7 834.9 862.7 897.6 957.3 19337.9 19486.4 20924.7 21322.1 21422.9 877.3 889.3 900.9 913.6 944.2 7987.1 9423.2 10820.7 10829.3 10837.0 518817.0 531161.0 534049.0 534859.0 534992.0 115246.0 117227.0 121384.0 122113.0 123614.4 721.4 890.8 955.6 958.4 958.7 18157.3 18198.2 18236.5 18311.8 18371.3 30126.0 49492.0 50049.7 51133.0 51136.0 70223.9 71200.6 71249.3 71270.6 72204.3 7684.1 7887.1 8027.9 8077.2 8175.7 9165.8 12387.4 12500.7 12739.4 12751.3 10921.5 11190.8 11262.3 11291.4 11341.0 10414.6 10706.5 10740.5 11103.5 11220.5 10313.7 11167.3 11211.3 11396.2 11455.9 7973.0 8152.8 8196.2 8392.2 8416.5 10406.3 10960.1 11232.3 11254.0 11324.9 10:17:02 INFO - PROCESS | 1632 | 10:17:02 INFO - PROCESS | 1632 | [#3] mootools.html Cycles:180 Average:5361.32 Median:5254.21 stddev:2924.44 (55.7%) stddev-sans-first:2917.84 10:17:02 INFO - PROCESS | 1632 | Values: 1446.0 1526.4 1637.4 1773.7 1824.9 7415.8 7665.6 7969.8 8375.2 8396.3 7530.2 7991.3 8227.7 8232.1 8242.3 2249.6 2289.5 2290.2 2292.7 2294.7 2043.4 2141.7 2180.3 2287.4 2305.0 2052.6 2094.8 2126.0 2222.4 2295.2 2103.4 2254.0 2279.2 2279.4 2280.4 2282.5 2303.6 2303.8 2308.5 2310.7 8218.0 8306.1 8391.9 8394.4 8401.2 4952.4 5109.4 5113.3 5126.6 5131.8 2743.3 3192.6 3525.6 3527.1 3531.8 1040.1 1047.7 1058.1 1075.0 1079.5 10451.8 10475.4 10618.1 10619.6 10624.2 3924.3 4396.0 4607.8 4616.4 4648.1 9248.8 9254.4 9258.8 9272.7 9274.8 5125.1 5133.5 5136.9 5142.6 5149.0 4573.5 4611.7 4651.2 4713.6 4726.8 3664.6 3671.5 3684.0 3791.1 3805.6 1055.4 1254.7 1257.9 1263.9 1274.3 624.0 759.4 811.4 863.0 909.5 5359.4 5524.3 5701.6 5793.4 5803.7 934.5 936.7 959.3 959.4 988.8 3343.8 3639.2 3805.7 3831.5 3923.4 9531.8 9972.2 9977.7 9982.6 10007.5 9923.2 9924.6 9926.0 9928.5 9935.3 7305.5 7615.4 7617.5 7621.6 7702.5 5697.3 5741.4 5816.2 5891.4 5946.8 7814.3 8144.2 9020.6 9228.5 9305.3 9284.3 9383.6 9430.6 9455.7 9526.8 6818.9 7073.1 7147.2 7228.7 7229.0 7842.6 7923.0 7923.4 7932.4 7936.9 5987.0 6928.9 6977.3 6999.9 7144.2 6866.4 6868.1 6880.7 6899.8 6934.8 6538.2 6545.3 6552.6 6609.3 6616.3 4778.4 4784.9 4802.3 4858.7 4938.3 4751.0 4758.7 4838.5 4906.5 5015.3 10:17:02 INFO - PROCESS | 1632 | 10:17:02 INFO - PROCESS | 1632 | [#4] prototype.html Cycles:180 Average:4308.21 Median:4720.85 stddev:1335.30 (28.3%) stddev-sans-first:1304.67 10:17:02 INFO - PROCESS | 1632 | Values: 297.1 300.4 303.7 311.4 314.2 4550.9 5010.3 5193.3 5275.8 5282.6 4420.3 4896.6 5089.5 5133.0 5176.2 3966.6 3969.5 3973.2 3990.3 4001.7 3757.2 3791.0 3949.4 3985.8 4014.4 2955.7 3287.2 3596.8 3783.4 3945.5 2959.5 3245.9 3553.5 3679.5 3789.2 3088.7 3454.7 3454.9 3461.6 3473.2 4365.7 4787.8 4810.6 4958.2 4961.9 4398.8 4491.6 4559.2 4578.8 4592.8 5368.8 5391.7 5402.9 5413.6 5425.4 3242.4 3599.1 3830.7 3844.3 3859.3 5519.9 5676.8 5772.3 5800.8 5810.5 3287.9 3711.1 3955.5 3974.2 3981.2 3605.5 3832.9 4022.0 4049.3 4073.8 4014.8 4019.6 4527.9 4616.8 4630.4 5444.7 5536.9 5554.4 5558.0 5564.5 1147.4 1188.6 1211.6 1298.4 1303.4 816.6 820.4 842.6 847.4 889.7 4047.9 4242.5 4341.8 4824.9 4877.9 4736.0 4893.4 5200.9 5275.3 5361.7 4281.4 4564.0 4619.8 4705.7 4751.8 2326.7 2401.9 2655.2 2670.4 2774.8 5115.5 5305.1 5357.7 5414.5 5516.4 4428.3 4558.0 4844.4 5334.3 5496.7 4672.9 4815.1 5086.5 5276.5 5471.9 4240.5 4455.0 4663.6 5238.5 5246.3 3821.8 5557.4 5655.0 5657.2 5670.5 5107.6 5752.4 5812.9 5908.5 5929.3 3066.0 3792.4 3817.6 3830.4 3833.3 4668.5 5353.1 5470.9 5696.7 5739.9 4561.5 5029.7 5478.5 5535.7 5555.0 5065.3 5239.1 5448.3 5471.2 5526.8 4827.2 4951.1 5182.6 5277.0 5464.9 4468.6 4604.4 4996.0 5021.1 5415.1 4983.5 5395.8 5405.3 5418.3 5448.4 10:17:02 INFO - PROCESS | 1632 | 10:17:02 INFO - PROCESS | 1632 | [#5] yui.html Cycles:180 Average:20630.90 Median:2429.88 stddev:29882.59 (1229.8%) stddev-sans-first:29928.52 10:17:02 INFO - PROCESS | 1632 | Values: 588.8 679.3 704.8 718.9 775.4 14725.9 15338.7 15342.7 15602.9 15614.5 13813.4 14077.5 14221.9 14359.5 14373.9 818.8 835.2 837.0 840.3 841.5 645.5 665.2 817.4 830.2 833.5 867.9 887.8 887.9 888.3 889.2 878.0 879.4 881.3 883.5 884.7 497.5 503.7 620.7 653.9 656.7 13997.5 14412.7 14422.4 14423.5 14425.2 13682.9 13808.6 13983.7 13989.5 14156.2 12529.9 12628.8 12863.9 12908.7 13103.4 4413.1 4521.1 4555.4 4555.7 4575.6 99979.0 100902.0 101394.5 108009.0 113384.3 10776.5 11015.3 11023.0 11292.0 11439.0 18386.6 21159.3 21850.8 21951.9 21965.0 7519.7 7643.7 7759.2 7783.1 7810.5 4044.7 4192.6 4199.0 4366.8 4369.3 3285.7 3391.1 3423.6 3424.4 3429.4 593.4 609.5 609.7 618.7 623.6 446.6 509.9 554.5 597.8 614.5 8477.7 8612.4 8686.5 8732.8 9120.8 529.5 568.3 609.9 617.7 633.8 3674.6 4005.8 4207.3 4314.5 4347.0 84427.2 87210.6 94393.0 98344.0 102115.0 89517.1 92827.0 93038.0 96069.0 98651.0 87150.1 87908.2 88628.0 89306.6 89777.8 8329.7 8404.2 8406.9 8451.4 8525.5 40613.0 51254.5 51738.0 53623.7 53784.2 69293.0 71253.6 73787.9 74753.9 75465.0 12424.4 12614.1 12878.0 12940.1 13519.9 14610.1 14788.3 14899.6 14935.8 15096.3 13252.4 13430.0 13475.3 14034.6 14272.1 9986.9 12281.0 12692.2 13433.9 13604.2 13108.5 13404.4 13579.7 13686.1 13731.9 10039.2 10189.7 10248.3 10466.6 10542.0 10316.8 11163.9 11289.0 11297.0 11574.1 10:17:02 INFO - PROCESS | 1632 | -------- Summary: end -------- 10:17:02 INFO - PROCESS | 1632 | 10:17:02 INFO - TEST-INFO | 1632: exit 0 10:17:02 INFO - TEST-OK | dromaeo_css | took 1121363ms 10:17:02 INFO - TEST-START | kraken 10:17:02 INFO - operating with platform_type : mac_ 10:17:02 INFO - Initialising browser for kraken test... 10:17:02 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpI2eA_L/profile http://localhost:49241/getInfo.html) 10:17:05 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 10:17:05 INFO - PROCESS | 1641 | colorDepth:24 10:17:05 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 10:17:05 INFO - PROCESS | 1641 | __metrics 10:17:05 INFO - PROCESS | 1641 | 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:17:05 INFO - PROCESS | 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:06 INFO - TEST-INFO | 1641: exit 0 10:17:06 INFO - Browser initialized. 10:17:06 INFO - Running cycle 1/1 for kraken test... 10:17:06 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpI2eA_L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:18 INFO - PROCESS | 1642 | RSS: Main: 245530624 10:17:18 INFO - PROCESS | 1642 | 10:17:21 INFO - PROCESS | 1642 | 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) 10:17:22 INFO - PROCESS | 1642 | RSS: Main: 295043072 10:17:22 INFO - PROCESS | 1642 | 10:17:25 INFO - PROCESS | 1642 | 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) 10:17:25 INFO - PROCESS | 1642 | RSS: Main: 296501248 10:17:25 INFO - PROCESS | 1642 | 10:17:29 INFO - PROCESS | 1642 | 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) 10:17:29 INFO - PROCESS | 1642 | RSS: Main: 385945600 10:17:29 INFO - PROCESS | 1642 | 10:17:31 INFO - PROCESS | 1642 | 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) 10:17:32 INFO - PROCESS | 1642 | RSS: Main: 289718272 10:17:32 INFO - PROCESS | 1642 | 10:17:34 INFO - PROCESS | 1642 | 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) 10:17:34 INFO - PROCESS | 1642 | RSS: Main: 292782080 10:17:34 INFO - PROCESS | 1642 | 10:17:37 INFO - PROCESS | 1642 | 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) 10:17:38 INFO - PROCESS | 1642 | RSS: Main: 335618048 10:17:38 INFO - PROCESS | 1642 | 10:17:41 INFO - PROCESS | 1642 | 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) 10:17:41 INFO - PROCESS | 1642 | RSS: Main: 336482304 10:17:41 INFO - PROCESS | 1642 | 10:17:44 INFO - PROCESS | 1642 | 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) 10:17:45 INFO - PROCESS | 1642 | RSS: Main: 334286848 10:17:45 INFO - PROCESS | 1642 | 10:17:46 INFO - PROCESS | 1642 | 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) 10:17:47 INFO - PROCESS | 1642 | RSS: Main: 310632448 10:17:47 INFO - PROCESS | 1642 | 10:17:49 INFO - PROCESS | 1642 | 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) 10:17:50 INFO - PROCESS | 1642 | RSS: Main: 312983552 10:17:50 INFO - PROCESS | 1642 | 10:17:52 INFO - PROCESS | 1642 | 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) 10:17:52 INFO - PROCESS | 1642 | RSS: Main: 314580992 10:17:52 INFO - PROCESS | 1642 | 10:17:55 INFO - PROCESS | 1642 | 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) 10:17:56 INFO - PROCESS | 1642 | RSS: Main: 335904768 10:17:56 INFO - PROCESS | 1642 | 10:17:59 INFO - PROCESS | 1642 | 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) 10:18:00 INFO - PROCESS | 1642 | RSS: Main: 329289728 10:18:00 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | 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) 10:18:02 INFO - PROCESS | 1642 | RSS: Main: 373518336 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | __start_tp_report 10:18:02 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 10:18:02 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 10:18:02 INFO - PROCESS | 1642 | |i|pagename|runs| 10:18:02 INFO - PROCESS | 1642 | |0;ai-astar;117;162;167;114;113;114;113;114;112;113 10:18:02 INFO - PROCESS | 1642 | |1;audio-beat-detection;152;113;114;150;119;120;116;119;141;142 10:18:02 INFO - PROCESS | 1642 | |2;audio-dft;186;184;184;185;186;183;181;185;183;183 10:18:02 INFO - PROCESS | 1642 | |3;audio-fft;80;59;60;89;61;59;59;62;74;58 10:18:02 INFO - PROCESS | 1642 | |4;audio-oscillator;84;94;116;101;68;69;82;67;69;83 10:18:02 INFO - PROCESS | 1642 | |5;imaging-gaussian-blur;87;85;86;85;87;83;89;85;88;84 10:18:02 INFO - PROCESS | 1642 | |6;imaging-darkroom;94;95;94;94;94;95;93;98;94;95 10:18:02 INFO - PROCESS | 1642 | |7;imaging-desaturate;116;85;87;88;86;86;87;85;85;87 10:18:02 INFO - PROCESS | 1642 | |8;json-parse-financial;58;56;55;54;55;56;56;54;55;55 10:18:02 INFO - PROCESS | 1642 | |9;json-stringify-tinderbox;70;65;69;80;71;69;68;72;70;69 10:18:02 INFO - PROCESS | 1642 | |10;stanford-crypto-aes;87;87;88;102;104;88;87;87;88;87 10:18:02 INFO - PROCESS | 1642 | |11;stanford-crypto-ccm;164;135;158;153;159;162;159;157;215;162 10:18:02 INFO - PROCESS | 1642 | |12;stanford-crypto-pbkdf2;174;194;239;192;174;175;174;172;170;175 10:18:02 INFO - PROCESS | 1642 | |13;stanford-crypto-sha256-iterative;71;68;70;70;71;80;87;89;86;71 10:18:02 INFO - PROCESS | 1642 | __end_tp_report 10:18:02 INFO - PROCESS | 1642 | __start_cc_report 10:18:02 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1970 10:18:02 INFO - PROCESS | 1642 | __end_cc_report 10:18:02 INFO - PROCESS | 1642 | __startTimestamp1480443482520__endTimestamp 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | ------- Summary: start ------- 10:18:02 INFO - PROCESS | 1642 | Number of tests: 14 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#0] ai-astar Cycles:10 Average:123.90 Median:114.00 stddev:21.47 (18.8%) stddev-sans-first:22.63 10:18:02 INFO - PROCESS | 1642 | Values: 117.0 162.0 167.0 114.0 113.0 114.0 113.0 114.0 112.0 113.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:130.50 stddev:15.68 (12.0%) stddev-sans-first:14.16 10:18:02 INFO - PROCESS | 1642 | Values: 152.0 113.0 114.0 150.0 119.0 120.0 116.0 119.0 141.0 142.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.56 (0.8%) stddev-sans-first:1.48 10:18:02 INFO - PROCESS | 1642 | Values: 186.0 184.0 184.0 185.0 186.0 183.0 181.0 185.0 183.0 183.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.50 stddev:10.94 (17.8%) stddev-sans-first:10.38 10:18:02 INFO - PROCESS | 1642 | Values: 80.0 59.0 60.0 89.0 61.0 59.0 59.0 62.0 74.0 58.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:75.50 stddev:16.36 (21.7%) stddev-sans-first:17.35 10:18:02 INFO - PROCESS | 1642 | Values: 84.0 94.0 116.0 101.0 68.0 69.0 82.0 67.0 69.0 83.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.50 stddev:1.85 (2.1%) stddev-sans-first:1.92 10:18:02 INFO - PROCESS | 1642 | Values: 87.0 85.0 86.0 85.0 87.0 83.0 89.0 85.0 88.0 84.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:94.50 stddev:1.35 (1.4%) stddev-sans-first:1.41 10:18:02 INFO - PROCESS | 1642 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 93.0 98.0 94.0 95.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#7] imaging-desaturate Cycles:10 Average:89.20 Median:86.50 stddev:9.47 (11.0%) stddev-sans-first:1.09 10:18:02 INFO - PROCESS | 1642 | Values: 116.0 85.0 87.0 88.0 86.0 86.0 87.0 85.0 85.0 87.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.17 (2.1%) stddev-sans-first:0.78 10:18:02 INFO - PROCESS | 1642 | Values: 58.0 56.0 55.0 54.0 55.0 56.0 56.0 54.0 55.0 55.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:3.89 (5.6%) stddev-sans-first:4.12 10:18:02 INFO - PROCESS | 1642 | Values: 70.0 65.0 69.0 80.0 71.0 69.0 68.0 72.0 70.0 69.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:87.00 stddev:6.62 (7.6%) stddev-sans-first:6.90 10:18:02 INFO - PROCESS | 1642 | Values: 87.0 87.0 88.0 102.0 104.0 88.0 87.0 87.0 88.0 87.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:160.50 stddev:20.22 (12.6%) stddev-sans-first:21.44 10:18:02 INFO - PROCESS | 1642 | Values: 164.0 135.0 158.0 153.0 159.0 162.0 159.0 157.0 215.0 162.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:175.00 stddev:21.06 (12.0%) stddev-sans-first:22.03 10:18:02 INFO - PROCESS | 1642 | Values: 174.0 194.0 239.0 192.0 174.0 175.0 174.0 172.0 170.0 175.0 10:18:02 INFO - PROCESS | 1642 | 10:18:02 INFO - PROCESS | 1642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:75.50 stddev:8.27 (11.0%) stddev-sans-first:8.55 10:18:02 INFO - PROCESS | 1642 | Values: 71.0 68.0 70.0 70.0 71.0 80.0 87.0 89.0 86.0 71.0 10:18:02 INFO - PROCESS | 1642 | -------- Summary: end -------- 10:18:02 INFO - PROCESS | 1642 | 10:18:03 INFO - TEST-INFO | 1642: exit 0 10:18:03 INFO - TEST-OK | kraken | took 60756ms 10:18:03 INFO - SUITE-END | took 1182s 10:18:03 INFO - Completed test suite (00:19:42) 10:18:03 INFO - javascript benchmark 10:18:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3243.82158981256, 3272.8527216275265, 3286.129175768421, 3322.983385083074, 3346.180185854466, 5495.835124946258, 5529.585281103913, 5607.551395888329, 5617.185508101323, 5643.802466913664, 5596.58025648077, 5627.943720562793, 5674.00704876646, 5701.857453563663, 5732.5987180897455, 4384.649228061748, 5006.499350065001, 5077.949220507785, 5104.0, 5177.792888284464, 5139.15203991341, 5215.791368345281, 5237.166991552964, 5246.0, 5287.603429742765, 4243.236217480852, 5051.0150520648485, 5191.117510023305, 5204.583633309327, 5266.315379000744, 4874.317595536592, 5085.821996230151, 5086.18621020635, 5108.386993560796, 5145.536901678867, 4946.183879659852, 5099.031184075014, 5128.999845030221, 5130.384353877558, 5139.229115632647, 5621.690807005613, 5631.099024156157, 5634.014047541664, 5658.490735833795, 5686.715664216773, 5963.98612235921, 6024.819255422344, 6037.064255040432, 6078.604890682136, 6202.503799696058, 6234.501239900843, 6257.249130104371, 6258.092576576417, 6270.372962703739, 6272.121902933547, 4818.59041981432, 5760.539156867399, 5766.769329226784, 5780.219670344533, 5784.739686714024, 5662.556048207681, 5942.227510423617, 6097.288715798892, 6302.464290535356, 6353.205849268841, 5854.941450585525, 5904.202932604129, 5980.252468441445, 6098.14625952367, 6133.0, 5637.605367624227, 6231.22109736283, 6233.906491402633, 6238.064290356483, 6241.126242326078, 5767.653940763567, 6023.6385816851125, 6140.688304616564, 6148.723307451175, 6168.907466388007, 5976.641401515923, 6057.061155520902, 6057.545684073712, 6112.0171844544475, 6192.009278515416, 4857.53853383928, 4861.465238823726, 4865.270209468537, 4870.488598697086, 4877.268409738496, 4203.768792716369, 4380.189664911938, 4421.115776844644, 4422.778861056999, 4441.000774825703, 5677.858053548612, 5704.372519022904, 5735.996200664867, 5771.711414429262, 5774.538036957033, 6158.199434073542, 6236.002239641635, 6254.6247225166635, 6268.529860260499, 6272.18461599989, 5543.085390910454, 5602.943970560243, 5722.713864306768, 5727.455891690282, 5739.799107031234, 4884.780184891689, 4971.477994810565, 5303.04545181871, 5351.678899266057, 5406.189071639285, 6291.307956124822, 6319.52603554726, 6321.462675672619, 6340.048992651139, 6345.0482427636225, 6077.331493535619, 6256.374362563707, 6257.2804127525915, 6270.937290627217, 6279.120923070683, 6191.628502289697, 6251.34360892118, 6274.968625156845, 6290.056491526125, 6333.334999824952, 6033.064874944391, 6111.227117700271, 6134.589663226307, 6137.346341658241, 6142.7136481981925, 6176.135341052166, 6210.347913469202, 6215.689215539114, 6216.316205217332, 6233.719482623384, 5798.855028624318, 5869.148973398918, 6007.158997740407, 6035.525942304, 6044.90932636002, 5927.347991720993, 5945.464908158287, 5999.040153575407, 6054.848628784315, 6090.2996155440915, 5894.469497745224, 5897.469227769521, 5904.173415721888, 5914.556408269483, 5916.674582897982, 5836.766529338779, 6009.819705408845, 6019.578629495893, 6024.036154215304, 6027.30685971119, 5771.769129234784, 5795.971020145041, 5798.739056742541, 5841.357450680507, 5847.766089356378], "value": 5610.387695605136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.17895913712294, 476.8174926183066, 480.7812445337372, 484.1430667718139, 527.7809708970777, 29249.0, 29753.40493190135, 30904.845475772618, 40614.59385406145, 41276.79361603195, 40463.79768101163, 40824.0, 40834.97912552187, 41048.76853694386, 41087.178256434854, 9206.49364284964, 9349.2988025898, 9361.57872895718, 9365.906340936572, 9390.765230869214, 8383.664653413887, 8627.741167764945, 9222.769430764218, 9333.579988900481, 10961.177911656618, 10967.232293739442, 11195.888041119606, 11212.495437705282, 11216.439178041106, 11221.438928053605, 11093.112550995982, 11193.7201569961, 11256.831147532794, 11259.1555633327, 11270.154738394653, 7293.963530182368, 8224.136465671138, 10781.191410644233, 11042.006219440289, 11086.722831929186, 36597.451038234445, 38492.0, 38569.0, 38616.03459913497, 38660.420093698616, 3276.1318250663594, 3276.6068071831533, 3276.639569647337, 3354.8658053677823, 3527.717067355459, 28691.56962645562, 29086.0, 29900.10299690991, 29947.850260748775, 29967.250818729488, 3117.173948903542, 3182.0931034655014, 3223.516472529116, 3261.119497735598, 3295.2091498040536, 422416.0, 425801.8709906462, 426343.86828065664, 428652.0, 429424.0, 56581.43418565844, 56798.43201568014, 56826.7158664204, 56857.14714279289, 56859.43140568624, 58741.11888321678, 58763.412365875796, 58787.118193227136, 58799.0, 59025.81948361009, 14533.27333633314, 14715.55853324402, 14733.0, 14742.189179595225, 14753.631159221106, 11863.822042669366, 11914.868087531671, 11915.88084119165, 11923.642290731292, 11934.880651193376, 11211.327320360804, 14238.572842814732, 14257.928710356382, 15928.123953182454, 16061.277242524115, 4856.211088052207, 5799.507041901401, 6480.675966201671, 6590.681863627294, 6596.637184954778, 833.7082021292621, 848.274725110022, 871.507598207011, 921.1433366968649, 959.3907868503551, 25163.62254566183, 28671.56992645112, 28756.568651470243, 29386.853065734962, 29660.851695741814, 986.2061040862175, 992.7021893431942, 1022.4529876516177, 1027.1936529824052, 1078.8112080385902, 14668.486602969058, 15097.641212290728, 15173.848261517243, 15196.544103676908, 15526.378944842305, 549222.0, 549721.0, 550068.0, 551395.4860451344, 551885.0, 56257.43742562604, 56428.87142257132, 56462.717686411306, 56694.43305566974, 56699.71650141806, 1278.8145718870712, 1322.7486777512242, 1338.7456383287144, 1340.5844188301853, 1345.387848528917, 24922.376940575905, 26117.608235876858, 28699.699534553794, 29575.556366654087, 29651.258718532208, 50013.74993125011, 50193.4941951742, 50222.0, 50299.49101526813, 50411.74794126006, 499213.0, 499487.0, 501060.0, 501132.0, 502198.0, 38740.6125938737, 39287.60712392954, 39681.2063758729, 39811.60188398079, 39889.20221595494, 44997.32504012377, 45270.868228293235, 45336.0, 46506.767466162455, 48753.75623121862, 35620.64379356277, 37728.81135594304, 38311.80844095762, 38687.226255475296, 39814.40278395768, 32106.83946580252, 36585.45121823122, 38136.04659883414, 38286.80856595699, 38601.6139838598, 34178.82910585431, 36915.26169476542, 37393.0, 37632.871013869626, 37971.24057518779, 30946.381072378877, 33366.666333336354, 33471.33057338791, 33534.826281080044, 33688.0, 19474.415767526996, 24305.288257259177, 24337.878310608332, 25026.499470010134, 25157.622635660846], "value": 19192.180902109638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.276072670662, 371.4094589602532, 373.24604299315365, 382.93872980323135, 401.14155706787477, 14521.0, 14762.483313084043, 15293.541193764177, 16352.918235408806, 19539.12073956672, 18787.24851005958, 19805.504862378446, 19937.003149842487, 19944.0, 20149.395518134443, 5787.421257874211, 5919.2009078774245, 5964.821055368346, 5967.075103358986, 5969.477783165286, 5176.974115129438, 5345.7059861707785, 5931.703414829241, 5977.521798256129, 5995.1906492623375, 5027.974860125694, 5901.409859014086, 5909.852253693671, 5915.911261331084, 5916.26046744157, 4842.61259099273, 5483.232347471358, 5826.854328641775, 5859.062549992023, 5864.354920958691, 5485.4640700603895, 5646.237757902672, 5666.461686139852, 5679.488846003838, 5850.64896106235, 12778.169418987736, 13102.148360356641, 13123.60629181126, 13137.802932955918, 15433.691326173526, 1892.3565987564157, 2145.6030634332697, 2164.7943445372666, 2183.9235626753148, 2296.1045192374986, 7906.486078404942, 9784.0, 9784.364016338986, 10244.733090448264, 10320.174386049173, 1532.716447457224, 1745.1623220853935, 1791.2118667786133, 1825.6348730254003, 1862.2737132518328, 107131.0, 107586.0, 107900.92099078988, 107907.0, 108635.45682271617, 11353.886461135447, 11380.658580242605, 11460.94269528647, 11529.250598711056, 11662.416879156008, 14526.782098268535, 14568.344424500923, 14599.92700036493, 14608.707825843636, 14617.196054216907, 7954.960225198837, 8031.196880311922, 8248.876266856001, 8414.957925210334, 8432.988041434945, 7918.564478953713, 8025.277725004661, 8053.355731541463, 8180.222878826621, 8182.0, 4508.346289787963, 4515.029268707178, 4526.506252936589, 4530.161920044802, 4599.0, 1623.2857542681184, 1703.8807283490037, 1854.4871698848137, 1906.4852489827947, 1937.4768812420568, 630.7035693224177, 834.8539005673982, 862.7109918177356, 897.6409436225562, 957.3203025851724, 19337.903310483358, 19486.415407537796, 20924.686129708065, 21322.14711411557, 21422.89288553547, 877.2674816528271, 889.2930120554175, 900.9098990221773, 913.6162811619135, 944.2493217891792, 7987.121416644164, 9423.246140308758, 10820.72948176286, 10829.29609575375, 10836.970487803803, 518817.0, 531161.0, 534049.0, 534859.0, 534992.0, 115246.0, 117227.0, 121384.0, 122113.0, 123614.38192808979, 721.3904250907974, 890.7773056735816, 955.5699935029264, 958.4441024205944, 958.7363475044418, 18157.27370905149, 18198.181081851082, 18236.544086397946, 18311.816881831543, 18371.265149393876, 30126.0, 49492.0, 50049.74975125101, 51132.97734045224, 51136.0, 70223.94664080146, 71200.64399678176, 71249.28750712426, 71270.64364678143, 72204.27795722186, 7684.11632662251, 7887.092984306878, 8027.8795818063945, 8077.192280771876, 8175.713850015459, 9165.816683666157, 12387.380630968235, 12500.686329807837, 12739.363031848185, 12751.298678572768, 10921.453927303763, 11190.776184476103, 11262.324260544394, 11291.43542822872, 11340.979311861973, 10414.594029806181, 10706.464676766287, 10740.462976851282, 11103.50034248477, 11220.495077721358, 10313.690589282334, 11167.329960202414, 11211.327320360479, 11396.202265841312, 11455.885441145481, 7972.960135199287, 8152.755417337252, 8196.221358970888, 8392.244697977212, 8416.4950102994, 10406.323588966692, 10960.068394186583, 11232.3260604364, 11254.043406310228, 11324.886751132382], "value": 8989.907207368824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.956621301361, 1526.358929249715, 1637.3941641592605, 1773.6630040292334, 1824.8905065696067, 7415.814604634887, 7665.5783931883725, 7969.840603187933, 8375.246227839501, 8396.328293736495, 7530.171681115073, 7991.280784729373, 8227.712030078934, 8232.1356257593, 8242.29940455062, 2249.6288112461466, 2289.473421113145, 2290.1526435218993, 2292.6904867842795, 2294.6902168207243, 2043.3767700851236, 2141.68945502902, 2180.3023032629567, 2287.3938406322336, 2305.0, 2052.568960518293, 2094.8219401350902, 2125.95748085039, 2222.4443889027743, 2295.2081531871563, 2103.4110449074283, 2254.0, 2279.168103642175, 2279.384566167142, 2280.429892526868, 2282.5206706591634, 2303.55080759252, 2303.781140791622, 2308.549832782608, 2310.722713274401, 8218.013838339377, 8306.08633050364, 8391.874121888177, 8394.412391132622, 8401.201885820838, 4952.356193694796, 5109.4379618241965, 5113.309703190059, 5126.615503837227, 5131.7690703918415, 2743.3004583830993, 3192.5952580864346, 3525.6298088700573, 3527.1182204448887, 3531.8057506837113, 1040.1055092620416, 1047.6699839550593, 1058.0636137018716, 1075.0324707763075, 1079.5142186016246, 10451.84322235167, 10475.423851688154, 10618.097461715763, 10619.628313009007, 10624.203184761096, 3924.3328634132267, 4396.0, 4607.76961151941, 4616.422947131608, 4648.140094082605, 9248.7687807804, 9254.398464099811, 9258.768530786649, 9272.72181834546, 9274.768130796783, 5125.103106956342, 5133.512316329943, 5136.897262054738, 5142.562882155059, 5149.0, 4573.47405048417, 4611.723296602215, 4651.162790697707, 4713.575778179912, 4726.834560790356, 3664.6152154023976, 3671.5227020487164, 3684.0, 3791.109089363997, 3805.6194380562274, 1055.4247934875511, 1254.6612414647993, 1257.937103144839, 1263.8925691316342, 1274.2927675140386, 623.9594426362272, 759.3976709143702, 811.4198348180961, 862.9816816156995, 909.4770506958394, 5359.410464848864, 5524.254225679482, 5701.600887937804, 5793.362730099686, 5803.709814509258, 934.514052692596, 936.7470782888719, 959.3428501476511, 959.3764053365229, 988.7676396046924, 3343.832808359621, 3639.1629925117372, 3805.7335986481235, 3831.5402151741414, 3923.4114882767244, 9531.761705957268, 9972.202223822076, 9977.650782222587, 9982.550785214682, 10007.499625018865, 9923.156531694742, 9924.553395097239, 9925.950370248103, 9928.453935033642, 9935.304528683067, 7305.525140865827, 7615.352695020985, 7617.466777325534, 7621.618919054136, 7702.460827742004, 5697.259356283656, 5741.363711342247, 5816.167907109247, 5891.440313170242, 5946.821595352147, 7814.335781458412, 8144.226298501633, 9020.59407326685, 9228.538573071186, 9305.302102342215, 9284.257259419095, 9383.577739001625, 9430.62277508892, 9455.669051583161, 9526.761830954281, 6818.897716534157, 7073.115860517435, 7147.249538798559, 7228.674709637974, 7228.96385518069, 7842.64708088126, 7922.960385198037, 7923.405744569296, 7932.405069619686, 7936.920630793849, 5987.0, 6928.896066558905, 6977.33715297046, 6999.895001574879, 7144.24985376528, 6866.416354609914, 6868.107146070979, 6880.724771009103, 6899.827504312432, 6934.791956241321, 6538.248101468392, 6545.345465453416, 6552.57408268461, 6609.339066093352, 6616.338366163538, 4778.426588809365, 4784.856454306377, 4802.255650374198, 4858.684185527929, 4938.259261110862, 4750.952490475051, 4758.738269395217, 4838.491958344323, 4906.509349065208, 5015.322931404214], "value": 4346.619167572913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.0923827706357, 300.4126931848237, 303.67961800300674, 311.3989999301347, 314.19722608734673, 4550.886227844306, 5010.323606313146, 5193.298904647876, 5275.788968441262, 5282.603804714642, 4420.336949457583, 4896.608271338293, 5089.541941225289, 5133.0, 5176.240078373352, 3966.643002129808, 3969.483967084275, 3973.165635216608, 3990.3216453202954, 4001.7398869073563, 3757.1546402059453, 3790.9810450947707, 3949.4273330367078, 3985.7608543487486, 4014.4179094031347, 2955.660099088611, 3287.1920443755957, 3596.766210196342, 3783.413570896502, 3945.4673619061346, 2959.4525012872473, 3245.8701651933893, 3553.466979953002, 3679.4664773607947, 3789.1853251550774, 3088.7065728755733, 3454.740894432902, 3454.913627159316, 3461.6019157796923, 3473.1838018065732, 4365.650747940157, 4787.832425865113, 4810.591099756525, 4958.206686930074, 4961.875953101166, 4398.7580683062415, 4491.573300536444, 4559.244690794035, 4578.839740609063, 4592.7933243004145, 5368.818859850827, 5391.676499410048, 5402.91895621566, 5413.621046526745, 5425.403205647375, 3242.367738291034, 3599.1182160370613, 3830.693544516432, 3844.3464611015916, 3859.286032084073, 5519.862003449946, 5676.801311954103, 5772.278465191893, 5800.796972106041, 5810.535157187457, 3287.8656863382093, 3711.1278849470355, 3955.5055618047745, 3974.205158968218, 3981.1838573092446, 3605.4952306677087, 3832.885013449601, 4021.9798901005306, 4049.331860243086, 4073.837046518165, 4014.759114453142, 4019.5578486366476, 4527.909441811211, 4616.76916154191, 4630.448799652154, 5444.727763611882, 5536.916946245809, 5554.389017208104, 5557.972210139004, 5564.4991950724625, 1147.449224372306, 1188.6434069779032, 1211.6425654431964, 1298.435385360657, 1303.4069498378215, 816.6243527977078, 820.4257020085963, 842.5955541340192, 847.3729440214197, 889.7330800759746, 4047.8988025299013, 4242.490901091827, 4341.782910854445, 4824.863838505, 4877.902441951142, 4735.976320118446, 4893.437254715682, 5200.947990520122, 5275.340582427197, 5361.705106219196, 4281.379200016043, 4563.95436045642, 4619.838305659286, 4705.731945380067, 4751.788293985081, 2326.674265602817, 2401.903923843062, 2655.1636234586044, 2670.4230417647063, 2774.834569480823, 5115.5396014358885, 5305.116683577275, 5357.651752636144, 5414.485623865727, 5516.365617953987, 4428.276609884898, 4558.014500502177, 4844.370231869834, 5334.279872217278, 5496.735750777344, 4672.8504887752015, 4815.133276010351, 5086.465921078234, 5276.525112739795, 5471.917921231265, 4240.533541310391, 4454.985769211538, 4663.603593694438, 5238.476152384731, 5246.275144647343, 3821.770693758272, 5557.44425557441, 5654.971725141512, 5657.209669521349, 5670.489655930986, 5107.591392688501, 5752.367239603556, 5812.912806307824, 5908.497777688773, 5929.288485381781, 3066.034199227236, 3792.35529959913, 3817.580066192661, 3830.4062870255157, 3833.348330783829, 4668.486466488752, 5353.063213937623, 5470.863228419322, 5696.686682232351, 5739.9139012915675, 4561.475430325422, 5029.74851257443, 5478.45215478449, 5535.723213839211, 5555.0, 5065.3161823153405, 5239.135542635422, 5448.318960129984, 5471.173200541411, 5526.806561770319, 4827.165677042702, 4951.10880041596, 5182.559482443884, 5276.973615131899, 5464.896015034161, 4468.597826195658, 4604.401427814362, 4996.0, 5021.07110184617, 5415.1047133504535, 4983.476734942924, 5395.785948161632, 5405.324334458192, 5418.349798024262, 5448.427915068861], "value": 3887.2070493540045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.8115802943058, 679.3206793206793, 704.7533363322838, 718.8885722712978, 775.383570061801, 14725.852741472581, 15338.693226135485, 15342.693146137084, 15602.921985390085, 15614.453494127707, 13813.447462101529, 14077.50728724495, 14221.933354998391, 14359.497417590386, 14373.856261437382, 818.758466252454, 835.1773503099442, 836.9539675317855, 840.315143158324, 841.5203334099566, 645.4771634975662, 665.2482694555146, 817.3706246190429, 830.1656834880936, 833.4832403909554, 867.9218870301671, 887.7780554861284, 887.9200871921526, 888.320434867327, 889.2263730554427, 877.9824403511926, 879.3668558637803, 881.3213825354442, 883.4522595990463, 884.650563027607, 497.5223785166245, 503.7179179659366, 620.6865532905899, 653.8921078022169, 656.6979189572802, 13997.510087147002, 14412.711745765026, 14422.350994205286, 14423.495177668836, 14425.206613636246, 13682.931585342109, 13808.585742427744, 13983.65040873976, 13989.510367137204, 14156.150630962073, 12529.93735031319, 12628.81056784149, 12863.871361286454, 12908.741825163444, 13103.410346534429, 4413.139437809628, 4521.095780843812, 4555.430571178603, 4555.658325625592, 4575.633949284049, 99979.0002099977, 100902.0, 101394.49302753512, 108009.0, 113384.29923551236, 10776.461176941279, 11015.339079655247, 11023.0, 11291.983721464943, 11439.0, 18386.632267354846, 21159.259425920325, 21850.781492185193, 21951.890240548695, 21965.0, 7519.661615227218, 7643.694252229849, 7759.18528554505, 7783.143854176036, 7810.453268271166, 4044.656204222615, 4192.580741925783, 4199.0, 4366.772945797666, 4369.257226271541, 3285.704286614216, 3391.0674564494466, 3423.5720534933134, 3424.366492198951, 3429.3655673700446, 593.3650993437067, 609.4971648390007, 609.7256234694316, 618.6844709198251, 623.557274335218, 446.6154919748753, 509.8731802716039, 554.5406123840779, 597.7698586044318, 614.4500671898626, 8477.74566762998, 8612.440191387539, 8686.478811271343, 8732.781680457912, 9120.81758364829, 529.4969778710164, 568.3492401200602, 609.9024156134997, 617.6911544227886, 633.7845132654919, 3674.632536746304, 4005.7997100144876, 4207.284253334153, 4314.50383205929, 4346.978265108717, 84427.15572844316, 87210.56394717986, 94393.0, 98344.0, 102115.0, 89517.10482895219, 92827.0, 93038.0, 96069.03930960741, 98651.01348986563, 87150.12849871546, 87908.24183516421, 88628.0, 89306.55346723225, 89777.75555611162, 8329.6668133274, 8404.159584041792, 8406.915930840858, 8451.408401411842, 8525.531095789544, 40612.96935153171, 51254.487455126466, 51738.0, 53623.73188134035, 53784.193237102256, 69293.0, 71253.643731781, 73787.89318160339, 74753.87869181858, 75465.0, 12424.440900159696, 12614.117011809452, 12878.0, 12940.094193406747, 13519.932400337935, 14610.050346727428, 14788.260586970393, 14899.553013409615, 14935.775963360342, 15096.320665570296, 13252.447510617541, 13430.0, 13475.32623368808, 14034.578962631138, 14272.072315299472, 9986.850197246902, 12280.956118729651, 12692.238465692088, 13433.932830336176, 13604.183748975092, 13108.475660973454, 13404.396802143732, 13579.660508487366, 13686.110402823784, 13731.862681373059, 10039.203247277816, 10189.74525636865, 10248.294190543034, 10466.581336746445, 10542.0, 10316.793664126826, 11163.901420342396, 11289.048832908746, 11297.039751620876, 11574.131940104695], "value": 7295.331863703338, "unit": "score"}], "name": "dromaeo_css", "value": 7016.585308705344, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 162.0, 167.0, 114.0, 113.0, 114.0, 113.0, 114.0, 112.0, 113.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 113.0, 114.0, 150.0, 119.0, 120.0, 116.0, 119.0, 141.0, 142.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 184.0, 185.0, 186.0, 183.0, 181.0, 185.0, 183.0, 183.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 89.0, 61.0, 59.0, 59.0, 62.0, 74.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 94.0, 116.0, 101.0, 68.0, 69.0, 82.0, 67.0, 69.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 85.0, 87.0, 83.0, 89.0, 85.0, 88.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 93.0, 98.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 85.0, 87.0, 88.0, 86.0, 86.0, 87.0, 85.0, 85.0, 87.0], "value": 89.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 54.0, 55.0, 56.0, 56.0, 54.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 69.0, 80.0, 71.0, 69.0, 68.0, 72.0, 70.0, 69.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 102.0, 104.0, 88.0, 87.0, 87.0, 88.0, 87.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 135.0, 158.0, 153.0, 159.0, 162.0, 159.0, 157.0, 215.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 194.0, 239.0, 192.0, 174.0, 175.0, 174.0, 172.0, 170.0, 175.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 70.0, 71.0, 80.0, 87.0, 89.0, 86.0, 71.0], "value": 76.3, "unit": "score"}], "name": "kraken", "value": 1494.4, "alertThreshold": 2.0}]} 10:18:03 INFO - Return code: 0 10:18:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:03 INFO - # TBPL SUCCESS # 10:18:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:03 INFO - 2016-11-29 10:18:03.816 screenresolution[1646:10225] starting screenresolution argv=screenresolution get 10:18:03 INFO - 2016-11-29 10:18:03.821 screenresolution[1646:10225] Display 0: 1600x1200x32@60 10:18:03 INFO - 2016-11-29 10:18:03.827 screenresolution[1647:10228] starting screenresolution argv=screenresolution list 10:18:03 INFO - Available Modes on Display 0 10:18:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:04 INFO - Intel Iris: 10:18:04 INFO - Chipset Model: Intel Iris 10:18:04 INFO - Type: GPU 10:18:04 INFO - Bus: Built-In 10:18:04 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:04 INFO - Vendor: Intel (0x8086) 10:18:04 INFO - Device ID: 0x0a2e 10:18:04 INFO - Revision ID: 0x0009 10:18:04 INFO - Displays: 10:18:04 INFO - Display: 10:18:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:04 INFO - Display Serial Number: 1600x1200 60 10:18:04 INFO - Main Display: Yes 10:18:04 INFO - Mirror: Off 10:18:04 INFO - Online: Yes 10:18:04 INFO - Rotation: Supported 10:18:04 INFO - Return code: 0 10:18:04 INFO - Running post-action listener: _resource_record_post_action 10:18:04 INFO - [mozharness: 2016-11-29 18:18:04.071664Z] Finished run-tests step (success) 10:18:04 INFO - Running post-run listener: _resource_record_post_run 10:18:04 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 38495232; Write bytes: 693547008; Read time: 383; Write time: 2472 10:18:04 INFO - TinderboxPrint: CPU usage
53.7% 10:18:04 INFO - TinderboxPrint: I/O read bytes / time
38,495,232 / 383 10:18:04 INFO - TinderboxPrint: I/O write bytes / time
693,547,008 / 2,472 10:18:04 INFO - TinderboxPrint: CPU idle
2,252.1 (46.3%) 10:18:04 INFO - TinderboxPrint: CPU system
974.9 (20.1%) 10:18:04 INFO - TinderboxPrint: CPU user
1,634.7 (33.6%) 10:18:04 INFO - TinderboxPrint: Swap in / out
421,695,488 / 0 10:18:04 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 366719488; Write bytes: 366867968; Read time: 27696; Write time: 844 10:18:04 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 37536768; Write bytes: 308206080; Read time: 366; Write time: 1589 10:18:04 INFO - Running post-run listener: _upload_blobber_files 10:18:04 INFO - Blob upload gear active. 10:18:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:04 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 10:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:18:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:18:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:06 INFO - (blobuploader) - INFO - Done attempting. 10:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:07 INFO - (blobuploader) - INFO - Done attempting. 10:18:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:09 INFO - (blobuploader) - INFO - Done attempting. 10:18:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:09 INFO - Return code: 0 10:18:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708be191587acfc1c11c26ead62a20b18305eaf4aef100c607625e95b93f0496de8faaf0efd496fa1f1437aaaaf65f7c940536150d12dddd09cfa7da028282b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d758beece036a3960cd79f11ac2848af0a3d9f09d8c03b802d85ec56ce25c464d66742bf297412b225cf900786f44e553a9a199a4c85ef320479581048aed2bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14e6a8ced80f5bdfd831b6d2a576e18b746cd710598ae2fe7e9b782c031f73c892af06098865e6e97f2512190843bf601a546d90d2e3c23277b771d92736f545"} 10:18:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:09 INFO - Contents: 10:18:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708be191587acfc1c11c26ead62a20b18305eaf4aef100c607625e95b93f0496de8faaf0efd496fa1f1437aaaaf65f7c940536150d12dddd09cfa7da028282b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d758beece036a3960cd79f11ac2848af0a3d9f09d8c03b802d85ec56ce25c464d66742bf297412b225cf900786f44e553a9a199a4c85ef320479581048aed2bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14e6a8ced80f5bdfd831b6d2a576e18b746cd710598ae2fe7e9b782c031f73c892af06098865e6e97f2512190843bf601a546d90d2e3c23277b771d92736f545"} 10:18:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:09 INFO - Copying logs to upload dir... 10:18:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.829030 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-29 10:18:09.777726) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 10:18:09.786282) ========= 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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708be191587acfc1c11c26ead62a20b18305eaf4aef100c607625e95b93f0496de8faaf0efd496fa1f1437aaaaf65f7c940536150d12dddd09cfa7da028282b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d758beece036a3960cd79f11ac2848af0a3d9f09d8c03b802d85ec56ce25c464d66742bf297412b225cf900786f44e553a9a199a4c85ef320479581048aed2bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14e6a8ced80f5bdfd831b6d2a576e18b746cd710598ae2fe7e9b782c031f73c892af06098865e6e97f2512190843bf601a546d90d2e3c23277b771d92736f545"} build_url:https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010687 build_url: 'https://queue.taskcluster.net/v1/task/FArNcJePR9GhXPnlq2V6kQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708be191587acfc1c11c26ead62a20b18305eaf4aef100c607625e95b93f0496de8faaf0efd496fa1f1437aaaaf65f7c940536150d12dddd09cfa7da028282b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d758beece036a3960cd79f11ac2848af0a3d9f09d8c03b802d85ec56ce25c464d66742bf297412b225cf900786f44e553a9a199a4c85ef320479581048aed2bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14e6a8ced80f5bdfd831b6d2a576e18b746cd710598ae2fe7e9b782c031f73c892af06098865e6e97f2512190843bf601a546d90d2e3c23277b771d92736f545"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 10:18:09.819548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:18:09.822905) ========= 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.tEPPcBzj8f/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.NH6AUtBHEN/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.005131 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:18:09.871584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 10:18:09.872929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 10:18:09.873255) ========= ========= Total master_lag: 4.89 =========