builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1480915253.36 results: success (0) buildid: 20161204201538 builduid: 5a945a861c1b4c11b0babb22b7b7a174 revision: 46322372c0f4c6b176c953ec1bef8516d4b382dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:53.361911) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:53.362347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:53.362622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:53.628811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:53.629064) ========= 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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-04 21:20:53-- 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% 20.7M=0.001s 2016-12-04 21:20:53 (20.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136359 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:53.839974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:53.840250) ========= 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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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.026555 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:53.931521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 21:20:53.931949) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 46322372c0f4c6b176c953ec1bef8516d4b382dd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 46322372c0f4c6b176c953ec1bef8516d4b382dd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-04 21:20:54,037 truncating revision to first 12 chars 2016-12-04 21:20:54,037 Setting DEBUG logging. 2016-12-04 21:20:54,037 attempt 1/10 2016-12-04 21:20:54,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/46322372c0f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-04 21:20:55,434 unpacking tar archive at: graphics-46322372c0f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.675703 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 21:20:55.635743) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:55.636100) ========= script_repo_revision: 46322372c0f4c6b176c953ec1bef8516d4b382dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:55.636581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:55.643063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 21:20:55.689824) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-04 21:20:55.690238) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:20:55 INFO - MultiFileLogger online at 20161204 21:20:55 in /builds/slave/test 21:20:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 21:20:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:20:55 INFO - {'append_to_log': False, 21:20:55 INFO - 'base_work_dir': '/builds/slave/test', 21:20:55 INFO - 'blob_upload_branch': 'Graphics', 21:20:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:20:55 INFO - 'branch': 'Graphics', 21:20:55 INFO - 'buildbot_json_path': 'buildprops.json', 21:20:55 INFO - 'config_files': ('talos/mac_config.py',), 21:20:55 INFO - 'default_actions': ('clobber', 21:20:55 INFO - 'read-buildbot-config', 21:20:55 INFO - 'download-and-extract', 21:20:55 INFO - 'populate-webroot', 21:20:55 INFO - 'create-virtualenv', 21:20:55 INFO - 'install', 21:20:55 INFO - 'run-tests'), 21:20:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:20:55 INFO - 'download_minidump_stackwalk': True, 21:20:55 INFO - 'download_symbols': 'ondemand', 21:20:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:20:55 INFO - 'tooltool.py': '/tools/tooltool.py', 21:20:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:20:55 INFO - '/tools/misc-python/virtualenv.py')}, 21:20:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:20:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:20:55 INFO - 'installer_path': 'installer.exe', 21:20:55 INFO - 'log_level': 'info', 21:20:55 INFO - 'log_name': 'talos', 21:20:55 INFO - 'log_to_console': True, 21:20:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:20:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:20:55 INFO - 'opt_config_files': (), 21:20:55 INFO - 'pip_index': False, 21:20:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:20:55 INFO - 'cmd': ('bash', 21:20:55 INFO - '-c', 21:20:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:20:55 INFO - 'enabled': True, 21:20:55 INFO - 'halt_on_failure': False, 21:20:55 INFO - 'name': 'check_screen_resolution'},), 21:20:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:20:55 INFO - 'cmd': ('bash', 21:20:55 INFO - '-c', 21:20:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:20:55 INFO - 'enabled': True, 21:20:55 INFO - 'halt_on_failure': False, 21:20:55 INFO - 'name': 'check_screen_resolution'},), 21:20:55 INFO - 'run_cmd_checks_enabled': True, 21:20:55 INFO - 'sps_profile': False, 21:20:55 INFO - 'sps_profile_interval': 0, 21:20:55 INFO - 'suite': 'dromaeojs', 21:20:55 INFO - 'system_bits': '32', 21:20:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:20:55 INFO - 'title': 't-yosemite-r7-0038', 21:20:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:20:55 INFO - 'use_talos_json': True, 21:20:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:20:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:20:55 INFO - 'work_dir': 'build'} 21:20:55 INFO - [mozharness: 2016-12-05 05:20:55.893461Z] Running clobber step. 21:20:55 INFO - Running pre-action listener: _resource_record_pre_action 21:20:55 INFO - Running main action method: clobber 21:20:55 INFO - rmtree: /builds/slave/test/build 21:20:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:20:58 INFO - Running post-action listener: _resource_record_post_action 21:20:58 INFO - [mozharness: 2016-12-05 05:20:58.211667Z] Finished clobber step (success) 21:20:58 INFO - [mozharness: 2016-12-05 05:20:58.211792Z] Running read-buildbot-config step. 21:20:58 INFO - Running pre-action listener: _resource_record_pre_action 21:20:58 INFO - Running main action method: read_buildbot_config 21:20:58 INFO - Using buildbot properties: 21:20:58 INFO - { 21:20:58 INFO - "project": "", 21:20:58 INFO - "product": "firefox", 21:20:58 INFO - "script_repo_revision": "default", 21:20:58 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 21:20:58 INFO - "repository": "", 21:20:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 21:20:58 INFO - "buildid": "20161204201538", 21:20:58 INFO - "pgo_build": "False", 21:20:58 INFO - "basedir": "/builds/slave/test", 21:20:58 INFO - "buildnumber": 0, 21:20:58 INFO - "slavename": "t-yosemite-r7-0038", 21:20:58 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 21:20:58 INFO - "platform": "yosemite_r7", 21:20:58 INFO - "scheduler": "tests-graphics-macosx64-talos", 21:20:58 INFO - "branch": "graphics", 21:20:58 INFO - "repo_path": "projects/graphics", 21:20:58 INFO - "revision": "46322372c0f4c6b176c953ec1bef8516d4b382dd", 21:20:58 INFO - "stage_platform": "macosx64", 21:20:58 INFO - "builduid": "5a945a861c1b4c11b0babb22b7b7a174", 21:20:58 INFO - "slavebuilddir": "test" 21:20:58 INFO - } 21:20:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:20:58 INFO - Running post-action listener: _resource_record_post_action 21:20:58 INFO - [mozharness: 2016-12-05 05:20:58.214963Z] Finished read-buildbot-config step (success) 21:20:58 INFO - [mozharness: 2016-12-05 05:20:58.215044Z] Running download-and-extract step. 21:20:58 INFO - Running pre-action listener: _resource_record_pre_action 21:20:58 INFO - Running main action method: download_and_extract 21:20:58 INFO - mkdir: /builds/slave/test/build/tests 21:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:58 INFO - trying https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:20:58 INFO - Downloading https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:20:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 21:20:59 INFO - Downloaded 1199 bytes. 21:20:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:20:59 INFO - Using the following test package requirements: 21:20:59 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:20:59 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:20:59 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:20:59 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:20:59 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:20:59 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:20:59 INFO - u'jsshell-mac.zip'], 21:20:59 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:20:59 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:20:59 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:20:59 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:20:59 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:20:59 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:20:59 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:20:59 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:20:59 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:20:59 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:20:59 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:20:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:20:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:20:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:20:59 INFO - Fetch https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:20:59 INFO - Http code: 200 21:20:59 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 21:20:59 INFO - x-amz-cf-id: vWSzdsIWPiPv0CTDZKlKa4xM7NMzukVvy91sSDQ9G1cYiC8EbsCt3w== 21:20:59 INFO - x-amz-version-id: OTIgGORS_11KW2DtcteekPSZ1RZ82tFF 21:21:00 INFO - Expected file size: 16282551 21:21:00 INFO - Obtained file size: 16282551 21:21:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:21:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:21:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:21:06 INFO - Fetch https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:21:07 INFO - Http code: 200 21:21:07 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 21:21:07 INFO - x-amz-cf-id: l-v6F-djiXSW-7vjeTTchBKKR4fWRU6zyBu3MfjQngoMRZyoVEC7Wg== 21:21:07 INFO - x-amz-version-id: OTIgGORS_11KW2DtcteekPSZ1RZ82tFF 21:21:07 INFO - Expected file size: 16282551 21:21:07 INFO - Obtained file size: 16282551 21:21:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:21:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:21:13 INFO - Fetch https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:21:14 INFO - Http code: 200 21:21:14 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 21:21:14 INFO - x-amz-cf-id: PhwLYY83B6TALW6F6UqIqsh6UZbsUeSxFAQmiFXwB5Sof7fw9sCl8w== 21:21:14 INFO - x-amz-version-id: tZ9VkZ6LdlohTJnsMbCLzA_U_E91UDyj 21:21:14 INFO - Expected file size: 14409702 21:21:14 INFO - Obtained file size: 14409702 21:21:15 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')]} 21:21:15 INFO - trying https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:21:15 INFO - Downloading https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 21:21:17 INFO - Downloaded 107762816 bytes. 21:21:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:21:17 INFO - mkdir: /builds/slave/test/properties 21:21:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:21:17 INFO - Writing to file /builds/slave/test/properties/build_url 21:21:17 INFO - Contents: 21:21:17 INFO - build_url:https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:21:18 INFO - Running post-action listener: _resource_record_post_action 21:21:18 INFO - Running post-action listener: set_extra_try_arguments 21:21:18 INFO - [mozharness: 2016-12-05 05:21:18.550597Z] Finished download-and-extract step (success) 21:21:18 INFO - [mozharness: 2016-12-05 05:21:18.550718Z] Running populate-webroot step. 21:21:18 INFO - Running pre-action listener: _resource_record_pre_action 21:21:18 INFO - Running main action method: populate_webroot 21:21:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:21:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:21:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:21:18 INFO - '--tppagecycles', 21:21:18 INFO - '7'], 21:21:18 INFO - 'tests': ['tsvgm']}}, 21:21:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:21:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:21:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:21:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:21:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:21:18 INFO - 'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:21:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:21:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:21:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:21:18 INFO - 'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['damp', 'tps']}, 21:21:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:21:18 INFO - 'tests': ['damp', 'tps']}, 21:21:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['dromaeo_dom']}, 21:21:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:21:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['basic_compositor_video']}, 21:21:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:21:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['a11yr', 21:21:18 INFO - 'ts_paint', 21:21:18 INFO - 'tpaint', 21:21:18 INFO - 'sessionrestore', 21:21:18 INFO - 'sessionrestore_no_auto_restore', 21:21:18 INFO - 'tabpaint']}, 21:21:18 INFO - 'other-e10s': {'tests': ['a11yr', 21:21:18 INFO - 'ts_paint', 21:21:18 INFO - 'tpaint', 21:21:18 INFO - 'sessionrestore', 21:21:18 INFO - 'sessionrestore_no_auto_restore', 21:21:18 INFO - 'tabpaint']}, 21:21:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:21:18 INFO - 'ts_paint', 21:21:18 INFO - 'tpaint', 21:21:18 INFO - 'sessionrestore', 21:21:18 INFO - 'sessionrestore_no_auto_restore', 21:21:18 INFO - 'tabpaint']}, 21:21:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:21:18 INFO - 'ts_paint', 21:21:18 INFO - 'tpaint', 21:21:18 INFO - 'sessionrestore', 21:21:18 INFO - 'sessionrestore_no_auto_restore', 21:21:18 INFO - 'tabpaint']}, 21:21:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['a11yr', 21:21:18 INFO - 'ts_paint', 21:21:18 INFO - 'tpaint', 21:21:18 INFO - 'sessionrestore', 21:21:18 INFO - 'sessionrestore_no_auto_restore', 21:21:18 INFO - 'tabpaint']}, 21:21:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['a11yr', 21:21:18 INFO - 'ts_paint', 21:21:18 INFO - 'tpaint', 21:21:18 INFO - 'sessionrestore', 21:21:18 INFO - 'sessionrestore_no_auto_restore', 21:21:18 INFO - 'tabpaint']}, 21:21:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['tsvgx', 21:21:18 INFO - 'tsvgr_opacity', 21:21:18 INFO - 'tart', 21:21:18 INFO - 'tscrollx', 21:21:18 INFO - 'cart', 21:21:18 INFO - 'tsvg_static']}, 21:21:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:21:18 INFO - 'tsvgr_opacity', 21:21:18 INFO - 'tart', 21:21:18 INFO - 'tscrollx', 21:21:18 INFO - 'cart', 21:21:18 INFO - 'tsvg_static']}, 21:21:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:21:18 INFO - 'talos_options': ['--disable-e10s'], 21:21:18 INFO - 'tests': ['tp5o']}, 21:21:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:21:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:21:18 INFO - 'talos_options': ['--disable-e10s', 21:21:18 INFO - '--xperf_path', 21:21:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:21:18 INFO - 'tests': ['tp5n']}, 21:21:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:21:18 INFO - 'talos_options': ['--xperf_path', 21:21:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:21:18 INFO - 'tests': ['tp5n']}}, 21:21:18 INFO - 'talos.zip': {'path': '', 21:21:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:21:18 INFO - Running post-action listener: _resource_record_post_action 21:21:18 INFO - [mozharness: 2016-12-05 05:21:18.569431Z] Finished populate-webroot step (success) 21:21:18 INFO - [mozharness: 2016-12-05 05:21:18.569540Z] Running create-virtualenv step. 21:21:18 INFO - Running pre-action listener: _resource_record_pre_action 21:21:18 INFO - Running main action method: create_virtualenv 21:21:18 INFO - Creating virtualenv /builds/slave/test/build/venv 21:21:18 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 21:21:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:21:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:21:18 INFO - Using real prefix '/tools/python27' 21:21:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:21:19 INFO - Installing distribute.............................................................................................................................................................................................done. 21:21:22 INFO - Installing pip.................done. 21:21:22 INFO - Return code: 0 21:21:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:21:22 INFO - Reading from file tmpfile_stdout 21:21:22 INFO - Output received: 21:21:22 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) 21:21:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:22 INFO - 'HOME': '/Users/cltbld', 21:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:22 INFO - 'LOGNAME': 'cltbld', 21:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:22 INFO - 'MOZ_NO_REMOTE': '1', 21:21:22 INFO - 'NO_EM_RESTART': '1', 21:21:22 INFO - 'PAGER': '/bin/cat', 21:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:22 INFO - 'PWD': '/builds/slave/test', 21:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:22 INFO - 'SHELL': '/bin/bash', 21:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:22 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:22 INFO - 'USER': 'cltbld', 21:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:22 INFO - 'XPC_FLAGS': '0x0', 21:21:22 INFO - 'XPC_SERVICE_NAME': '0', 21:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:22 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 21:21:22 INFO - Cleaning up... 21:21:22 INFO - Return code: 0 21:21:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:22 INFO - 'HOME': '/Users/cltbld', 21:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:22 INFO - 'LOGNAME': 'cltbld', 21:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:22 INFO - 'MOZ_NO_REMOTE': '1', 21:21:22 INFO - 'NO_EM_RESTART': '1', 21:21:22 INFO - 'PAGER': '/bin/cat', 21:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:22 INFO - 'PWD': '/builds/slave/test', 21:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:22 INFO - 'SHELL': '/bin/bash', 21:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:22 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:22 INFO - 'USER': 'cltbld', 21:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:22 INFO - 'XPC_FLAGS': '0x0', 21:21:22 INFO - 'XPC_SERVICE_NAME': '0', 21:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:23 INFO - Downloading/unpacking psutil>=3.1.1 21:21:23 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 21:21:23 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 21:21:23 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 21:21:23 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 21:21:23 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 21:21:23 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 21:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:21:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:21:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:21:26 INFO - Installing collected packages: psutil 21:21:26 INFO - Running setup.py install for psutil 21:21:27 INFO - building 'psutil._psutil_osx' extension 21:21:27 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 21:21:27 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 21:21:27 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 21:21:27 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 21:21:27 INFO - building 'psutil._psutil_posix' extension 21:21:27 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 21:21:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:21:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:21:27 INFO - ^ 21:21:27 INFO - 1 warning generated. 21:21:27 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 21:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:21:28 INFO - Successfully installed psutil 21:21:28 INFO - Cleaning up... 21:21:28 INFO - Return code: 0 21:21:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:28 INFO - 'HOME': '/Users/cltbld', 21:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:28 INFO - 'LOGNAME': 'cltbld', 21:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:28 INFO - 'MOZ_NO_REMOTE': '1', 21:21:28 INFO - 'NO_EM_RESTART': '1', 21:21:28 INFO - 'PAGER': '/bin/cat', 21:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:28 INFO - 'PWD': '/builds/slave/test', 21:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:28 INFO - 'SHELL': '/bin/bash', 21:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:28 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:28 INFO - 'USER': 'cltbld', 21:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:28 INFO - 'XPC_FLAGS': '0x0', 21:21:28 INFO - 'XPC_SERVICE_NAME': '0', 21:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:21:31 INFO - Installing collected packages: mozsystemmonitor 21:21:31 INFO - Running setup.py install for mozsystemmonitor 21:21:31 INFO - Successfully installed mozsystemmonitor 21:21:31 INFO - Cleaning up... 21:21:31 INFO - Return code: 0 21:21:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:31 INFO - 'HOME': '/Users/cltbld', 21:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:31 INFO - 'LOGNAME': 'cltbld', 21:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:31 INFO - 'MOZ_NO_REMOTE': '1', 21:21:31 INFO - 'NO_EM_RESTART': '1', 21:21:31 INFO - 'PAGER': '/bin/cat', 21:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:31 INFO - 'PWD': '/builds/slave/test', 21:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:31 INFO - 'SHELL': '/bin/bash', 21:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:31 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:31 INFO - 'USER': 'cltbld', 21:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:31 INFO - 'XPC_FLAGS': '0x0', 21:21:31 INFO - 'XPC_SERVICE_NAME': '0', 21:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:31 INFO - Downloading/unpacking jsonschema==2.5.1 21:21:31 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 21:21:31 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 21:21:31 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 21:21:31 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 21:21:31 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 21:21:31 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 21:21:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:21:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:21: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 21:21: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 21:21: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 21:21: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 21:21: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 21:21: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 21:21:34 INFO - Downloading functools32-3.2.3-2.tar.gz 21:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:21:34 INFO - warning: no files found matching '*.txt' 21:21:34 INFO - no previously-included directories found matching 'build' 21:21:34 INFO - no previously-included directories found matching 'dist' 21:21:34 INFO - no previously-included directories found matching '.git*' 21:21:34 INFO - Installing collected packages: jsonschema, functools32 21:21:34 INFO - Running setup.py install for functools32 21:21:34 INFO - warning: no files found matching '*.txt' 21:21:34 INFO - no previously-included directories found matching 'build' 21:21:34 INFO - no previously-included directories found matching 'dist' 21:21:34 INFO - no previously-included directories found matching '.git*' 21:21:34 INFO - Successfully installed jsonschema functools32 21:21:34 INFO - Cleaning up... 21:21:34 INFO - Return code: 0 21:21:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:21: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')]} 21:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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')]} 21:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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', '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 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:21: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 functools32==3.2.3-2 21:21:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:34 INFO - 'HOME': '/Users/cltbld', 21:21:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:34 INFO - 'LOGNAME': 'cltbld', 21:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:34 INFO - 'MOZ_NO_REMOTE': '1', 21:21:34 INFO - 'NO_EM_RESTART': '1', 21:21:34 INFO - 'PAGER': '/bin/cat', 21:21:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:34 INFO - 'PWD': '/builds/slave/test', 21:21:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:34 INFO - 'SHELL': '/bin/bash', 21:21:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:34 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:34 INFO - 'USER': 'cltbld', 21:21:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:34 INFO - 'XPC_FLAGS': '0x0', 21:21:34 INFO - 'XPC_SERVICE_NAME': '0', 21:21:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:21:35 INFO - Cleaning up... 21:21:35 INFO - Return code: 0 21:21:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:21:35 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')]} 21:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:35 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')]} 21:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:35 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 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21:35 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 21:21:35 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 21:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:35 INFO - 'HOME': '/Users/cltbld', 21:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:35 INFO - 'LOGNAME': 'cltbld', 21:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:35 INFO - 'MOZ_NO_REMOTE': '1', 21:21:35 INFO - 'NO_EM_RESTART': '1', 21:21:35 INFO - 'PAGER': '/bin/cat', 21:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:35 INFO - 'PWD': '/builds/slave/test', 21:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:35 INFO - 'SHELL': '/bin/bash', 21:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:35 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:35 INFO - 'USER': 'cltbld', 21:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:35 INFO - 'XPC_FLAGS': '0x0', 21:21:35 INFO - 'XPC_SERVICE_NAME': '0', 21:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:35 INFO - Downloading/unpacking blobuploader==1.2.4 21:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:38 INFO - Downloading blobuploader-1.2.4.tar.gz 21:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:21:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:21:38 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 21:21:38 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 21:21:38 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 21:21:38 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 21:21:38 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 21:21:38 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 21:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:21:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:21:38 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 21:21:38 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 21:21:38 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 21:21:38 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 21:21:38 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 21:21:38 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 21:21:39 INFO - Downloading docopt-0.6.1.tar.gz 21:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:21:39 INFO - Installing collected packages: blobuploader, requests, docopt 21:21:39 INFO - Running setup.py install for blobuploader 21:21:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:21:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:21:39 INFO - Running setup.py install for requests 21:21:40 INFO - Running setup.py install for docopt 21:21:40 INFO - Successfully installed blobuploader requests docopt 21:21:40 INFO - Cleaning up... 21:21:40 INFO - Return code: 0 21:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:40 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 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21:40 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 21:21:40 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 21:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:40 INFO - 'HOME': '/Users/cltbld', 21:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:40 INFO - 'LOGNAME': 'cltbld', 21:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:40 INFO - 'MOZ_NO_REMOTE': '1', 21:21:40 INFO - 'NO_EM_RESTART': '1', 21:21:40 INFO - 'PAGER': '/bin/cat', 21:21:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:40 INFO - 'PWD': '/builds/slave/test', 21:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:40 INFO - 'SHELL': '/bin/bash', 21:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:40 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:40 INFO - 'USER': 'cltbld', 21:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:40 INFO - 'XPC_FLAGS': '0x0', 21:21:40 INFO - 'XPC_SERVICE_NAME': '0', 21:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:21:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-SLIQf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:21:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-Mr0Iv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:21:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-8uVeMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:21:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-HiQMwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:21:40 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-GqGIMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-qqCkq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-X02nQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-ZscsIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-07mZCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-hJr5B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-54x7qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-m938ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-75eMYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-oa1kuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:41 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-v7TWBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:21:42 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-vbgVQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:21:42 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-AgfEz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:21:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:21:42 INFO - Running setup.py install for manifestparser 21:21:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:21:42 INFO - Running setup.py install for mozcrash 21:21:42 INFO - Running setup.py install for mozdebug 21:21:42 INFO - Running setup.py install for mozdevice 21:21:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:21:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:21:42 INFO - Running setup.py install for mozfile 21:21:43 INFO - Running setup.py install for mozhttpd 21:21:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:21:43 INFO - Running setup.py install for mozinfo 21:21:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:21:43 INFO - Running setup.py install for mozInstall 21:21:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:21:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:21:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:21:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:21:43 INFO - Running setup.py install for mozleak 21:21:43 INFO - Running setup.py install for mozlog 21:21:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:21:43 INFO - Running setup.py install for moznetwork 21:21:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:21:43 INFO - Running setup.py install for mozprocess 21:21:44 INFO - Running setup.py install for mozprofile 21:21:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:21:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:21:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:21:44 INFO - Running setup.py install for mozrunner 21:21:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:21:44 INFO - Running setup.py install for mozscreenshot 21:21:44 INFO - Running setup.py install for moztest 21:21:44 INFO - Running setup.py install for mozversion 21:21:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:21:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:21:44 INFO - Cleaning up... 21:21:44 INFO - Return code: 0 21:21:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:44 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')]} 21:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:44 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')]} 21:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:44 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 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21:44 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 21:21:44 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 21:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:44 INFO - 'HOME': '/Users/cltbld', 21:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:44 INFO - 'LOGNAME': 'cltbld', 21:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:44 INFO - 'MOZ_NO_REMOTE': '1', 21:21:44 INFO - 'NO_EM_RESTART': '1', 21:21:44 INFO - 'PAGER': '/bin/cat', 21:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:44 INFO - 'PWD': '/builds/slave/test', 21:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:44 INFO - 'SHELL': '/bin/bash', 21:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:44 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:44 INFO - 'USER': 'cltbld', 21:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:44 INFO - 'XPC_FLAGS': '0x0', 21:21:44 INFO - 'XPC_SERVICE_NAME': '0', 21:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:21:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-wf9TT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:21:45 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)) 21:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:21:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-ZaoZIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:21:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-Zigysa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:21:45 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)) 21:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:21:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-pk3v4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:21:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-9wyWel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:21:45 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)) 21:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:21:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-vUT6NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:21:45 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)) 21:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:21:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-fb6IPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:21:45 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)) 21:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:21:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-w8vhVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:21:45 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)) 21:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:21:45 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-KNzj5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:21:46 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)) 21:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:21:46 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-Fxks4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:21:46 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)) 21:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:21:46 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-FV3fd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:21:46 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)) 21:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:21:46 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-6_SgLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:21:46 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)) 21:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:21:46 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-RTG2qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:21:46 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)) 21:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:21:46 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-HiogtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:46 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-fjz18X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:46 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)) 21:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:21:46 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-Morqpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:21:46 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)) 21:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:21:46 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-0v9t4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:21:46 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)) 21:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:21:46 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)) 21:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:21:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:21:46 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 21:21:46 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 21:21:46 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 21:21:46 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 21:21:46 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 21:21:46 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 21:21:49 INFO - Downloading blessings-1.6.tar.gz 21:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:21:49 INFO - Installing collected packages: blessings 21:21:49 INFO - Running setup.py install for blessings 21:21:49 INFO - Successfully installed blessings 21:21:49 INFO - Cleaning up... 21:21:49 INFO - Return code: 0 21:21:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:21:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:21:50 INFO - Reading from file tmpfile_stdout 21:21:50 INFO - Current package versions: 21:21:50 INFO - blessings == 1.6 21:21:50 INFO - blobuploader == 1.2.4 21:21:50 INFO - docopt == 0.6.1 21:21:50 INFO - functools32 == 3.2.3-2 21:21:50 INFO - jsonschema == 2.5.1 21:21:50 INFO - manifestparser == 1.1 21:21:50 INFO - mozInstall == 1.12 21:21:50 INFO - mozcrash == 1.0 21:21:50 INFO - mozdebug == 0.1 21:21:50 INFO - mozdevice == 0.49 21:21:50 INFO - mozfile == 1.2 21:21:50 INFO - mozhttpd == 0.7 21:21:50 INFO - mozinfo == 0.9 21:21:50 INFO - mozleak == 0.1 21:21:50 INFO - mozlog == 3.4 21:21:50 INFO - moznetwork == 0.27 21:21:50 INFO - mozprocess == 0.23 21:21:50 INFO - mozprofile == 0.28 21:21:50 INFO - mozrunner == 6.13 21:21:50 INFO - mozscreenshot == 0.1 21:21:50 INFO - mozsystemmonitor == 0.3 21:21:50 INFO - moztest == 0.7 21:21:50 INFO - mozversion == 1.4 21:21:50 INFO - psutil == 3.1.1 21:21:50 INFO - requests == 1.2.3 21:21:50 INFO - wsgiref == 0.1.2 21:21:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21: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')]} 21:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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')]} 21:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:50 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 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21:50 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 21:21:50 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 21:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:50 INFO - 'HOME': '/Users/cltbld', 21:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:50 INFO - 'LOGNAME': 'cltbld', 21:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:50 INFO - 'MOZ_NO_REMOTE': '1', 21:21:50 INFO - 'NO_EM_RESTART': '1', 21:21:50 INFO - 'PAGER': '/bin/cat', 21:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:50 INFO - 'PWD': '/builds/slave/test', 21:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:50 INFO - 'SHELL': '/bin/bash', 21:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:50 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:50 INFO - 'USER': 'cltbld', 21:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:50 INFO - 'XPC_FLAGS': '0x0', 21:21:50 INFO - 'XPC_SERVICE_NAME': '0', 21:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:50 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)) 21:21:50 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)) 21:21:50 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)) 21:21:50 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)) 21:21:50 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)) 21:21:50 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)) 21:21:50 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)) 21:21:50 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)) 21:21:50 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)) 21:21:50 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)) 21:21:50 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)) 21:21:50 INFO - Cleaning up... 21:21:50 INFO - Return code: 0 21:21:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:21: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')]} 21:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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')]} 21:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077cc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107742570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3258f860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, '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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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 21:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:21:50 INFO - 'HOME': '/Users/cltbld', 21:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:21:50 INFO - 'LOGNAME': 'cltbld', 21:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:50 INFO - 'MOZ_NO_REMOTE': '1', 21:21:50 INFO - 'NO_EM_RESTART': '1', 21:21:50 INFO - 'PAGER': '/bin/cat', 21:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:50 INFO - 'PWD': '/builds/slave/test', 21:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:21:50 INFO - 'SHELL': '/bin/bash', 21:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:21:50 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:21:50 INFO - 'USER': 'cltbld', 21:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:50 INFO - 'XPC_FLAGS': '0x0', 21:21:50 INFO - 'XPC_SERVICE_NAME': '0', 21:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:21:50 INFO - Cleaning up... 21:21:50 INFO - Return code: 0 21:21:50 INFO - Running post-action listener: _resource_record_post_action 21:21:50 INFO - Running post-action listener: _start_resource_monitoring 21:21:50 INFO - Starting resource monitoring. 21:21:50 INFO - [mozharness: 2016-12-05 05:21:50.790884Z] Finished create-virtualenv step (success) 21:21:50 INFO - [mozharness: 2016-12-05 05:21:50.791879Z] Running install step. 21:21:50 INFO - Running pre-action listener: _resource_record_pre_action 21:21:50 INFO - Running main action method: install 21:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:21:51 INFO - Reading from file tmpfile_stdout 21:21:51 INFO - Detecting whether we're running mozinstall >=1.0... 21:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:21:51 INFO - Reading from file tmpfile_stdout 21:21:51 INFO - Output received: 21:21:51 INFO - Usage: mozinstall [options] installer 21:21:51 INFO - Options: 21:21:51 INFO - -h, --help show this help message and exit 21:21:51 INFO - -d DEST, --destination=DEST 21:21:51 INFO - Directory to install application into. [default: 21:21:51 INFO - "/builds/slave/test"] 21:21:51 INFO - --app=APP Application being installed. [default: firefox] 21:21:51 INFO - mkdir: /builds/slave/test/build/application 21:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:22:23 INFO - Reading from file tmpfile_stdout 21:22:23 INFO - Output received: 21:22:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:22:23 INFO - Running post-action listener: _resource_record_post_action 21:22:23 INFO - [mozharness: 2016-12-05 05:22:23.702713Z] Finished install step (success) 21:22:23 INFO - [mozharness: 2016-12-05 05:22:23.702871Z] Running run-tests step. 21:22:23 INFO - Running pre-action listener: _resource_record_pre_action 21:22:23 INFO - Running main action method: run_tests 21:22:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:22:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:22:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:22:23 INFO - 2016-12-04 21:22:23.717 screenresolution[1636:9275] starting screenresolution argv=screenresolution get 21:22:23 INFO - 2016-12-04 21:22:23.720 screenresolution[1636:9275] Display 0: 1600x1200x32@60 21:22:23 INFO - 2016-12-04 21:22:23.725 screenresolution[1637:9278] starting screenresolution argv=screenresolution list 21:22:23 INFO - Available Modes on Display 0 21:22:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:22:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:22:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:22:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:22:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:22:23 INFO - Intel Iris: 21:22:23 INFO - Chipset Model: Intel Iris 21:22:23 INFO - Type: GPU 21:22:23 INFO - Bus: Built-In 21:22:23 INFO - VRAM (Dynamic, Max): 1536 MB 21:22:23 INFO - Vendor: Intel (0x8086) 21:22:23 INFO - Device ID: 0x0a2e 21:22:23 INFO - Revision ID: 0x0009 21:22:23 INFO - Displays: 21:22:23 INFO - Display: 21:22:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:22:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:22:23 INFO - Display Serial Number: 1600x1200 60 21:22:23 INFO - Main Display: Yes 21:22:23 INFO - Mirror: Off 21:22:23 INFO - Online: Yes 21:22:23 INFO - Rotation: Supported 21:22:23 INFO - Return code: 0 21:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:22:23 INFO - Python 2.7.3 21:22:23 INFO - Return code: 0 21:22:23 INFO - grabbing minidump binary from tooltool 21:22:23 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')]} 21:22:23 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 0x1075e2d30>, '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 0x107449db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075dab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:22:23 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 21:22:23 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 21:22:23 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 21:22:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:22:24 INFO - Return code: 0 21:22:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:22:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:22:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:22:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:22:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:22:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 21:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 21:22:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X6RZNpcF3N/Render', 21:22:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:24 INFO - 'HOME': '/Users/cltbld', 21:22:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:24 INFO - 'LOGNAME': 'cltbld', 21:22:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:22:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:24 INFO - 'MOZ_NO_REMOTE': '1', 21:22:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:22:24 INFO - 'NO_EM_RESTART': '1', 21:22:24 INFO - 'PAGER': '/bin/cat', 21:22:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:24 INFO - 'PWD': '/builds/slave/test', 21:22:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:22:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:24 INFO - 'SHELL': '/bin/bash', 21:22:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aVOqFpf3Y/Listeners', 21:22:24 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 21:22:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:24 INFO - 'USER': 'cltbld', 21:22:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:24 INFO - 'XPC_FLAGS': '0x0', 21:22:24 INFO - 'XPC_SERVICE_NAME': '0', 21:22:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 21:22:24 INFO - mozversion application_buildid: 20161204201538 21:22:24 INFO - mozversion application_changeset: 46322372c0f4c6b176c953ec1bef8516d4b382dd 21:22:24 INFO - mozversion application_display_name: Nightly 21:22:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:22:24 INFO - mozversion application_name: Firefox 21:22:24 INFO - mozversion application_remotingname: firefox 21:22:24 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 21:22:24 INFO - mozversion application_vendor: Mozilla 21:22:24 INFO - mozversion application_version: 53.0a1 21:22:24 INFO - mozversion platform_buildid: 20161204201538 21:22:24 INFO - mozversion platform_changeset: 46322372c0f4c6b176c953ec1bef8516d4b382dd 21:22:24 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 21:22:24 INFO - mozversion platform_version: 53.0a1 21:22:24 INFO - using testdate: 1480915344 21:22:24 INFO - actual date: 1480915344 21:22:24 INFO - starting webserver on 'localhost:49242' 21:22:24 INFO - SUITE-START | Running 2 tests 21:22:24 INFO - TEST-START | dromaeo_css 21:22:24 INFO - operating with platform_type : mac_ 21:22:24 INFO - Initialising browser for dromaeo_css test... 21:22:24 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpXOBgRs/profile http://localhost:49242/getInfo.html) 21:22:27 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 21:22:27 INFO - PROCESS | 1647 | colorDepth:24 21:22:27 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 21:22:27 INFO - PROCESS | 1647 | __metrics 21:22:27 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:22:27 INFO - PROCESS | 1647 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:22:28 INFO - TEST-INFO | 1647: exit 0 21:22:28 INFO - Browser initialized. 21:22:28 INFO - Running cycle 1/1 for dromaeo_css test... 21:22:28 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpXOBgRs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:22:40 INFO - PROCESS | 1650 | RSS: Main: 245469184 21:22:40 INFO - PROCESS | 1650 | 21:23:31 INFO - PROCESS | 1650 | 1480915411430 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] 21:25:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 21:25:47 INFO - PROCESS | 1650 | RSS: Main: 525828096 21:25:47 INFO - PROCESS | 1650 | 21:28:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 21:28:51 INFO - PROCESS | 1650 | RSS: Main: 376696832 21:28:51 INFO - PROCESS | 1650 | 21:31:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 21:31:54 INFO - PROCESS | 1650 | RSS: Main: 351883264 21:31:54 INFO - PROCESS | 1650 | 21:34:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 21:34:57 INFO - PROCESS | 1650 | RSS: Main: 340963328 21:34:57 INFO - PROCESS | 1650 | 21:38:00 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 21:38:01 INFO - PROCESS | 1650 | RSS: Main: 332791808 21:38:01 INFO - PROCESS | 1650 | 21:41:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 21:41:04 INFO - PROCESS | 1650 | RSS: Main: 406814720 21:41:04 INFO - PROCESS | 1650 | 21:41:04 INFO - PROCESS | 1650 | __start_tp_report 21:41:04 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 21:41:04 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 21:41:04 INFO - PROCESS | 1650 | |i|pagename|runs| 21:41:04 INFO - PROCESS | 1650 | |0;dojo.html;2770.542860428029;3316.3864685033286;3321.319129578437;3342.2312868040335;3385.5937287525485;5552.305961754781;5569.10894256918;5576.219329293902;5664.348599911006;5673.744681489333;5617.213590097379;5633.0987042073275;5636.689982050985;5661.66030038198;5738.42615738426;5109.897802043957;5152.613553983466;5153.665011774241;5179.119549676564;5185.196294574347;5078.669886457387;5146.922796158042;5163.3545806774155;5192.3249977503065;5211.114110601206;5175.24958880962;5231.712255825928;5240.60695447841;5243.475652434764;5263.526282634562;5066;5087.745612719349;5093.516115968977;5128.230765385185;5171.793128274864;5109.642325037249;5125.487451254845;5138.100832354323;5139.563137133348;5209.687418754849;5569.526590239834;5612.07400778871;5630.8029218977135;5647.407022262644;5658.85852853682;5861.970690146564;6152.969235153841;6155.476784473325;6159.784407545759;6162.1681073055015;6005.129256257862;6084.543659225532;6137.8187520601;6170.105334726484;6173.012318029094;5733.226014488033;5733.598648094677;5736.971315143481;5738.196652468658;5767.163761254595;6210.130581718563;6255.655938923403;6279.654618995999;6282.717277722513;6286.591371560834;5004.724740139327;5842.503387212049;5851.619644723164;5856.795012174553;5906.291245050621;5034.471380505068;6027.126066720301;6087.147799308101;6093.69531523422;6098.1157732128595;5993.460588547052;6003.729832157564;6017.578769486094;6018.909716354258;6024.819255422257;6029.758809647565;6059.575829691968;6114.2662880453745;6139.10982907476;6218.973869311513;4869.074875773592;4873.244647079638;4881.560659540658;4910;4910.828121015818;4406.713563618355;4425.645948324126;4426.645868330525;4451.198784218872;4470.508244093147;5581.302337207849;5593.552515798727;5607.990561698852;5648.15277708347;5660.85847853807;6171.47542458896;6188.071789231652;6204.441600255908;6206.627602343874;6209.96895015522;5707.3721890592005;5715.428457154251;5736.397678243808;5736.483716465538;5747.597668163272;5268.604854635918;5274.789008439696;5285.995660824508;5366.704831234241;5375.435579264199;6181.196444462191;6194.938050619617;6205;6289.7169627365965;6290;5039.72281524505;6032.215811944419;6204.844878878064;6215.689215539295;6221.9377806223165;6107.583301036431;6238.75044998195;6278.968605156945;6294.464970477561;6303.6532990685955;5937.465628093492;5995.820125396245;6048.304444988883;6056.878862422815;6071.9981203101;5529.391766905717;5747.281589801275;6107.3708791890585;6112.351504965315;6139.57023008403;5199.80404506958;5384.892302154013;5932.970335148297;5954.404559544011;5960.8807823844145;5977.820665380045;6038.6678732670125;6039.667818270037;6041.546883983631;6041.697915104315;5840.1531777892815;5852.4147585241135;5867.853303667443;5869.559783016205;5881.470667639762;6017.759289628366;6025.0661147522205;6037.305709843425;6050.273967123797;6062;5854.385289544707;5855.619384739978;5864.44287792659;5935.673537955454;5959.523238140851 21:41:04 INFO - PROCESS | 1650 | |1;ext.html;492.8890999525105;502.7913415932388;520.1911028350918;520.5705293133165;531.893621275745;26545.336366590822;31078.06765797027;31201.84399078007;35326;38246.617533824654;37641;40919.795401023024;41008;41053.79473102638;41091.17817643653;9222.077792220774;9379.812403751921;9393.859092113624;9396.718098457057;9406.247500199968;8413.15868413157;8580.570971451403;9304.720858374225;9395.530223488833;10883;11116.499757510892;11216.046636035946;11240.381779002193;11242.887571124307;11291;11076.335419874793;11099.889001109967;11127.944360278228;11135.832962505569;11151.832722509169;8289.626966786449;8521.701740439117;10678.839817402668;10964.342139471657;11014.669559913216;38073.61926380756;38523;38564.03589910247;38644.227115457536;38656.033599159964;3202.3595280943905;3246.2858171202533;3257.641659417462;3267.754918381131;3367.9158021049425;28591.428171436455;29258.414831703245;29555.261118472212;29649.625330554034;29758;3169.3344397676515;3190;3192.5530425740417;3219.4526930421885;3276.8689252429876;468358;469167;469821;469846;470259;58770.70614646899;58873.93512778408;58890.705546471996;58912.70543647254;59100.81798364009;61538.69230653818;61596.69201653963;61639;61668;61754.69122654358;15026.774598381033;15130.092194468367;15233.6191595211;15592.688146237238;15597.53207403757;11198.552057917756;11631.127665425127;11646.53413863453;11687.357195354167;11699.356535390636;14796.70406591862;15151.045546118621;15194.848051519564;16482.83517164837;16753.581160470843;6740.730370785212;6756.695948682321;6824.6928888200155;6838.760643377458;6854.760083397057;869.4913475616709;942.5098948546854;1019.2610357490908;1032.4115254305125;1059.645018918671;24082.79586020692;27052;29179.562306565418;29554.556681649792;29755;855.3542075732906;938.6526985015588;1008.7881544875512;1092.830611255241;1122.1527746551465;14154.292285385689;14168.308021475887;14323.14061156334;14938.626534336729;15340;493546.5322673364;587563.0621846949;589620;592043;786821;45902.5409745905;46197;58396.54008649733;58523;58653;1324.8675132486674;1354.519145703261;1370.4381203706432;1371.2732251906505;1371.4582739817715;23814.404639884142;29912.25219369533;29964.101076967727;30501.54247686331;30591.54112688267;48879.511204887494;49292;49367.506324936294;49469;49547;537240;541896;543067.8392336537;543433;543576;37301.38890277763;37710.81144594259;37932.24135517219;37992.810035949646;38036.04909877275;41341.37987930243;44249.55750442583;44426.55573444224;45102;45528.317075243234;36685.899423017356;38769.255383508375;38930;40230.39654405245;40378;36250.63749362472;36702.265954681294;37968.24063518769;38007.04982375463;38085.619143809316;36163.27673446569;36687.63312366842;36999.63000369962;37410.6258937418;37455.438168426954;31290;32515;32933.50599741054;33691.83154084214;34622.82688586541;18853;23442;23970.44192127506;24778.380540486633;25146.49707005813 21:41:04 INFO - PROCESS | 1650 | |2;jquery.html;349.8705478972781;369.6026771220938;372.8024147201982;382.5887171290862;401.03150890599204;14595.416183352667;14991.40034398624;15324.770128448068;19743.605127897434;20443;18486.722699159523;18940.621187576242;18981.24075037;19243.615127697438;20385.49036274094;5570.972145139269;5690.971545142268;5728.140778883159;6089.2692876854835;6107.877842443148;4693.9295910561195;5977.5815692901515;6009.969950150243;6014.067819487965;6015.157877897098;5607.691576963265;5950.9107363389585;5955.791547295846;5964.13520039594;5968.88062238755;5808.622439541437;5942.762289508414;5958.165856780054;5961.850953726148;5967.134765459027;4644.558766917171;5184.196449550326;5188.9740551297;5191.039657663345;5331.333583302087;12781.680457988532;12987.87012129876;13004.349782510837;13043.934780326037;18176.90911545447;1927.4025052233853;2024.9088791004292;2244.304265677645;2327.1156960355124;2819.971800282012;8916.331275154389;9423.952880235554;9925.057119573628;10002.49987500622;10111.3427627204;1659.601695593061;1741.4340339389623;1773.485689150145;1778.315348590789;1826.2147276671026;76343.61828190878;91685;116824;117913.82086179114;120445.39777301146;9135.817283654289;9390;9682.225421966226;9768.804623907625;11000.724981875517;11828.349440780668;12150.57472988441;12195.329256890956;12218.816717749241;12230.694232644255;7089.858202835914;7139.5720855828;7767.844643107219;7786.57173855432;7959.482633628912;7557.773266802004;7715.961420192975;7864.5057439086395;8016.198380162054;8081.919180808234;3708.35103856824;3816.2939856126704;3824.3880979043774;3871.690264778811;3897.415387691869;1648.8351164883416;1821.5901422180168;1841.0058568372929;1886.547228665138;1888.8583356248337;754.9698012079565;865.485036403339;869.4783130122003;887.1084560017141;896.1799953043023;17545.56136096608;19602.509937251398;20475.795242047687;20786;20879.582408352053;779.3726050529378;914.5427286356821;917.321182325088;926.4719110107175;939.6241503398559;10627.89372106269;10911.781764364669;10981;11003.734570524332;11083.778324433628;536070;539539;541326;547682;550878;112850.43574782074;120374;121984;124779.3761031189;126830.73169268374;971.2375785008734;974.907383798538;980.6665733650593;982.7248370456284;983.1250187333279;16564.337426502803;18287.45137645873;18402.26390944347;18581.81418185855;18710.345137920107;44332.556674434134;44547.66357009295;47528;49876.75061624814;52210.06345875211;72761.6361918187;74151.8877216853;75768.62115689386;78252;78612;5279.630425870152;7282;7344.82482802749;7780.766577002699;8018.3184429324165;8339.66565349541;11792.646220613395;11887.583934562248;11968.281903085843;12314.322712250912;10352.378857268588;10722.678319650424;10814.945925270324;10852.457377130953;11031.17266205054;8828.470291782514;10309.690709278733;10442.895571044191;10578.947105264424;10872.728181795519;9177.587008584496;10587.100096491884;10837.807841137312;10866.67399978002;11112.22214444981;6545.0182472629485;7602.429817763579;7677.884831727641;7926.24700653437;8107.351411887153;10048.246381521269;10474.476276186313;10507.89492105069;10693.679189624012;10877.67366978992 21:41:04 INFO - PROCESS | 1650 | |3;mootools.html;1320.7358528294344;1459.6496840758214;1499.0256333383302;1652.6694661067781;1843.7418761373401;6091.817245482637;7730.18833022533;7919.6832126714935;8244;8245.95877020614;8082.19178082193;8132.26809587137;8203.056648485426;8206.712765053224;8219.589020548978;2045.642012647788;2277.533105713333;2325.5930212212793;2326.813854891613;2329.988350058256;2126.680997850327;2132.1364847236896;2139.9465013374634;2257.7742225777456;2337.509123084146;2299.1378233162563;2300.7469178390365;2301.5281867217263;2303.147835300941;2304.0092760113143;2268.330842401479;2282.6918366020623;2284.977150228501;2309.2379514760087;2315.1549684365255;2262.2760716570706;2299.609066458706;2329.324495896188;2334.0897050150456;2336.1122773346187;8185.877211841827;8195.303399211074;8273.627686754111;8275.420720549564;8293.709720159826;4980.427250866161;5144.74276286188;5150.845474635767;5152.92270615941;5157.277981082651;3326.846215488449;3422.281320922609;3447.793132412063;3530;3544.6455354464606;1012.6556970630021;1048.6539441984128;1071.8285074388061;1084.5119696136692;1086.9565217391296;10611.41637209961;10720.142388608892;10769.246152769309;10777.9760922713;10783.352998820095;3930.9779457340724;4326.329418940069;4536.183486972311;4631.606313463393;4646.09401166776;9223.76940576491;9232.353735238468;9240.399374040666;9252.444853308823;9253.398529095588;5130.743462826844;5139.691618502902;5142.665726727751;5149.742512874342;5151.25306830515;4523.84166554169;4643.883902902455;4674.97662511692;4676.205045142334;4737.573618374363;3473.8436770345397;3600.3879340512176;3603.9099022524647;3630.2920930418845;3715.9071023224637;1178.2164860367932;1194.8446701928694;1196.3778835005749;1215.1797536662718;1260.357217818919;735.3528894572742;837.367787320569;854.78203058221;874.2219424712011;920.4569304110607;5497.697626630574;5508.91736623951;5566.387697353288;5602.162518674721;5647.209390685307;807.5840941914919;864.1358641358642;891.3760367742606;899.1727610598265;919.8758167647281;3688.5389326334207;3710.4434334849448;3746.138388170736;3779.848806047727;3845.9807700961874;9468.100530449596;9926.007399260016;9937.900620993698;9981.051800078982;9995.200383969264;9889.802203956024;9907.306488545733;9913.752156196153;9917.107460328461;9921.702348929544;7293;7554.773356799305;7590.240975902366;7597.734079307308;7709.267619576131;4569.840055598038;5254.896471740977;5666.631668941505;5690.402507736793;5715.199872017838;8258;8845.203931646183;9163.86254206174;9333.160015598358;9352.766180845534;9286.117818807203;9364.672236471692;9369.203617692572;9460;9528.666496672584;6978.825529361807;7004.964975175091;7052.929470705432;7165.3551180394015;7175.390091842252;7610.8097297568;7687.461877668509;7691.38468922496;7704.730334438492;7705.460617756703;5679.971600141973;6906.067680863019;7033.894491582528;7095.361417472246;7235.8552828944175;6864.24493305726;6908.896366554405;6911.928651059094;6955.652217389212;6978.616176110363;6350.936490635035;6453;6453.645049522322;6556.803295901131;6572.441342485751;4724.574788269072;4754.477007529238;4766.61867050642;4805.37530121096;4901.975490122527;4589.58693717567;4786.377770889762;4790.209615413418;4851.34506841586;4983 21:41:04 INFO - PROCESS | 1650 | |4;prototype.html;301.3866781100461;302.1705418625872;308.822427104415;310.58691939720177;313.7364613724471;4256.340267258573;4950.678205916613;5029.798808047678;5136.974315128419;5217.582483473321;4247.362895565667;4745.549172828576;4914.926276105862;5164.715940623264;5181.43004269531;4016.4778578784717;4024.939625905621;4025.59197678543;4027.41602467642;4057.7159598828093;3628.2743451309843;3738.4205448155444;3906.1015966327764;4021.9597804022023;4054.513458384998;3404.114930118175;3479.3389256041396;3972.1459886124476;4014.538328092263;4015.2973229684835;3113.4395808754416;3980.5223373195113;3988.9229907924987;3993.44091827143;4021.537523184842;2901.883924643033;3193.4730769423018;3490.581130264359;3491.2493813829897;3499.705109109646;4245.214635292481;4876.390451193601;5085.872853178663;5089.821856235014;5093.872653183663;3836.4538022443494;4573.405457290564;4577.748223847687;4580.824108548446;4605.4473463184295;4587.362042199734;4815.256971882693;5393.9190912135955;5455.781768729246;5468.48049435303;3399.2351720862857;3718.9628103718887;3722.8324725387424;3850.0759817643566;3870.748401353903;4877.731789734659;5114.539691427789;5251.632385733;5733.799317023884;5749.453801888814;3899.317619416591;3899.863504777319;3900.473436086092;3901.3562762144497;3906.3554513505524;3462.272922686214;3788.9012186465616;3942.586028467027;3946.427767973685;3954.406838974177;3864.497615310048;3868.497095377639;4086.896537934741;4488.1472520221705;4498.325251212279;4619.584237418581;5513.696746678891;5525.723713814293;5527.695976721238;5541.33503979525;1159.6694941941507;1185.6443067079842;1206.6621346023128;1209.3106929050532;1212.024320422051;767.4052609227781;841.6086519768337;849.3375167369462;858.6565373850385;860.7460799064291;4806.831760888352;4814.8796280093275;4889.190999330271;4893.535114164149;4909.337239472697;4873.19592267279;4970.17992031318;5120.009470537758;5127.717975511308;5376.91934620981;3992.8203230854683;4077.1856523846604;4401.031773009932;4788.61691064714;4851.902961940741;2392.940176495567;2646.827956182842;2739.369944912681;2739.794515411352;2749.6425464689864;4714.7741587187575;5050.242463630411;5084.389873215164;5315.558218494062;5321.376980021053;4444.799984000728;4696.882577935579;5052.650517509376;5179;5454.53636440899;5210.791568337376;5286.334804536558;5386.8383948481605;5446.673199608036;5458.263134476874;4639.373684552542;4789.4855201019745;4811.7834697438;4838.951610483991;5006.62450316235;5180.818671346485;5389.541888939484;5607.3551541571605;5686.488216060575;5701.828945131652;5803.593748437737;5831.35855055935;5844.94155058461;5847.561432892465;5854.648721076749;3082.3064810417477;3601.6038235794567;3759;3779.093017675683;3801.5438147422487;5273.868153296198;5515.889682206253;5589.608727389043;5655.095184770417;5657.4908258256955;4867.037878598689;5262.289590905179;5443.760962227469;5449.629411206138;5522.641028333145;4830.347903033045;4983.978284451751;5240.423553409199;5402.729863506887;5459.208414779914;4894.19245824435;5100.62283183531;5330.493603107699;5364.356277246756;5385.703786291791;4609.976950115228;5262.868428289324;5391.353037635509;5539.446055394428;5541.224228608079;4981.829270121591;5404.567634589302;5424.403315635198;5426.802145131228;5427.972860135674 21:41:04 INFO - PROCESS | 1650 | |5;yui.html;689.9448044156467;721.4625104297296;748.1359030319979;790.2571582712246;791.0862953288952;15149.39402423903;15759.133247671374;15759.92120039401;15785.842141578582;15820.288087036082;11910.880891191107;14289.928255380835;14316.28418579072;14326;14398.352074156663;660.1945626335862;687.7833482453011;693.2132030145771;810.9351251899864;823.5305875650866;826.7519744076783;826.8677011678133;834.157500924065;840.3403328387217;841.9031811341713;898.2275243290765;899.7435730816718;901.076396693388;901.7835719427355;906.1210625693067;890.4968692688675;890.8396488632044;892.9196372326489;893.4282059481936;897;508.8295421033958;534.5509771791714;627.6422439209653;660.2440205964192;665.6804733727789;14558.92720536401;14589.9787014909;14592.562223133324;14612.342444590018;14646.41414343425;12707.936460317731;12851.807222891664;13511.391987360592;13943.930280348533;13990.16059036461;12357.938210308981;12429.627111186679;12640;12731.809022864665;12966.675833104247;4096.9795151024055;4259.76571288579;4281.764502952336;4387;4459.665525085632;103968;111373;112208;112795.43602282018;112984;10464;10886.074683651977;10886.129109671207;10918.836217456745;11233;21455.89272053661;21599.460013499473;21632.35102946914;21672.56654866894;21915.01382437794;7560.3573696236435;7609.809754756176;7696.923030769621;7702.845943081107;7875.330596899214;3557.9110522236633;4180.707350485498;4257.106007738348;4288.356746488052;4445.310976798602;3448.189675426273;3600.8837260449345;3601.2797440512004;3605.4952306677087;3607.67530922213;651.1502489251573;653.7189008726199;668.5153263883645;669.036587314266;672.2504407585604;595.2648479128273;630.9873802524015;645.3965542218041;671.4058058618158;671.8824205763972;8843.292536597057;9028.593713282919;9116.424947061378;9233.630654773868;9380.90619093814;628.3252600651141;639.4756299834091;644.9838754031186;666.4002397841884;673.2157037051878;3552.609212986569;4379.715318504287;4436.268015777425;4445.244308467568;4487.798049087799;103856;111038.88961110286;111195;111865.44067279612;112356.40067640752;96665.51667241618;99163.51254731185;100104;100183.49908250412;101265;87164;87295.56352218325;87665;88619.55690221637;89163.75853690179;8566.400351975552;8645.135486451305;8706.60820263077;8772.780680482783;8874.423162494417;51807;54367.18449223344;54748.45251547593;55477.1678424832;57146;59362.10956835565;60962.695186523786;61993;62581;72690.63654681692;10904;12365.567205147776;12766.68083297925;12914.741705165656;13331.466741330238;14219.50231741884;14540.200288984208;14801.629959251104;15004.29235959993;15245.466408675644;13550;13562.457501699822;13724.039317247696;13960.720785584028;14055.718885622435;13313.733725325634;13597.592072237849;13760.724785504033;13984.790228146789;14081.577552673436;13280.933595331962;13404.195748255135;13676.384562694504;13763.449462021406;14053.156810591398;11055.281406708538;11083.778324433628;11119.777604447703;11149.721256968316;11596.362200079077;10781.9460902695;11206.327620342805;11280.2667826591;11369.658910232707;11510.194286399872 21:41:04 INFO - PROCESS | 1650 | __end_tp_report 21:41:04 INFO - PROCESS | 1650 | __start_cc_report 21:41:04 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,3877 21:41:04 INFO - PROCESS | 1650 | __end_cc_report 21:41:04 INFO - PROCESS | 1650 | __startTimestamp1480916464887__endTimestamp 21:41:04 INFO - PROCESS | 1650 | 21:41:04 INFO - PROCESS | 1650 | ------- Summary: start ------- 21:41:04 INFO - PROCESS | 1650 | Number of tests: 6 21:41:04 INFO - PROCESS | 1650 | 21:41:04 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5632.65 Median:5840.15 stddev:627.25 (10.7%) stddev-sans-first:587.62 21:41:04 INFO - PROCESS | 1650 | Values: 2770.5 3316.4 3321.3 3342.2 3385.6 5552.3 5569.1 5576.2 5664.3 5673.7 5617.2 5633.1 5636.7 5661.7 5738.4 5109.9 5152.6 5153.7 5179.1 5185.2 5078.7 5146.9 5163.4 5192.3 5211.1 5175.2 5231.7 5240.6 5243.5 5263.5 5066.0 5087.7 5093.5 5128.2 5171.8 5109.6 5125.5 5138.1 5139.6 5209.7 5569.5 5612.1 5630.8 5647.4 5658.9 5862.0 6153.0 6155.5 6159.8 6162.2 6005.1 6084.5 6137.8 6170.1 6173.0 5733.2 5733.6 5737.0 5738.2 5767.2 6210.1 6255.7 6279.7 6282.7 6286.6 5004.7 5842.5 5851.6 5856.8 5906.3 5034.5 6027.1 6087.1 6093.7 6098.1 5993.5 6003.7 6017.6 6018.9 6024.8 6029.8 6059.6 6114.3 6139.1 6219.0 4869.1 4873.2 4881.6 4910.0 4910.8 4406.7 4425.6 4426.6 4451.2 4470.5 5581.3 5593.6 5608.0 5648.2 5660.9 6171.5 6188.1 6204.4 6206.6 6210.0 5707.4 5715.4 5736.4 5736.5 5747.6 5268.6 5274.8 5286.0 5366.7 5375.4 6181.2 6194.9 6205.0 6289.7 6290.0 5039.7 6032.2 6204.8 6215.7 6221.9 6107.6 6238.8 6279.0 6294.5 6303.7 5937.5 5995.8 6048.3 6056.9 6072.0 5529.4 5747.3 6107.4 6112.4 6139.6 5199.8 5384.9 5933.0 5954.4 5960.9 5977.8 6038.7 6039.7 6041.5 6041.7 5840.2 5852.4 5867.9 5869.6 5881.5 6017.8 6025.1 6037.3 6050.3 6062.0 5854.4 5855.6 5864.4 5935.7 5959.5 21:41:04 INFO - PROCESS | 1650 | 21:41:04 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:67192.28 Median:37356.01 stddev:145961.04 (390.7%) stddev-sans-first:146284.59 21:41:04 INFO - PROCESS | 1650 | Values: 492.9 502.8 520.2 520.6 531.9 26545.3 31078.1 31201.8 35326.0 38246.6 37641.0 40919.8 41008.0 41053.8 41091.2 9222.1 9379.8 9393.9 9396.7 9406.2 8413.2 8580.6 9304.7 9395.5 10883.0 11116.5 11216.0 11240.4 11242.9 11291.0 11076.3 11099.9 11127.9 11135.8 11151.8 8289.6 8521.7 10678.8 10964.3 11014.7 38073.6 38523.0 38564.0 38644.2 38656.0 3202.4 3246.3 3257.6 3267.8 3367.9 28591.4 29258.4 29555.3 29649.6 29758.0 3169.3 3190.0 3192.6 3219.5 3276.9 468358.0 469167.0 469821.0 469846.0 470259.0 58770.7 58873.9 58890.7 58912.7 59100.8 61538.7 61596.7 61639.0 61668.0 61754.7 15026.8 15130.1 15233.6 15592.7 15597.5 11198.6 11631.1 11646.5 11687.4 11699.4 14796.7 15151.0 15194.8 16482.8 16753.6 6740.7 6756.7 6824.7 6838.8 6854.8 869.5 942.5 1019.3 1032.4 1059.6 24082.8 27052.0 29179.6 29554.6 29755.0 855.4 938.7 1008.8 1092.8 1122.2 14154.3 14168.3 14323.1 14938.6 15340.0 493546.5 587563.1 589620.0 592043.0 786821.0 45902.5 46197.0 58396.5 58523.0 58653.0 1324.9 1354.5 1370.4 1371.3 1371.5 23814.4 29912.3 29964.1 30501.5 30591.5 48879.5 49292.0 49367.5 49469.0 49547.0 537240.0 541896.0 543067.8 543433.0 543576.0 37301.4 37710.8 37932.2 37992.8 38036.0 41341.4 44249.6 44426.6 45102.0 45528.3 36685.9 38769.3 38930.0 40230.4 40378.0 36250.6 36702.3 37968.2 38007.0 38085.6 36163.3 36687.6 36999.6 37410.6 37455.4 31290.0 32515.0 32933.5 33691.8 34622.8 18853.0 23442.0 23970.4 24778.4 25146.5 21:41:04 INFO - PROCESS | 1650 | 21:41:04 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:31890.72 Median:3884.55 stddev:90848.63 (2338.7%) stddev-sans-first:91072.62 21:41:04 INFO - PROCESS | 1650 | Values: 349.9 369.6 372.8 382.6 401.0 14595.4 14991.4 15324.8 19743.6 20443.0 18486.7 18940.6 18981.2 19243.6 20385.5 5571.0 5691.0 5728.1 6089.3 6107.9 4693.9 5977.6 6010.0 6014.1 6015.2 5607.7 5950.9 5955.8 5964.1 5968.9 5808.6 5942.8 5958.2 5961.9 5967.1 4644.6 5184.2 5189.0 5191.0 5331.3 12781.7 12987.9 13004.3 13043.9 18176.9 1927.4 2024.9 2244.3 2327.1 2820.0 8916.3 9424.0 9925.1 10002.5 10111.3 1659.6 1741.4 1773.5 1778.3 1826.2 76343.6 91685.0 116824.0 117913.8 120445.4 9135.8 9390.0 9682.2 9768.8 11000.7 11828.3 12150.6 12195.3 12218.8 12230.7 7089.9 7139.6 7767.8 7786.6 7959.5 7557.8 7716.0 7864.5 8016.2 8081.9 3708.4 3816.3 3824.4 3871.7 3897.4 1648.8 1821.6 1841.0 1886.5 1888.9 755.0 865.5 869.5 887.1 896.2 17545.6 19602.5 20475.8 20786.0 20879.6 779.4 914.5 917.3 926.5 939.6 10627.9 10911.8 10981.0 11003.7 11083.8 536070.0 539539.0 541326.0 547682.0 550878.0 112850.4 120374.0 121984.0 124779.4 126830.7 971.2 974.9 980.7 982.7 983.1 16564.3 18287.5 18402.3 18581.8 18710.3 44332.6 44547.7 47528.0 49876.8 52210.1 72761.6 74151.9 75768.6 78252.0 78612.0 5279.6 7282.0 7344.8 7780.8 8018.3 8339.7 11792.6 11887.6 11968.3 12314.3 10352.4 10722.7 10814.9 10852.5 11031.2 8828.5 10309.7 10442.9 10578.9 10872.7 9177.6 10587.1 10837.8 10866.7 11112.2 6545.0 7602.4 7677.9 7926.2 8107.4 10048.2 10474.5 10507.9 10693.7 10877.7 21:41:04 INFO - PROCESS | 1650 | 21:41:04 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5341.06 Median:5206.09 stddev:2924.01 (56.2%) stddev-sans-first:2916.60 21:41:04 INFO - PROCESS | 1650 | Values: 1320.7 1459.6 1499.0 1652.7 1843.7 6091.8 7730.2 7919.7 8244.0 8246.0 8082.2 8132.3 8203.1 8206.7 8219.6 2045.6 2277.5 2325.6 2326.8 2330.0 2126.7 2132.1 2139.9 2257.8 2337.5 2299.1 2300.7 2301.5 2303.1 2304.0 2268.3 2282.7 2285.0 2309.2 2315.2 2262.3 2299.6 2329.3 2334.1 2336.1 8185.9 8195.3 8273.6 8275.4 8293.7 4980.4 5144.7 5150.8 5152.9 5157.3 3326.8 3422.3 3447.8 3530.0 3544.6 1012.7 1048.7 1071.8 1084.5 1087.0 10611.4 10720.1 10769.2 10778.0 10783.4 3931.0 4326.3 4536.2 4631.6 4646.1 9223.8 9232.4 9240.4 9252.4 9253.4 5130.7 5139.7 5142.7 5149.7 5151.3 4523.8 4643.9 4675.0 4676.2 4737.6 3473.8 3600.4 3603.9 3630.3 3715.9 1178.2 1194.8 1196.4 1215.2 1260.4 735.4 837.4 854.8 874.2 920.5 5497.7 5508.9 5566.4 5602.2 5647.2 807.6 864.1 891.4 899.2 919.9 3688.5 3710.4 3746.1 3779.8 3846.0 9468.1 9926.0 9937.9 9981.1 9995.2 9889.8 9907.3 9913.8 9917.1 9921.7 7293.0 7554.8 7590.2 7597.7 7709.3 4569.8 5254.9 5666.6 5690.4 5715.2 8258.0 8845.2 9163.9 9333.2 9352.8 9286.1 9364.7 9369.2 9460.0 9528.7 6978.8 7005.0 7052.9 7165.4 7175.4 7610.8 7687.5 7691.4 7704.7 7705.5 5680.0 6906.1 7033.9 7095.4 7235.9 6864.2 6908.9 6911.9 6955.7 6978.6 6350.9 6453.0 6453.6 6556.8 6572.4 4724.6 4754.5 4766.6 4805.4 4902.0 4589.6 4786.4 4790.2 4851.3 4983.0 21:41:04 INFO - PROCESS | 1650 | 21:41:04 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4325.94 Median:4834.65 stddev:1323.10 (27.4%) stddev-sans-first:1291.87 21:41:04 INFO - PROCESS | 1650 | Values: 301.4 302.2 308.8 310.6 313.7 4256.3 4950.7 5029.8 5137.0 5217.6 4247.4 4745.5 4914.9 5164.7 5181.4 4016.5 4024.9 4025.6 4027.4 4057.7 3628.3 3738.4 3906.1 4022.0 4054.5 3404.1 3479.3 3972.1 4014.5 4015.3 3113.4 3980.5 3988.9 3993.4 4021.5 2901.9 3193.5 3490.6 3491.2 3499.7 4245.2 4876.4 5085.9 5089.8 5093.9 3836.5 4573.4 4577.7 4580.8 4605.4 4587.4 4815.3 5393.9 5455.8 5468.5 3399.2 3719.0 3722.8 3850.1 3870.7 4877.7 5114.5 5251.6 5733.8 5749.5 3899.3 3899.9 3900.5 3901.4 3906.4 3462.3 3788.9 3942.6 3946.4 3954.4 3864.5 3868.5 4086.9 4488.1 4498.3 4619.6 5513.7 5525.7 5527.7 5541.3 1159.7 1185.6 1206.7 1209.3 1212.0 767.4 841.6 849.3 858.7 860.7 4806.8 4814.9 4889.2 4893.5 4909.3 4873.2 4970.2 5120.0 5127.7 5376.9 3992.8 4077.2 4401.0 4788.6 4851.9 2392.9 2646.8 2739.4 2739.8 2749.6 4714.8 5050.2 5084.4 5315.6 5321.4 4444.8 4696.9 5052.7 5179.0 5454.5 5210.8 5286.3 5386.8 5446.7 5458.3 4639.4 4789.5 4811.8 4839.0 5006.6 5180.8 5389.5 5607.4 5686.5 5701.8 5803.6 5831.4 5844.9 5847.6 5854.6 3082.3 3601.6 3759.0 3779.1 3801.5 5273.9 5515.9 5589.6 5655.1 5657.5 4867.0 5262.3 5443.8 5449.6 5522.6 4830.3 4984.0 5240.4 5402.7 5459.2 4894.2 5100.6 5330.5 5364.4 5385.7 4610.0 5262.9 5391.4 5539.4 5541.2 4981.8 5404.6 5424.4 5426.8 5428.0 21:41:04 INFO - PROCESS | 1650 | 21:41:04 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:21342.90 Median:4138.84 stddev:31593.45 (763.3%) stddev-sans-first:31644.02 21:41:04 INFO - PROCESS | 1650 | Values: 689.9 721.5 748.1 790.3 791.1 15149.4 15759.1 15759.9 15785.8 15820.3 11910.9 14289.9 14316.3 14326.0 14398.4 660.2 687.8 693.2 810.9 823.5 826.8 826.9 834.2 840.3 841.9 898.2 899.7 901.1 901.8 906.1 890.5 890.8 892.9 893.4 897.0 508.8 534.6 627.6 660.2 665.7 14558.9 14590.0 14592.6 14612.3 14646.4 12707.9 12851.8 13511.4 13943.9 13990.2 12357.9 12429.6 12640.0 12731.8 12966.7 4097.0 4259.8 4281.8 4387.0 4459.7 103968.0 111373.0 112208.0 112795.4 112984.0 10464.0 10886.1 10886.1 10918.8 11233.0 21455.9 21599.5 21632.4 21672.6 21915.0 7560.4 7609.8 7696.9 7702.8 7875.3 3557.9 4180.7 4257.1 4288.4 4445.3 3448.2 3600.9 3601.3 3605.5 3607.7 651.2 653.7 668.5 669.0 672.3 595.3 631.0 645.4 671.4 671.9 8843.3 9028.6 9116.4 9233.6 9380.9 628.3 639.5 645.0 666.4 673.2 3552.6 4379.7 4436.3 4445.2 4487.8 103856.0 111038.9 111195.0 111865.4 112356.4 96665.5 99163.5 100104.0 100183.5 101265.0 87164.0 87295.6 87665.0 88619.6 89163.8 8566.4 8645.1 8706.6 8772.8 8874.4 51807.0 54367.2 54748.5 55477.2 57146.0 59362.1 60962.7 61993.0 62581.0 72690.6 10904.0 12365.6 12766.7 12914.7 13331.5 14219.5 14540.2 14801.6 15004.3 15245.5 13550.0 13562.5 13724.0 13960.7 14055.7 13313.7 13597.6 13760.7 13984.8 14081.6 13280.9 13404.2 13676.4 13763.4 14053.2 11055.3 11083.8 11119.8 11149.7 11596.4 10781.9 11206.3 11280.3 11369.7 11510.2 21:41:04 INFO - PROCESS | 1650 | -------- Summary: end -------- 21:41:04 INFO - PROCESS | 1650 | 21:41:05 INFO - TEST-INFO | 1650: exit 0 21:41:05 INFO - TEST-OK | dromaeo_css | took 1121289ms 21:41:05 INFO - TEST-START | kraken 21:41:05 INFO - operating with platform_type : mac_ 21:41:05 INFO - Initialising browser for kraken test... 21:41:05 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpz5AEbf/profile http://localhost:49242/getInfo.html) 21:41:08 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 21:41:08 INFO - PROCESS | 1656 | colorDepth:24 21:41:08 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 21:41:08 INFO - PROCESS | 1656 | __metrics 21:41:08 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:41:08 INFO - PROCESS | 1656 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:41:08 INFO - TEST-INFO | 1656: exit 0 21:41:08 INFO - Browser initialized. 21:41:08 INFO - Running cycle 1/1 for kraken test... 21:41:08 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpz5AEbf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:41:21 INFO - PROCESS | 1657 | RSS: Main: 235909120 21:41:21 INFO - PROCESS | 1657 | 21:41:24 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 21:41:25 INFO - PROCESS | 1657 | RSS: Main: 295112704 21:41:25 INFO - PROCESS | 1657 | 21:41:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 21:41:28 INFO - PROCESS | 1657 | RSS: Main: 297734144 21:41:28 INFO - PROCESS | 1657 | 21:41:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 21:41:32 INFO - PROCESS | 1657 | RSS: Main: 390422528 21:41:32 INFO - PROCESS | 1657 | 21:41:34 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 21:41:35 INFO - PROCESS | 1657 | RSS: Main: 290578432 21:41:35 INFO - PROCESS | 1657 | 21:41:37 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:41:37 INFO - PROCESS | 1657 | RSS: Main: 293912576 21:41:37 INFO - PROCESS | 1657 | 21:41:40 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 21:41:41 INFO - PROCESS | 1657 | RSS: Main: 336072704 21:41:41 INFO - PROCESS | 1657 | 21:41:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 21:41:44 INFO - PROCESS | 1657 | RSS: Main: 339324928 21:41:44 INFO - PROCESS | 1657 | 21:41:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 21:41:47 INFO - PROCESS | 1657 | RSS: Main: 337195008 21:41:47 INFO - PROCESS | 1657 | 21:41:49 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:41:50 INFO - PROCESS | 1657 | RSS: Main: 311705600 21:41:50 INFO - PROCESS | 1657 | 21:41:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:41:52 INFO - PROCESS | 1657 | RSS: Main: 315609088 21:41:52 INFO - PROCESS | 1657 | 21:41:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:41:55 INFO - PROCESS | 1657 | RSS: Main: 317648896 21:41:55 INFO - PROCESS | 1657 | 21:41:58 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:41:59 INFO - PROCESS | 1657 | RSS: Main: 336236544 21:41:59 INFO - PROCESS | 1657 | 21:42:02 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:42:02 INFO - PROCESS | 1657 | RSS: Main: 330297344 21:42:02 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 21:42:04 INFO - PROCESS | 1657 | RSS: Main: 373997568 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | __start_tp_report 21:42:04 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 21:42:04 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 21:42:04 INFO - PROCESS | 1657 | |i|pagename|runs| 21:42:04 INFO - PROCESS | 1657 | |0;ai-astar;111;113;114;113;112;114;113;113;113;113 21:42:04 INFO - PROCESS | 1657 | |1;audio-beat-detection;151;115;113;151;120;140;140;117;138;113 21:42:04 INFO - PROCESS | 1657 | |2;audio-dft;199;255;195;183;182;177;183;186;184;185 21:42:04 INFO - PROCESS | 1657 | |3;audio-fft;79;59;58;86;62;60;59;59;75;58 21:42:04 INFO - PROCESS | 1657 | |4;audio-oscillator;90;74;84;69;69;69;81;66;68;83 21:42:04 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;87;84;86;84;87;83;86;83;86;88 21:42:04 INFO - PROCESS | 1657 | |6;imaging-darkroom;98;116;97;93;93;93;93;93;97;92 21:42:04 INFO - PROCESS | 1657 | |7;imaging-desaturate;86;85;88;84;86;86;87;87;85;85 21:42:04 INFO - PROCESS | 1657 | |8;json-parse-financial;57;55;54;53;52;56;55;56;56;56 21:42:04 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;65;73;71;78;72;72;73;69;70;70 21:42:04 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;89;89;75;87;96;78;97;100;110;108 21:42:04 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;138;160;163;153;163;145;136;150;187;166 21:42:04 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;176;174;174;172;179;176;172;170;173;171 21:42:04 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;70;71;70;75;86;86;68;70;69;69 21:42:04 INFO - PROCESS | 1657 | __end_tp_report 21:42:04 INFO - PROCESS | 1657 | __start_cc_report 21:42:04 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,2015 21:42:04 INFO - PROCESS | 1657 | __end_cc_report 21:42:04 INFO - PROCESS | 1657 | __startTimestamp1480916524901__endTimestamp 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | ------- Summary: start ------- 21:42:04 INFO - PROCESS | 1657 | Number of tests: 14 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:0.88 (0.8%) stddev-sans-first:0.60 21:42:04 INFO - PROCESS | 1657 | Values: 111.0 113.0 114.0 113.0 112.0 114.0 113.0 113.0 113.0 113.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:139.00 stddev:15.70 (11.3%) stddev-sans-first:14.66 21:42:04 INFO - PROCESS | 1657 | Values: 151.0 115.0 113.0 151.0 120.0 140.0 140.0 117.0 138.0 113.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:192.90 Median:185.50 stddev:22.74 (12.3%) stddev-sans-first:24.01 21:42:04 INFO - PROCESS | 1657 | Values: 199.0 255.0 195.0 183.0 182.0 177.0 183.0 186.0 184.0 185.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:65.50 Median:61.00 stddev:10.41 (17.1%) stddev-sans-first:9.82 21:42:04 INFO - PROCESS | 1657 | Values: 79.0 59.0 58.0 86.0 62.0 60.0 59.0 59.0 75.0 58.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:77.50 stddev:8.46 (10.9%) stddev-sans-first:7.11 21:42:04 INFO - PROCESS | 1657 | Values: 90.0 74.0 84.0 69.0 69.0 69.0 81.0 66.0 68.0 83.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.00 stddev:1.78 (2.1%) stddev-sans-first:1.79 21:42:04 INFO - PROCESS | 1657 | Values: 87.0 84.0 86.0 84.0 87.0 83.0 86.0 83.0 86.0 88.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:96.50 Median:93.00 stddev:7.18 (7.7%) stddev-sans-first:7.60 21:42:04 INFO - PROCESS | 1657 | Values: 98.0 116.0 97.0 93.0 93.0 93.0 93.0 93.0 97.0 92.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.20 (1.4%) stddev-sans-first:1.27 21:42:04 INFO - PROCESS | 1657 | Values: 86.0 85.0 88.0 84.0 86.0 86.0 87.0 87.0 85.0 85.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:1.56 (2.8%) stddev-sans-first:1.48 21:42:04 INFO - PROCESS | 1657 | Values: 57.0 55.0 54.0 53.0 52.0 56.0 55.0 56.0 56.0 56.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.00 stddev:3.33 (4.6%) stddev-sans-first:2.65 21:42:04 INFO - PROCESS | 1657 | Values: 65.0 73.0 71.0 78.0 72.0 72.0 73.0 69.0 70.0 70.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:88.00 stddev:11.57 (13.1%) stddev-sans-first:12.19 21:42:04 INFO - PROCESS | 1657 | Values: 89.0 89.0 75.0 87.0 96.0 78.0 97.0 100.0 110.0 108.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:156.10 Median:161.50 stddev:15.15 (9.4%) stddev-sans-first:14.58 21:42:04 INFO - PROCESS | 1657 | Values: 138.0 160.0 163.0 153.0 163.0 145.0 136.0 150.0 187.0 166.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.00 stddev:2.71 (1.6%) stddev-sans-first:2.74 21:42:04 INFO - PROCESS | 1657 | Values: 176.0 174.0 174.0 172.0 179.0 176.0 172.0 170.0 173.0 171.0 21:42:04 INFO - PROCESS | 1657 | 21:42:04 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:70.50 stddev:6.90 (9.8%) stddev-sans-first:7.21 21:42:04 INFO - PROCESS | 1657 | Values: 70.0 71.0 70.0 75.0 86.0 86.0 68.0 70.0 69.0 69.0 21:42:04 INFO - PROCESS | 1657 | -------- Summary: end -------- 21:42:04 INFO - PROCESS | 1657 | 21:42:05 INFO - TEST-INFO | 1657: exit 0 21:42:05 INFO - TEST-OK | kraken | took 60369ms 21:42:05 INFO - SUITE-END | took 1181s 21:42:06 INFO - Completed test suite (00:19:41) 21:42:06 INFO - javascript benchmark 21:42:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2770.542860428029, 3316.3864685033286, 3321.319129578437, 3342.2312868040335, 3385.5937287525485, 5552.305961754781, 5569.10894256918, 5576.219329293902, 5664.348599911006, 5673.744681489333, 5617.213590097379, 5633.0987042073275, 5636.689982050985, 5661.66030038198, 5738.42615738426, 5109.897802043957, 5152.613553983466, 5153.665011774241, 5179.119549676564, 5185.196294574347, 5078.669886457387, 5146.922796158042, 5163.3545806774155, 5192.3249977503065, 5211.114110601206, 5175.24958880962, 5231.712255825928, 5240.60695447841, 5243.475652434764, 5263.526282634562, 5066.0, 5087.745612719349, 5093.516115968977, 5128.230765385185, 5171.793128274864, 5109.642325037249, 5125.487451254845, 5138.100832354323, 5139.563137133348, 5209.687418754849, 5569.526590239834, 5612.07400778871, 5630.8029218977135, 5647.407022262644, 5658.85852853682, 5861.970690146564, 6152.969235153841, 6155.476784473325, 6159.784407545759, 6162.1681073055015, 6005.129256257862, 6084.543659225532, 6137.8187520601, 6170.105334726484, 6173.012318029094, 5733.226014488033, 5733.598648094677, 5736.971315143481, 5738.196652468658, 5767.163761254595, 6210.130581718563, 6255.655938923403, 6279.654618995999, 6282.717277722513, 6286.591371560834, 5004.724740139327, 5842.503387212049, 5851.619644723164, 5856.795012174553, 5906.291245050621, 5034.471380505068, 6027.126066720301, 6087.147799308101, 6093.69531523422, 6098.1157732128595, 5993.460588547052, 6003.729832157564, 6017.578769486094, 6018.909716354258, 6024.819255422257, 6029.758809647565, 6059.575829691968, 6114.2662880453745, 6139.10982907476, 6218.973869311513, 4869.074875773592, 4873.244647079638, 4881.560659540658, 4910.0, 4910.828121015818, 4406.713563618355, 4425.645948324126, 4426.645868330525, 4451.198784218872, 4470.508244093147, 5581.302337207849, 5593.552515798727, 5607.990561698852, 5648.15277708347, 5660.85847853807, 6171.47542458896, 6188.071789231652, 6204.441600255908, 6206.627602343874, 6209.96895015522, 5707.3721890592005, 5715.428457154251, 5736.397678243808, 5736.483716465538, 5747.597668163272, 5268.604854635918, 5274.789008439696, 5285.995660824508, 5366.704831234241, 5375.435579264199, 6181.196444462191, 6194.938050619617, 6205.0, 6289.7169627365965, 6290.0, 5039.72281524505, 6032.215811944419, 6204.844878878064, 6215.689215539295, 6221.9377806223165, 6107.583301036431, 6238.75044998195, 6278.968605156945, 6294.464970477561, 6303.6532990685955, 5937.465628093492, 5995.820125396245, 6048.304444988883, 6056.878862422815, 6071.9981203101, 5529.391766905717, 5747.281589801275, 6107.3708791890585, 6112.351504965315, 6139.57023008403, 5199.80404506958, 5384.892302154013, 5932.970335148297, 5954.404559544011, 5960.8807823844145, 5977.820665380045, 6038.6678732670125, 6039.667818270037, 6041.546883983631, 6041.697915104315, 5840.1531777892815, 5852.4147585241135, 5867.853303667443, 5869.559783016205, 5881.470667639762, 6017.759289628366, 6025.0661147522205, 6037.305709843425, 6050.273967123797, 6062.0, 5854.385289544707, 5855.619384739978, 5864.44287792659, 5935.673537955454, 5959.523238140851], "value": 5593.033516154592, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.8890999525105, 502.7913415932388, 520.1911028350918, 520.5705293133165, 531.893621275745, 26545.336366590822, 31078.06765797027, 31201.84399078007, 35326.0, 38246.617533824654, 37641.0, 40919.795401023024, 41008.0, 41053.79473102638, 41091.17817643653, 9222.077792220774, 9379.812403751921, 9393.859092113624, 9396.718098457057, 9406.247500199968, 8413.15868413157, 8580.570971451403, 9304.720858374225, 9395.530223488833, 10883.0, 11116.499757510892, 11216.046636035946, 11240.381779002193, 11242.887571124307, 11291.0, 11076.335419874793, 11099.889001109967, 11127.944360278228, 11135.832962505569, 11151.832722509169, 8289.626966786449, 8521.701740439117, 10678.839817402668, 10964.342139471657, 11014.669559913216, 38073.61926380756, 38523.0, 38564.03589910247, 38644.227115457536, 38656.033599159964, 3202.3595280943905, 3246.2858171202533, 3257.641659417462, 3267.754918381131, 3367.9158021049425, 28591.428171436455, 29258.414831703245, 29555.261118472212, 29649.625330554034, 29758.0, 3169.3344397676515, 3190.0, 3192.5530425740417, 3219.4526930421885, 3276.8689252429876, 468358.0, 469167.0, 469821.0, 469846.0, 470259.0, 58770.70614646899, 58873.93512778408, 58890.705546471996, 58912.70543647254, 59100.81798364009, 61538.69230653818, 61596.69201653963, 61639.0, 61668.0, 61754.69122654358, 15026.774598381033, 15130.092194468367, 15233.6191595211, 15592.688146237238, 15597.53207403757, 11198.552057917756, 11631.127665425127, 11646.53413863453, 11687.357195354167, 11699.356535390636, 14796.70406591862, 15151.045546118621, 15194.848051519564, 16482.83517164837, 16753.581160470843, 6740.730370785212, 6756.695948682321, 6824.6928888200155, 6838.760643377458, 6854.760083397057, 869.4913475616709, 942.5098948546854, 1019.2610357490908, 1032.4115254305125, 1059.645018918671, 24082.79586020692, 27052.0, 29179.562306565418, 29554.556681649792, 29755.0, 855.3542075732906, 938.6526985015588, 1008.7881544875512, 1092.830611255241, 1122.1527746551465, 14154.292285385689, 14168.308021475887, 14323.14061156334, 14938.626534336729, 15340.0, 493546.5322673364, 587563.0621846949, 589620.0, 592043.0, 786821.0, 45902.5409745905, 46197.0, 58396.54008649733, 58523.0, 58653.0, 1324.8675132486674, 1354.519145703261, 1370.4381203706432, 1371.2732251906505, 1371.4582739817715, 23814.404639884142, 29912.25219369533, 29964.101076967727, 30501.54247686331, 30591.54112688267, 48879.511204887494, 49292.0, 49367.506324936294, 49469.0, 49547.0, 537240.0, 541896.0, 543067.8392336537, 543433.0, 543576.0, 37301.38890277763, 37710.81144594259, 37932.24135517219, 37992.810035949646, 38036.04909877275, 41341.37987930243, 44249.55750442583, 44426.55573444224, 45102.0, 45528.317075243234, 36685.899423017356, 38769.255383508375, 38930.0, 40230.39654405245, 40378.0, 36250.63749362472, 36702.265954681294, 37968.24063518769, 38007.04982375463, 38085.619143809316, 36163.27673446569, 36687.63312366842, 36999.63000369962, 37410.6258937418, 37455.438168426954, 31290.0, 32515.0, 32933.50599741054, 33691.83154084214, 34622.82688586541, 18853.0, 23442.0, 23970.44192127506, 24778.380540486633, 25146.49707005813], "value": 19477.243506687468, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.8705478972781, 369.6026771220938, 372.8024147201982, 382.5887171290862, 401.03150890599204, 14595.416183352667, 14991.40034398624, 15324.770128448068, 19743.605127897434, 20443.0, 18486.722699159523, 18940.621187576242, 18981.24075037, 19243.615127697438, 20385.49036274094, 5570.972145139269, 5690.971545142268, 5728.140778883159, 6089.2692876854835, 6107.877842443148, 4693.9295910561195, 5977.5815692901515, 6009.969950150243, 6014.067819487965, 6015.157877897098, 5607.691576963265, 5950.9107363389585, 5955.791547295846, 5964.13520039594, 5968.88062238755, 5808.622439541437, 5942.762289508414, 5958.165856780054, 5961.850953726148, 5967.134765459027, 4644.558766917171, 5184.196449550326, 5188.9740551297, 5191.039657663345, 5331.333583302087, 12781.680457988532, 12987.87012129876, 13004.349782510837, 13043.934780326037, 18176.90911545447, 1927.4025052233853, 2024.9088791004292, 2244.304265677645, 2327.1156960355124, 2819.971800282012, 8916.331275154389, 9423.952880235554, 9925.057119573628, 10002.49987500622, 10111.3427627204, 1659.601695593061, 1741.4340339389623, 1773.485689150145, 1778.315348590789, 1826.2147276671026, 76343.61828190878, 91685.0, 116824.0, 117913.82086179114, 120445.39777301146, 9135.817283654289, 9390.0, 9682.225421966226, 9768.804623907625, 11000.724981875517, 11828.349440780668, 12150.57472988441, 12195.329256890956, 12218.816717749241, 12230.694232644255, 7089.858202835914, 7139.5720855828, 7767.844643107219, 7786.57173855432, 7959.482633628912, 7557.773266802004, 7715.961420192975, 7864.5057439086395, 8016.198380162054, 8081.919180808234, 3708.35103856824, 3816.2939856126704, 3824.3880979043774, 3871.690264778811, 3897.415387691869, 1648.8351164883416, 1821.5901422180168, 1841.0058568372929, 1886.547228665138, 1888.8583356248337, 754.9698012079565, 865.485036403339, 869.4783130122003, 887.1084560017141, 896.1799953043023, 17545.56136096608, 19602.509937251398, 20475.795242047687, 20786.0, 20879.582408352053, 779.3726050529378, 914.5427286356821, 917.321182325088, 926.4719110107175, 939.6241503398559, 10627.89372106269, 10911.781764364669, 10981.0, 11003.734570524332, 11083.778324433628, 536070.0, 539539.0, 541326.0, 547682.0, 550878.0, 112850.43574782074, 120374.0, 121984.0, 124779.3761031189, 126830.73169268374, 971.2375785008734, 974.907383798538, 980.6665733650593, 982.7248370456284, 983.1250187333279, 16564.337426502803, 18287.45137645873, 18402.26390944347, 18581.81418185855, 18710.345137920107, 44332.556674434134, 44547.66357009295, 47528.0, 49876.75061624814, 52210.06345875211, 72761.6361918187, 74151.8877216853, 75768.62115689386, 78252.0, 78612.0, 5279.630425870152, 7282.0, 7344.82482802749, 7780.766577002699, 8018.3184429324165, 8339.66565349541, 11792.646220613395, 11887.583934562248, 11968.281903085843, 12314.322712250912, 10352.378857268588, 10722.678319650424, 10814.945925270324, 10852.457377130953, 11031.17266205054, 8828.470291782514, 10309.690709278733, 10442.895571044191, 10578.947105264424, 10872.728181795519, 9177.587008584496, 10587.100096491884, 10837.807841137312, 10866.67399978002, 11112.22214444981, 6545.0182472629485, 7602.429817763579, 7677.884831727641, 7926.24700653437, 8107.351411887153, 10048.246381521269, 10474.476276186313, 10507.89492105069, 10693.679189624012, 10877.67366978992], "value": 8812.783512424421, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.7358528294344, 1459.6496840758214, 1499.0256333383302, 1652.6694661067781, 1843.7418761373401, 6091.817245482637, 7730.18833022533, 7919.6832126714935, 8244.0, 8245.95877020614, 8082.19178082193, 8132.26809587137, 8203.056648485426, 8206.712765053224, 8219.589020548978, 2045.642012647788, 2277.533105713333, 2325.5930212212793, 2326.813854891613, 2329.988350058256, 2126.680997850327, 2132.1364847236896, 2139.9465013374634, 2257.7742225777456, 2337.509123084146, 2299.1378233162563, 2300.7469178390365, 2301.5281867217263, 2303.147835300941, 2304.0092760113143, 2268.330842401479, 2282.6918366020623, 2284.977150228501, 2309.2379514760087, 2315.1549684365255, 2262.2760716570706, 2299.609066458706, 2329.324495896188, 2334.0897050150456, 2336.1122773346187, 8185.877211841827, 8195.303399211074, 8273.627686754111, 8275.420720549564, 8293.709720159826, 4980.427250866161, 5144.74276286188, 5150.845474635767, 5152.92270615941, 5157.277981082651, 3326.846215488449, 3422.281320922609, 3447.793132412063, 3530.0, 3544.6455354464606, 1012.6556970630021, 1048.6539441984128, 1071.8285074388061, 1084.5119696136692, 1086.9565217391296, 10611.41637209961, 10720.142388608892, 10769.246152769309, 10777.9760922713, 10783.352998820095, 3930.9779457340724, 4326.329418940069, 4536.183486972311, 4631.606313463393, 4646.09401166776, 9223.76940576491, 9232.353735238468, 9240.399374040666, 9252.444853308823, 9253.398529095588, 5130.743462826844, 5139.691618502902, 5142.665726727751, 5149.742512874342, 5151.25306830515, 4523.84166554169, 4643.883902902455, 4674.97662511692, 4676.205045142334, 4737.573618374363, 3473.8436770345397, 3600.3879340512176, 3603.9099022524647, 3630.2920930418845, 3715.9071023224637, 1178.2164860367932, 1194.8446701928694, 1196.3778835005749, 1215.1797536662718, 1260.357217818919, 735.3528894572742, 837.367787320569, 854.78203058221, 874.2219424712011, 920.4569304110607, 5497.697626630574, 5508.91736623951, 5566.387697353288, 5602.162518674721, 5647.209390685307, 807.5840941914919, 864.1358641358642, 891.3760367742606, 899.1727610598265, 919.8758167647281, 3688.5389326334207, 3710.4434334849448, 3746.138388170736, 3779.848806047727, 3845.9807700961874, 9468.100530449596, 9926.007399260016, 9937.900620993698, 9981.051800078982, 9995.200383969264, 9889.802203956024, 9907.306488545733, 9913.752156196153, 9917.107460328461, 9921.702348929544, 7293.0, 7554.773356799305, 7590.240975902366, 7597.734079307308, 7709.267619576131, 4569.840055598038, 5254.896471740977, 5666.631668941505, 5690.402507736793, 5715.199872017838, 8258.0, 8845.203931646183, 9163.86254206174, 9333.160015598358, 9352.766180845534, 9286.117818807203, 9364.672236471692, 9369.203617692572, 9460.0, 9528.666496672584, 6978.825529361807, 7004.964975175091, 7052.929470705432, 7165.3551180394015, 7175.390091842252, 7610.8097297568, 7687.461877668509, 7691.38468922496, 7704.730334438492, 7705.460617756703, 5679.971600141973, 6906.067680863019, 7033.894491582528, 7095.361417472246, 7235.8552828944175, 6864.24493305726, 6908.896366554405, 6911.928651059094, 6955.652217389212, 6978.616176110363, 6350.936490635035, 6453.0, 6453.645049522322, 6556.803295901131, 6572.441342485751, 4724.574788269072, 4754.477007529238, 4766.61867050642, 4805.37530121096, 4901.975490122527, 4589.58693717567, 4786.377770889762, 4790.209615413418, 4851.34506841586, 4983.0], "value": 4330.4901965113595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.3866781100461, 302.1705418625872, 308.822427104415, 310.58691939720177, 313.7364613724471, 4256.340267258573, 4950.678205916613, 5029.798808047678, 5136.974315128419, 5217.582483473321, 4247.362895565667, 4745.549172828576, 4914.926276105862, 5164.715940623264, 5181.43004269531, 4016.4778578784717, 4024.939625905621, 4025.59197678543, 4027.41602467642, 4057.7159598828093, 3628.2743451309843, 3738.4205448155444, 3906.1015966327764, 4021.9597804022023, 4054.513458384998, 3404.114930118175, 3479.3389256041396, 3972.1459886124476, 4014.538328092263, 4015.2973229684835, 3113.4395808754416, 3980.5223373195113, 3988.9229907924987, 3993.44091827143, 4021.537523184842, 2901.883924643033, 3193.4730769423018, 3490.581130264359, 3491.2493813829897, 3499.705109109646, 4245.214635292481, 4876.390451193601, 5085.872853178663, 5089.821856235014, 5093.872653183663, 3836.4538022443494, 4573.405457290564, 4577.748223847687, 4580.824108548446, 4605.4473463184295, 4587.362042199734, 4815.256971882693, 5393.9190912135955, 5455.781768729246, 5468.48049435303, 3399.2351720862857, 3718.9628103718887, 3722.8324725387424, 3850.0759817643566, 3870.748401353903, 4877.731789734659, 5114.539691427789, 5251.632385733, 5733.799317023884, 5749.453801888814, 3899.317619416591, 3899.863504777319, 3900.473436086092, 3901.3562762144497, 3906.3554513505524, 3462.272922686214, 3788.9012186465616, 3942.586028467027, 3946.427767973685, 3954.406838974177, 3864.497615310048, 3868.497095377639, 4086.896537934741, 4488.1472520221705, 4498.325251212279, 4619.584237418581, 5513.696746678891, 5525.723713814293, 5527.695976721238, 5541.33503979525, 1159.6694941941507, 1185.6443067079842, 1206.6621346023128, 1209.3106929050532, 1212.024320422051, 767.4052609227781, 841.6086519768337, 849.3375167369462, 858.6565373850385, 860.7460799064291, 4806.831760888352, 4814.8796280093275, 4889.190999330271, 4893.535114164149, 4909.337239472697, 4873.19592267279, 4970.17992031318, 5120.009470537758, 5127.717975511308, 5376.91934620981, 3992.8203230854683, 4077.1856523846604, 4401.031773009932, 4788.61691064714, 4851.902961940741, 2392.940176495567, 2646.827956182842, 2739.369944912681, 2739.794515411352, 2749.6425464689864, 4714.7741587187575, 5050.242463630411, 5084.389873215164, 5315.558218494062, 5321.376980021053, 4444.799984000728, 4696.882577935579, 5052.650517509376, 5179.0, 5454.53636440899, 5210.791568337376, 5286.334804536558, 5386.8383948481605, 5446.673199608036, 5458.263134476874, 4639.373684552542, 4789.4855201019745, 4811.7834697438, 4838.951610483991, 5006.62450316235, 5180.818671346485, 5389.541888939484, 5607.3551541571605, 5686.488216060575, 5701.828945131652, 5803.593748437737, 5831.35855055935, 5844.94155058461, 5847.561432892465, 5854.648721076749, 3082.3064810417477, 3601.6038235794567, 3759.0, 3779.093017675683, 3801.5438147422487, 5273.868153296198, 5515.889682206253, 5589.608727389043, 5655.095184770417, 5657.4908258256955, 4867.037878598689, 5262.289590905179, 5443.760962227469, 5449.629411206138, 5522.641028333145, 4830.347903033045, 4983.978284451751, 5240.423553409199, 5402.729863506887, 5459.208414779914, 4894.19245824435, 5100.62283183531, 5330.493603107699, 5364.356277246756, 5385.703786291791, 4609.976950115228, 5262.868428289324, 5391.353037635509, 5539.446055394428, 5541.224228608079, 4981.829270121591, 5404.567634589302, 5424.403315635198, 5426.802145131228, 5427.972860135674], "value": 3904.1774311974405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.9448044156467, 721.4625104297296, 748.1359030319979, 790.2571582712246, 791.0862953288952, 15149.39402423903, 15759.133247671374, 15759.92120039401, 15785.842141578582, 15820.288087036082, 11910.880891191107, 14289.928255380835, 14316.28418579072, 14326.0, 14398.352074156663, 660.1945626335862, 687.7833482453011, 693.2132030145771, 810.9351251899864, 823.5305875650866, 826.7519744076783, 826.8677011678133, 834.157500924065, 840.3403328387217, 841.9031811341713, 898.2275243290765, 899.7435730816718, 901.076396693388, 901.7835719427355, 906.1210625693067, 890.4968692688675, 890.8396488632044, 892.9196372326489, 893.4282059481936, 897.0, 508.8295421033958, 534.5509771791714, 627.6422439209653, 660.2440205964192, 665.6804733727789, 14558.92720536401, 14589.9787014909, 14592.562223133324, 14612.342444590018, 14646.41414343425, 12707.936460317731, 12851.807222891664, 13511.391987360592, 13943.930280348533, 13990.16059036461, 12357.938210308981, 12429.627111186679, 12640.0, 12731.809022864665, 12966.675833104247, 4096.9795151024055, 4259.76571288579, 4281.764502952336, 4387.0, 4459.665525085632, 103968.0, 111373.0, 112208.0, 112795.43602282018, 112984.0, 10464.0, 10886.074683651977, 10886.129109671207, 10918.836217456745, 11233.0, 21455.89272053661, 21599.460013499473, 21632.35102946914, 21672.56654866894, 21915.01382437794, 7560.3573696236435, 7609.809754756176, 7696.923030769621, 7702.845943081107, 7875.330596899214, 3557.9110522236633, 4180.707350485498, 4257.106007738348, 4288.356746488052, 4445.310976798602, 3448.189675426273, 3600.8837260449345, 3601.2797440512004, 3605.4952306677087, 3607.67530922213, 651.1502489251573, 653.7189008726199, 668.5153263883645, 669.036587314266, 672.2504407585604, 595.2648479128273, 630.9873802524015, 645.3965542218041, 671.4058058618158, 671.8824205763972, 8843.292536597057, 9028.593713282919, 9116.424947061378, 9233.630654773868, 9380.90619093814, 628.3252600651141, 639.4756299834091, 644.9838754031186, 666.4002397841884, 673.2157037051878, 3552.609212986569, 4379.715318504287, 4436.268015777425, 4445.244308467568, 4487.798049087799, 103856.0, 111038.88961110286, 111195.0, 111865.44067279612, 112356.40067640752, 96665.51667241618, 99163.51254731185, 100104.0, 100183.49908250412, 101265.0, 87164.0, 87295.56352218325, 87665.0, 88619.55690221637, 89163.75853690179, 8566.400351975552, 8645.135486451305, 8706.60820263077, 8772.780680482783, 8874.423162494417, 51807.0, 54367.18449223344, 54748.45251547593, 55477.1678424832, 57146.0, 59362.10956835565, 60962.695186523786, 61993.0, 62581.0, 72690.63654681692, 10904.0, 12365.567205147776, 12766.68083297925, 12914.741705165656, 13331.466741330238, 14219.50231741884, 14540.200288984208, 14801.629959251104, 15004.29235959993, 15245.466408675644, 13550.0, 13562.457501699822, 13724.039317247696, 13960.720785584028, 14055.718885622435, 13313.733725325634, 13597.592072237849, 13760.724785504033, 13984.790228146789, 14081.577552673436, 13280.933595331962, 13404.195748255135, 13676.384562694504, 13763.449462021406, 14053.156810591398, 11055.281406708538, 11083.778324433628, 11119.777604447703, 11149.721256968316, 11596.362200079077, 10781.9460902695, 11206.327620342805, 11280.2667826591, 11369.658910232707, 11510.194286399872], "value": 7478.419355790641, "unit": "score"}], "name": "dromaeo_css", "value": 7036.696555201589, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 114.0, 113.0, 112.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 115.0, 113.0, 151.0, 120.0, 140.0, 140.0, 117.0, 138.0, 113.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 255.0, 195.0, 183.0, 182.0, 177.0, 183.0, 186.0, 184.0, 185.0], "value": 192.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 86.0, 62.0, 60.0, 59.0, 59.0, 75.0, 58.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 74.0, 84.0, 69.0, 69.0, 69.0, 81.0, 66.0, 68.0, 83.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 87.0, 83.0, 86.0, 83.0, 86.0, 88.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 116.0, 97.0, 93.0, 93.0, 93.0, 93.0, 93.0, 97.0, 92.0], "value": 96.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 88.0, 84.0, 86.0, 86.0, 87.0, 87.0, 85.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 53.0, 52.0, 56.0, 55.0, 56.0, 56.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 71.0, 78.0, 72.0, 72.0, 73.0, 69.0, 70.0, 70.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 75.0, 87.0, 96.0, 78.0, 97.0, 100.0, 110.0, 108.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 160.0, 163.0, 153.0, 163.0, 145.0, 136.0, 150.0, 187.0, 166.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 174.0, 172.0, 179.0, 176.0, 172.0, 170.0, 173.0, 171.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 75.0, 86.0, 86.0, 68.0, 70.0, 69.0, 69.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1466.6, "alertThreshold": 2.0}]} 21:42:06 INFO - Return code: 0 21:42:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:42:06 INFO - # TBPL SUCCESS # 21:42:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:42:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:42:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:42:06 INFO - 2016-12-04 21:42:06.201 screenresolution[1661:11421] starting screenresolution argv=screenresolution get 21:42:06 INFO - 2016-12-04 21:42:06.204 screenresolution[1661:11421] Display 0: 1600x1200x32@60 21:42:06 INFO - 2016-12-04 21:42:06.210 screenresolution[1662:11424] starting screenresolution argv=screenresolution list 21:42:06 INFO - Available Modes on Display 0 21:42:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:42:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:42:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:42:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:42:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:42:06 INFO - Intel Iris: 21:42:06 INFO - Chipset Model: Intel Iris 21:42:06 INFO - Type: GPU 21:42:06 INFO - Bus: Built-In 21:42:06 INFO - VRAM (Dynamic, Max): 1536 MB 21:42:06 INFO - Vendor: Intel (0x8086) 21:42:06 INFO - Device ID: 0x0a2e 21:42:06 INFO - Revision ID: 0x0009 21:42:06 INFO - Displays: 21:42:06 INFO - Display: 21:42:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:42:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:42:06 INFO - Display Serial Number: 1600x1200 60 21:42:06 INFO - Main Display: Yes 21:42:06 INFO - Mirror: Off 21:42:06 INFO - Online: Yes 21:42:06 INFO - Rotation: Supported 21:42:06 INFO - Return code: 0 21:42:06 INFO - Running post-action listener: _resource_record_post_action 21:42:06 INFO - [mozharness: 2016-12-05 05:42:06.455631Z] Finished run-tests step (success) 21:42:06 INFO - Running post-run listener: _resource_record_post_run 21:42:06 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 31435776; Write bytes: 696155136; Read time: 314; Write time: 1971 21:42:06 INFO - TinderboxPrint: CPU usage
53.6% 21:42:06 INFO - TinderboxPrint: I/O read bytes / time
31,435,776 / 314 21:42:06 INFO - TinderboxPrint: I/O write bytes / time
696,155,136 / 1,971 21:42:06 INFO - TinderboxPrint: CPU idle
2,255.7 (46.4%) 21:42:06 INFO - TinderboxPrint: CPU system
969.2 (19.9%) 21:42:06 INFO - TinderboxPrint: CPU user
1,636.8 (33.7%) 21:42:06 INFO - TinderboxPrint: Swap in / out
411,201,536 / 0 21:42:06 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 365480448; Write bytes: 361116672; Read time: 27592; Write time: 732 21:42:06 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 30505984; Write bytes: 307943424; Read time: 301; Write time: 1169 21:42:06 INFO - Running post-run listener: _upload_blobber_files 21:42:06 INFO - Blob upload gear active. 21:42:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:42:06 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 21:42:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:42:07 INFO - (blobuploader) - INFO - Open directory for files ... 21:42:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:42:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:42:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:08 INFO - (blobuploader) - INFO - Done attempting. 21:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:09 INFO - (blobuploader) - INFO - Done attempting. 21:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:11 INFO - (blobuploader) - INFO - Done attempting. 21:42:11 INFO - (blobuploader) - INFO - Iteration through files over. 21:42:12 INFO - Return code: 0 21:42:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:42:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:42:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/40d9e791545b5e77f46c890297097ca92055cd1cd0592b79739a1729190539bdc16e68917b791eabb39868194bcd8725ae6b6337d986dba73934f58698ace0b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2786fb114add61e828bda3d1ed779e9f05d0e39782c70eb0664aa0135d172d5a2d495ac76e9d2c3586daad533593048d53fd1920574b7c46b4471f4b9f07419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/71bcf66d92f66ca9df6b9b4c9692ae8ac3399b07324be830e208529fea115c42ed55910262a2b77825551f44faf7e86e0bc5f991978d53f5e28d50fad265fd6e"} 21:42:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:42:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:42:12 INFO - Contents: 21:42:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/40d9e791545b5e77f46c890297097ca92055cd1cd0592b79739a1729190539bdc16e68917b791eabb39868194bcd8725ae6b6337d986dba73934f58698ace0b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2786fb114add61e828bda3d1ed779e9f05d0e39782c70eb0664aa0135d172d5a2d495ac76e9d2c3586daad533593048d53fd1920574b7c46b4471f4b9f07419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/71bcf66d92f66ca9df6b9b4c9692ae8ac3399b07324be830e208529fea115c42ed55910262a2b77825551f44faf7e86e0bc5f991978d53f5e28d50fad265fd6e"} 21:42:12 INFO - Running post-run listener: copy_logs_to_upload_dir 21:42:12 INFO - Copying logs to upload dir... 21:42:12 INFO - mkdir: /builds/slave/test/build/upload/logs 21:42:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.336650 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-04 21:42:12.083365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 21:42:12.088306) ========= 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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/40d9e791545b5e77f46c890297097ca92055cd1cd0592b79739a1729190539bdc16e68917b791eabb39868194bcd8725ae6b6337d986dba73934f58698ace0b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2786fb114add61e828bda3d1ed779e9f05d0e39782c70eb0664aa0135d172d5a2d495ac76e9d2c3586daad533593048d53fd1920574b7c46b4471f4b9f07419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/71bcf66d92f66ca9df6b9b4c9692ae8ac3399b07324be830e208529fea115c42ed55910262a2b77825551f44faf7e86e0bc5f991978d53f5e28d50fad265fd6e"} build_url:https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/UDx0J90KQqWzgVPrZy37ug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/40d9e791545b5e77f46c890297097ca92055cd1cd0592b79739a1729190539bdc16e68917b791eabb39868194bcd8725ae6b6337d986dba73934f58698ace0b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e2786fb114add61e828bda3d1ed779e9f05d0e39782c70eb0664aa0135d172d5a2d495ac76e9d2c3586daad533593048d53fd1920574b7c46b4471f4b9f07419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/71bcf66d92f66ca9df6b9b4c9692ae8ac3399b07324be830e208529fea115c42ed55910262a2b77825551f44faf7e86e0bc5f991978d53f5e28d50fad265fd6e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 21:42:12.126175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 21:42:12.126565) ========= 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.X6RZNpcF3N/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.6aVOqFpf3Y/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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.005149 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 21:42:12.175317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 21:42:12.175625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 21:42:12.178938) ========= ========= Total master_lag: 0.29 =========