builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1476286438.95 results: success (0) buildid: 20161011132146 builduid: 3cc371284a184299930fc58c8e67a74b revision: 6d67a819cff05013f27677d48528ce3492f429be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 08:33:58.952959) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 08:33:58.953389) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 08:33:58.953662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 08:33:59.016745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 08:33:59.017128) ========= 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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-12 08:33:59-- 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% 14.4M=0.001s 2016-10-12 08:33:59 (14.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 08:33:59.180574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 08:33:59.183940) ========= 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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.029081 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 08:33:59.232582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 08:33:59.236008) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6d67a819cff05013f27677d48528ce3492f429be --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 6d67a819cff05013f27677d48528ce3492f429be --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-12 08:33:59,309 truncating revision to first 12 chars 2016-10-12 08:33:59,309 Setting DEBUG logging. 2016-10-12 08:33:59,309 attempt 1/10 2016-10-12 08:33:59,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6d67a819cff0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 08:34:00,426 unpacking tar archive at: autoland-6d67a819cff0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.391995 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 08:34:00.648848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 08:34:00.649164) ========= script_repo_revision: 6d67a819cff05013f27677d48528ce3492f429be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 08:34:00.649560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 08:34:00.649941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 08:34:00.667907) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-12 08:34:00.668258) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:00 INFO - MultiFileLogger online at 20161012 08:34:00 in /builds/slave/test 08:34:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 08:34:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:00 INFO - {'append_to_log': False, 08:34:00 INFO - 'base_work_dir': '/builds/slave/test', 08:34:00 INFO - 'blob_upload_branch': 'Autoland', 08:34:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:00 INFO - 'branch': 'Autoland', 08:34:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:00 INFO - 'config_files': ('talos/mac_config.py',), 08:34:00 INFO - 'default_actions': ('clobber', 08:34:00 INFO - 'read-buildbot-config', 08:34:00 INFO - 'download-and-extract', 08:34:00 INFO - 'populate-webroot', 08:34:00 INFO - 'create-virtualenv', 08:34:00 INFO - 'install', 08:34:00 INFO - 'run-tests'), 08:34:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:00 INFO - 'download_minidump_stackwalk': True, 08:34:00 INFO - 'download_symbols': 'ondemand', 08:34:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:00 INFO - 'installer_path': 'installer.exe', 08:34:00 INFO - 'log_level': 'info', 08:34:00 INFO - 'log_name': 'talos', 08:34:00 INFO - 'log_to_console': True, 08:34:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:34:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:34:00 INFO - 'opt_config_files': (), 08:34:00 INFO - 'pip_index': False, 08:34:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:00 INFO - 'cmd': ('bash', 08:34:00 INFO - '-c', 08:34:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:00 INFO - 'enabled': True, 08:34:00 INFO - 'halt_on_failure': False, 08:34:00 INFO - 'name': 'check_screen_resolution'},), 08:34:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:00 INFO - 'cmd': ('bash', 08:34:00 INFO - '-c', 08:34:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:00 INFO - 'enabled': True, 08:34:00 INFO - 'halt_on_failure': False, 08:34:00 INFO - 'name': 'check_screen_resolution'},), 08:34:00 INFO - 'run_cmd_checks_enabled': True, 08:34:00 INFO - 'sps_profile': False, 08:34:00 INFO - 'sps_profile_interval': 0, 08:34:00 INFO - 'suite': 'dromaeojs', 08:34:00 INFO - 'system_bits': '32', 08:34:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:00 INFO - 'title': 't-yosemite-r7-0102', 08:34:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:00 INFO - 'use_talos_json': True, 08:34:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:00 INFO - 'work_dir': 'build'} 08:34:00 INFO - [mozharness: 2016-10-12 15:34:00.869156Z] Running clobber step. 08:34:00 INFO - Running pre-action listener: _resource_record_pre_action 08:34:00 INFO - Running main action method: clobber 08:34:00 INFO - rmtree: /builds/slave/test/build 08:34:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:03 INFO - Running post-action listener: _resource_record_post_action 08:34:03 INFO - [mozharness: 2016-10-12 15:34:03.100933Z] Finished clobber step (success) 08:34:03 INFO - [mozharness: 2016-10-12 15:34:03.101060Z] Running read-buildbot-config step. 08:34:03 INFO - Running pre-action listener: _resource_record_pre_action 08:34:03 INFO - Running main action method: read_buildbot_config 08:34:03 INFO - Using buildbot properties: 08:34:03 INFO - { 08:34:03 INFO - "project": "", 08:34:03 INFO - "product": "firefox", 08:34:03 INFO - "script_repo_revision": "production", 08:34:03 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 08:34:03 INFO - "repository": "", 08:34:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 08:34:03 INFO - "buildid": "20161011132146", 08:34:03 INFO - "pgo_build": "False", 08:34:03 INFO - "basedir": "/builds/slave/test", 08:34:03 INFO - "buildnumber": 285, 08:34:03 INFO - "slavename": "t-yosemite-r7-0102", 08:34:03 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:34:03 INFO - "platform": "yosemite_r7", 08:34:03 INFO - "scheduler": "tests-autoland-macosx64-talos", 08:34:03 INFO - "branch": "autoland", 08:34:03 INFO - "repo_path": "integration/autoland", 08:34:03 INFO - "revision": "6d67a819cff05013f27677d48528ce3492f429be", 08:34:03 INFO - "stage_platform": "macosx64", 08:34:03 INFO - "builduid": "3cc371284a184299930fc58c8e67a74b", 08:34:03 INFO - "slavebuilddir": "test" 08:34:03 INFO - } 08:34:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 08:34:03 INFO - Running post-action listener: _resource_record_post_action 08:34:03 INFO - [mozharness: 2016-10-12 15:34:03.104663Z] Finished read-buildbot-config step (success) 08:34:03 INFO - [mozharness: 2016-10-12 15:34:03.104799Z] Running download-and-extract step. 08:34:03 INFO - Running pre-action listener: _resource_record_pre_action 08:34:03 INFO - Running main action method: download_and_extract 08:34:03 INFO - mkdir: /builds/slave/test/build/tests 08:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:03 INFO - trying https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 08:34:03 INFO - Downloading https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 08:34:04 INFO - Downloaded 1199 bytes. 08:34:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:34:04 INFO - Using the following test package requirements: 08:34:04 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:34:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:34:04 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 08:34:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:34:04 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 08:34:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:34:04 INFO - u'jsshell-mac.zip'], 08:34:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:34:04 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 08:34:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:34:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:34:04 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 08:34:04 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:34:04 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 08:34:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:34:04 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 08:34:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:34:04 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 08:34:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:34:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:34:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:34:04 INFO - Fetch https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:34:06 INFO - Http code: 200 08:34:06 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 08:34:06 INFO - x-amz-cf-id: zaWn3IgHoZRAV2A7mqRyTj6YstylrPkc83hzOCAz9UrtT7sMbb0KBQ== 08:34:06 INFO - x-amz-version-id: pOfT4hzdWhFXIgWzlr3X6wGxQd0DqSon 08:34:06 INFO - Expected file size: 16508470 08:34:06 INFO - Obtained file size: 16508470 08:34:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:34:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:34:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:34:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:34:13 INFO - Http code: 200 08:34:13 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 08:34:13 INFO - x-amz-cf-id: -XOX5e0ON-Awo4bgJZW1_Io3nG5Vv6b5Li7E665W01GT1C5G4VnsXA== 08:34:13 INFO - x-amz-version-id: pOfT4hzdWhFXIgWzlr3X6wGxQd0DqSon 08:34:13 INFO - Expected file size: 16508470 08:34:13 INFO - Obtained file size: 16508470 08:34:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 08:34:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:34:20 INFO - Fetch https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 08:34:21 INFO - Http code: 200 08:34:21 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 08:34:21 INFO - x-amz-cf-id: EVk2IqIQoX3kO9xOqfIwmksOXE3xa1-w4EOHeGeOdqoYjs0vKiMroA== 08:34:21 INFO - x-amz-version-id: oo4vVtFrO4tmnLETKt63Cz5Rg_Ijc.lW 08:34:21 INFO - Expected file size: 14409006 08:34:21 INFO - Obtained file size: 14409006 08:34: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')]} 08:34:21 INFO - trying https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:34:21 INFO - Downloading https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 08:34:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 08:34:24 INFO - Downloaded 111678731 bytes. 08:34:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:34:24 INFO - mkdir: /builds/slave/test/properties 08:34:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:34:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:34:24 INFO - Contents: 08:34:24 INFO - build_url:https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:34:25 INFO - Running post-action listener: _resource_record_post_action 08:34:25 INFO - Running post-action listener: set_extra_try_arguments 08:34:25 INFO - [mozharness: 2016-10-12 15:34:25.304626Z] Finished download-and-extract step (success) 08:34:25 INFO - [mozharness: 2016-10-12 15:34:25.304778Z] Running populate-webroot step. 08:34:25 INFO - Running pre-action listener: _resource_record_pre_action 08:34:25 INFO - Running main action method: populate_webroot 08:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:34:25 INFO - '--tppagecycles', 08:34:25 INFO - '7'], 08:34:25 INFO - 'tests': ['tsvgm']}}, 08:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:34:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:25 INFO - 'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:25 INFO - 'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['damp', 'tps']}, 08:34:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:25 INFO - 'tests': ['damp', 'tps']}, 08:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['dromaeo_dom']}, 08:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:34:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['basic_compositor_video']}, 08:34:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['a11yr', 08:34:25 INFO - 'ts_paint', 08:34:25 INFO - 'tpaint', 08:34:25 INFO - 'sessionrestore', 08:34:25 INFO - 'sessionrestore_no_auto_restore', 08:34:25 INFO - 'tabpaint']}, 08:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:34:25 INFO - 'ts_paint', 08:34:25 INFO - 'tpaint', 08:34:25 INFO - 'sessionrestore', 08:34:25 INFO - 'sessionrestore_no_auto_restore', 08:34:25 INFO - 'tabpaint']}, 08:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:34:25 INFO - 'ts_paint', 08:34:25 INFO - 'tpaint', 08:34:25 INFO - 'sessionrestore', 08:34:25 INFO - 'sessionrestore_no_auto_restore', 08:34:25 INFO - 'tabpaint']}, 08:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:34:25 INFO - 'ts_paint', 08:34:25 INFO - 'tpaint', 08:34:25 INFO - 'sessionrestore', 08:34:25 INFO - 'sessionrestore_no_auto_restore', 08:34:25 INFO - 'tabpaint']}, 08:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['a11yr', 08:34:25 INFO - 'ts_paint', 08:34:25 INFO - 'tpaint', 08:34:25 INFO - 'sessionrestore', 08:34:25 INFO - 'sessionrestore_no_auto_restore', 08:34:25 INFO - 'tabpaint']}, 08:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['a11yr', 08:34:25 INFO - 'ts_paint', 08:34:25 INFO - 'tpaint', 08:34:25 INFO - 'sessionrestore', 08:34:25 INFO - 'sessionrestore_no_auto_restore', 08:34:25 INFO - 'tabpaint']}, 08:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['tsvgx', 08:34:25 INFO - 'tsvgr_opacity', 08:34:25 INFO - 'tart', 08:34:25 INFO - 'tscrollx', 08:34:25 INFO - 'cart']}, 08:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:34:25 INFO - 'tsvgr_opacity', 08:34:25 INFO - 'tart', 08:34:25 INFO - 'tscrollx', 08:34:25 INFO - 'cart']}, 08:34:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:25 INFO - 'talos_options': ['--disable-e10s'], 08:34:25 INFO - 'tests': ['tp5o']}, 08:34:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:25 INFO - 'tests': ['tp5o']}, 08:34:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:25 INFO - 'talos_options': ['--disable-e10s', 08:34:25 INFO - '--xperf_path', 08:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:25 INFO - 'tests': ['tp5n']}, 08:34:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:25 INFO - 'talos_options': ['--xperf_path', 08:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:25 INFO - 'tests': ['tp5n']}}, 08:34:25 INFO - 'talos.zip': {'path': '', 08:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:34:25 INFO - Running post-action listener: _resource_record_post_action 08:34:25 INFO - [mozharness: 2016-10-12 15:34:25.323805Z] Finished populate-webroot step (success) 08:34:25 INFO - [mozharness: 2016-10-12 15:34:25.323914Z] Running create-virtualenv step. 08:34:25 INFO - Running pre-action listener: _resource_record_pre_action 08:34:25 INFO - Running main action method: create_virtualenv 08:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:34:25 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 08:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:34:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:34:25 INFO - Using real prefix '/tools/python27' 08:34:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:34:26 INFO - Installing distribute.............................................................................................................................................................................................done. 08:34:29 INFO - Installing pip.................done. 08:34:29 INFO - Return code: 0 08:34:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:34:29 INFO - Reading from file tmpfile_stdout 08:34:29 INFO - Output received: 08:34:29 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) 08:34:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:29 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 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:29 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 08:34:29 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 08:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:29 INFO - 'HOME': '/Users/cltbld', 08:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:29 INFO - 'LOGNAME': 'cltbld', 08:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:29 INFO - 'MOZ_NO_REMOTE': '1', 08:34:29 INFO - 'NO_EM_RESTART': '1', 08:34:29 INFO - 'PAGER': '/bin/cat', 08:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:29 INFO - 'PWD': '/builds/slave/test', 08:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:29 INFO - 'SHELL': '/bin/bash', 08:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:29 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:29 INFO - 'USER': 'cltbld', 08:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:29 INFO - 'XPC_FLAGS': '0x0', 08:34:29 INFO - 'XPC_SERVICE_NAME': '0', 08:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:29 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 08:34:29 INFO - Cleaning up... 08:34:29 INFO - Return code: 0 08:34:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:29 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 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:29 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 08:34:29 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 08:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:29 INFO - 'HOME': '/Users/cltbld', 08:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:29 INFO - 'LOGNAME': 'cltbld', 08:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:29 INFO - 'MOZ_NO_REMOTE': '1', 08:34:29 INFO - 'NO_EM_RESTART': '1', 08:34:29 INFO - 'PAGER': '/bin/cat', 08:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:29 INFO - 'PWD': '/builds/slave/test', 08:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:29 INFO - 'SHELL': '/bin/bash', 08:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:29 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:29 INFO - 'USER': 'cltbld', 08:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:29 INFO - 'XPC_FLAGS': '0x0', 08:34:29 INFO - 'XPC_SERVICE_NAME': '0', 08:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:29 INFO - Downloading/unpacking psutil>=3.1.1 08:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:34:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:33 INFO - Installing collected packages: psutil 08:34:33 INFO - Running setup.py install for psutil 08:34:33 INFO - building 'psutil._psutil_osx' extension 08:34:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:34:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:34:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:34:34 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 08:34:34 INFO - building 'psutil._psutil_posix' extension 08:34:34 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 08:34:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:34:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:34:34 INFO - ^ 08:34:34 INFO - 1 warning generated. 08:34:34 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 08:34:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:34 INFO - Successfully installed psutil 08:34:34 INFO - Cleaning up... 08:34:34 INFO - Return code: 0 08:34:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:34 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 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:34 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 08:34:34 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 08:34:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:34 INFO - 'HOME': '/Users/cltbld', 08:34:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:34 INFO - 'LOGNAME': 'cltbld', 08:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:34 INFO - 'MOZ_NO_REMOTE': '1', 08:34:34 INFO - 'NO_EM_RESTART': '1', 08:34:34 INFO - 'PAGER': '/bin/cat', 08:34:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:34 INFO - 'PWD': '/builds/slave/test', 08:34:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:34 INFO - 'SHELL': '/bin/bash', 08:34:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:34 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:34 INFO - 'USER': 'cltbld', 08:34:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:34 INFO - 'XPC_FLAGS': '0x0', 08:34:34 INFO - 'XPC_SERVICE_NAME': '0', 08:34:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:34:37 INFO - Installing collected packages: mozsystemmonitor 08:34:37 INFO - Running setup.py install for mozsystemmonitor 08:34:37 INFO - Successfully installed mozsystemmonitor 08:34:37 INFO - Cleaning up... 08:34:37 INFO - Return code: 0 08:34:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:34: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')]} 08:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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')]} 08:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:37 INFO - 'HOME': '/Users/cltbld', 08:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:37 INFO - 'LOGNAME': 'cltbld', 08:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:37 INFO - 'MOZ_NO_REMOTE': '1', 08:34:37 INFO - 'NO_EM_RESTART': '1', 08:34:37 INFO - 'PAGER': '/bin/cat', 08:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:37 INFO - 'PWD': '/builds/slave/test', 08:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:37 INFO - 'SHELL': '/bin/bash', 08:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:37 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:37 INFO - 'USER': 'cltbld', 08:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:37 INFO - 'XPC_FLAGS': '0x0', 08:34:37 INFO - 'XPC_SERVICE_NAME': '0', 08:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:37 INFO - Downloading/unpacking jsonschema==2.5.1 08:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:34:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:34:40 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 08:34:40 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 08:34:40 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 08:34:40 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 08:34:40 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 08:34:40 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 08:34:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:34:40 INFO - warning: no files found matching '*.txt' 08:34:40 INFO - no previously-included directories found matching 'build' 08:34:40 INFO - no previously-included directories found matching 'dist' 08:34:40 INFO - no previously-included directories found matching '.git*' 08:34:40 INFO - Installing collected packages: jsonschema, functools32 08:34:40 INFO - Running setup.py install for functools32 08:34:40 INFO - warning: no files found matching '*.txt' 08:34:40 INFO - no previously-included directories found matching 'build' 08:34:40 INFO - no previously-included directories found matching 'dist' 08:34:40 INFO - no previously-included directories found matching '.git*' 08:34:41 INFO - Successfully installed jsonschema functools32 08:34:41 INFO - Cleaning up... 08:34:41 INFO - Return code: 0 08:34:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:41 INFO - 'HOME': '/Users/cltbld', 08:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:41 INFO - 'LOGNAME': 'cltbld', 08:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:41 INFO - 'MOZ_NO_REMOTE': '1', 08:34:41 INFO - 'NO_EM_RESTART': '1', 08:34:41 INFO - 'PAGER': '/bin/cat', 08:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:41 INFO - 'PWD': '/builds/slave/test', 08:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:41 INFO - 'SHELL': '/bin/bash', 08:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:41 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:41 INFO - 'USER': 'cltbld', 08:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:41 INFO - 'XPC_FLAGS': '0x0', 08:34:41 INFO - 'XPC_SERVICE_NAME': '0', 08:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:34:41 INFO - Cleaning up... 08:34:41 INFO - Return code: 0 08:34:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:41 INFO - 'HOME': '/Users/cltbld', 08:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:41 INFO - 'LOGNAME': 'cltbld', 08:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:41 INFO - 'MOZ_NO_REMOTE': '1', 08:34:41 INFO - 'NO_EM_RESTART': '1', 08:34:41 INFO - 'PAGER': '/bin/cat', 08:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:41 INFO - 'PWD': '/builds/slave/test', 08:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:41 INFO - 'SHELL': '/bin/bash', 08:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:41 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:41 INFO - 'USER': 'cltbld', 08:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:41 INFO - 'XPC_FLAGS': '0x0', 08:34:41 INFO - 'XPC_SERVICE_NAME': '0', 08:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:34:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:34: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 08:34: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 08:34: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 08:34: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 08:34: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 08:34: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 08:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:34:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:34: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 08:34: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 08:34: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 08:34: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 08:34: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 08:34: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 08:34:45 INFO - Downloading docopt-0.6.1.tar.gz 08:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:34:45 INFO - Installing collected packages: blobuploader, requests, docopt 08:34:45 INFO - Running setup.py install for blobuploader 08:34:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:34:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:34:45 INFO - Running setup.py install for requests 08:34:46 INFO - Running setup.py install for docopt 08:34:46 INFO - Successfully installed blobuploader requests docopt 08:34:46 INFO - Cleaning up... 08:34:46 INFO - Return code: 0 08:34:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:34:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:46 INFO - 'HOME': '/Users/cltbld', 08:34:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:46 INFO - 'LOGNAME': 'cltbld', 08:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:46 INFO - 'MOZ_NO_REMOTE': '1', 08:34:46 INFO - 'NO_EM_RESTART': '1', 08:34:46 INFO - 'PAGER': '/bin/cat', 08:34:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:46 INFO - 'PWD': '/builds/slave/test', 08:34:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:46 INFO - 'SHELL': '/bin/bash', 08:34:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:46 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:46 INFO - 'USER': 'cltbld', 08:34:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:46 INFO - 'XPC_FLAGS': '0x0', 08:34:46 INFO - 'XPC_SERVICE_NAME': '0', 08:34:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Z7p32T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ZYEHil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-EkuJRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-5G85W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-pcE2VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-CeuJsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ekZCle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-WABs97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-g7d2sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-77Xd0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-HVIENz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-4yW9Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-XgxxKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-v_KaHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:48 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ayhJyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:48 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-FFWyuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:48 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-tTuyRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:34:48 INFO - Running setup.py install for manifestparser 08:34:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:34:48 INFO - Running setup.py install for mozcrash 08:34:48 INFO - Running setup.py install for mozdebug 08:34:48 INFO - Running setup.py install for mozdevice 08:34:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:34:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:34:48 INFO - Running setup.py install for mozfile 08:34:49 INFO - Running setup.py install for mozhttpd 08:34:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:34:49 INFO - Running setup.py install for mozinfo 08:34:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:34:49 INFO - Running setup.py install for mozInstall 08:34:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:34:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:34:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:34:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:34:49 INFO - Running setup.py install for mozleak 08:34:49 INFO - Running setup.py install for mozlog 08:34:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:34:49 INFO - Running setup.py install for moznetwork 08:34:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:34:50 INFO - Running setup.py install for mozprocess 08:34:50 INFO - Running setup.py install for mozprofile 08:34:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:34:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:34:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:34:50 INFO - Running setup.py install for mozrunner 08:34:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:34:50 INFO - Running setup.py install for mozscreenshot 08:34:50 INFO - Running setup.py install for moztest 08:34:50 INFO - Running setup.py install for mozversion 08:34:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:34:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:34:50 INFO - Cleaning up... 08:34:50 INFO - Return code: 0 08:34:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:51 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 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:51 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 08:34:51 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 08:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:51 INFO - 'HOME': '/Users/cltbld', 08:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:51 INFO - 'LOGNAME': 'cltbld', 08:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:51 INFO - 'MOZ_NO_REMOTE': '1', 08:34:51 INFO - 'NO_EM_RESTART': '1', 08:34:51 INFO - 'PAGER': '/bin/cat', 08:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:51 INFO - 'PWD': '/builds/slave/test', 08:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:51 INFO - 'SHELL': '/bin/bash', 08:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:51 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:51 INFO - 'USER': 'cltbld', 08:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:51 INFO - 'XPC_FLAGS': '0x0', 08:34:51 INFO - 'XPC_SERVICE_NAME': '0', 08:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:52 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-bt8caq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:52 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)) 08:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:52 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-p160qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:52 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-fi3ywq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:52 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)) 08:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:52 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kbwRps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:52 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-LHg_um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:52 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)) 08:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:52 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-cF0kX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:52 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)) 08:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:52 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-73iD39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:52 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)) 08:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:52 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-LK9dWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:52 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)) 08:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:52 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-HdNi1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:53 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)) 08:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-KALI9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:53 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)) 08:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-DH9dJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:53 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)) 08:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-TnDzjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:53 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)) 08:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-6iFcO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:53 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)) 08:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-DjmtAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-zs6Or8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:53 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)) 08:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Xj9osk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:53 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)) 08:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:53 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-dbIrIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:53 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)) 08:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:53 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)) 08:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:34:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:34:53 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 08:34:53 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 08:34:53 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 08:34:53 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 08:34:53 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 08:34:53 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 08:34:56 INFO - Downloading blessings-1.6.tar.gz 08:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:34:56 INFO - Installing collected packages: blessings 08:34:56 INFO - Running setup.py install for blessings 08:34:56 INFO - Successfully installed blessings 08:34:56 INFO - Cleaning up... 08:34:57 INFO - Return code: 0 08:34:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:57 INFO - Reading from file tmpfile_stdout 08:34:57 INFO - Current package versions: 08:34:57 INFO - blessings == 1.6 08:34:57 INFO - blobuploader == 1.2.4 08:34:57 INFO - docopt == 0.6.1 08:34:57 INFO - functools32 == 3.2.3-2 08:34:57 INFO - jsonschema == 2.5.1 08:34:57 INFO - manifestparser == 1.1 08:34:57 INFO - mozInstall == 1.12 08:34:57 INFO - mozcrash == 0.17 08:34:57 INFO - mozdebug == 0.1 08:34:57 INFO - mozdevice == 0.48 08:34:57 INFO - mozfile == 1.2 08:34:57 INFO - mozhttpd == 0.7 08:34:57 INFO - mozinfo == 0.9 08:34:57 INFO - mozleak == 0.1 08:34:57 INFO - mozlog == 3.4 08:34:57 INFO - moznetwork == 0.27 08:34:57 INFO - mozprocess == 0.23 08:34:57 INFO - mozprofile == 0.28 08:34:57 INFO - mozrunner == 6.12 08:34:57 INFO - mozscreenshot == 0.1 08:34:57 INFO - mozsystemmonitor == 0.3 08:34:57 INFO - moztest == 0.7 08:34:57 INFO - mozversion == 1.4 08:34:57 INFO - psutil == 3.1.1 08:34:57 INFO - requests == 1.2.3 08:34:57 INFO - wsgiref == 0.1.2 08:34:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:57 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')]} 08:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:57 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')]} 08:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:57 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 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:57 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 08:34:57 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 08:34:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:57 INFO - 'HOME': '/Users/cltbld', 08:34:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:57 INFO - 'LOGNAME': 'cltbld', 08:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:57 INFO - 'MOZ_NO_REMOTE': '1', 08:34:57 INFO - 'NO_EM_RESTART': '1', 08:34:57 INFO - 'PAGER': '/bin/cat', 08:34:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:57 INFO - 'PWD': '/builds/slave/test', 08:34:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:57 INFO - 'SHELL': '/bin/bash', 08:34:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:57 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:57 INFO - 'USER': 'cltbld', 08:34:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:57 INFO - 'XPC_FLAGS': '0x0', 08:34:57 INFO - 'XPC_SERVICE_NAME': '0', 08:34:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:57 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)) 08:34:57 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)) 08:34:57 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)) 08:34:57 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)) 08:34:57 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)) 08:34:57 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)) 08:34:57 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)) 08:34:57 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)) 08:34:57 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)) 08:34:57 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)) 08:34:57 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)) 08:34:57 INFO - Cleaning up... 08:34:57 INFO - Return code: 0 08:34:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:34:57 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')]} 08:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:57 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')]} 08:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:57 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 0x10a0e3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a059570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff2d87300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, '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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:34:57 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 08:34:57 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 08:34:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:34:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:57 INFO - 'HOME': '/Users/cltbld', 08:34:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:57 INFO - 'LOGNAME': 'cltbld', 08:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:57 INFO - 'MOZ_NO_REMOTE': '1', 08:34:57 INFO - 'NO_EM_RESTART': '1', 08:34:57 INFO - 'PAGER': '/bin/cat', 08:34:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:57 INFO - 'PWD': '/builds/slave/test', 08:34:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:57 INFO - 'SHELL': '/bin/bash', 08:34:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:34:57 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:34:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:57 INFO - 'USER': 'cltbld', 08:34:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:57 INFO - 'XPC_FLAGS': '0x0', 08:34:57 INFO - 'XPC_SERVICE_NAME': '0', 08:34:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:34:57 INFO - Cleaning up... 08:34:57 INFO - Return code: 0 08:34:57 INFO - Running post-action listener: _resource_record_post_action 08:34:57 INFO - Running post-action listener: _start_resource_monitoring 08:34:57 INFO - Starting resource monitoring. 08:34:57 INFO - [mozharness: 2016-10-12 15:34:57.893923Z] Finished create-virtualenv step (success) 08:34:57 INFO - [mozharness: 2016-10-12 15:34:57.894891Z] Running install step. 08:34:57 INFO - Running pre-action listener: _resource_record_pre_action 08:34:57 INFO - Running main action method: install 08:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:58 INFO - Reading from file tmpfile_stdout 08:34:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:34:58 INFO - Reading from file tmpfile_stdout 08:34:58 INFO - Output received: 08:34:58 INFO - Usage: mozinstall [options] installer 08:34:58 INFO - Options: 08:34:58 INFO - -h, --help show this help message and exit 08:34:58 INFO - -d DEST, --destination=DEST 08:34:58 INFO - Directory to install application into. [default: 08:34:58 INFO - "/builds/slave/test"] 08:34:58 INFO - --app=APP Application being installed. [default: firefox] 08:34:58 INFO - mkdir: /builds/slave/test/build/application 08:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:35:33 INFO - Reading from file tmpfile_stdout 08:35:33 INFO - Output received: 08:35:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:35:33 INFO - Running post-action listener: _resource_record_post_action 08:35:33 INFO - [mozharness: 2016-10-12 15:35:33.976605Z] Finished install step (success) 08:35:33 INFO - [mozharness: 2016-10-12 15:35:33.976727Z] Running run-tests step. 08:35:33 INFO - Running pre-action listener: _resource_record_pre_action 08:35:33 INFO - Running main action method: run_tests 08:35:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:35:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:35:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:35:33 INFO - 2016-10-12 08:35:33.991 screenresolution[1647:7916] starting screenresolution argv=screenresolution get 08:35:33 INFO - 2016-10-12 08:35:33.994 screenresolution[1647:7916] Display 0: 1600x1200x32@60 08:35:34 INFO - 2016-10-12 08:35:34.000 screenresolution[1648:7918] starting screenresolution argv=screenresolution list 08:35:34 INFO - Available Modes on Display 0 08:35:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:35:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:35:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:35:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:35:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:35:34 INFO - Intel Iris: 08:35:34 INFO - Chipset Model: Intel Iris 08:35:34 INFO - Type: GPU 08:35:34 INFO - Bus: Built-In 08:35:34 INFO - VRAM (Dynamic, Max): 1536 MB 08:35:34 INFO - Vendor: Intel (0x8086) 08:35:34 INFO - Device ID: 0x0a2e 08:35:34 INFO - Revision ID: 0x0009 08:35:34 INFO - Displays: 08:35:34 INFO - Display: 08:35:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:35:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:35:34 INFO - Display Serial Number: 1600x1200 60 08:35:34 INFO - Main Display: Yes 08:35:34 INFO - Mirror: Off 08:35:34 INFO - Online: Yes 08:35:34 INFO - Rotation: Supported 08:35:34 INFO - Return code: 0 08:35:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:35:34 INFO - Python 2.7.3 08:35:34 INFO - Return code: 0 08:35:34 INFO - grabbing minidump binary from tooltool 08:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:34 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 0x109ef7d30>, '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 0x109d1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eefb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:35:34 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 08:35:34 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 08:35:34 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 08:35:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:35:34 INFO - Return code: 0 08:35:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:35:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:35:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:35:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:35:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:35:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 08:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 08:35:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOvQfRIoMB/Render', 08:35:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:34 INFO - 'HOME': '/Users/cltbld', 08:35:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:34 INFO - 'LOGNAME': 'cltbld', 08:35:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:35:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:34 INFO - 'MOZ_NO_REMOTE': '1', 08:35:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:35:34 INFO - 'NO_EM_RESTART': '1', 08:35:34 INFO - 'PAGER': '/bin/cat', 08:35:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:34 INFO - 'PWD': '/builds/slave/test', 08:35:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:35:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:34 INFO - 'SHELL': '/bin/bash', 08:35:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AYcGnN3GWc/Listeners', 08:35:34 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:35:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:34 INFO - 'USER': 'cltbld', 08:35:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:34 INFO - 'XPC_FLAGS': '0x0', 08:35:34 INFO - 'XPC_SERVICE_NAME': '0', 08:35:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 08:35:34 INFO - mozversion application_buildid: 20161011132146 08:35:34 INFO - mozversion application_changeset: 6d67a819cff05013f27677d48528ce3492f429be 08:35:34 INFO - mozversion application_display_name: Nightly 08:35:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:35:34 INFO - mozversion application_name: Firefox 08:35:34 INFO - mozversion application_remotingname: firefox 08:35:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:35:34 INFO - mozversion application_vendor: Mozilla 08:35:34 INFO - mozversion application_version: 52.0a1 08:35:34 INFO - mozversion platform_buildid: 20161011132146 08:35:34 INFO - mozversion platform_changeset: 6d67a819cff05013f27677d48528ce3492f429be 08:35:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:35:34 INFO - mozversion platform_version: 52.0a1 08:35:34 INFO - using testdate: 1476286534 08:35:34 INFO - actual date: 1476286534 08:35:34 INFO - starting webserver on 'localhost:49278' 08:35:34 INFO - SUITE-START | Running 2 tests 08:35:34 INFO - TEST-START | dromaeo_css 08:35:34 INFO - operating with platform_type : mac_ 08:35:34 INFO - Initialising browser for dromaeo_css test... 08:35:34 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpd62DTr/profile http://localhost:49278/getInfo.html) 08:35:37 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 08:35:37 INFO - PROCESS | 1658 | colorDepth:24 08:35:37 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 08:35:37 INFO - PROCESS | 1658 | __metrics 08:35:37 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:35:37 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:37 INFO - TEST-INFO | 1658: exit 0 08:35:37 INFO - Browser initialized. 08:35:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:35:37 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpd62DTr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:49 INFO - PROCESS | 1660 | RSS: Main: 243462144 08:35:49 INFO - PROCESS | 1660 | 08:36:40 INFO - PROCESS | 1660 | 1476286600954 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] 08:38:53 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 08:38:55 INFO - PROCESS | 1660 | RSS: Main: 385351680 08:38:55 INFO - PROCESS | 1660 | 08:41:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 08:41:59 INFO - PROCESS | 1660 | RSS: Main: 372088832 08:41:59 INFO - PROCESS | 1660 | 08:45:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 08:45:02 INFO - PROCESS | 1660 | RSS: Main: 329768960 08:45:02 INFO - PROCESS | 1660 | 08:48:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 08:48:05 INFO - PROCESS | 1660 | RSS: Main: 347615232 08:48:05 INFO - PROCESS | 1660 | 08:51:08 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 08:51:09 INFO - PROCESS | 1660 | RSS: Main: 328876032 08:51:09 INFO - PROCESS | 1660 | 08:54:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 08:54:12 INFO - PROCESS | 1660 | RSS: Main: 395853824 08:54:12 INFO - PROCESS | 1660 | 08:54:12 INFO - PROCESS | 1660 | __start_tp_report 08:54:12 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 08:54:12 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 08:54:12 INFO - PROCESS | 1660 | |i|pagename|runs| 08:54:12 INFO - PROCESS | 1660 | |0;dojo.html;3003.4443627928836;3295.406826771181;3331.450310698733;3353.6082525751813;3364.4616861302197;4692.366530518383;5213.348331458567;5577.3028371453565;5666.971665141674;5677;4803.831865884695;5583.609147359676;5666.263385759856;5692.203091567184;5751.683657398852;5180.948190518085;5197.0905091609;5230.2416149658275;5246.606504512177;5251.947480525184;5169.586433085344;5237.10969135246;5255.737213139328;5265.710385928773;5279.973600131994;4490.393796837434;4975.880426903954;5119.360079990001;5301.1783173608155;5331.840044798662;4787.904241915177;5103.055934652101;5207.6354655174155;5218.9739051304505;5254.369475662907;5109.795608175668;5123.1546794778815;5176.145935920568;5186.870328241786;5188.962207558503;5578.3584887738025;5605.1872478490795;5619.80330688424;5621.437856214387;5641.689707066151;6185.752569897199;6196;6209.596376235575;6213.813585592439;6219.1604133442315;6095.634261944298;6107.340534417129;6112.083187521863;6186.443220110166;6256.280527739323;5688.317401911714;5708.743106560215;5725.112607545837;5734.426557344315;5741.942580574224;6270;6273.404026617464;6290.654014029181;6290.905636415458;6313.9368606314265;5868.061110222429;5936.673482958478;6074.908876366858;6085.939140608626;6087.1173679816175;6102.664353460514;6133.48768512239;6140.267580926534;6141.946315431794;6145.477634401126;6066.575339726265;6127.142200091991;6140.938590614037;6149.13912052313;6156.938430615726;6133.570650054453;6163.19878415803;6177.4749146322165;6188.9690551546955;6204.069389591597;4837.153498137812;4837.443693975238;4841.515848415131;4862.367892174066;4865.002674451729;4282.464691913511;4341.804618792099;4343.695941284143;4344.717593356485;4386.342048692722;5670.234518339971;5686.118651609007;5717.885642287214;5729.312482502127;5751.913721294184;6183.84540386494;6212.875742485216;6251.624902505864;6254.562180647311;6256.217972753406;5424.783008679688;5465.863353416196;5702.629329093678;5705.2012718219485;5733.627314224562;5192.350956130484;5203.765830537635;5295;5337.359516857924;5346.652467589672;6234.096056071844;6247.687615619292;6256.405641464054;6259.029850373199;6269.843253918689;6207.224096987877;6212.409821066992;6244.313125556276;6254.21822272216;6268.561200715906;6102.216595924137;6154.261488621394;6239.563230573998;6245.313015568375;6260.624362538262;5869.735861886311;5915.822525324247;5923.614965027259;5953.583249172516;5971.910421343597;5976.103584462366;6004.8498787528915;6007.759689612367;6012.6392416455155;6017.578769486269;5762.394948530512;5766.8846623066465;5826.475617194473;5838.4453476919625;5881.470667639933;5939.584229103922;5982.940170598238;5994.490468310242;6023.216981792339;6038.63768173911;5891.3224979126235;5916.290045194604;5949.1076338549565;5952.136940143741;5971.164037034905;5148.510891465305;5981.0729336952845;6052.122442245938;6075.483583895419;6078.969605151946;5711.343195532567;5789.623674461147;5923.111533269872;5931.970340148444;5933.436323549256 08:54:12 INFO - PROCESS | 1660 | |1;ext.html;472.832144588671;496.523337595908;504.5685938522563;524.5357858295407;528.6061883896498;28020.217270668454;37332.44001339982;38299.425508617394;38356.616433835654;38432.99999999996;38978.61021389785;39333.409998849966;39612;39698.00754981127;39707.60292397075;8436.493810371367;9243.352965292415;9440.669576564822;9446.574904129297;9454.574544145496;8512.276456501204;8576.957115214447;8582.356323275748;8585.356098292621;8588.570571471433;11155.442227888614;11385;11395.943020284929;11529.02003329718;11560.132990025739;11318.434078296094;11351.829722554168;11362.659120226324;11369.999999999958;11379.487923043484;11153.832692509619;11255.212135150543;11258.831117533244;11261.380624065672;11295.943520282428;37371;37665.62334376676;37723.811380943196;37782.24435511274;37820;3431.7083047940955;3482.512448257246;3554.2891421715503;3721.3673675475234;3920.5491368492703;23714.762852371427;29878.402431951457;29894.252643683863;29908.102756917327;30062.54906176409;2979.3743313904106;3077.984610076958;3174.746020318369;3242.8216448095345;3280.5079238114236;491551;494012;496725;497890;499964;54122.72938635282;54381.728091360084;54409.72795135999;54469;54589.454105459234;57011;57076;57098.85802284014;57126.7143664279;57145;15560.533184004498;15819.288132034086;15821.841781582267;15832;15877.20613969297;12309.56916507918;12360.505579776709;12365.134440589072;12376;12397.75204495905;13215.537456188988;13499.662508437172;13552.322383880964;13908;14517.98374113823;5488.286522752017;5561.694106824163;6165.136880836686;6312;6320.494360451153;846.2933450568844;946.6118891254553;969.5346233807671;1026.5688410867454;1085.5169449595012;23075.307740767803;27879.860600697273;28624.427511449656;29292;29483.705162948525;1002.2733518199393;1008.6016023670755;1017.8524114003576;1101.6474728086935;1150.6250031212787;14826.629334266514;14840.62898427548;14893.106413615218;15171.089734615958;15249.771253431207;628675;637713;639369;639558;640320;46662;46959.5304046962;53032;54606;54903.450965490636;1301.2322729589587;1338.3642769684516;1350.3518311210478;1350.648831303868;1351.4256441012333;29475.852620736758;30063.098107056823;30186.69813301927;30290.939817107177;30329.848350758104;45195;46018.07963840771;46041;46044.53955460402;46163;593530;631296;633273;645921.9335129836;799609;23921.880390597937;24098.87950560306;24112.156074537306;24477.265682029567;24556.877215613807;43193.35209971916;43240.78379608082;43903.560964389944;44171.674849754556;44598;36849.447258291686;37231.441528376556;38204.6179538201;38647.806760966014;40434.59565404426;36560.63439365679;36850.8157459211;37521.81239093787;37549.4367584481;37834.24331513299;35565;36273.81863090667;36405.90782276536;36483.08792280108;36873.81563092167;27278.181654550393;32573;33297.667023330425;33383.833080835415;33438.83280583679;21638.6754198684;24354.446040867973;24430.633540497263;24764.009439622212;25042.74957250477 08:54:12 INFO - PROCESS | 1660 | |2;jquery.html;322.6676523181124;348.96161422243534;368.3976698098609;374.9418840079787;401.2096170544029;14590.927045364771;14894.47869324574;15545.067295962235;19583.118759655816;19987.20051197954;19147.42557723267;19259.518512037204;19360.935148566823;20543.383698489033;20786;6462.935370646303;6768.898466522982;6822.4200942919915;6828.2488926218075;6831.04365388846;7066.85866282674;7219.350258476736;7422.443316751238;7554.169041405441;7607.315341619254;4564.406627138467;4782.904341913159;4833.903321933559;7655;7697.384209263246;7424.109106907205;7724.1889601591865;7732.265434783687;7741.8838717419285;7747.457677962517;7365.668544915492;7429.5542267464125;7439.925600743977;7441.032665753418;7441.441891858078;26927.865360673266;27441.17676469709;28133.718662813313;28232;28547.858085676547;2278.6012447821563;2387.7612238775982;2519.5842685956795;2533.556627590183;2936.4273966576525;15408.767298616196;16425.58936026597;16442.917785411115;16954.406595769087;17859.107044647844;1924.441911845563;2059.2072052259837;2104.884231367274;2112.5352422467186;2144.496043429808;124755;128326.4098218878;134610;141071;142648;18491.70558060923;19277.8072219276;20316.187352505734;21293.46766330854;21496.247631333143;35251.294974100376;35309.823450882584;35436.468452973226;35451.82274088613;35507;9972.700818975442;10649.201309901788;10869.45652717361;11029.724256893642;11163.051140652973;8891.19979201875;8916.687915922912;8991.955040224757;9133.360664753403;9134.497602631918;7981.281684648409;9485.525723713787;9626.807463850684;9781.951090244504;9791.412515248965;3222.9838850805595;3554.63616694895;3576.6959808416054;3630.3102410541915;3657.8353974070696;720.8666396716624;867.7266661001764;903.9276857851356;922.1285884838763;928.8467402878449;19834.008299584963;20460.590788184152;20500.69248961267;20510.487237819172;20611;895.9865602015975;897.3404547657467;914.6250037484732;917.9724608261763;968.8449848024283;8271.54506502148;10399.02664316046;10515.369077855354;10634.680959571226;10686.412247326472;586984;589244.3982282276;595137;602475;603089;108528;119219.80780192261;139702;139812.30093849465;142477;951.5575257505155;976.1166144638971;1016.7458135466134;1018.1701912940929;1019.2814066083394;18306.084695765425;18306.90846545759;18402.539936501158;18448.07759612041;18496.907515462335;51700.482995169565;52661.47338526719;53000;53722.73138634282;54453.72773136109;74207;78289;80037.59981200057;80262.59868700619;80601.19398806171;7839.951355419607;7927.920720792949;8181.018277806464;8213.753587392388;8272.420930534805;11417.828732569184;12762.808557871454;12812.167209131749;13231.536896208587;13263.535776247785;10939.398333091756;11187.32876027441;11257.155713321697;11439.714007149887;11495.712607184887;11020.944895275472;11111.611093611686;11131.666050018512;11433.428328583372;11441.771164576496;5777.9133313001175;7940.444168908121;9814.85277720849;10016.599336026477;11373.260738052;7066.258042905421;7463.626818659154;8051.597420128853;8079.959600201962;8272.214139656722;10260.948695256477;10352.792944141225;10761;10947.83578246311;11710.473028713557 08:54:12 INFO - PROCESS | 1660 | |3;mootools.html;1343.100122917645;1515.5680631020161;1532.1190315568547;1698.380091266688;1850.8611854110936;7153.928460715398;7681.923180768191;8158.143394943527;8744.344174186945;8783.077776833436;8629.266512346458;8686.218240358367;8688.782780430492;8695.39132260742;8697.608607612658;2307.3078076577044;2324.2921995874785;2333.311673056444;2336.3458231695067;2342.7305859826083;2249.707538020055;2285.485765702712;2288.233441797;2291.6906217660653;2291.9541609167804;2294.265834932822;2304.481491664379;2311.5492478966607;2321.663358812971;2328.092044102801;2270.352949409427;2296.0815673730476;2296.1848543766973;2297.8621282722925;2298.253327471134;2006.6488364536149;2280.931572052841;2282.657601359793;2284.6344584866506;2289.347535952246;8636.697715579925;8645.178708022728;8701.434406763603;8702.260307873838;8715.825683486359;5065;5291.708956007418;5292.708901010443;5330.093884039723;5333.653312534673;3325.384803811303;3450.240946991658;3543.2382037861726;3550.4851796489625;3567.1795487037866;887.7958069644018;999.5002498750624;1028.300755486269;1046.9371837689764;1052.952617132231;11319.151063670257;11324.263922844988;11427.885721142766;11430.142739294586;11431.59989400367;4264.7654379009455;4311.719738217069;4484.977575112169;4487.640988720895;4489.416375871116;8781.824363512822;8874.334424918157;8876.51179185151;8914.375993680509;8936.821263574691;5153.768080436389;5162.148245539519;5164.690118592896;5166.250893620404;5176.922346164811;4104.651104656137;4325.891852703708;4469.955300447019;4505.16654418927;4850.6119510439785;3441.741869359758;3738.1776009277914;3739.383001804672;3739.513863197821;3741.214344987529;975.5414954971152;1064.1646307648614;1108.1688733449912;1118.9440527973732;1126.1441304608556;833.7498750374863;842.5913431985482;881.1716986033108;900.8648702694649;941.3833938770116;5494;5702.344230413472;5822.7088645567555;5892.469677729025;6005.549583781234;871.54679566625;881.1452890696015;905.5110240470204;934.2572654739498;959.9232061435068;3724.5902950675404;3774.490443790108;3818.312703713358;3892.163184915257;3925.509311336083;9365.719028429157;10278.640247591298;10372.533236004247;10388.636397726043;10394;10340.586376544854;10350.844737328945;10351.223658225663;10355.17158627323;10392;8019.879701804478;8162.714304999416;8166.7958301042945;8173.100958894517;8177.9182208178345;5081.441041485507;5750.856228594319;5917.112433135064;5974.970125149346;6095.603785753912;9640.855387169058;9941.801163976535;9945.552450139905;9972.152367048591;10002.399856008662;9499.620015199314;9762.219022478042;9899.20806335477;9974.40153590787;10004.999500050228;7300.488965772345;7489.812754680958;7500.324970752658;7505.887411688938;7507;8037;8102;8126.471779334324;8181.713640022571;8193.83612327762;7325.7802265932105;7383.483156179231;7397.704091836266;7447.32974032318;7465;6956.200036995608;7160.427165826825;7214.386777124003;7283.089613798275;7337.449691273283;6805.965970170316;6908.896366554606;6927.411170050602;6930.44556435494;6935.445164386938;4715.929261061156;4855.878603034952;4865.829695960624;4939.629527785502;5071.695698258116;4821.276808478756;4874.854409213903;4970.502949705001;5017.197248440232;5129.461406552258 08:54:12 INFO - PROCESS | 1660 | |4;prototype.html;296.51075725053664;296.64847156120015;306.16569847166465;310.93314937288477;311.6291612980552;4201.936970945439;4268.40242366069;4653.395058642376;4958.016793282689;5121.487851214877;4963.627727920411;5033.974830125844;5074.594032477402;5093.351457242232;5097.566706829914;3334.6328005517744;3924.941125883114;3936.1930804185217;3942.4283478895545;3952.774639861645;3637.290728307981;3966.9404958925493;3966.9801650991703;3976.840926362942;3982.960170398288;3433.8798142065034;3888.51393575803;3892.610738926113;3925.5485619153733;3936.6457018868296;3900.3759398496386;3911.1004468972296;3920.607939206085;3951.328274193394;3969.6824254059607;3232.482802751572;3380.830958452092;3424;3426.229098452853;3432.433648448003;4970.577500912426;4974.4776798436005;4988.725620090893;4993.750312484398;4997.725125118117;4434.667399944985;4447.688661793676;4454.198244316054;4458.977705111453;4486.327050942352;4342.913141737179;4504.549545045502;5213.4004589472315;5215.3741551013745;5255.001549705582;3154.9053528394184;3155.100796273074;3366.107981384935;3688.428293614494;3743.232637309345;5161.509656582619;5197.66215196011;5327.469452010303;5695.971520142456;5715.742791574347;3229.951550726741;3252.837358132084;3504.3367041048987;3795.962040379616;3798.3352913240074;3382.864685412556;3679.742418030712;3786.9431958520645;3812.864795714409;3850.5186851643543;4425.911481770347;4426.3581780641625;4431.33529970507;4432.689711720149;4437.33439984005;5236.528712415825;5439.537639300704;5440.483154100433;5445.591580631469;5447;1089.7057794395469;1106.0930037369442;1164.2083383299437;1168.258156070884;1285.6850071732486;716.3373879161754;772.2547741429547;772.6986475274647;784.2862994674819;792.7582087463263;3350.3466823969093;4054.9254447571416;4074.5110586729784;4202.117555313357;4218.7468751874985;3717.7955212463576;3903.4144878268485;4512.481064677539;4521.796519156645;4543.34121552373;3554.7867127972404;3639.6906262967414;3778.8110594470168;4100.876973690794;4212.599803018708;2136.369770917583;2373.3623799578236;2398.328468028955;2462.876856157185;2477.08347911274;3515.472679098156;4138.813753381105;4609.216433206363;4668.229742092584;4685.906281874343;3907.648311651908;3916.784576848244;4443.155800397979;4563.99184358881;4605.0559635274685;3861.864834730771;4012.6789856811383;4082.1631565528996;4467.374567560544;4585.564371384713;3393.1347506385714;3699.685526730258;4507.756756891794;4522.231220692424;4524.796384162655;3957.8416863326297;4025.9668867221867;4435.248077009499;4499.707519011254;4509;4255.340422234559;4273.401723758614;4589.219832628394;4650.000249946278;4696.8121275148615;2907.7964542481823;2924.7513961313525;3146.559481672522;3210.3739770744482;3270.9205962032947;3697.7966211858607;4115.991582062414;4214.367844823301;4529.353870134441;4576.176288268143;3695.408734602558;4390.517043125317;4417.197515825593;4431.446069241345;4433.246348120762;4175.352820312856;5165.354330708661;5209.004822227159;5249.790008399621;5268.394134674561;4348.34774783785;5009.849704508871;5272.525472707322;5311.3891902431715;5326.493983071602;5102.617303702312;5392.568594512508;5395.784168633368;5399.892002160013;5419.620626556103;5332.466753324637;5352.287268074178;5363.356397232357;5371.570274377962;5380.596455265949 08:54:12 INFO - PROCESS | 1660 | |5;yui.html;714.9785506434808;755.5768769489086;756.6821934787389;771.0285040848529;801.3108726495215;15475.226238688063;15735.291911863966;15745;15757.369705211779;15766.684666306666;14131.293435328218;14233.217173055478;14269.286535673227;14272.71454570908;14282.2858857057;667.9031540426636;688.2601203706012;689;813.8738495533202;827.7227128911807;836.3643630840544;836.8702851058096;845.4758050009003;846.2130218896424;847.5719761520423;902.345799295512;904.4030939579878;907.3240435875249;908.3596064774351;908.7319240823973;896.820635872828;901.197933838884;901.8331608652387;903.5121034641253;904.6336233825245;486.1880659298979;516.2050442318824;649.3636236488268;665.5208250059949;666.9566478178951;14365.13809171453;14407.038064532233;14443.78334324986;14459.566213013626;14484.710305793826;11600.477978490904;13116.01629877763;13361.331933403291;13492.12301200419;13714.22322520356;11802.940985295105;12186.939065304705;12195.695107622292;12220.511179552896;12365.505379784798;4396.362527433536;4422.867313980586;4431;4453.3320001999955;4518.728876267402;87060.56469717674;91779.08220917772;108142.91857081486;108842;109004;10394.272400932014;10630.30902991303;10686.625968091235;10827.78344433107;10916.945415273032;20895.37313880586;20944.162233510793;20965.37103886886;20968.47578810542;21003.369898903056;7433;7784.494007889469;7870.881936770838;8041.075276343178;8099.433039687283;4235.830566777295;4299.400187534471;4306.3061263223235;4332.090261045153;4515.571020753023;3378;3472.9826350868084;3491.0748651607346;3497.632748561415;3516.6659167379057;626.5707990026846;648.5265755998148;649.7693318871827;655.131950166032;660.6663634864459;551.8537587539305;557.6598275052215;614.0482252508683;615.9199304090529;616.9228846394201;7579.848403031909;8221.630026648816;8611.870821937677;8703.477791332414;8797.208251257418;587.6033677267912;619.5353484886335;622.0116985666039;624.144921457606;638.7189636559899;4177.540470548237;4222.915541689149;4286.742795432284;4303.526612072669;4367.372514695482;106154.93845061606;129852.3507382457;145360;158983;161919.38080619278;130124;137437;137833;138361;139006.30496847653;80354.39291214143;113879;114980;116276;119101;7014.649267536704;8304.501729896225;8376.623051962555;8385.37109716786;8500.192481714228;42658.78670606627;61124;61676.69161654163;62343;64517.354826451134;74829.14293999052;87615;93206;95117.52441237749;95357.52321238627;10467.267291289536;10588.67641544807;10865;11101.666949991513;11479.311241325548;9994.300398972002;11821;12016.819747703617;12051.75896482048;12448.688782780502;11250.549978001116;11259.605913792979;11372.943135284271;11381.374024428405;11729.178957472895;9862.802743944938;11406.201565890307;11422.600208992646;11460.19778615489;11523.769524609294;10967.50646220906;10990.670279891616;11032.44837758125;11337.773244535229;11572.826407603725;8881.467111973303;9069.501177435304;9205.263578913804;9429.292803039936;9441.622335106518;8799.560021999003;9047.095290470901;9080.818383632159;9103.362764606414;9233.307501937246 08:54:12 INFO - PROCESS | 1660 | __end_tp_report 08:54:12 INFO - PROCESS | 1660 | __start_cc_report 08:54:12 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1680 08:54:12 INFO - PROCESS | 1660 | __end_cc_report 08:54:12 INFO - PROCESS | 1660 | __startTimestamp1476287652635__endTimestamp 08:54:12 INFO - PROCESS | 1660 | 08:54:12 INFO - PROCESS | 1660 | ------- Summary: start ------- 08:54:12 INFO - PROCESS | 1660 | Number of tests: 6 08:54:12 INFO - PROCESS | 1660 | 08:54:12 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5649.74 Median:5868.06 stddev:649.35 (11.1%) stddev-sans-first:617.27 08:54:12 INFO - PROCESS | 1660 | Values: 3003.4 3295.4 3331.5 3353.6 3364.5 4692.4 5213.3 5577.3 5667.0 5677.0 4803.8 5583.6 5666.3 5692.2 5751.7 5180.9 5197.1 5230.2 5246.6 5251.9 5169.6 5237.1 5255.7 5265.7 5280.0 4490.4 4975.9 5119.4 5301.2 5331.8 4787.9 5103.1 5207.6 5219.0 5254.4 5109.8 5123.2 5176.1 5186.9 5189.0 5578.4 5605.2 5619.8 5621.4 5641.7 6185.8 6196.0 6209.6 6213.8 6219.2 6095.6 6107.3 6112.1 6186.4 6256.3 5688.3 5708.7 5725.1 5734.4 5741.9 6270.0 6273.4 6290.7 6290.9 6313.9 5868.1 5936.7 6074.9 6085.9 6087.1 6102.7 6133.5 6140.3 6141.9 6145.5 6066.6 6127.1 6140.9 6149.1 6156.9 6133.6 6163.2 6177.5 6189.0 6204.1 4837.2 4837.4 4841.5 4862.4 4865.0 4282.5 4341.8 4343.7 4344.7 4386.3 5670.2 5686.1 5717.9 5729.3 5751.9 6183.8 6212.9 6251.6 6254.6 6256.2 5424.8 5465.9 5702.6 5705.2 5733.6 5192.4 5203.8 5295.0 5337.4 5346.7 6234.1 6247.7 6256.4 6259.0 6269.8 6207.2 6212.4 6244.3 6254.2 6268.6 6102.2 6154.3 6239.6 6245.3 6260.6 5869.7 5915.8 5923.6 5953.6 5971.9 5976.1 6004.8 6007.8 6012.6 6017.6 5762.4 5766.9 5826.5 5838.4 5881.5 5939.6 5982.9 5994.5 6023.2 6038.6 5891.3 5916.3 5949.1 5952.1 5971.2 5148.5 5981.1 6052.1 6075.5 6079.0 5711.3 5789.6 5923.1 5932.0 5933.4 08:54:12 INFO - PROCESS | 1660 | 08:54:12 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:71205.01 Median:36705.04 stddev:161922.94 (441.1%) stddev-sans-first:162290.09 08:54:12 INFO - PROCESS | 1660 | Values: 472.8 496.5 504.6 524.5 528.6 28020.2 37332.4 38299.4 38356.6 38433.0 38978.6 39333.4 39612.0 39698.0 39707.6 8436.5 9243.4 9440.7 9446.6 9454.6 8512.3 8577.0 8582.4 8585.4 8588.6 11155.4 11385.0 11395.9 11529.0 11560.1 11318.4 11351.8 11362.7 11370.0 11379.5 11153.8 11255.2 11258.8 11261.4 11295.9 37371.0 37665.6 37723.8 37782.2 37820.0 3431.7 3482.5 3554.3 3721.4 3920.5 23714.8 29878.4 29894.3 29908.1 30062.5 2979.4 3078.0 3174.7 3242.8 3280.5 491551.0 494012.0 496725.0 497890.0 499964.0 54122.7 54381.7 54409.7 54469.0 54589.5 57011.0 57076.0 57098.9 57126.7 57145.0 15560.5 15819.3 15821.8 15832.0 15877.2 12309.6 12360.5 12365.1 12376.0 12397.8 13215.5 13499.7 13552.3 13908.0 14518.0 5488.3 5561.7 6165.1 6312.0 6320.5 846.3 946.6 969.5 1026.6 1085.5 23075.3 27879.9 28624.4 29292.0 29483.7 1002.3 1008.6 1017.9 1101.6 1150.6 14826.6 14840.6 14893.1 15171.1 15249.8 628675.0 637713.0 639369.0 639558.0 640320.0 46662.0 46959.5 53032.0 54606.0 54903.5 1301.2 1338.4 1350.4 1350.6 1351.4 29475.9 30063.1 30186.7 30290.9 30329.8 45195.0 46018.1 46041.0 46044.5 46163.0 593530.0 631296.0 633273.0 645921.9 799609.0 23921.9 24098.9 24112.2 24477.3 24556.9 43193.4 43240.8 43903.6 44171.7 44598.0 36849.4 37231.4 38204.6 38647.8 40434.6 36560.6 36850.8 37521.8 37549.4 37834.2 35565.0 36273.8 36405.9 36483.1 36873.8 27278.2 32573.0 33297.7 33383.8 33438.8 21638.7 24354.4 24430.6 24764.0 25042.7 08:54:12 INFO - PROCESS | 1660 | 08:54:12 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:36760.99 Median:17800.13 stddev:99665.20 (559.9%) stddev-sans-first:99907.24 08:54:12 INFO - PROCESS | 1660 | Values: 322.7 349.0 368.4 374.9 401.2 14590.9 14894.5 15545.1 19583.1 19987.2 19147.4 19259.5 19360.9 20543.4 20786.0 6462.9 6768.9 6822.4 6828.2 6831.0 7066.9 7219.4 7422.4 7554.2 7607.3 4564.4 4782.9 4833.9 7655.0 7697.4 7424.1 7724.2 7732.3 7741.9 7747.5 7365.7 7429.6 7439.9 7441.0 7441.4 26927.9 27441.2 28133.7 28232.0 28547.9 2278.6 2387.8 2519.6 2533.6 2936.4 15408.8 16425.6 16442.9 16954.4 17859.1 1924.4 2059.2 2104.9 2112.5 2144.5 124755.0 128326.4 134610.0 141071.0 142648.0 18491.7 19277.8 20316.2 21293.5 21496.2 35251.3 35309.8 35436.5 35451.8 35507.0 9972.7 10649.2 10869.5 11029.7 11163.1 8891.2 8916.7 8992.0 9133.4 9134.5 7981.3 9485.5 9626.8 9782.0 9791.4 3223.0 3554.6 3576.7 3630.3 3657.8 720.9 867.7 903.9 922.1 928.8 19834.0 20460.6 20500.7 20510.5 20611.0 896.0 897.3 914.6 918.0 968.8 8271.5 10399.0 10515.4 10634.7 10686.4 586984.0 589244.4 595137.0 602475.0 603089.0 108528.0 119219.8 139702.0 139812.3 142477.0 951.6 976.1 1016.7 1018.2 1019.3 18306.1 18306.9 18402.5 18448.1 18496.9 51700.5 52661.5 53000.0 53722.7 54453.7 74207.0 78289.0 80037.6 80262.6 80601.2 7840.0 7927.9 8181.0 8213.8 8272.4 11417.8 12762.8 12812.2 13231.5 13263.5 10939.4 11187.3 11257.2 11439.7 11495.7 11020.9 11111.6 11131.7 11433.4 11441.8 5777.9 7940.4 9814.9 10016.6 11373.3 7066.3 7463.6 8051.6 8080.0 8272.2 10260.9 10352.8 10761.0 10947.8 11710.5 08:54:12 INFO - PROCESS | 1660 | 08:54:12 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5549.50 Median:5157.96 stddev:3108.97 (60.3%) stddev-sans-first:3101.62 08:54:12 INFO - PROCESS | 1660 | Values: 1343.1 1515.6 1532.1 1698.4 1850.9 7153.9 7681.9 8158.1 8744.3 8783.1 8629.3 8686.2 8688.8 8695.4 8697.6 2307.3 2324.3 2333.3 2336.3 2342.7 2249.7 2285.5 2288.2 2291.7 2292.0 2294.3 2304.5 2311.5 2321.7 2328.1 2270.4 2296.1 2296.2 2297.9 2298.3 2006.6 2280.9 2282.7 2284.6 2289.3 8636.7 8645.2 8701.4 8702.3 8715.8 5065.0 5291.7 5292.7 5330.1 5333.7 3325.4 3450.2 3543.2 3550.5 3567.2 887.8 999.5 1028.3 1046.9 1053.0 11319.2 11324.3 11427.9 11430.1 11431.6 4264.8 4311.7 4485.0 4487.6 4489.4 8781.8 8874.3 8876.5 8914.4 8936.8 5153.8 5162.1 5164.7 5166.3 5176.9 4104.7 4325.9 4470.0 4505.2 4850.6 3441.7 3738.2 3739.4 3739.5 3741.2 975.5 1064.2 1108.2 1118.9 1126.1 833.7 842.6 881.2 900.9 941.4 5494.0 5702.3 5822.7 5892.5 6005.5 871.5 881.1 905.5 934.3 959.9 3724.6 3774.5 3818.3 3892.2 3925.5 9365.7 10278.6 10372.5 10388.6 10394.0 10340.6 10350.8 10351.2 10355.2 10392.0 8019.9 8162.7 8166.8 8173.1 8177.9 5081.4 5750.9 5917.1 5975.0 6095.6 9640.9 9941.8 9945.6 9972.2 10002.4 9499.6 9762.2 9899.2 9974.4 10005.0 7300.5 7489.8 7500.3 7505.9 7507.0 8037.0 8102.0 8126.5 8181.7 8193.8 7325.8 7383.5 7397.7 7447.3 7465.0 6956.2 7160.4 7214.4 7283.1 7337.4 6806.0 6908.9 6927.4 6930.4 6935.4 4715.9 4855.9 4865.8 4939.6 5071.7 4821.3 4874.9 4970.5 5017.2 5129.5 08:54:12 INFO - PROCESS | 1660 | 08:54:12 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:3987.43 Median:4270.90 stddev:1218.98 (28.5%) stddev-sans-first:1190.50 08:54:12 INFO - PROCESS | 1660 | Values: 296.5 296.6 306.2 310.9 311.6 4201.9 4268.4 4653.4 4958.0 5121.5 4963.6 5034.0 5074.6 5093.4 5097.6 3334.6 3924.9 3936.2 3942.4 3952.8 3637.3 3966.9 3967.0 3976.8 3983.0 3433.9 3888.5 3892.6 3925.5 3936.6 3900.4 3911.1 3920.6 3951.3 3969.7 3232.5 3380.8 3424.0 3426.2 3432.4 4970.6 4974.5 4988.7 4993.8 4997.7 4434.7 4447.7 4454.2 4459.0 4486.3 4342.9 4504.5 5213.4 5215.4 5255.0 3154.9 3155.1 3366.1 3688.4 3743.2 5161.5 5197.7 5327.5 5696.0 5715.7 3230.0 3252.8 3504.3 3796.0 3798.3 3382.9 3679.7 3786.9 3812.9 3850.5 4425.9 4426.4 4431.3 4432.7 4437.3 5236.5 5439.5 5440.5 5445.6 5447.0 1089.7 1106.1 1164.2 1168.3 1285.7 716.3 772.3 772.7 784.3 792.8 3350.3 4054.9 4074.5 4202.1 4218.7 3717.8 3903.4 4512.5 4521.8 4543.3 3554.8 3639.7 3778.8 4100.9 4212.6 2136.4 2373.4 2398.3 2462.9 2477.1 3515.5 4138.8 4609.2 4668.2 4685.9 3907.6 3916.8 4443.2 4564.0 4605.1 3861.9 4012.7 4082.2 4467.4 4585.6 3393.1 3699.7 4507.8 4522.2 4524.8 3957.8 4026.0 4435.2 4499.7 4509.0 4255.3 4273.4 4589.2 4650.0 4696.8 2907.8 2924.8 3146.6 3210.4 3270.9 3697.8 4116.0 4214.4 4529.4 4576.2 3695.4 4390.5 4417.2 4431.4 4433.2 4175.4 5165.4 5209.0 5249.8 5268.4 4348.3 5009.8 5272.5 5311.4 5326.5 5102.6 5392.6 5395.8 5399.9 5419.6 5332.5 5352.3 5363.4 5371.6 5380.6 08:54:12 INFO - PROCESS | 1660 | 08:54:12 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:23828.17 Median:4409.61 stddev:39134.99 (887.5%) stddev-sans-first:39206.29 08:54:12 INFO - PROCESS | 1660 | Values: 715.0 755.6 756.7 771.0 801.3 15475.2 15735.3 15745.0 15757.4 15766.7 14131.3 14233.2 14269.3 14272.7 14282.3 667.9 688.3 689.0 813.9 827.7 836.4 836.9 845.5 846.2 847.6 902.3 904.4 907.3 908.4 908.7 896.8 901.2 901.8 903.5 904.6 486.2 516.2 649.4 665.5 667.0 14365.1 14407.0 14443.8 14459.6 14484.7 11600.5 13116.0 13361.3 13492.1 13714.2 11802.9 12186.9 12195.7 12220.5 12365.5 4396.4 4422.9 4431.0 4453.3 4518.7 87060.6 91779.1 108142.9 108842.0 109004.0 10394.3 10630.3 10686.6 10827.8 10916.9 20895.4 20944.2 20965.4 20968.5 21003.4 7433.0 7784.5 7870.9 8041.1 8099.4 4235.8 4299.4 4306.3 4332.1 4515.6 3378.0 3473.0 3491.1 3497.6 3516.7 626.6 648.5 649.8 655.1 660.7 551.9 557.7 614.0 615.9 616.9 7579.8 8221.6 8611.9 8703.5 8797.2 587.6 619.5 622.0 624.1 638.7 4177.5 4222.9 4286.7 4303.5 4367.4 106154.9 129852.4 145360.0 158983.0 161919.4 130124.0 137437.0 137833.0 138361.0 139006.3 80354.4 113879.0 114980.0 116276.0 119101.0 7014.6 8304.5 8376.6 8385.4 8500.2 42658.8 61124.0 61676.7 62343.0 64517.4 74829.1 87615.0 93206.0 95117.5 95357.5 10467.3 10588.7 10865.0 11101.7 11479.3 9994.3 11821.0 12016.8 12051.8 12448.7 11250.5 11259.6 11372.9 11381.4 11729.2 9862.8 11406.2 11422.6 11460.2 11523.8 10967.5 10990.7 11032.4 11337.8 11572.8 8881.5 9069.5 9205.3 9429.3 9441.6 8799.6 9047.1 9080.8 9103.4 9233.3 08:54:12 INFO - PROCESS | 1660 | -------- Summary: end -------- 08:54:12 INFO - PROCESS | 1660 | 08:54:13 INFO - TEST-INFO | 1660: exit 0 08:54:13 INFO - TEST-OK | dromaeo_css | took 1118720ms 08:54:13 INFO - TEST-START | kraken 08:54:13 INFO - operating with platform_type : mac_ 08:54:13 INFO - Initialising browser for kraken test... 08:54:13 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpJhX0Vi/profile http://localhost:49278/getInfo.html) 08:54:15 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 08:54:15 INFO - PROCESS | 1667 | colorDepth:24 08:54:15 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 08:54:15 INFO - PROCESS | 1667 | __metrics 08:54:15 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:54:15 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:16 INFO - TEST-INFO | 1667: exit 0 08:54:16 INFO - Browser initialized. 08:54:16 INFO - Running cycle 1/1 for kraken test... 08:54:16 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpJhX0Vi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:28 INFO - PROCESS | 1668 | RSS: Main: 234676224 08:54:28 INFO - PROCESS | 1668 | 08:54:31 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 08:54:31 INFO - PROCESS | 1668 | RSS: Main: 293511168 08:54:31 INFO - PROCESS | 1668 | 08:54:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 08:54:35 INFO - PROCESS | 1668 | RSS: Main: 293531648 08:54:35 INFO - PROCESS | 1668 | 08:54:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 08:54:39 INFO - PROCESS | 1668 | RSS: Main: 383188992 08:54:39 INFO - PROCESS | 1668 | 08:54:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 08:54:41 INFO - PROCESS | 1668 | RSS: Main: 284143616 08:54:41 INFO - PROCESS | 1668 | 08:54:43 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:54:44 INFO - PROCESS | 1668 | RSS: Main: 288092160 08:54:44 INFO - PROCESS | 1668 | 08:54:47 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 08:54:47 INFO - PROCESS | 1668 | RSS: Main: 326406144 08:54:47 INFO - PROCESS | 1668 | 08:54:50 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 08:54:51 INFO - PROCESS | 1668 | RSS: Main: 329043968 08:54:51 INFO - PROCESS | 1668 | 08:54:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 08:54:54 INFO - PROCESS | 1668 | RSS: Main: 324894720 08:54:54 INFO - PROCESS | 1668 | 08:54:56 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:54:56 INFO - PROCESS | 1668 | RSS: Main: 300929024 08:54:56 INFO - PROCESS | 1668 | 08:54:58 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:54:59 INFO - PROCESS | 1668 | RSS: Main: 305598464 08:54:59 INFO - PROCESS | 1668 | 08:55:01 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:55:02 INFO - PROCESS | 1668 | RSS: Main: 307998720 08:55:02 INFO - PROCESS | 1668 | 08:55:05 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:55:06 INFO - PROCESS | 1668 | RSS: Main: 326275072 08:55:06 INFO - PROCESS | 1668 | 08:55:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:55:09 INFO - PROCESS | 1668 | RSS: Main: 319631360 08:55:09 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 08:55:11 INFO - PROCESS | 1668 | RSS: Main: 363012096 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | __start_tp_report 08:55:11 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 08:55:11 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 08:55:11 INFO - PROCESS | 1668 | |i|pagename|runs| 08:55:11 INFO - PROCESS | 1668 | |0;ai-astar;114;114;114;114;113;113;112;113;114;113 08:55:11 INFO - PROCESS | 1668 | |1;audio-beat-detection;151;114;117;151;116;112;117;111;142;115 08:55:11 INFO - PROCESS | 1668 | |2;audio-dft;188;183;181;185;182;183;180;183;183;183 08:55:11 INFO - PROCESS | 1668 | |3;audio-fft;78;58;60;86;61;58;59;58;83;58 08:55:11 INFO - PROCESS | 1668 | |4;audio-oscillator;85;71;92;70;68;69;92;68;68;90 08:55:11 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;96;122;90;87;90;86;90;87;90;87 08:55:11 INFO - PROCESS | 1668 | |6;imaging-darkroom;95;95;94;95;94;95;94;120;146;96 08:55:11 INFO - PROCESS | 1668 | |7;imaging-desaturate;86;87;84;86;85;86;84;87;85;93 08:55:11 INFO - PROCESS | 1668 | |8;json-parse-financial;57;52;53;53;55;54;54;53;54;55 08:55:11 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;66;66;77;83;104;97;85;70;70;70 08:55:11 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;87;88;90;87;84;85;89;86;86;90 08:55:11 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;149;153;139;159;173;164;154;152;191;246 08:55:11 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;166;171;170;178;222;212;172;171;172;172 08:55:11 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;69;68;70;65;86;69;68;68;68;68 08:55:11 INFO - PROCESS | 1668 | __end_tp_report 08:55:11 INFO - PROCESS | 1668 | __start_cc_report 08:55:11 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,2016 08:55:11 INFO - PROCESS | 1668 | __end_cc_report 08:55:11 INFO - PROCESS | 1668 | __startTimestamp1476287711963__endTimestamp 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | ------- Summary: start ------- 08:55:11 INFO - PROCESS | 1668 | Number of tests: 14 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 08:55:11 INFO - PROCESS | 1668 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 112.0 113.0 114.0 113.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:117.00 stddev:16.45 (14.1%) stddev-sans-first:14.40 08:55:11 INFO - PROCESS | 1668 | Values: 151.0 114.0 117.0 151.0 116.0 112.0 117.0 111.0 142.0 115.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.00 stddev:2.18 (1.2%) stddev-sans-first:1.42 08:55:11 INFO - PROCESS | 1668 | Values: 188.0 183.0 181.0 185.0 182.0 183.0 180.0 183.0 183.0 183.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:65.90 Median:60.50 stddev:11.54 (19.1%) stddev-sans-first:11.38 08:55:11 INFO - PROCESS | 1668 | Values: 78.0 58.0 60.0 86.0 61.0 58.0 59.0 58.0 83.0 58.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.00 stddev:10.92 (14.0%) stddev-sans-first:11.23 08:55:11 INFO - PROCESS | 1668 | Values: 85.0 71.0 92.0 70.0 68.0 69.0 92.0 68.0 68.0 90.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:90.00 stddev:10.75 (11.9%) stddev-sans-first:11.33 08:55:11 INFO - PROCESS | 1668 | Values: 96.0 122.0 90.0 87.0 90.0 86.0 90.0 87.0 90.0 87.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:95.00 stddev:17.26 (18.2%) stddev-sans-first:18.10 08:55:11 INFO - PROCESS | 1668 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 94.0 120.0 146.0 96.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.00 stddev:2.58 (3.0%) stddev-sans-first:2.74 08:55:11 INFO - PROCESS | 1668 | Values: 86.0 87.0 84.0 86.0 85.0 86.0 84.0 87.0 85.0 93.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.41 (2.6%) stddev-sans-first:1.00 08:55:11 INFO - PROCESS | 1668 | Values: 57.0 52.0 53.0 53.0 55.0 54.0 54.0 53.0 54.0 55.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:78.80 Median:73.50 stddev:13.27 (18.1%) stddev-sans-first:13.25 08:55:11 INFO - PROCESS | 1668 | Values: 66.0 66.0 77.0 83.0 104.0 97.0 85.0 70.0 70.0 70.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.50 stddev:2.04 (2.3%) stddev-sans-first:2.17 08:55:11 INFO - PROCESS | 1668 | Values: 87.0 88.0 90.0 87.0 84.0 85.0 89.0 86.0 86.0 90.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:168.00 Median:161.50 stddev:30.94 (19.2%) stddev-sans-first:32.04 08:55:11 INFO - PROCESS | 1668 | Values: 149.0 153.0 139.0 159.0 173.0 164.0 154.0 152.0 191.0 246.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:172.00 stddev:19.55 (11.4%) stddev-sans-first:20.00 08:55:11 INFO - PROCESS | 1668 | Values: 166.0 171.0 170.0 178.0 222.0 212.0 172.0 171.0 172.0 172.0 08:55:11 INFO - PROCESS | 1668 | 08:55:11 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:68.50 stddev:5.80 (8.5%) stddev-sans-first:6.14 08:55:11 INFO - PROCESS | 1668 | Values: 69.0 68.0 70.0 65.0 86.0 69.0 68.0 68.0 68.0 68.0 08:55:11 INFO - PROCESS | 1668 | -------- Summary: end -------- 08:55:11 INFO - PROCESS | 1668 | 08:55:12 INFO - TEST-INFO | 1668: exit 0 08:55:12 INFO - TEST-OK | kraken | took 59623ms 08:55:12 INFO - SUITE-END | took 1178s 08:55:13 INFO - Completed test suite (00:19:38) 08:55:13 INFO - javascript benchmark 08:55:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3003.4443627928836, 3295.406826771181, 3331.450310698733, 3353.6082525751813, 3364.4616861302197, 4692.366530518383, 5213.348331458567, 5577.3028371453565, 5666.971665141674, 5677.0, 4803.831865884695, 5583.609147359676, 5666.263385759856, 5692.203091567184, 5751.683657398852, 5180.948190518085, 5197.0905091609, 5230.2416149658275, 5246.606504512177, 5251.947480525184, 5169.586433085344, 5237.10969135246, 5255.737213139328, 5265.710385928773, 5279.973600131994, 4490.393796837434, 4975.880426903954, 5119.360079990001, 5301.1783173608155, 5331.840044798662, 4787.904241915177, 5103.055934652101, 5207.6354655174155, 5218.9739051304505, 5254.369475662907, 5109.795608175668, 5123.1546794778815, 5176.145935920568, 5186.870328241786, 5188.962207558503, 5578.3584887738025, 5605.1872478490795, 5619.80330688424, 5621.437856214387, 5641.689707066151, 6185.752569897199, 6196.0, 6209.596376235575, 6213.813585592439, 6219.1604133442315, 6095.634261944298, 6107.340534417129, 6112.083187521863, 6186.443220110166, 6256.280527739323, 5688.317401911714, 5708.743106560215, 5725.112607545837, 5734.426557344315, 5741.942580574224, 6270.0, 6273.404026617464, 6290.654014029181, 6290.905636415458, 6313.9368606314265, 5868.061110222429, 5936.673482958478, 6074.908876366858, 6085.939140608626, 6087.1173679816175, 6102.664353460514, 6133.48768512239, 6140.267580926534, 6141.946315431794, 6145.477634401126, 6066.575339726265, 6127.142200091991, 6140.938590614037, 6149.13912052313, 6156.938430615726, 6133.570650054453, 6163.19878415803, 6177.4749146322165, 6188.9690551546955, 6204.069389591597, 4837.153498137812, 4837.443693975238, 4841.515848415131, 4862.367892174066, 4865.002674451729, 4282.464691913511, 4341.804618792099, 4343.695941284143, 4344.717593356485, 4386.342048692722, 5670.234518339971, 5686.118651609007, 5717.885642287214, 5729.312482502127, 5751.913721294184, 6183.84540386494, 6212.875742485216, 6251.624902505864, 6254.562180647311, 6256.217972753406, 5424.783008679688, 5465.863353416196, 5702.629329093678, 5705.2012718219485, 5733.627314224562, 5192.350956130484, 5203.765830537635, 5295.0, 5337.359516857924, 5346.652467589672, 6234.096056071844, 6247.687615619292, 6256.405641464054, 6259.029850373199, 6269.843253918689, 6207.224096987877, 6212.409821066992, 6244.313125556276, 6254.21822272216, 6268.561200715906, 6102.216595924137, 6154.261488621394, 6239.563230573998, 6245.313015568375, 6260.624362538262, 5869.735861886311, 5915.822525324247, 5923.614965027259, 5953.583249172516, 5971.910421343597, 5976.103584462366, 6004.8498787528915, 6007.759689612367, 6012.6392416455155, 6017.578769486269, 5762.394948530512, 5766.8846623066465, 5826.475617194473, 5838.4453476919625, 5881.470667639933, 5939.584229103922, 5982.940170598238, 5994.490468310242, 6023.216981792339, 6038.63768173911, 5891.3224979126235, 5916.290045194604, 5949.1076338549565, 5952.136940143741, 5971.164037034905, 5148.510891465305, 5981.0729336952845, 6052.122442245938, 6075.483583895419, 6078.969605151946, 5711.343195532567, 5789.623674461147, 5923.111533269872, 5931.970340148444, 5933.436323549256], "value": 5607.382533032429, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.832144588671, 496.523337595908, 504.5685938522563, 524.5357858295407, 528.6061883896498, 28020.217270668454, 37332.44001339982, 38299.425508617394, 38356.616433835654, 38432.99999999996, 38978.61021389785, 39333.409998849966, 39612.0, 39698.00754981127, 39707.60292397075, 8436.493810371367, 9243.352965292415, 9440.669576564822, 9446.574904129297, 9454.574544145496, 8512.276456501204, 8576.957115214447, 8582.356323275748, 8585.356098292621, 8588.570571471433, 11155.442227888614, 11385.0, 11395.943020284929, 11529.02003329718, 11560.132990025739, 11318.434078296094, 11351.829722554168, 11362.659120226324, 11369.999999999958, 11379.487923043484, 11153.832692509619, 11255.212135150543, 11258.831117533244, 11261.380624065672, 11295.943520282428, 37371.0, 37665.62334376676, 37723.811380943196, 37782.24435511274, 37820.0, 3431.7083047940955, 3482.512448257246, 3554.2891421715503, 3721.3673675475234, 3920.5491368492703, 23714.762852371427, 29878.402431951457, 29894.252643683863, 29908.102756917327, 30062.54906176409, 2979.3743313904106, 3077.984610076958, 3174.746020318369, 3242.8216448095345, 3280.5079238114236, 491551.0, 494012.0, 496725.0, 497890.0, 499964.0, 54122.72938635282, 54381.728091360084, 54409.72795135999, 54469.0, 54589.454105459234, 57011.0, 57076.0, 57098.85802284014, 57126.7143664279, 57145.0, 15560.533184004498, 15819.288132034086, 15821.841781582267, 15832.0, 15877.20613969297, 12309.56916507918, 12360.505579776709, 12365.134440589072, 12376.0, 12397.75204495905, 13215.537456188988, 13499.662508437172, 13552.322383880964, 13908.0, 14517.98374113823, 5488.286522752017, 5561.694106824163, 6165.136880836686, 6312.0, 6320.494360451153, 846.2933450568844, 946.6118891254553, 969.5346233807671, 1026.5688410867454, 1085.5169449595012, 23075.307740767803, 27879.860600697273, 28624.427511449656, 29292.0, 29483.705162948525, 1002.2733518199393, 1008.6016023670755, 1017.8524114003576, 1101.6474728086935, 1150.6250031212787, 14826.629334266514, 14840.62898427548, 14893.106413615218, 15171.089734615958, 15249.771253431207, 628675.0, 637713.0, 639369.0, 639558.0, 640320.0, 46662.0, 46959.5304046962, 53032.0, 54606.0, 54903.450965490636, 1301.2322729589587, 1338.3642769684516, 1350.3518311210478, 1350.648831303868, 1351.4256441012333, 29475.852620736758, 30063.098107056823, 30186.69813301927, 30290.939817107177, 30329.848350758104, 45195.0, 46018.07963840771, 46041.0, 46044.53955460402, 46163.0, 593530.0, 631296.0, 633273.0, 645921.9335129836, 799609.0, 23921.880390597937, 24098.87950560306, 24112.156074537306, 24477.265682029567, 24556.877215613807, 43193.35209971916, 43240.78379608082, 43903.560964389944, 44171.674849754556, 44598.0, 36849.447258291686, 37231.441528376556, 38204.6179538201, 38647.806760966014, 40434.59565404426, 36560.63439365679, 36850.8157459211, 37521.81239093787, 37549.4367584481, 37834.24331513299, 35565.0, 36273.81863090667, 36405.90782276536, 36483.08792280108, 36873.81563092167, 27278.181654550393, 32573.0, 33297.667023330425, 33383.833080835415, 33438.83280583679, 21638.6754198684, 24354.446040867973, 24430.633540497263, 24764.009439622212, 25042.74957250477], "value": 19275.30970088714, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.6676523181124, 348.96161422243534, 368.3976698098609, 374.9418840079787, 401.2096170544029, 14590.927045364771, 14894.47869324574, 15545.067295962235, 19583.118759655816, 19987.20051197954, 19147.42557723267, 19259.518512037204, 19360.935148566823, 20543.383698489033, 20786.0, 6462.935370646303, 6768.898466522982, 6822.4200942919915, 6828.2488926218075, 6831.04365388846, 7066.85866282674, 7219.350258476736, 7422.443316751238, 7554.169041405441, 7607.315341619254, 4564.406627138467, 4782.904341913159, 4833.903321933559, 7655.0, 7697.384209263246, 7424.109106907205, 7724.1889601591865, 7732.265434783687, 7741.8838717419285, 7747.457677962517, 7365.668544915492, 7429.5542267464125, 7439.925600743977, 7441.032665753418, 7441.441891858078, 26927.865360673266, 27441.17676469709, 28133.718662813313, 28232.0, 28547.858085676547, 2278.6012447821563, 2387.7612238775982, 2519.5842685956795, 2533.556627590183, 2936.4273966576525, 15408.767298616196, 16425.58936026597, 16442.917785411115, 16954.406595769087, 17859.107044647844, 1924.441911845563, 2059.2072052259837, 2104.884231367274, 2112.5352422467186, 2144.496043429808, 124755.0, 128326.4098218878, 134610.0, 141071.0, 142648.0, 18491.70558060923, 19277.8072219276, 20316.187352505734, 21293.46766330854, 21496.247631333143, 35251.294974100376, 35309.823450882584, 35436.468452973226, 35451.82274088613, 35507.0, 9972.700818975442, 10649.201309901788, 10869.45652717361, 11029.724256893642, 11163.051140652973, 8891.19979201875, 8916.687915922912, 8991.955040224757, 9133.360664753403, 9134.497602631918, 7981.281684648409, 9485.525723713787, 9626.807463850684, 9781.951090244504, 9791.412515248965, 3222.9838850805595, 3554.63616694895, 3576.6959808416054, 3630.3102410541915, 3657.8353974070696, 720.8666396716624, 867.7266661001764, 903.9276857851356, 922.1285884838763, 928.8467402878449, 19834.008299584963, 20460.590788184152, 20500.69248961267, 20510.487237819172, 20611.0, 895.9865602015975, 897.3404547657467, 914.6250037484732, 917.9724608261763, 968.8449848024283, 8271.54506502148, 10399.02664316046, 10515.369077855354, 10634.680959571226, 10686.412247326472, 586984.0, 589244.3982282276, 595137.0, 602475.0, 603089.0, 108528.0, 119219.80780192261, 139702.0, 139812.30093849465, 142477.0, 951.5575257505155, 976.1166144638971, 1016.7458135466134, 1018.1701912940929, 1019.2814066083394, 18306.084695765425, 18306.90846545759, 18402.539936501158, 18448.07759612041, 18496.907515462335, 51700.482995169565, 52661.47338526719, 53000.0, 53722.73138634282, 54453.72773136109, 74207.0, 78289.0, 80037.59981200057, 80262.59868700619, 80601.19398806171, 7839.951355419607, 7927.920720792949, 8181.018277806464, 8213.753587392388, 8272.420930534805, 11417.828732569184, 12762.808557871454, 12812.167209131749, 13231.536896208587, 13263.535776247785, 10939.398333091756, 11187.32876027441, 11257.155713321697, 11439.714007149887, 11495.712607184887, 11020.944895275472, 11111.611093611686, 11131.666050018512, 11433.428328583372, 11441.771164576496, 5777.9133313001175, 7940.444168908121, 9814.85277720849, 10016.599336026477, 11373.260738052, 7066.258042905421, 7463.626818659154, 8051.597420128853, 8079.959600201962, 8272.214139656722, 10260.948695256477, 10352.792944141225, 10761.0, 10947.83578246311, 11710.473028713557], "value": 10771.602484829416, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.100122917645, 1515.5680631020161, 1532.1190315568547, 1698.380091266688, 1850.8611854110936, 7153.928460715398, 7681.923180768191, 8158.143394943527, 8744.344174186945, 8783.077776833436, 8629.266512346458, 8686.218240358367, 8688.782780430492, 8695.39132260742, 8697.608607612658, 2307.3078076577044, 2324.2921995874785, 2333.311673056444, 2336.3458231695067, 2342.7305859826083, 2249.707538020055, 2285.485765702712, 2288.233441797, 2291.6906217660653, 2291.9541609167804, 2294.265834932822, 2304.481491664379, 2311.5492478966607, 2321.663358812971, 2328.092044102801, 2270.352949409427, 2296.0815673730476, 2296.1848543766973, 2297.8621282722925, 2298.253327471134, 2006.6488364536149, 2280.931572052841, 2282.657601359793, 2284.6344584866506, 2289.347535952246, 8636.697715579925, 8645.178708022728, 8701.434406763603, 8702.260307873838, 8715.825683486359, 5065.0, 5291.708956007418, 5292.708901010443, 5330.093884039723, 5333.653312534673, 3325.384803811303, 3450.240946991658, 3543.2382037861726, 3550.4851796489625, 3567.1795487037866, 887.7958069644018, 999.5002498750624, 1028.300755486269, 1046.9371837689764, 1052.952617132231, 11319.151063670257, 11324.263922844988, 11427.885721142766, 11430.142739294586, 11431.59989400367, 4264.7654379009455, 4311.719738217069, 4484.977575112169, 4487.640988720895, 4489.416375871116, 8781.824363512822, 8874.334424918157, 8876.51179185151, 8914.375993680509, 8936.821263574691, 5153.768080436389, 5162.148245539519, 5164.690118592896, 5166.250893620404, 5176.922346164811, 4104.651104656137, 4325.891852703708, 4469.955300447019, 4505.16654418927, 4850.6119510439785, 3441.741869359758, 3738.1776009277914, 3739.383001804672, 3739.513863197821, 3741.214344987529, 975.5414954971152, 1064.1646307648614, 1108.1688733449912, 1118.9440527973732, 1126.1441304608556, 833.7498750374863, 842.5913431985482, 881.1716986033108, 900.8648702694649, 941.3833938770116, 5494.0, 5702.344230413472, 5822.7088645567555, 5892.469677729025, 6005.549583781234, 871.54679566625, 881.1452890696015, 905.5110240470204, 934.2572654739498, 959.9232061435068, 3724.5902950675404, 3774.490443790108, 3818.312703713358, 3892.163184915257, 3925.509311336083, 9365.719028429157, 10278.640247591298, 10372.533236004247, 10388.636397726043, 10394.0, 10340.586376544854, 10350.844737328945, 10351.223658225663, 10355.17158627323, 10392.0, 8019.879701804478, 8162.714304999416, 8166.7958301042945, 8173.100958894517, 8177.9182208178345, 5081.441041485507, 5750.856228594319, 5917.112433135064, 5974.970125149346, 6095.603785753912, 9640.855387169058, 9941.801163976535, 9945.552450139905, 9972.152367048591, 10002.399856008662, 9499.620015199314, 9762.219022478042, 9899.20806335477, 9974.40153590787, 10004.999500050228, 7300.488965772345, 7489.812754680958, 7500.324970752658, 7505.887411688938, 7507.0, 8037.0, 8102.0, 8126.471779334324, 8181.713640022571, 8193.83612327762, 7325.7802265932105, 7383.483156179231, 7397.704091836266, 7447.32974032318, 7465.0, 6956.200036995608, 7160.427165826825, 7214.386777124003, 7283.089613798275, 7337.449691273283, 6805.965970170316, 6908.896366554606, 6927.411170050602, 6930.44556435494, 6935.445164386938, 4715.929261061156, 4855.878603034952, 4865.829695960624, 4939.629527785502, 5071.695698258116, 4821.276808478756, 4874.854409213903, 4970.502949705001, 5017.197248440232, 5129.461406552258], "value": 4444.882892656453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.51075725053664, 296.64847156120015, 306.16569847166465, 310.93314937288477, 311.6291612980552, 4201.936970945439, 4268.40242366069, 4653.395058642376, 4958.016793282689, 5121.487851214877, 4963.627727920411, 5033.974830125844, 5074.594032477402, 5093.351457242232, 5097.566706829914, 3334.6328005517744, 3924.941125883114, 3936.1930804185217, 3942.4283478895545, 3952.774639861645, 3637.290728307981, 3966.9404958925493, 3966.9801650991703, 3976.840926362942, 3982.960170398288, 3433.8798142065034, 3888.51393575803, 3892.610738926113, 3925.5485619153733, 3936.6457018868296, 3900.3759398496386, 3911.1004468972296, 3920.607939206085, 3951.328274193394, 3969.6824254059607, 3232.482802751572, 3380.830958452092, 3424.0, 3426.229098452853, 3432.433648448003, 4970.577500912426, 4974.4776798436005, 4988.725620090893, 4993.750312484398, 4997.725125118117, 4434.667399944985, 4447.688661793676, 4454.198244316054, 4458.977705111453, 4486.327050942352, 4342.913141737179, 4504.549545045502, 5213.4004589472315, 5215.3741551013745, 5255.001549705582, 3154.9053528394184, 3155.100796273074, 3366.107981384935, 3688.428293614494, 3743.232637309345, 5161.509656582619, 5197.66215196011, 5327.469452010303, 5695.971520142456, 5715.742791574347, 3229.951550726741, 3252.837358132084, 3504.3367041048987, 3795.962040379616, 3798.3352913240074, 3382.864685412556, 3679.742418030712, 3786.9431958520645, 3812.864795714409, 3850.5186851643543, 4425.911481770347, 4426.3581780641625, 4431.33529970507, 4432.689711720149, 4437.33439984005, 5236.528712415825, 5439.537639300704, 5440.483154100433, 5445.591580631469, 5447.0, 1089.7057794395469, 1106.0930037369442, 1164.2083383299437, 1168.258156070884, 1285.6850071732486, 716.3373879161754, 772.2547741429547, 772.6986475274647, 784.2862994674819, 792.7582087463263, 3350.3466823969093, 4054.9254447571416, 4074.5110586729784, 4202.117555313357, 4218.7468751874985, 3717.7955212463576, 3903.4144878268485, 4512.481064677539, 4521.796519156645, 4543.34121552373, 3554.7867127972404, 3639.6906262967414, 3778.8110594470168, 4100.876973690794, 4212.599803018708, 2136.369770917583, 2373.3623799578236, 2398.328468028955, 2462.876856157185, 2477.08347911274, 3515.472679098156, 4138.813753381105, 4609.216433206363, 4668.229742092584, 4685.906281874343, 3907.648311651908, 3916.784576848244, 4443.155800397979, 4563.99184358881, 4605.0559635274685, 3861.864834730771, 4012.6789856811383, 4082.1631565528996, 4467.374567560544, 4585.564371384713, 3393.1347506385714, 3699.685526730258, 4507.756756891794, 4522.231220692424, 4524.796384162655, 3957.8416863326297, 4025.9668867221867, 4435.248077009499, 4499.707519011254, 4509.0, 4255.340422234559, 4273.401723758614, 4589.219832628394, 4650.000249946278, 4696.8121275148615, 2907.7964542481823, 2924.7513961313525, 3146.559481672522, 3210.3739770744482, 3270.9205962032947, 3697.7966211858607, 4115.991582062414, 4214.367844823301, 4529.353870134441, 4576.176288268143, 3695.408734602558, 4390.517043125317, 4417.197515825593, 4431.446069241345, 4433.246348120762, 4175.352820312856, 5165.354330708661, 5209.004822227159, 5249.790008399621, 5268.394134674561, 4348.34774783785, 5009.849704508871, 5272.525472707322, 5311.3891902431715, 5326.493983071602, 5102.617303702312, 5392.568594512508, 5395.784168633368, 5399.892002160013, 5419.620626556103, 5332.466753324637, 5352.287268074178, 5363.356397232357, 5371.570274377962, 5380.596455265949], "value": 3610.194868017792, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.9785506434808, 755.5768769489086, 756.6821934787389, 771.0285040848529, 801.3108726495215, 15475.226238688063, 15735.291911863966, 15745.0, 15757.369705211779, 15766.684666306666, 14131.293435328218, 14233.217173055478, 14269.286535673227, 14272.71454570908, 14282.2858857057, 667.9031540426636, 688.2601203706012, 689.0, 813.8738495533202, 827.7227128911807, 836.3643630840544, 836.8702851058096, 845.4758050009003, 846.2130218896424, 847.5719761520423, 902.345799295512, 904.4030939579878, 907.3240435875249, 908.3596064774351, 908.7319240823973, 896.820635872828, 901.197933838884, 901.8331608652387, 903.5121034641253, 904.6336233825245, 486.1880659298979, 516.2050442318824, 649.3636236488268, 665.5208250059949, 666.9566478178951, 14365.13809171453, 14407.038064532233, 14443.78334324986, 14459.566213013626, 14484.710305793826, 11600.477978490904, 13116.01629877763, 13361.331933403291, 13492.12301200419, 13714.22322520356, 11802.940985295105, 12186.939065304705, 12195.695107622292, 12220.511179552896, 12365.505379784798, 4396.362527433536, 4422.867313980586, 4431.0, 4453.3320001999955, 4518.728876267402, 87060.56469717674, 91779.08220917772, 108142.91857081486, 108842.0, 109004.0, 10394.272400932014, 10630.30902991303, 10686.625968091235, 10827.78344433107, 10916.945415273032, 20895.37313880586, 20944.162233510793, 20965.37103886886, 20968.47578810542, 21003.369898903056, 7433.0, 7784.494007889469, 7870.881936770838, 8041.075276343178, 8099.433039687283, 4235.830566777295, 4299.400187534471, 4306.3061263223235, 4332.090261045153, 4515.571020753023, 3378.0, 3472.9826350868084, 3491.0748651607346, 3497.632748561415, 3516.6659167379057, 626.5707990026846, 648.5265755998148, 649.7693318871827, 655.131950166032, 660.6663634864459, 551.8537587539305, 557.6598275052215, 614.0482252508683, 615.9199304090529, 616.9228846394201, 7579.848403031909, 8221.630026648816, 8611.870821937677, 8703.477791332414, 8797.208251257418, 587.6033677267912, 619.5353484886335, 622.0116985666039, 624.144921457606, 638.7189636559899, 4177.540470548237, 4222.915541689149, 4286.742795432284, 4303.526612072669, 4367.372514695482, 106154.93845061606, 129852.3507382457, 145360.0, 158983.0, 161919.38080619278, 130124.0, 137437.0, 137833.0, 138361.0, 139006.30496847653, 80354.39291214143, 113879.0, 114980.0, 116276.0, 119101.0, 7014.649267536704, 8304.501729896225, 8376.623051962555, 8385.37109716786, 8500.192481714228, 42658.78670606627, 61124.0, 61676.69161654163, 62343.0, 64517.354826451134, 74829.14293999052, 87615.0, 93206.0, 95117.52441237749, 95357.52321238627, 10467.267291289536, 10588.67641544807, 10865.0, 11101.666949991513, 11479.311241325548, 9994.300398972002, 11821.0, 12016.819747703617, 12051.75896482048, 12448.688782780502, 11250.549978001116, 11259.605913792979, 11372.943135284271, 11381.374024428405, 11729.178957472895, 9862.802743944938, 11406.201565890307, 11422.600208992646, 11460.19778615489, 11523.769524609294, 10967.50646220906, 10990.670279891616, 11032.44837758125, 11337.773244535229, 11572.826407603725, 8881.467111973303, 9069.501177435304, 9205.263578913804, 9429.292803039936, 9441.622335106518, 8799.560021999003, 9047.095290470901, 9080.818383632159, 9103.362764606414, 9233.307501937246], "value": 7357.840466714892, "unit": "score"}], "name": "dromaeo_css", "value": 7184.109892819485, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 112.0, 113.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 117.0, 151.0, 116.0, 112.0, 117.0, 111.0, 142.0, 115.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 181.0, 185.0, 182.0, 183.0, 180.0, 183.0, 183.0, 183.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 60.0, 86.0, 61.0, 58.0, 59.0, 58.0, 83.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 92.0, 70.0, 68.0, 69.0, 92.0, 68.0, 68.0, 90.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 122.0, 90.0, 87.0, 90.0, 86.0, 90.0, 87.0, 90.0, 87.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 120.0, 146.0, 96.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 86.0, 85.0, 86.0, 84.0, 87.0, 85.0, 93.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 53.0, 53.0, 55.0, 54.0, 54.0, 53.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 77.0, 83.0, 104.0, 97.0, 85.0, 70.0, 70.0, 70.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 90.0, 87.0, 84.0, 85.0, 89.0, 86.0, 86.0, 90.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 153.0, 139.0, 159.0, 173.0, 164.0, 154.0, 152.0, 191.0, 246.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 170.0, 178.0, 222.0, 212.0, 172.0, 171.0, 172.0, 172.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 65.0, 86.0, 69.0, 68.0, 68.0, 68.0, 68.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1483.9999999999998, "alertThreshold": 2.0}]} 08:55:13 INFO - Return code: 0 08:55:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:55:13 INFO - # TBPL SUCCESS # 08:55:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:55:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:55:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:55:13 INFO - 2016-10-12 08:55:13.260 screenresolution[1672:10394] starting screenresolution argv=screenresolution get 08:55:13 INFO - 2016-10-12 08:55:13.264 screenresolution[1672:10394] Display 0: 1600x1200x32@60 08:55:13 INFO - 2016-10-12 08:55:13.270 screenresolution[1673:10397] starting screenresolution argv=screenresolution list 08:55:13 INFO - Available Modes on Display 0 08:55:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:55:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:55:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:55:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:55:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:55:13 INFO - Intel Iris: 08:55:13 INFO - Chipset Model: Intel Iris 08:55:13 INFO - Type: GPU 08:55:13 INFO - Bus: Built-In 08:55:13 INFO - VRAM (Dynamic, Max): 1536 MB 08:55:13 INFO - Vendor: Intel (0x8086) 08:55:13 INFO - Device ID: 0x0a2e 08:55:13 INFO - Revision ID: 0x0009 08:55:13 INFO - Displays: 08:55:13 INFO - Display: 08:55:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:55:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:55:13 INFO - Display Serial Number: 1600x1200 60 08:55:13 INFO - Main Display: Yes 08:55:13 INFO - Mirror: Off 08:55:13 INFO - Online: Yes 08:55:13 INFO - Rotation: Supported 08:55:13 INFO - Return code: 0 08:55:13 INFO - Running post-action listener: _resource_record_post_action 08:55:13 INFO - [mozharness: 2016-10-12 15:55:13.511454Z] Finished run-tests step (success) 08:55:13 INFO - Running post-run listener: _resource_record_post_run 08:55:13 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 38323200; Write bytes: 707192832; Read time: 373; Write time: 1921 08:55:13 INFO - TinderboxPrint: CPU usage
53.9% 08:55:13 INFO - TinderboxPrint: I/O read bytes / time
38,323,200 / 373 08:55:13 INFO - TinderboxPrint: I/O write bytes / time
707,192,832 / 1,921 08:55:13 INFO - TinderboxPrint: CPU idle
2,241.7 (46.1%) 08:55:13 INFO - TinderboxPrint: CPU system
980.1 (20.2%) 08:55:13 INFO - TinderboxPrint: CPU user
1,639.9 (33.7%) 08:55:13 INFO - TinderboxPrint: Swap in / out
445,607,936 / 0 08:55:13 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 413420032; Write bytes: 410523648; Read time: 32254; Write time: 761 08:55:13 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 29150208; Write bytes: 295063552; Read time: 280; Write time: 1154 08:55:14 INFO - Running post-run listener: _upload_blobber_files 08:55:14 INFO - Blob upload gear active. 08:55:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:55:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:55:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:55:14 INFO - (blobuploader) - INFO - Open directory for files ... 08:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:15 INFO - (blobuploader) - INFO - Done attempting. 08:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:55:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:16 INFO - (blobuploader) - INFO - Done attempting. 08:55:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:55:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:55:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:19 INFO - (blobuploader) - INFO - Done attempting. 08:55:19 INFO - (blobuploader) - INFO - Iteration through files over. 08:55:19 INFO - Return code: 0 08:55:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:55:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:55:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/39efc74a2df983f09637af547b970bde8971e1d09abd3ad45e96fa70716e0804babe89d32a3756372a8349ea57b700ed41298c3f0dc93c1eacffe4cbd22ba1c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4b512b7bd8f837371354b65121fa9052bb6a52afde181c012ff66384d46db6ed64546120053651986e03348787900ba9baacb40f1d4330368f7000a17f2e504", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/58a7ae43bbfc9777ca0e42e3ee68be49093815ff1b6651f1b6db1f479444076f261f1b3706814412e3a056e3bf7464846cb7258f70f6e014512fd44888f2c115"} 08:55:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:55:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:55:19 INFO - Contents: 08:55:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/39efc74a2df983f09637af547b970bde8971e1d09abd3ad45e96fa70716e0804babe89d32a3756372a8349ea57b700ed41298c3f0dc93c1eacffe4cbd22ba1c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4b512b7bd8f837371354b65121fa9052bb6a52afde181c012ff66384d46db6ed64546120053651986e03348787900ba9baacb40f1d4330368f7000a17f2e504", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/58a7ae43bbfc9777ca0e42e3ee68be49093815ff1b6651f1b6db1f479444076f261f1b3706814412e3a056e3bf7464846cb7258f70f6e014512fd44888f2c115"} 08:55:19 INFO - Running post-run listener: copy_logs_to_upload_dir 08:55:19 INFO - Copying logs to upload dir... 08:55:19 INFO - mkdir: /builds/slave/test/build/upload/logs 08:55:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.695497 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-12 08:55:19.399833) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 08:55:19.403245) ========= 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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/Autoland/sha512/39efc74a2df983f09637af547b970bde8971e1d09abd3ad45e96fa70716e0804babe89d32a3756372a8349ea57b700ed41298c3f0dc93c1eacffe4cbd22ba1c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4b512b7bd8f837371354b65121fa9052bb6a52afde181c012ff66384d46db6ed64546120053651986e03348787900ba9baacb40f1d4330368f7000a17f2e504", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/58a7ae43bbfc9777ca0e42e3ee68be49093815ff1b6651f1b6db1f479444076f261f1b3706814412e3a056e3bf7464846cb7258f70f6e014512fd44888f2c115"} build_url:https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/DfIBmbViS_aCBALNFw-EPw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/39efc74a2df983f09637af547b970bde8971e1d09abd3ad45e96fa70716e0804babe89d32a3756372a8349ea57b700ed41298c3f0dc93c1eacffe4cbd22ba1c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4b512b7bd8f837371354b65121fa9052bb6a52afde181c012ff66384d46db6ed64546120053651986e03348787900ba9baacb40f1d4330368f7000a17f2e504", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/58a7ae43bbfc9777ca0e42e3ee68be49093815ff1b6651f1b6db1f479444076f261f1b3706814412e3a056e3bf7464846cb7258f70f6e014512fd44888f2c115"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 08:55:19.435929) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 08:55:19.436278) ========= 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.ZOvQfRIoMB/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.AYcGnN3GWc/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005090 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 08:55:19.485005) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 08:55:19.485329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 08:55:19.485658) ========= ========= Total master_lag: 0.16 =========