builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0176 starttime: 1487375075.12 results: success (0) buildid: 20170217134420 builduid: a9848e0d7eb743bf9ec03ca5dd2447b7 revision: 42db8a0b3673b959560b0edc2ac89a44576bddd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:35.119900) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:35.120381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:35.120858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:35.150310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:35.150721) ========= 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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 --2017-02-17 15:44:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.96M=0.001s 2017-02-17 15:44:35 (7.96 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109659 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:35.287771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:35.288147) ========= 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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.022448 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:35.337623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 15:44:35.337995) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 42db8a0b3673b959560b0edc2ac89a44576bddd1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 42db8a0b3673b959560b0edc2ac89a44576bddd1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H0nQPVJYXv/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.4kYpfp1IcA/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 2017-02-17 15:44:35,428 truncating revision to first 12 chars 2017-02-17 15:44:35,428 Setting DEBUG logging. 2017-02-17 15:44:35,428 attempt 1/10 2017-02-17 15:44:35,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/42db8a0b3673?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-17 15:44:36,865 unpacking tar archive at: mozilla-beta-42db8a0b3673/testing/mozharness/ program finished with exit code 0 elapsedTime=1.676189 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 15:44:37.041751) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:37.042149) ========= script_repo_revision: 42db8a0b3673b959560b0edc2ac89a44576bddd1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:37.042564) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:37.042858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 15:44:37.063482) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-17 15:44:37.063921) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H0nQPVJYXv/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.4kYpfp1IcA/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:44:37 INFO - MultiFileLogger online at 20170217 15:44:37 in /builds/slave/test 15:44:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:44:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:44:37 INFO - {'append_to_log': False, 15:44:37 INFO - 'base_work_dir': '/builds/slave/test', 15:44:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:44:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:44:37 INFO - 'branch': 'Mozilla-Beta', 15:44:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:44:37 INFO - 'config_files': ('talos/mac_config.py',), 15:44:37 INFO - 'default_actions': ('clobber', 15:44:37 INFO - 'read-buildbot-config', 15:44:37 INFO - 'download-and-extract', 15:44:37 INFO - 'populate-webroot', 15:44:37 INFO - 'create-virtualenv', 15:44:37 INFO - 'install', 15:44:37 INFO - 'run-tests'), 15:44:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:44:37 INFO - 'download_minidump_stackwalk': True, 15:44:37 INFO - 'download_symbols': 'ondemand', 15:44:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:44:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:44:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:44:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:44:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:44:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:44:37 INFO - 'installer_path': 'installer.exe', 15:44:37 INFO - 'log_level': 'info', 15:44:37 INFO - 'log_name': 'talos', 15:44:37 INFO - 'log_to_console': True, 15:44:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:44:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:44:37 INFO - 'opt_config_files': (), 15:44:37 INFO - 'pip_index': False, 15:44:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:44:37 INFO - 'cmd': ('bash', 15:44:37 INFO - '-c', 15:44:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:44:37 INFO - 'enabled': True, 15:44:37 INFO - 'halt_on_failure': False, 15:44:37 INFO - 'name': 'check_screen_resolution'},), 15:44:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:44:37 INFO - 'cmd': ('bash', 15:44:37 INFO - '-c', 15:44:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:44:37 INFO - 'enabled': True, 15:44:37 INFO - 'halt_on_failure': False, 15:44:37 INFO - 'name': 'check_screen_resolution'},), 15:44:37 INFO - 'run_cmd_checks_enabled': True, 15:44:37 INFO - 'sps_profile': False, 15:44:37 INFO - 'sps_profile_interval': 0, 15:44:37 INFO - 'suite': 'dromaeojs', 15:44:37 INFO - 'system_bits': '32', 15:44:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:44:37 INFO - 'title': 't-yosemite-r7-0176', 15:44:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:44:37 INFO - 'use_talos_json': True, 15:44:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:44:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:44:37 INFO - 'work_dir': 'build'} 15:44:37 INFO - [mozharness: 2017-02-17 23:44:37.277255Z] Running clobber step. 15:44:37 INFO - Running pre-action listener: _resource_record_pre_action 15:44:37 INFO - Running main action method: clobber 15:44:37 INFO - rmtree: /builds/slave/test/build 15:44:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:44:40 INFO - Running post-action listener: _resource_record_post_action 15:44:40 INFO - [mozharness: 2017-02-17 23:44:40.612794Z] Finished clobber step (success) 15:44:40 INFO - [mozharness: 2017-02-17 23:44:40.612928Z] Running read-buildbot-config step. 15:44:40 INFO - Running pre-action listener: _resource_record_pre_action 15:44:40 INFO - Running main action method: read_buildbot_config 15:44:40 INFO - Using buildbot properties: 15:44:40 INFO - { 15:44:40 INFO - "project": "", 15:44:40 INFO - "product": "firefox", 15:44:40 INFO - "script_repo_revision": "production", 15:44:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:44:40 INFO - "repository": "", 15:44:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:44:40 INFO - "buildid": "20170217134420", 15:44:40 INFO - "pgo_build": "False", 15:44:40 INFO - "basedir": "/builds/slave/test", 15:44:40 INFO - "buildnumber": 11, 15:44:40 INFO - "slavename": "t-yosemite-r7-0176", 15:44:40 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:44:40 INFO - "platform": "yosemite_r7", 15:44:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:44:40 INFO - "branch": "mozilla-beta", 15:44:40 INFO - "repo_path": "releases/mozilla-beta", 15:44:40 INFO - "revision": "42db8a0b3673b959560b0edc2ac89a44576bddd1", 15:44:40 INFO - "stage_platform": "macosx64", 15:44:40 INFO - "builduid": "a9848e0d7eb743bf9ec03ca5dd2447b7", 15:44:40 INFO - "slavebuilddir": "test" 15:44:40 INFO - } 15:44:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 15:44:40 INFO - Running post-action listener: _resource_record_post_action 15:44:40 INFO - [mozharness: 2017-02-17 23:44:40.616305Z] Finished read-buildbot-config step (success) 15:44:40 INFO - [mozharness: 2017-02-17 23:44:40.616437Z] Running download-and-extract step. 15:44:40 INFO - Running pre-action listener: _resource_record_pre_action 15:44:40 INFO - Running main action method: download_and_extract 15:44:40 INFO - mkdir: /builds/slave/test/build/tests 15:44: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')]} 15:44:40 INFO - trying https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 15:44:40 INFO - Downloading https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 15:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 15:44:41 INFO - Downloaded 1165 bytes. 15:44:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 15:44:41 INFO - Using the following test package requirements: 15:44:41 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 15:44:41 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 15:44:41 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 15:44:41 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 15:44:41 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 15:44:41 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:44:41 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 15:44:41 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 15:44:41 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 15:44:41 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 15:44:41 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 15:44:41 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 15:44:41 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 15:44:41 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 15:44:41 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 15:44:41 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 15:44:41 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 15:44:41 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 15:44:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 15:44:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 15:44:41 INFO - Fetch https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 15:44:41 INFO - Http code: 200 15:44:41 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 15:44:41 INFO - x-amz-cf-id: pfGS64gfbBNs0xnI-vLxkk1crcfiKLPSqM270cHbsflKP9Azb-SWOg== 15:44:41 INFO - x-amz-version-id: RLSkFym.oSf4ZaBFN0y9lxeUnYFLXms4 15:44:42 INFO - Expected file size: 16092968 15:44:42 INFO - Obtained file size: 16092968 15:44:48 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:44:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 15:44:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 15:44:48 INFO - Fetch https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 15:44:49 INFO - Http code: 200 15:44:49 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 15:44:49 INFO - x-amz-cf-id: PzD_1QI5k7XwRrh6bkS3Vibp_hk8ovzwfJQ4dLBVs3mGhAvH_wvptQ== 15:44:49 INFO - x-amz-version-id: RLSkFym.oSf4ZaBFN0y9lxeUnYFLXms4 15:44:49 INFO - Expected file size: 16092968 15:44:49 INFO - Obtained file size: 16092968 15:44:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 15:44:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 15:44:56 INFO - Fetch https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 15:44:56 INFO - Http code: 200 15:44:56 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 15:44:56 INFO - x-amz-cf-id: ia11lNq8l8Fq2-CHie0K_6pRerZfoh4wr8tybd0ZL3YEN_FBJ8viBA== 15:44:56 INFO - x-amz-version-id: 8dd4w6GhfywNMwx8s.oAKa68hWvsGV96 15:44:57 INFO - Expected file size: 14403005 15:44:57 INFO - Obtained file size: 14403005 15:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:57 INFO - trying https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 15:44:57 INFO - Downloading https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 15:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 15:44:59 INFO - Downloaded 82136880 bytes. 15:44:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 15:44:59 INFO - mkdir: /builds/slave/test/properties 15:44:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:44:59 INFO - Writing to file /builds/slave/test/properties/build_url 15:44:59 INFO - Contents: 15:44:59 INFO - build_url:https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 15:45:00 INFO - Running post-action listener: _resource_record_post_action 15:45:00 INFO - Running post-action listener: set_extra_try_arguments 15:45:00 INFO - [mozharness: 2017-02-17 23:45:00.414677Z] Finished download-and-extract step (success) 15:45:00 INFO - [mozharness: 2017-02-17 23:45:00.414795Z] Running populate-webroot step. 15:45:00 INFO - Running pre-action listener: _resource_record_pre_action 15:45:00 INFO - Running main action method: populate_webroot 15:45:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:45:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:45:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:45:00 INFO - '--tppagecycles', 15:45:00 INFO - '7'], 15:45:00 INFO - 'tests': ['tsvgm']}}, 15:45:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:45:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:45:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:45:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:45:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:00 INFO - 'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:00 INFO - 'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['damp', 'tps']}, 15:45:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:00 INFO - 'tests': ['damp', 'tps']}, 15:45:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['dromaeo_dom']}, 15:45:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:45:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['basic_compositor_video']}, 15:45:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:45:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['a11yr', 15:45:00 INFO - 'ts_paint', 15:45:00 INFO - 'tpaint', 15:45:00 INFO - 'sessionrestore', 15:45:00 INFO - 'sessionrestore_no_auto_restore', 15:45:00 INFO - 'tabpaint']}, 15:45:00 INFO - 'other-e10s': {'tests': ['a11yr', 15:45:00 INFO - 'ts_paint', 15:45:00 INFO - 'tpaint', 15:45:00 INFO - 'sessionrestore', 15:45:00 INFO - 'sessionrestore_no_auto_restore', 15:45:00 INFO - 'tabpaint']}, 15:45:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:45:00 INFO - 'ts_paint', 15:45:00 INFO - 'tpaint', 15:45:00 INFO - 'sessionrestore', 15:45:00 INFO - 'sessionrestore_no_auto_restore', 15:45:00 INFO - 'tabpaint']}, 15:45:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:45:00 INFO - 'ts_paint', 15:45:00 INFO - 'tpaint', 15:45:00 INFO - 'sessionrestore', 15:45:00 INFO - 'sessionrestore_no_auto_restore', 15:45:00 INFO - 'tabpaint']}, 15:45:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['a11yr', 15:45:00 INFO - 'ts_paint', 15:45:00 INFO - 'tpaint', 15:45:00 INFO - 'sessionrestore', 15:45:00 INFO - 'sessionrestore_no_auto_restore', 15:45:00 INFO - 'tabpaint']}, 15:45:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['a11yr', 15:45:00 INFO - 'ts_paint', 15:45:00 INFO - 'tpaint', 15:45:00 INFO - 'sessionrestore', 15:45:00 INFO - 'sessionrestore_no_auto_restore', 15:45:00 INFO - 'tabpaint']}, 15:45:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['tsvgx', 15:45:00 INFO - 'tsvgr_opacity', 15:45:00 INFO - 'tart', 15:45:00 INFO - 'tscrollx', 15:45:00 INFO - 'cart']}, 15:45:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:45:00 INFO - 'tsvgr_opacity', 15:45:00 INFO - 'tart', 15:45:00 INFO - 'tscrollx', 15:45:00 INFO - 'cart']}, 15:45:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:00 INFO - 'talos_options': ['--disable-e10s'], 15:45:00 INFO - 'tests': ['tp5o']}, 15:45:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:00 INFO - 'tests': ['tp5o']}, 15:45:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:00 INFO - 'talos_options': ['--disable-e10s', 15:45:00 INFO - '--xperf_path', 15:45:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:00 INFO - 'tests': ['tp5n']}, 15:45:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:00 INFO - 'talos_options': ['--xperf_path', 15:45:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:00 INFO - 'tests': ['tp5n']}}, 15:45:00 INFO - 'talos.zip': {'path': '', 15:45:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:45:00 INFO - Running post-action listener: _resource_record_post_action 15:45:00 INFO - [mozharness: 2017-02-17 23:45:00.433209Z] Finished populate-webroot step (success) 15:45:00 INFO - [mozharness: 2017-02-17 23:45:00.433312Z] Running create-virtualenv step. 15:45:00 INFO - Running pre-action listener: _resource_record_pre_action 15:45:00 INFO - Running main action method: create_virtualenv 15:45:00 INFO - Creating virtualenv /builds/slave/test/build/venv 15:45:00 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 15:45:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:45:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:45:00 INFO - Using real prefix '/tools/python27' 15:45:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:45:01 INFO - Installing distribute.............................................................................................................................................................................................done. 15:45:04 INFO - Installing pip.................done. 15:45:04 INFO - Return code: 0 15:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:45:04 INFO - Reading from file tmpfile_stdout 15:45:04 INFO - Output received: 15:45:04 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) 15:45:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:45:04 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')]} 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 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')]} 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 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 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:04 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 15:45:04 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 15:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:04 INFO - 'HOME': '/Users/cltbld', 15:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:04 INFO - 'LOGNAME': 'cltbld', 15:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:04 INFO - 'MOZ_NO_REMOTE': '1', 15:45:04 INFO - 'NO_EM_RESTART': '1', 15:45:04 INFO - 'PAGER': '/bin/cat', 15:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:04 INFO - 'PWD': '/builds/slave/test', 15:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:04 INFO - 'SHELL': '/bin/bash', 15:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:04 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:04 INFO - 'USER': 'cltbld', 15:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:04 INFO - 'XPC_FLAGS': '0x0', 15:45:04 INFO - 'XPC_SERVICE_NAME': '0', 15:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:04 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 15:45:04 INFO - Cleaning up... 15:45:04 INFO - Return code: 0 15:45:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:45:04 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')]} 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 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')]} 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 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 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:04 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 15:45:04 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 15:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:04 INFO - 'HOME': '/Users/cltbld', 15:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:04 INFO - 'LOGNAME': 'cltbld', 15:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:04 INFO - 'MOZ_NO_REMOTE': '1', 15:45:04 INFO - 'NO_EM_RESTART': '1', 15:45:04 INFO - 'PAGER': '/bin/cat', 15:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:04 INFO - 'PWD': '/builds/slave/test', 15:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:04 INFO - 'SHELL': '/bin/bash', 15:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:04 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:04 INFO - 'USER': 'cltbld', 15:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:04 INFO - 'XPC_FLAGS': '0x0', 15:45:04 INFO - 'XPC_SERVICE_NAME': '0', 15:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:05 INFO - Downloading/unpacking psutil>=3.1.1 15:45:05 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 15:45:05 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 15:45:05 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 15:45:05 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 15:45:05 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 15:45:05 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 15:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:45:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:08 INFO - Installing collected packages: psutil 15:45:08 INFO - Running setup.py install for psutil 15:45:08 INFO - building 'psutil._psutil_osx' extension 15:45:08 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 15:45:08 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 15:45:08 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 15:45:08 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 15:45:08 INFO - building 'psutil._psutil_posix' extension 15:45:08 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 15:45:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:45:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:45:09 INFO - ^ 15:45:09 INFO - 1 warning generated. 15:45:09 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 15:45:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:09 INFO - Successfully installed psutil 15:45:09 INFO - Cleaning up... 15:45:09 INFO - Return code: 0 15:45:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:45:09 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')]} 15:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:09 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')]} 15:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:09 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 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:09 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 15:45:09 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 15:45:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:09 INFO - 'HOME': '/Users/cltbld', 15:45:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:09 INFO - 'LOGNAME': 'cltbld', 15:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:09 INFO - 'MOZ_NO_REMOTE': '1', 15:45:09 INFO - 'NO_EM_RESTART': '1', 15:45:09 INFO - 'PAGER': '/bin/cat', 15:45:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:09 INFO - 'PWD': '/builds/slave/test', 15:45:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:09 INFO - 'SHELL': '/bin/bash', 15:45:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:09 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:09 INFO - 'USER': 'cltbld', 15:45:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:09 INFO - 'XPC_FLAGS': '0x0', 15:45:09 INFO - 'XPC_SERVICE_NAME': '0', 15:45:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:45:09 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 15:45:09 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 15:45:09 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 15:45:09 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 15:45:09 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 15:45:09 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 15:45:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:45:12 INFO - Installing collected packages: mozsystemmonitor 15:45:12 INFO - Running setup.py install for mozsystemmonitor 15:45:12 INFO - Successfully installed mozsystemmonitor 15:45:12 INFO - Cleaning up... 15:45:12 INFO - Return code: 0 15:45:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:12 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 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:12 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 15:45:12 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 15:45:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:12 INFO - 'HOME': '/Users/cltbld', 15:45:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:12 INFO - 'LOGNAME': 'cltbld', 15:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:12 INFO - 'MOZ_NO_REMOTE': '1', 15:45:12 INFO - 'NO_EM_RESTART': '1', 15:45:12 INFO - 'PAGER': '/bin/cat', 15:45:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:12 INFO - 'PWD': '/builds/slave/test', 15:45:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:12 INFO - 'SHELL': '/bin/bash', 15:45:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:12 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:12 INFO - 'USER': 'cltbld', 15:45:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:12 INFO - 'XPC_FLAGS': '0x0', 15:45:12 INFO - 'XPC_SERVICE_NAME': '0', 15:45:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:12 INFO - Downloading/unpacking jsonschema==2.5.1 15:45:12 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 15:45:12 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 15:45:12 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 15:45:12 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 15:45:12 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 15:45:12 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 15:45:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:45:15 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 15:45:15 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 15:45:15 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 15:45:15 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 15:45:15 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 15:45:15 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 15:45:15 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:16 INFO - warning: no files found matching '*.txt' 15:45:16 INFO - no previously-included directories found matching 'build' 15:45:16 INFO - no previously-included directories found matching 'dist' 15:45:16 INFO - no previously-included directories found matching '.git*' 15:45:16 INFO - Installing collected packages: jsonschema, functools32 15:45:16 INFO - Running setup.py install for functools32 15:45:16 INFO - warning: no files found matching '*.txt' 15:45:16 INFO - no previously-included directories found matching 'build' 15:45:16 INFO - no previously-included directories found matching 'dist' 15:45:16 INFO - no previously-included directories found matching '.git*' 15:45:16 INFO - Successfully installed jsonschema functools32 15:45:16 INFO - Cleaning up... 15:45:16 INFO - Return code: 0 15:45:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:45:16 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')]} 15:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:16 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')]} 15:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:16 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 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:16 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 15:45:16 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 15:45:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:16 INFO - 'HOME': '/Users/cltbld', 15:45:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:16 INFO - 'LOGNAME': 'cltbld', 15:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:16 INFO - 'MOZ_NO_REMOTE': '1', 15:45:16 INFO - 'NO_EM_RESTART': '1', 15:45:16 INFO - 'PAGER': '/bin/cat', 15:45:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:16 INFO - 'PWD': '/builds/slave/test', 15:45:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:16 INFO - 'SHELL': '/bin/bash', 15:45:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:16 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:16 INFO - 'USER': 'cltbld', 15:45:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:16 INFO - 'XPC_FLAGS': '0x0', 15:45:16 INFO - 'XPC_SERVICE_NAME': '0', 15:45:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:45:16 INFO - Cleaning up... 15:45:16 INFO - Return code: 0 15:45:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:45:16 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')]} 15:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:16 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')]} 15:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:16 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 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:16 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 15:45:16 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 15:45:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:16 INFO - 'HOME': '/Users/cltbld', 15:45:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:16 INFO - 'LOGNAME': 'cltbld', 15:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:16 INFO - 'MOZ_NO_REMOTE': '1', 15:45:16 INFO - 'NO_EM_RESTART': '1', 15:45:16 INFO - 'PAGER': '/bin/cat', 15:45:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:16 INFO - 'PWD': '/builds/slave/test', 15:45:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:16 INFO - 'SHELL': '/bin/bash', 15:45:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:16 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:16 INFO - 'USER': 'cltbld', 15:45:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:16 INFO - 'XPC_FLAGS': '0x0', 15:45:16 INFO - 'XPC_SERVICE_NAME': '0', 15:45:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:16 INFO - Downloading/unpacking blobuploader==1.2.4 15:45:16 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 15:45:16 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 15:45:16 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 15:45:16 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 15:45:16 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 15:45:16 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 15:45:19 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:45:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:20 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 15:45:20 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 15:45:20 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 15:45:20 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 15:45:20 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 15:45:20 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 15:45:20 INFO - Downloading docopt-0.6.1.tar.gz 15:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:20 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:20 INFO - Running setup.py install for blobuploader 15:45:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:45:21 INFO - Running setup.py install for requests 15:45:21 INFO - Running setup.py install for docopt 15:45:21 INFO - Successfully installed blobuploader requests docopt 15:45:21 INFO - Cleaning up... 15:45:21 INFO - Return code: 0 15:45:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:21 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 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:21 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 15:45:21 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 15:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:21 INFO - 'HOME': '/Users/cltbld', 15:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:21 INFO - 'LOGNAME': 'cltbld', 15:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:21 INFO - 'MOZ_NO_REMOTE': '1', 15:45:21 INFO - 'NO_EM_RESTART': '1', 15:45:21 INFO - 'PAGER': '/bin/cat', 15:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:21 INFO - 'PWD': '/builds/slave/test', 15:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:21 INFO - 'SHELL': '/bin/bash', 15:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:21 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:21 INFO - 'USER': 'cltbld', 15:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:21 INFO - 'XPC_FLAGS': '0x0', 15:45:21 INFO - 'XPC_SERVICE_NAME': '0', 15:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-5cYfg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-cTp82Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-f6Sm93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-NYEhXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-ULEgzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Sf94IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-DZlIF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-ct_3yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-_oOyOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:22 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-LISEy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:23 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-68O4C6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:23 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-TWchkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:23 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-378by5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:23 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-3BQ1Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:23 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-p40epS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:23 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-4wGM2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:23 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-mfWWxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:45:23 INFO - Running setup.py install for manifestparser 15:45:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:45:23 INFO - Running setup.py install for mozcrash 15:45:24 INFO - Running setup.py install for mozdebug 15:45:24 INFO - Running setup.py install for mozdevice 15:45:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:45:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:45:24 INFO - Running setup.py install for mozfile 15:45:24 INFO - Running setup.py install for mozhttpd 15:45:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:45:24 INFO - Running setup.py install for mozinfo 15:45:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:45:24 INFO - Running setup.py install for mozInstall 15:45:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:45:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:45:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:45:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:45:25 INFO - Running setup.py install for mozleak 15:45:25 INFO - Running setup.py install for mozlog 15:45:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:45:25 INFO - Running setup.py install for moznetwork 15:45:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:45:25 INFO - Running setup.py install for mozprocess 15:45:25 INFO - Running setup.py install for mozprofile 15:45:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:45:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:45:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:45:25 INFO - Running setup.py install for mozrunner 15:45:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:45:26 INFO - Running setup.py install for mozscreenshot 15:45:26 INFO - Running setup.py install for moztest 15:45:26 INFO - Running setup.py install for mozversion 15:45:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:45:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:26 INFO - Cleaning up... 15:45:26 INFO - Return code: 0 15:45:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:26 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')]} 15:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:26 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')]} 15:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:26 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 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:26 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 15:45:26 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 15:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:26 INFO - 'HOME': '/Users/cltbld', 15:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:26 INFO - 'LOGNAME': 'cltbld', 15:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:26 INFO - 'MOZ_NO_REMOTE': '1', 15:45:26 INFO - 'NO_EM_RESTART': '1', 15:45:26 INFO - 'PAGER': '/bin/cat', 15:45:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:26 INFO - 'PWD': '/builds/slave/test', 15:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:26 INFO - 'SHELL': '/bin/bash', 15:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:26 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:26 INFO - 'USER': 'cltbld', 15:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:26 INFO - 'XPC_FLAGS': '0x0', 15:45:26 INFO - 'XPC_SERVICE_NAME': '0', 15:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:26 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-aB79HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:26 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)) 15:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:26 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-GeBDs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:26 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)) 15:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:26 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-8h88jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:27 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)) 15:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:27 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-o6YFRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:27 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-cfngNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:27 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)) 15:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:27 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-ZdTn4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:27 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)) 15:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:27 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-dQyV2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:27 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)) 15:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:27 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-GP8HQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:27 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)) 15:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:27 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-OqBVBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:27 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)) 15:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:27 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-gWT744-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:27 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)) 15:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:27 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-2nKXOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:27 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)) 15:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:27 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-ZaS0C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:28 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-1cvzTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:28 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-3nFbRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:28 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-W0e7vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:28 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Z_LApj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:28 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Wosdrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:28 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)) 15:45:28 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)) 15:45:28 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)) 15:45:28 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)) 15:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:45:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:31 INFO - Downloading blessings-1.6.tar.gz 15:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:31 INFO - Installing collected packages: blessings 15:45:31 INFO - Running setup.py install for blessings 15:45:31 INFO - Successfully installed blessings 15:45:31 INFO - Cleaning up... 15:45:31 INFO - Return code: 0 15:45:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:45:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:31 INFO - Reading from file tmpfile_stdout 15:45:31 INFO - Current package versions: 15:45:31 INFO - blessings == 1.6 15:45:31 INFO - blobuploader == 1.2.4 15:45:31 INFO - docopt == 0.6.1 15:45:31 INFO - functools32 == 3.2.3-2 15:45:31 INFO - jsonschema == 2.5.1 15:45:31 INFO - manifestparser == 1.1 15:45:31 INFO - mozInstall == 1.12 15:45:31 INFO - mozcrash == 1.0 15:45:31 INFO - mozdebug == 0.1 15:45:31 INFO - mozdevice == 0.48 15:45:31 INFO - mozfile == 1.2 15:45:31 INFO - mozhttpd == 0.7 15:45:31 INFO - mozinfo == 0.9 15:45:31 INFO - mozleak == 0.1 15:45:31 INFO - mozlog == 3.4 15:45:31 INFO - moznetwork == 0.27 15:45:31 INFO - mozprocess == 0.23 15:45:31 INFO - mozprofile == 0.28 15:45:31 INFO - mozrunner == 6.13 15:45:31 INFO - mozscreenshot == 0.1 15:45:31 INFO - mozsystemmonitor == 0.3 15:45:31 INFO - moztest == 0.8 15:45:31 INFO - mozversion == 1.4 15:45:31 INFO - psutil == 3.1.1 15:45:31 INFO - requests == 1.2.3 15:45:31 INFO - wsgiref == 0.1.2 15:45:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45: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')]} 15:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45: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')]} 15:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:32 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 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:32 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 15:45:32 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 15:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:32 INFO - 'HOME': '/Users/cltbld', 15:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:32 INFO - 'LOGNAME': 'cltbld', 15:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:32 INFO - 'MOZ_NO_REMOTE': '1', 15:45:32 INFO - 'NO_EM_RESTART': '1', 15:45:32 INFO - 'PAGER': '/bin/cat', 15:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:32 INFO - 'PWD': '/builds/slave/test', 15:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:32 INFO - 'SHELL': '/bin/bash', 15:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:32 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:32 INFO - 'USER': 'cltbld', 15:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:32 INFO - 'XPC_FLAGS': '0x0', 15:45:32 INFO - 'XPC_SERVICE_NAME': '0', 15:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 INFO - Cleaning up... 15:45:32 INFO - Return code: 0 15:45:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:45:32 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')]} 15:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:32 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')]} 15:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1083bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108333570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b8d96010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, '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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 15:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:32 INFO - 'HOME': '/Users/cltbld', 15:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:32 INFO - 'LOGNAME': 'cltbld', 15:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:32 INFO - 'MOZ_NO_REMOTE': '1', 15:45:32 INFO - 'NO_EM_RESTART': '1', 15:45:32 INFO - 'PAGER': '/bin/cat', 15:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:32 INFO - 'PWD': '/builds/slave/test', 15:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:32 INFO - 'SHELL': '/bin/bash', 15:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:32 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:32 INFO - 'USER': 'cltbld', 15:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:32 INFO - 'XPC_FLAGS': '0x0', 15:45:32 INFO - 'XPC_SERVICE_NAME': '0', 15:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:45:33 INFO - Cleaning up... 15:45:33 INFO - Return code: 0 15:45:33 INFO - Running post-action listener: _resource_record_post_action 15:45:33 INFO - Running post-action listener: _start_resource_monitoring 15:45:33 INFO - Starting resource monitoring. 15:45:33 INFO - [mozharness: 2017-02-17 23:45:33.262417Z] Finished create-virtualenv step (success) 15:45:33 INFO - [mozharness: 2017-02-17 23:45:33.263520Z] Running install step. 15:45:33 INFO - Running pre-action listener: _resource_record_pre_action 15:45:33 INFO - Running main action method: install 15:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:33 INFO - Reading from file tmpfile_stdout 15:45:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:45:33 INFO - Reading from file tmpfile_stdout 15:45:33 INFO - Output received: 15:45:33 INFO - Usage: mozinstall [options] installer 15:45:33 INFO - Options: 15:45:33 INFO - -h, --help show this help message and exit 15:45:33 INFO - -d DEST, --destination=DEST 15:45:33 INFO - Directory to install application into. [default: 15:45:33 INFO - "/builds/slave/test"] 15:45:33 INFO - --app=APP Application being installed. [default: firefox] 15:45:33 INFO - mkdir: /builds/slave/test/build/application 15:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:45:54 INFO - Reading from file tmpfile_stdout 15:45:54 INFO - Output received: 15:45:54 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:45:54 INFO - Running post-action listener: _resource_record_post_action 15:45:54 INFO - [mozharness: 2017-02-17 23:45:54.975321Z] Finished install step (success) 15:45:54 INFO - [mozharness: 2017-02-17 23:45:54.975465Z] Running run-tests step. 15:45:54 INFO - Running pre-action listener: _resource_record_pre_action 15:45:54 INFO - Running main action method: run_tests 15:45:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:45:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:45:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:45:54 INFO - 2017-02-17 15:45:54.990 screenresolution[2814:36346] starting screenresolution argv=screenresolution get 15:45:54 INFO - 2017-02-17 15:45:54.992 screenresolution[2814:36346] Display 0: 1600x1200x32@60 15:45:54 INFO - 2017-02-17 15:45:54.998 screenresolution[2815:36348] starting screenresolution argv=screenresolution list 15:45:55 INFO - Available Modes on Display 0 15:45:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:45:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:45:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:45:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:45:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:45:55 INFO - Intel Iris: 15:45:55 INFO - Chipset Model: Intel Iris 15:45:55 INFO - Type: GPU 15:45:55 INFO - Bus: Built-In 15:45:55 INFO - VRAM (Dynamic, Max): 1536 MB 15:45:55 INFO - Vendor: Intel (0x8086) 15:45:55 INFO - Device ID: 0x0a2e 15:45:55 INFO - Revision ID: 0x0009 15:45:55 INFO - Displays: 15:45:55 INFO - Display: 15:45:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:45:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:45:55 INFO - Display Serial Number: 1600x1200 60 15:45:55 INFO - Main Display: Yes 15:45:55 INFO - Mirror: Off 15:45:55 INFO - Online: Yes 15:45:55 INFO - Rotation: Supported 15:45:55 INFO - Return code: 0 15:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:45:55 INFO - Python 2.7.3 15:45:55 INFO - Return code: 0 15:45:55 INFO - grabbing minidump binary from tooltool 15:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:55 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 0x1081d1d30>, '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 0x108037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081c9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:45:55 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 15:45:55 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 15:45:55 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 15:45:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:45:55 INFO - Return code: 0 15:45:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:45:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:45:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:45:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:45:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 15:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0176 --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 15:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0nQPVJYXv/Render', 15:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:55 INFO - 'HOME': '/Users/cltbld', 15:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:55 INFO - 'LOGNAME': 'cltbld', 15:45:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:45:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:55 INFO - 'MOZ_NO_REMOTE': '1', 15:45:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:45:55 INFO - 'NO_EM_RESTART': '1', 15:45:55 INFO - 'PAGER': '/bin/cat', 15:45:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:55 INFO - 'PWD': '/builds/slave/test', 15:45:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:55 INFO - 'SHELL': '/bin/bash', 15:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4kYpfp1IcA/Listeners', 15:45:55 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 15:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:55 INFO - 'USER': 'cltbld', 15:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:55 INFO - 'XPC_FLAGS': '0x0', 15:45:55 INFO - 'XPC_SERVICE_NAME': '0', 15:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 15:45:55 INFO - mozversion application_buildid: 20170217134420 15:45:55 INFO - mozversion application_changeset: 42db8a0b3673b959560b0edc2ac89a44576bddd1 15:45:55 INFO - mozversion application_display_name: Firefox 15:45:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:45:55 INFO - mozversion application_name: Firefox 15:45:55 INFO - mozversion application_remotingname: firefox 15:45:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:45:55 INFO - mozversion application_vendor: Mozilla 15:45:55 INFO - mozversion application_version: 52.0 15:45:55 INFO - mozversion platform_buildid: 20170217134420 15:45:55 INFO - mozversion platform_changeset: 42db8a0b3673b959560b0edc2ac89a44576bddd1 15:45:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:45:55 INFO - mozversion platform_version: 52.0 15:45:55 INFO - using testdate: 1487375155 15:45:55 INFO - actual date: 1487375155 15:45:55 INFO - starting webserver on 'localhost:60471' 15:45:55 INFO - SUITE-START | Running 2 tests 15:45:55 INFO - TEST-START | dromaeo_css 15:45:55 INFO - operating with platform_type : mac_ 15:45:55 INFO - Initialising browser for dromaeo_css test... 15:45:55 INFO - TEST-INFO | started process 2825 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpJewAOn/profile http://localhost:60471/getInfo.html) 15:45:58 INFO - PROCESS | 2825 | __metrics Screen width/height:1600/1200 15:45:58 INFO - PROCESS | 2825 | colorDepth:24 15:45:58 INFO - PROCESS | 2825 | Browser inner width/height: 1024/689 15:45:58 INFO - PROCESS | 2825 | __metrics 15:45:58 INFO - PROCESS | 2825 | 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" 15:45:58 INFO - PROCESS | 2825 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:45:59 INFO - TEST-INFO | 2825: exit 0 15:45:59 INFO - Browser initialized. 15:45:59 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:59 INFO - TEST-INFO | started process 2827 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpJewAOn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:11 INFO - PROCESS | 2827 | RSS: Main: 172224512 15:46:11 INFO - PROCESS | 2827 | 15:49:13 INFO - PROCESS | 2827 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60471/tests/dromaeo/cssquery-ext.html) 15:49:15 INFO - PROCESS | 2827 | RSS: Main: 257953792 15:49:15 INFO - PROCESS | 2827 | 15:52:18 INFO - PROCESS | 2827 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-ext.html (next: http://localhost:60471/tests/dromaeo/cssquery-jquery.html) 15:52:19 INFO - PROCESS | 2827 | RSS: Main: 303357952 15:52:19 INFO - PROCESS | 2827 | 15:55:21 INFO - PROCESS | 2827 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60471/tests/dromaeo/cssquery-mootools.html) 15:55:22 INFO - PROCESS | 2827 | RSS: Main: 270094336 15:55:22 INFO - PROCESS | 2827 | 15:58:24 INFO - PROCESS | 2827 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60471/tests/dromaeo/cssquery-prototype.html) 15:58:25 INFO - PROCESS | 2827 | RSS: Main: 262504448 15:58:25 INFO - PROCESS | 2827 | 16:01:28 INFO - PROCESS | 2827 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60471/tests/dromaeo/cssquery-yui.html) 16:01:29 INFO - PROCESS | 2827 | RSS: Main: 261644288 16:01:29 INFO - PROCESS | 2827 | 16:04:32 INFO - PROCESS | 2827 | Cycle 1(1): loaded http://localhost:60471/tests/dromaeo/cssquery-yui.html (next: http://localhost:60471/tests/dromaeo/cssquery-dojo.html) 16:04:33 INFO - PROCESS | 2827 | RSS: Main: 306425856 16:04:33 INFO - PROCESS | 2827 | 16:04:33 INFO - PROCESS | 2827 | __start_tp_report 16:04:33 INFO - PROCESS | 2827 | _x_x_mozilla_page_load 16:04:33 INFO - PROCESS | 2827 | _x_x_mozilla_page_load_details 16:04:33 INFO - PROCESS | 2827 | |i|pagename|runs| 16:04:33 INFO - PROCESS | 2827 | |0;dojo.html;3368.6968172864445;3369.0566641340424;3371.7302615790722;3379.2565635560168;3432.3478539077587;5523.1163013917785;5577.498025177733;5578.386377498472;5581.134924086763;5586.525145362649;5613.214150019001;5667.263255776754;5681.034224181889;5694.088945768678;5699.173619825123;5110.6422550421485;5124.359455068116;5128.8461346159675;5150.356205474316;5177.637565370425;5080.41575218849;5091.312672789163;5091.389033316007;5171;5225.320708307915;5184.429712731597;5198.350206224222;5200.505951934579;5204.583633309345;5210.426853046162;5108.131617625013;5136.922946155811;5155.226715992593;5159;5168.250603662448;4810.759462026919;5102.489751024905;5150.407703114115;5152.862646450025;5155.40712818027;5680.829575112712;5731.570132240098;5788.710564471759;5794.333651630074;5818.679972601505;6019.277686677583;6074.696265186723;6083.543734219951;6114.449699527019;6140.0789881517685;6171.981623032194;6206.379362063803;6228;6237.126802247689;6288.685565721696;5735.856603584902;5740.311162660508;5750.741216645261;5754.5971781975695;5795.507381872546;6156.261248650101;6213.565050446516;6230.283517395467;6296;6304.590201636879;6034.974054410761;6080.558673151266;6107.317848872468;6115.270764408881;6141.508679305645;5194.68831870089;6180.536459765535;6233.34549872266;6237.095621135;6239.500839932794;5980.252468441445;6043.456088952015;6071.635701857903;6089.208402907594;6106.900578982698;6113.789106610777;6114.9694251529345;6169.537284703665;6176.629402235881;6186.783462578788;4902.460729319772;4912.680675756064;4914.459409464956;4915.827946021872;4939.777710003059;4331.177076355545;4378.956210437918;4407.515173330931;4426.247537918562;4429.800658970354;4801.4958429365115;5705.800296989585;5756.1653560233535;5776.249087618583;5883.264591926009;6232.220972378453;6243.43809057187;6252.3122456529745;6260.060990851318;6274.937250627527;5822.621529600562;5830.679312637761;5844.970775146097;5852.795152169739;5894.911576326359;4291.442112525414;5223.843284701465;5309.681419114865;5337.919931201035;5340.813071542478;6248.875022499616;6285.842853928597;6297.338779428094;6297.370262973666;6299.559030867796;6257.843553911007;6260.186175797117;6260.499160067093;6289.685515724287;6295.905561416491;6110.358412366638;6173.166622505904;6174.25908890918;6191.504679625709;6240.5319601031015;6163.3836616338;6174.783882564088;6175.783847565313;6181.103739957591;6186.536009799193;6217.720202590985;6246.718897649525;6259.96870015647;6263.3736626337;6270.341614130451;5849.356570777126;5916.911246331395;5920.052791553331;5977.22296101504;5992;5997.160397544434;6049.818505444844;6069.817905462844;6071.514278857592;6088.817335479943;5829.213056237523;5881.500072493886;5889.705514724161;5907.586468947133;5958.463738263404;4955.2567114933045;5846.123081537803;5893.145493903446;5910.704464776658;5956;5841.795537156179;5860;5867.882642347215;5872.1778950946045;5917.615355001911 16:04:33 INFO - PROCESS | 2827 | |1;ext.html;492.6354497671723;495.45994865596515;538.1174873207939;538.7898719499395;541.5207541325925;31166.532502012487;31868;33117;33177.83411082947;33272.667273327286;33852.32295354091;34604.65395346046;35931.922042338774;41665.16669666612;43127.78436107815;9534.952325238399;9668.419894806299;9669.854952175689;9672.226221902267;9677;9531.80936381272;9631.422114673107;9637.469939153343;9642.2768292378;9655.758606034835;8875.467471951672;9097.090290970917;11450.713732156679;11694.8245776313;11790;11614.709632259177;11674.824877626843;11693.824592631117;11694.122940779476;11705.414729263588;10730.463476826206;10979.737330207048;11627.244229125165;11724.765504689944;11731.296122232694;40261;40590;40747.59252407467;40765.38851917224;40782.77651670454;3198.2484116232667;3299.4390953537954;3358.2611825398617;3652.3425783358985;3947.230290093433;29718.257043573867;29721.55417668737;29793.851030744925;30352.241193970105;30439.847800760854;3098.5048547544984;3216.903492895217;3288.556044933951;3407.557017587698;3410.931781364359;469108;472543;473131.6343418261;474188.629056856;474997;62615;62711.059334110025;62853.371466285666;62926.37073629296;63035.684821575596;61281;61378.69310653507;61397.38602614006;61476;61485.77028459406;17211.741823872653;17472;17487;17489.387871424693;17494.912525437292;13267.469301228035;13353.46586136563;13385.866141338656;13389.464421423228;13407.731845363232;15726.928796268616;16956.406525771537;17327.787054906286;19569.02794077244;19598.02009899528;5417.241586177938;7015.824604384931;7321.487495875344;7842.725609573274;7949.801254968672;806.8305655812228;865.7359505350803;958.3100167879115;1096.8683757949098;1101.6970333158445;29961.550576741367;30036;30086.398272034876;30616.23459413488;30809.075727728203;913.4062859141611;959.5729900194347;979.2117345536911;1111.3165403277087;1166.719987203065;15285.694286114438;15587.454439094578;15587.454439094578;15609.204941431653;15926.840731592767;646040;656020;657091;658211;658443;51945.48054519482;52118;59336;59813.700931495936;60390.39609603935;1368.548379034916;1373.8694823991905;1413.314542446933;1415.8442571317146;1416.242310363971;29921.606271497792;31259.53110703387;31367.05898823039;31463.685363146076;32184.517232241065;52378;52914;52919.47080529299;52987.4701252998;53021.204681930576;569105;580540.6810761603;587757;763668;775569;24574.894129763845;24833;25034.874825625757;25041.499170016134;25098.37254068663;44647.33029004503;45008.77495612501;45532.089358213314;45744.313835293164;46457.07085858197;36385;36951.26097477982;37138.62861371352;38125;38180.590449142575;36727.26545469129;36982.44526332054;37952.62047379491;37976.81011594924;38054.619453805106;36015.0996225086;36459;36828.26343473062;37157.62842371542;37296.81351593225;25581.872090639426;33706;33755;33830.492542612374;33846.81536146223;24571.64855932941;24799.13203037885;25095.49809003846;25671.358216044748;25674.871625641754 16:04:33 INFO - PROCESS | 2827 | |2;jquery.html;384.61346844625143;385.2487649084286;389.53061560819197;394.3001172918071;422.06091446531474;19921.800781992177;20460.59078818423;21068.367948961517;21145.894270528646;21241;20599.485012874648;20641.483962900937;20659.17363305466;20913.790862091373;20923.16307347708;5197.688138711689;5453.945460545393;5921;5975.52195824333;5984.401559844025;5731.14032895067;5950.642961422307;5988.970055149718;6025.216721826157;6043;5860.648361098348;5922.851928701795;5928.584999050068;5929.436703513159;5931.525477961753;5639.943600563983;5889.352171261158;5917.112433135043;5927.585069045147;5932.940670593303;5782.9421705782825;5787.826365209051;5791.82624521265;5794.246747922785;5795.275590551181;13538.390772415265;13692.931535342359;13741.381637826322;13758.65603359914;20471;2220.2673117871063;2443.3647251714506;2464.8521088734556;2729.290384500044;2798.538241190201;9452.621895124186;9847.16299114576;10153.238507111922;10380.532876020598;10454.79090418195;1870.523016630764;1895.6682580548486;1920.1359388275332;1935.129191863667;1951.668216403215;97543.51228243884;111923;113613;116045;116269;11420.486078126503;11516.1362897783;11630.825537616942;11648.184627076193;11806.989217749418;13636.250006249751;14651.706965860623;14700.926495367668;14703.044302120328;14726.926365368105;7946.523208607502;7966.681332746625;8591.226789588967;8616.439931404439;8802.515861627544;8499.065102838806;8509.574521273911;8689.739307820775;8692.087740697036;8708.825823483496;4512.120136573337;4549.112922980054;4557.430321209848;4609.308603709471;4653.255479123324;1921.154691935544;1971.960560788805;1975.9901200493905;1976.1305025788606;1977.6440240756515;856.2892798976834;882.7395918204145;897.9506127163069;971.218169373661;984.5913945712592;20689.689654654892;21608.24371147034;21666.89166554157;21673.566528669337;21708.45728856791;902.120432578244;917.5824999625155;925.2413021322451;942.2838642631649;1017.6082208349691;10553.683389498327;10977.668981365776;11019.889801101886;11119.166062545342;11237.381943992996;610468;621641;625459;628581;629916;75392;117598.41200793942;121230.39384803196;121426;130086.34956825155;905.4748246017294;906.8639704044314;965.5124162297994;973.9123478886934;975.4050029482011;18707.90646046761;19104.8089519103;19300;19382;19464;48521;51323.23015154701;53004.46995529995;53243.81208536798;53570.196447054106;66604.0009399869;74812.62593686997;77123;78199;79266.60366698129;7823.335016523659;7929.484583502054;7978.920210797818;8251.463654862655;8290.963629546306;10738.624148154777;11826.64520064365;12583.622491325275;12838.229706217657;12987.675308116995;10822.945885270523;10840.349579025284;10863;10896.727581810519;11225.775484490428;7563.924360756322;9212;10929.234953553176;11039.116870650489;11187.776244475228;10536.262461627612;10768.569257229623;10960.890391096305;11146;11187.105031597615;6857.417119544894;8065.919340806751;8117.918820811717;8230.506169629842;8334.874791903016;8116.391270654843;9867.358621689567;10114.089731924161;10737.785244294913;11421.428928553372 16:04:33 INFO - PROCESS | 2827 | |3;mootools.html;1287.4978758284267;1522.3606085444112;1638.1809095452275;1830.1398342778905;1871.354382737955;7910.683572657094;8365.58172091396;8365.790855228623;8379.24586787189;8379.790505237364;7441.665125069371;7658.54048757075;7934.960325198366;8136;8190.344772418207;2323.8605683658993;2359.6814430051895;2360.7639236076343;2361.468669549346;2368.834181607288;2343;2375.2043065572966;2388.4028992751814;2389.6893403857475;2395.9880200598973;2302.7466978632337;2306.123673004256;2324.5118525109747;2325.2094287942095;2327.441414060622;2253.7408198057105;2259.29961711869;2285.9771402286096;2290.4159439342943;2291.4844160064017;2345.3550273674878;2362.208660098869;2362.362162216209;2363;2363.4327761337327;8208.753737387888;8274.213949674831;8312.625931833081;8338.541380224146;8359.373047021438;4855.951440485621;4972.502749725035;5125;5125.231215317732;5129.897402051938;3271.775192868848;3336.182635254354;3418.9487157692406;3467.7052450541732;3471.427214509603;1015.7206768138747;1062.7290041039562;1081.691717860414;1092.3336764573603;1098.5550851904911;10619.522121504551;10711.678649640524;10744.409057501834;10752.032317091422;10781.191410644155;4394.428724265825;4542.500324964251;4630.490646028934;4630.606398456169;4683.227267500824;9227.984921658612;9260.305477089245;9266.907330926604;9271.768205794775;9281.39670921388;5171.663841850268;5175.663581867167;5176.275321454999;5177.534021937969;5178.585713142939;3932.4494570760116;4297.376880352332;4387.3857659927635;4734.124187025412;4758.119747846659;3709;3753.155540003477;3830.444585535082;3858.8070596470066;3865.1303456722576;1122.8820973797797;1219.6584956212275;1263.5830176041884;1266.7529831682734;1281.493809945085;806.6934564865313;835.7492752174323;896.9282457403392;901.8456375838937;913.5751875377981;5351.170568561879;5499.175123731392;5617.971910140505;5783.739731712083;5981.252343457068;950.9239260859254;963.0754475703263;986.4475893499663;986.4673076538588;997.8574532160635;3668.4313931340685;3679.8528058877882;3777;3803.752756070902;3826.426036094608;9644.517774111266;9875.160611348116;9896.802063958681;9941.850872236922;9991.400515969066;9305.534723263945;9652.372595781251;9656.37233579815;9850.458224797705;9964.701058968243;7617.961910190525;7837.216278372117;7841.843163136819;7857.685692572348;7895.60521973899;4707;5588.580856435702;5663.178839068394;5755.53955683536;5761.39505351932;9101.453912765255;9129.041450647586;9222.077792220723;9227.400218985744;9275.118863707938;9160.496172710298;9413.529323533932;9440.716778496657;9461.38500997433;9553.713388598353;6556.868862622816;6869.347411995853;7117.181524124792;7172.892406614009;7286.380657644159;7800.726974555863;7922.762317130495;7947.642356093874;7947.84104317922;7953.363730901629;6908.723651053901;7052.576845389088;7080.433565314659;7105.25394833535;7234.6020968847215;6789.355011273921;6961.443084553122;6986.126734158231;6989.685464154024;6990;5526.91709624364;6493.155889734304;6590.143281373391;6603.471722262111;6654.068430419648;4552.157850797613;4577.954220457886;4637.9536204637525;4667.883302917454;4738.407699037621;4652.464966528757;4701.9529804701515;4724.267738500538;4872.853814385574;4916.901661966812 16:04:33 INFO - PROCESS | 2827 | |4;prototype.html;311.6587336866132;316.39726321357807;317.2133109887478;322.29256781364916;324.8343344894103;5065.1389263825195;5090.5164009419095;5125.487451254872;5133.3839939207255;5157.458466860972;4714.0772720913;5009.972955544114;5039.647224694273;5077.441481437048;5102.693838369701;3229.4509933311274;3744.3634582121035;3825.7236944018405;3879.5538513071074;3944.1717239379764;3483.937399093288;3901.609839016104;3903.843846246161;3906.921861562767;3944.5266568011734;3848.6914449087303;3849.749766265184;3885.5531613864487;3899.278633452806;3930.842766289345;3360.3447327771096;3514.6836784689244;3726.6149664214654;3822.522184726909;3888.47505586745;2825.7174282571577;2833.4474777418413;2995.011646156763;3050.6796786337336;3081.6764239754953;4935.975320123376;4961.454240033593;4967.701937883702;4974.353334066548;4974.651774375795;4258.829646814123;4404.757738324391;4431.6233120184825;4444.355588432269;4465.754383508905;5188.766505507261;5259;5265.315508983846;5281.151596941078;5336.959292937879;3095.8886319249236;3323.8005719656658;3629.1108678373703;3768.5854555998817;3772.1889793694486;4976.104301225778;5423.701696406657;5427.701476418795;5527.778888844441;5566.805161819317;3761.3041587306434;3807.6192380761704;3822.3884178531857;3839.404892241707;3845.250176215667;3278.9836050819595;3293.75296852737;3896.473976013202;3918.647321741057;3941.2708648900043;4067.4102255173425;4440.7335559866515;4456.732596044248;4496.886463362214;4505.7296562206375;4541.841035563805;4944.480829512921;5070.299119767402;5224.425313215544;5267.130923397596;1112.4938153140301;1120.5461787975883;1200.2978257719158;1267.1700036476122;1276.3809552367095;849.6134258912303;881.5107615273456;896.1486587741672;898.4025622960658;899.1547944931743;4086.3053280942313;4432.960838014485;4839.943024214695;5004.84985450437;5012.749362531932;4994.451719966822;5344.225087362311;5474.370447398521;5528.102687605228;5535.944640553543;3922.4116382542848;4489.266100848727;4528.69405334108;4825.083234185494;5092.28707980883;2031.6444622191057;2344.812415006795;2367.43181636406;2386.1052105460453;2736.7706106794176;5172.896542069213;5376.462353764592;5399.109146990702;5433.897407457344;5446.564274858002;4099.831548008803;4793.23308270675;5071.163258062452;5082.5349705392855;5265.657732247391;4441.333799929972;4848.702882040247;5298.364196296392;5422.40353561108;5427.538659214011;5156.381234251764;5178.844634660966;5201.011807756514;5227.18978558324;5259.947400525945;3954.426608141861;4130.617076900335;4688.960302268524;4996.625927869864;5126.897462050663;4657.906841863211;4855.684380515255;4942.752862356796;5411.350637923474;5533.012173426305;3053.6106071736863;3123.6407813100877;3518.574977134265;3528.594211665691;3578.2843431314363;4895.853124406273;5078.568321692697;5111.469822437917;5119.590432765295;5130.12787826063;4568.17772800899;4703.38961876162;4747.691400058985;5007.397632757483;5021.610412971157;4784.976075119602;4975.527324904128;4981.227909674007;4985.451600324034;4987.376577927759;4464.799084041291;4845.3216549682365;4909.607231421549;4913.427703134963;4923.409190897115;4829.372181616367;4892.92660610084;5050.898982020412;5095.26118712792;5257.342832145981;4252.957470425256;5231.9536092782355;5286.286351342674;5331.893362132658;5336.759845807026 16:04:33 INFO - PROCESS | 2827 | |5;yui.html;718.9101362329709;729.1723893381013;795.4869109424418;808.7250334886138;810.8621534339162;14670.266486675664;14942.402303907858;15502.457413990513;15558.844411555881;15612.2974466149;14164.433422663082;14200.644983875409;14388.784168237486;14397.424103035866;14414.711705765878;687.7902239816854;700.1982729774405;823.8887750153742;825.6325934958945;852.0159216105408;716.8960500727392;850.3792231670884;872.4590753732695;877.6533269358599;878.9912100878973;917.0829170829171;918.2424499787669;920.0523460835317;920.1626519866923;920.1718453391934;912.447968978765;916.3402350307767;917.8760867282898;918.4489306416164;918.6830543462495;680.1837794646394;681.2676372899103;682.0144890633037;682.2631557917438;682.4267615203204;13855.515056972958;14227.644308892257;14254.501092461818;14258.500952466718;14598.70802583953;14033.508827190999;14319.212443315613;14379.137251764823;14385.85614143866;14503.347349369304;10940.4529773511;11148.331100133937;11434.256773309708;11568;11663.183577149603;4388.341748737683;4471.463424389061;4528.026474308007;4546.909061818778;4585.564371384713;87714.5614271931;92125;93370;93722;94821.52589237079;10396.324238924446;10424.895751042393;10619.203559732896;10672.199585030998;11028.834567481494;20252.392428227176;20610.79389206119;20621.072051757707;20631.071601777956;20692.172313107607;7717.884231736529;7814.921850781533;8098.190180981855;8183.631736571869;8184.099749027602;4403;4415.646748260196;4474.440694913136;4518.819247230074;4630.282306242538;3358.882439114619;3477.2697733475748;3488.389531831919;3495.9825200873834;3501.7548771585743;630.1807650055002;636.2651137935692;664.3223911610131;664.7606861529846;665.6372277108987;553.7729530892315;583.6264790534061;669.2136739331266;676.736072931557;686.3891136888174;7773.805654858561;8658.913410865936;8887.73336799897;8928.866067009;9545.427274363561;606.5450911816138;613.7483631710977;659.8713250916121;682.0281099433288;690.7340673840607;4225.218334608107;4370.781460926941;4550.408446901882;4559.430071241095;4638.188317044571;101363;106039.46980265203;114886.82631456084;115896.42051789687;116903;33121.50317745236;33149.3370132596;44278.77860610676;57860.42139578635;78957;50900.95897339294;77106.22893771103;77409.61295193601;78358.21641783738;78794.60602697065;9233.769155771159;9532.23742100644;9655.517224138624;9871.309008369346;9875;49325.506744933526;52010.479895200566;52454.688632782956;52920.20619690631;53726.92546149133;72241.27758722345;73732;74404.62797685977;74585.62707186646;76124.61937690276;10825.404602746925;11831;12103.818442723543;12270.386480676108;12512.624621261377;13100.410481528545;13848.515301964382;13881.930590346983;14211.218382988622;14608.123512589278;12341.62975110748;13390.464381424634;13728.244946528037;13870.167789932637;13873;12865.292408917225;13297.716227173341;13479.123856949267;13580.864191358356;13862.792058118934;12207.657043736835;12962.092653514164;13112.737745245233;13118.475260989453;13549.25479098659;10143.442110683984;11075.05862001739;11534.302296741109;11556.94221528887;11659.358735269641;10940.39827809478;11137.498812553293;11243.494042767932;11318.886811131782;11356.772864542829 16:04:33 INFO - PROCESS | 2827 | __end_tp_report 16:04:33 INFO - PROCESS | 2827 | __start_cc_report 16:04:33 INFO - PROCESS | 2827 | _x_x_mozilla_cycle_collect,1516 16:04:33 INFO - PROCESS | 2827 | __end_cc_report 16:04:33 INFO - PROCESS | 2827 | __startTimestamp1487376273147__endTimestamp 16:04:33 INFO - PROCESS | 2827 | 16:04:33 INFO - PROCESS | 2827 | ------- Summary: start ------- 16:04:33 INFO - PROCESS | 2827 | Number of tests: 6 16:04:33 INFO - PROCESS | 2827 | 16:04:33 INFO - PROCESS | 2827 | [#0] dojo.html Cycles:165 Average:5679.89 Median:5881.50 stddev:645.09 (11.0%) stddev-sans-first:621.07 16:04:33 INFO - PROCESS | 2827 | Values: 3368.7 3369.1 3371.7 3379.3 3432.3 5523.1 5577.5 5578.4 5581.1 5586.5 5613.2 5667.3 5681.0 5694.1 5699.2 5110.6 5124.4 5128.8 5150.4 5177.6 5080.4 5091.3 5091.4 5171.0 5225.3 5184.4 5198.4 5200.5 5204.6 5210.4 5108.1 5136.9 5155.2 5159.0 5168.3 4810.8 5102.5 5150.4 5152.9 5155.4 5680.8 5731.6 5788.7 5794.3 5818.7 6019.3 6074.7 6083.5 6114.4 6140.1 6172.0 6206.4 6228.0 6237.1 6288.7 5735.9 5740.3 5750.7 5754.6 5795.5 6156.3 6213.6 6230.3 6296.0 6304.6 6035.0 6080.6 6107.3 6115.3 6141.5 5194.7 6180.5 6233.3 6237.1 6239.5 5980.3 6043.5 6071.6 6089.2 6106.9 6113.8 6115.0 6169.5 6176.6 6186.8 4902.5 4912.7 4914.5 4915.8 4939.8 4331.2 4379.0 4407.5 4426.2 4429.8 4801.5 5705.8 5756.2 5776.2 5883.3 6232.2 6243.4 6252.3 6260.1 6274.9 5822.6 5830.7 5845.0 5852.8 5894.9 4291.4 5223.8 5309.7 5337.9 5340.8 6248.9 6285.8 6297.3 6297.4 6299.6 6257.8 6260.2 6260.5 6289.7 6295.9 6110.4 6173.2 6174.3 6191.5 6240.5 6163.4 6174.8 6175.8 6181.1 6186.5 6217.7 6246.7 6260.0 6263.4 6270.3 5849.4 5916.9 5920.1 5977.2 5992.0 5997.2 6049.8 6069.8 6071.5 6088.8 5829.2 5881.5 5889.7 5907.6 5958.5 4955.3 5846.1 5893.1 5910.7 5956.0 5841.8 5860.0 5867.9 5872.2 5917.6 16:04:33 INFO - PROCESS | 2827 | 16:04:33 INFO - PROCESS | 2827 | [#1] ext.html Cycles:180 Average:72051.74 Median:20055.67 stddev:161610.36 (805.8%) stddev-sans-first:161974.41 16:04:33 INFO - PROCESS | 2827 | Values: 492.6 495.5 538.1 538.8 541.5 31166.5 31868.0 33117.0 33177.8 33272.7 33852.3 34604.7 35931.9 41665.2 43127.8 9535.0 9668.4 9669.9 9672.2 9677.0 9531.8 9631.4 9637.5 9642.3 9655.8 8875.5 9097.1 11450.7 11694.8 11790.0 11614.7 11674.8 11693.8 11694.1 11705.4 10730.5 10979.7 11627.2 11724.8 11731.3 40261.0 40590.0 40747.6 40765.4 40782.8 3198.2 3299.4 3358.3 3652.3 3947.2 29718.3 29721.6 29793.9 30352.2 30439.8 3098.5 3216.9 3288.6 3407.6 3410.9 469108.0 472543.0 473131.6 474188.6 474997.0 62615.0 62711.1 62853.4 62926.4 63035.7 61281.0 61378.7 61397.4 61476.0 61485.8 17211.7 17472.0 17487.0 17489.4 17494.9 13267.5 13353.5 13385.9 13389.5 13407.7 15726.9 16956.4 17327.8 19569.0 19598.0 5417.2 7015.8 7321.5 7842.7 7949.8 806.8 865.7 958.3 1096.9 1101.7 29961.6 30036.0 30086.4 30616.2 30809.1 913.4 959.6 979.2 1111.3 1166.7 15285.7 15587.5 15587.5 15609.2 15926.8 646040.0 656020.0 657091.0 658211.0 658443.0 51945.5 52118.0 59336.0 59813.7 60390.4 1368.5 1373.9 1413.3 1415.8 1416.2 29921.6 31259.5 31367.1 31463.7 32184.5 52378.0 52914.0 52919.5 52987.5 53021.2 569105.0 580540.7 587757.0 763668.0 775569.0 24574.9 24833.0 25034.9 25041.5 25098.4 44647.3 45008.8 45532.1 45744.3 46457.1 36385.0 36951.3 37138.6 38125.0 38180.6 36727.3 36982.4 37952.6 37976.8 38054.6 36015.1 36459.0 36828.3 37157.6 37296.8 25581.9 33706.0 33755.0 33830.5 33846.8 24571.6 24799.1 25095.5 25671.4 25674.9 16:04:33 INFO - PROCESS | 2827 | 16:04:33 INFO - PROCESS | 2827 | [#2] jquery.html Cycles:180 Average:34705.18 Median:391.92 stddev:103376.89 (26377.4%) stddev-sans-first:103634.77 16:04:33 INFO - PROCESS | 2827 | Values: 384.6 385.2 389.5 394.3 422.1 19921.8 20460.6 21068.4 21145.9 21241.0 20599.5 20641.5 20659.2 20913.8 20923.2 5197.7 5453.9 5921.0 5975.5 5984.4 5731.1 5950.6 5989.0 6025.2 6043.0 5860.6 5922.9 5928.6 5929.4 5931.5 5639.9 5889.4 5917.1 5927.6 5932.9 5782.9 5787.8 5791.8 5794.2 5795.3 13538.4 13692.9 13741.4 13758.7 20471.0 2220.3 2443.4 2464.9 2729.3 2798.5 9452.6 9847.2 10153.2 10380.5 10454.8 1870.5 1895.7 1920.1 1935.1 1951.7 97543.5 111923.0 113613.0 116045.0 116269.0 11420.5 11516.1 11630.8 11648.2 11807.0 13636.3 14651.7 14700.9 14703.0 14726.9 7946.5 7966.7 8591.2 8616.4 8802.5 8499.1 8509.6 8689.7 8692.1 8708.8 4512.1 4549.1 4557.4 4609.3 4653.3 1921.2 1972.0 1976.0 1976.1 1977.6 856.3 882.7 898.0 971.2 984.6 20689.7 21608.2 21666.9 21673.6 21708.5 902.1 917.6 925.2 942.3 1017.6 10553.7 10977.7 11019.9 11119.2 11237.4 610468.0 621641.0 625459.0 628581.0 629916.0 75392.0 117598.4 121230.4 121426.0 130086.3 905.5 906.9 965.5 973.9 975.4 18707.9 19104.8 19300.0 19382.0 19464.0 48521.0 51323.2 53004.5 53243.8 53570.2 66604.0 74812.6 77123.0 78199.0 79266.6 7823.3 7929.5 7978.9 8251.5 8291.0 10738.6 11826.6 12583.6 12838.2 12987.7 10822.9 10840.3 10863.0 10896.7 11225.8 7563.9 9212.0 10929.2 11039.1 11187.8 10536.3 10768.6 10960.9 11146.0 11187.1 6857.4 8065.9 8117.9 8230.5 8334.9 8116.4 9867.4 10114.1 10737.8 11421.4 16:04:33 INFO - PROCESS | 2827 | 16:04:33 INFO - PROCESS | 2827 | [#3] mootools.html Cycles:180 Average:5385.68 Median:5264.88 stddev:2923.68 (55.5%) stddev-sans-first:2915.66 16:04:33 INFO - PROCESS | 2827 | Values: 1287.5 1522.4 1638.2 1830.1 1871.4 7910.7 8365.6 8365.8 8379.2 8379.8 7441.7 7658.5 7935.0 8136.0 8190.3 2323.9 2359.7 2360.8 2361.5 2368.8 2343.0 2375.2 2388.4 2389.7 2396.0 2302.7 2306.1 2324.5 2325.2 2327.4 2253.7 2259.3 2286.0 2290.4 2291.5 2345.4 2362.2 2362.4 2363.0 2363.4 8208.8 8274.2 8312.6 8338.5 8359.4 4856.0 4972.5 5125.0 5125.2 5129.9 3271.8 3336.2 3418.9 3467.7 3471.4 1015.7 1062.7 1081.7 1092.3 1098.6 10619.5 10711.7 10744.4 10752.0 10781.2 4394.4 4542.5 4630.5 4630.6 4683.2 9228.0 9260.3 9266.9 9271.8 9281.4 5171.7 5175.7 5176.3 5177.5 5178.6 3932.4 4297.4 4387.4 4734.1 4758.1 3709.0 3753.2 3830.4 3858.8 3865.1 1122.9 1219.7 1263.6 1266.8 1281.5 806.7 835.7 896.9 901.8 913.6 5351.2 5499.2 5618.0 5783.7 5981.3 950.9 963.1 986.4 986.5 997.9 3668.4 3679.9 3777.0 3803.8 3826.4 9644.5 9875.2 9896.8 9941.9 9991.4 9305.5 9652.4 9656.4 9850.5 9964.7 7618.0 7837.2 7841.8 7857.7 7895.6 4707.0 5588.6 5663.2 5755.5 5761.4 9101.5 9129.0 9222.1 9227.4 9275.1 9160.5 9413.5 9440.7 9461.4 9553.7 6556.9 6869.3 7117.2 7172.9 7286.4 7800.7 7922.8 7947.6 7947.8 7953.4 6908.7 7052.6 7080.4 7105.3 7234.6 6789.4 6961.4 6986.1 6989.7 6990.0 5526.9 6493.2 6590.1 6603.5 6654.1 4552.2 4578.0 4638.0 4667.9 4738.4 4652.5 4702.0 4724.3 4872.9 4916.9 16:04:33 INFO - PROCESS | 2827 | 16:04:33 INFO - PROCESS | 2827 | [#4] prototype.html Cycles:180 Average:4201.52 Median:4827.23 stddev:1286.57 (26.7%) stddev-sans-first:1256.62 16:04:33 INFO - PROCESS | 2827 | Values: 311.7 316.4 317.2 322.3 324.8 5065.1 5090.5 5125.5 5133.4 5157.5 4714.1 5010.0 5039.6 5077.4 5102.7 3229.5 3744.4 3825.7 3879.6 3944.2 3483.9 3901.6 3903.8 3906.9 3944.5 3848.7 3849.7 3885.6 3899.3 3930.8 3360.3 3514.7 3726.6 3822.5 3888.5 2825.7 2833.4 2995.0 3050.7 3081.7 4936.0 4961.5 4967.7 4974.4 4974.7 4258.8 4404.8 4431.6 4444.4 4465.8 5188.8 5259.0 5265.3 5281.2 5337.0 3095.9 3323.8 3629.1 3768.6 3772.2 4976.1 5423.7 5427.7 5527.8 5566.8 3761.3 3807.6 3822.4 3839.4 3845.3 3279.0 3293.8 3896.5 3918.6 3941.3 4067.4 4440.7 4456.7 4496.9 4505.7 4541.8 4944.5 5070.3 5224.4 5267.1 1112.5 1120.5 1200.3 1267.2 1276.4 849.6 881.5 896.1 898.4 899.2 4086.3 4433.0 4839.9 5004.8 5012.7 4994.5 5344.2 5474.4 5528.1 5535.9 3922.4 4489.3 4528.7 4825.1 5092.3 2031.6 2344.8 2367.4 2386.1 2736.8 5172.9 5376.5 5399.1 5433.9 5446.6 4099.8 4793.2 5071.2 5082.5 5265.7 4441.3 4848.7 5298.4 5422.4 5427.5 5156.4 5178.8 5201.0 5227.2 5259.9 3954.4 4130.6 4689.0 4996.6 5126.9 4657.9 4855.7 4942.8 5411.4 5533.0 3053.6 3123.6 3518.6 3528.6 3578.3 4895.9 5078.6 5111.5 5119.6 5130.1 4568.2 4703.4 4747.7 5007.4 5021.6 4785.0 4975.5 4981.2 4985.5 4987.4 4464.8 4845.3 4909.6 4913.4 4923.4 4829.4 4892.9 5050.9 5095.3 5257.3 4253.0 5232.0 5286.3 5331.9 5336.8 16:04:33 INFO - PROCESS | 2827 | 16:04:33 INFO - PROCESS | 2827 | [#5] yui.html Cycles:180 Average:19182.70 Median:4523.42 stddev:27431.47 (606.4%) stddev-sans-first:27473.39 16:04:33 INFO - PROCESS | 2827 | Values: 718.9 729.2 795.5 808.7 810.9 14670.3 14942.4 15502.5 15558.8 15612.3 14164.4 14200.6 14388.8 14397.4 14414.7 687.8 700.2 823.9 825.6 852.0 716.9 850.4 872.5 877.7 879.0 917.1 918.2 920.1 920.2 920.2 912.4 916.3 917.9 918.4 918.7 680.2 681.3 682.0 682.3 682.4 13855.5 14227.6 14254.5 14258.5 14598.7 14033.5 14319.2 14379.1 14385.9 14503.3 10940.5 11148.3 11434.3 11568.0 11663.2 4388.3 4471.5 4528.0 4546.9 4585.6 87714.6 92125.0 93370.0 93722.0 94821.5 10396.3 10424.9 10619.2 10672.2 11028.8 20252.4 20610.8 20621.1 20631.1 20692.2 7717.9 7814.9 8098.2 8183.6 8184.1 4403.0 4415.6 4474.4 4518.8 4630.3 3358.9 3477.3 3488.4 3496.0 3501.8 630.2 636.3 664.3 664.8 665.6 553.8 583.6 669.2 676.7 686.4 7773.8 8658.9 8887.7 8928.9 9545.4 606.5 613.7 659.9 682.0 690.7 4225.2 4370.8 4550.4 4559.4 4638.2 101363.0 106039.5 114886.8 115896.4 116903.0 33121.5 33149.3 44278.8 57860.4 78957.0 50901.0 77106.2 77409.6 78358.2 78794.6 9233.8 9532.2 9655.5 9871.3 9875.0 49325.5 52010.5 52454.7 52920.2 53726.9 72241.3 73732.0 74404.6 74585.6 76124.6 10825.4 11831.0 12103.8 12270.4 12512.6 13100.4 13848.5 13881.9 14211.2 14608.1 12341.6 13390.5 13728.2 13870.2 13873.0 12865.3 13297.7 13479.1 13580.9 13862.8 12207.7 12962.1 13112.7 13118.5 13549.3 10143.4 11075.1 11534.3 11556.9 11659.4 10940.4 11137.5 11243.5 11318.9 11356.8 16:04:33 INFO - PROCESS | 2827 | -------- Summary: end -------- 16:04:33 INFO - PROCESS | 2827 | 16:04:33 INFO - TEST-INFO | 2827: exit 0 16:04:33 INFO - TEST-OK | dromaeo_css | took 1118182ms 16:04:33 INFO - TEST-START | kraken 16:04:33 INFO - operating with platform_type : mac_ 16:04:33 INFO - Initialising browser for kraken test... 16:04:33 INFO - TEST-INFO | started process 2830 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpAiQ6bu/profile http://localhost:60471/getInfo.html) 16:04:36 INFO - PROCESS | 2830 | __metrics Screen width/height:1600/1200 16:04:36 INFO - PROCESS | 2830 | colorDepth:24 16:04:36 INFO - PROCESS | 2830 | Browser inner width/height: 1024/689 16:04:36 INFO - PROCESS | 2830 | __metrics 16:04:36 INFO - PROCESS | 2830 | 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" 16:04:36 INFO - PROCESS | 2830 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:37 INFO - TEST-INFO | 2830: exit 0 16:04:37 INFO - Browser initialized. 16:04:37 INFO - Running cycle 1/1 for kraken test... 16:04:37 INFO - TEST-INFO | started process 2832 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpAiQ6bu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:49 INFO - PROCESS | 2832 | RSS: Main: 172642304 16:04:49 INFO - PROCESS | 2832 | 16:04:51 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60471/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:52 INFO - PROCESS | 2832 | RSS: Main: 222486528 16:04:52 INFO - PROCESS | 2832 | 16:04:55 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60471/tests/kraken/driver.html?testName=audio-dft) 16:04:56 INFO - PROCESS | 2832 | RSS: Main: 234483712 16:04:56 INFO - PROCESS | 2832 | 16:04:59 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60471/tests/kraken/driver.html?testName=audio-fft) 16:04:59 INFO - PROCESS | 2832 | RSS: Main: 333492224 16:04:59 INFO - PROCESS | 2832 | 16:05:01 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60471/tests/kraken/driver.html?testName=audio-oscillator) 16:05:02 INFO - PROCESS | 2832 | RSS: Main: 234672128 16:05:02 INFO - PROCESS | 2832 | 16:05:04 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:05:05 INFO - PROCESS | 2832 | RSS: Main: 236081152 16:05:05 INFO - PROCESS | 2832 | 16:05:07 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60471/tests/kraken/driver.html?testName=imaging-darkroom) 16:05:08 INFO - PROCESS | 2832 | RSS: Main: 275877888 16:05:08 INFO - PROCESS | 2832 | 16:05:11 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60471/tests/kraken/driver.html?testName=imaging-desaturate) 16:05:11 INFO - PROCESS | 2832 | RSS: Main: 276545536 16:05:11 INFO - PROCESS | 2832 | 16:05:14 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60471/tests/kraken/driver.html?testName=json-parse-financial) 16:05:15 INFO - PROCESS | 2832 | RSS: Main: 275939328 16:05:15 INFO - PROCESS | 2832 | 16:05:16 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:05:17 INFO - PROCESS | 2832 | RSS: Main: 249290752 16:05:17 INFO - PROCESS | 2832 | 16:05:19 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:05:19 INFO - PROCESS | 2832 | RSS: Main: 253456384 16:05:19 INFO - PROCESS | 2832 | 16:05:21 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:05:22 INFO - PROCESS | 2832 | RSS: Main: 255897600 16:05:22 INFO - PROCESS | 2832 | 16:05:25 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:05:26 INFO - PROCESS | 2832 | RSS: Main: 267075584 16:05:26 INFO - PROCESS | 2832 | 16:05:28 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:29 INFO - PROCESS | 2832 | RSS: Main: 267202560 16:05:29 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | Cycle 1(1): loaded http://localhost:60471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60471/tests/kraken/driver.html?testName=ai-astar) 16:05:31 INFO - PROCESS | 2832 | RSS: Main: 310984704 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | __start_tp_report 16:05:31 INFO - PROCESS | 2832 | _x_x_mozilla_page_load 16:05:31 INFO - PROCESS | 2832 | _x_x_mozilla_page_load_details 16:05:31 INFO - PROCESS | 2832 | |i|pagename|runs| 16:05:31 INFO - PROCESS | 2832 | |0;ai-astar;115;115;116;114;116;115;115;115;115;116 16:05:31 INFO - PROCESS | 2832 | |1;audio-beat-detection;151;108;107;145;134;137;107;119;147;134 16:05:31 INFO - PROCESS | 2832 | |2;audio-dft;198;184;187;185;183;183;185;184;184;185 16:05:31 INFO - PROCESS | 2832 | |3;audio-fft;79;69;60;90;63;58;58;58;82;58 16:05:31 INFO - PROCESS | 2832 | |4;audio-oscillator;83;70;94;72;70;68;88;67;69;91 16:05:31 INFO - PROCESS | 2832 | |5;imaging-gaussian-blur;87;84;86;83;87;84;86;83;86;83 16:05:31 INFO - PROCESS | 2832 | |6;imaging-darkroom;94;95;95;96;97;95;96;95;94;94 16:05:31 INFO - PROCESS | 2832 | |7;imaging-desaturate;85;81;83;129;85;82;82;83;81;85 16:05:31 INFO - PROCESS | 2832 | |8;json-parse-financial;55;54;53;53;56;56;58;57;58;56 16:05:31 INFO - PROCESS | 2832 | |9;json-stringify-tinderbox;63;72;79;75;69;72;68;69;70;69 16:05:31 INFO - PROCESS | 2832 | |10;stanford-crypto-aes;84;82;83;83;83;82;83;82;82;84 16:05:31 INFO - PROCESS | 2832 | |11;stanford-crypto-ccm;140;138;136;137;137;143;148;153;177;150 16:05:31 INFO - PROCESS | 2832 | |12;stanford-crypto-pbkdf2;169;162;163;163;163;161;163;161;161;159 16:05:31 INFO - PROCESS | 2832 | |13;stanford-crypto-sha256-iterative;67;66;68;65;65;64;66;65;64;66 16:05:31 INFO - PROCESS | 2832 | __end_tp_report 16:05:31 INFO - PROCESS | 2832 | __start_cc_report 16:05:31 INFO - PROCESS | 2832 | _x_x_mozilla_cycle_collect,1915 16:05:31 INFO - PROCESS | 2832 | __end_cc_report 16:05:31 INFO - PROCESS | 2832 | __startTimestamp1487376331440__endTimestamp 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | ------- Summary: start ------- 16:05:31 INFO - PROCESS | 2832 | Number of tests: 14 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 16:05:31 INFO - PROCESS | 2832 | Values: 115.0 115.0 116.0 114.0 116.0 115.0 115.0 115.0 115.0 116.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:135.50 stddev:17.28 (12.8%) stddev-sans-first:16.37 16:05:31 INFO - PROCESS | 2832 | Values: 151.0 108.0 107.0 145.0 134.0 137.0 107.0 119.0 147.0 134.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#2] audio-dft Cycles:10 Average:185.80 Median:185.00 stddev:4.44 (2.4%) stddev-sans-first:1.24 16:05:31 INFO - PROCESS | 2832 | Values: 198.0 184.0 187.0 185.0 183.0 183.0 185.0 184.0 184.0 185.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#3] audio-fft Cycles:10 Average:67.50 Median:66.00 stddev:11.97 (18.1%) stddev-sans-first:11.95 16:05:31 INFO - PROCESS | 2832 | Values: 79.0 69.0 60.0 90.0 63.0 58.0 58.0 58.0 82.0 58.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.50 stddev:10.59 (13.7%) stddev-sans-first:11.02 16:05:31 INFO - PROCESS | 2832 | Values: 83.0 70.0 94.0 72.0 70.0 68.0 88.0 67.0 69.0 91.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.58 16:05:31 INFO - PROCESS | 2832 | Values: 87.0 84.0 86.0 83.0 87.0 84.0 86.0 83.0 86.0 83.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.00 stddev:0.99 (1.0%) stddev-sans-first:0.97 16:05:31 INFO - PROCESS | 2832 | Values: 94.0 95.0 95.0 96.0 97.0 95.0 96.0 95.0 94.0 94.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#7] imaging-desaturate Cycles:10 Average:87.60 Median:83.00 stddev:14.63 (17.6%) stddev-sans-first:15.49 16:05:31 INFO - PROCESS | 2832 | Values: 85.0 81.0 83.0 129.0 85.0 82.0 82.0 83.0 81.0 85.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.84 (3.3%) stddev-sans-first:1.94 16:05:31 INFO - PROCESS | 2832 | Values: 55.0 54.0 53.0 53.0 56.0 56.0 58.0 57.0 58.0 56.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:4.30 (6.1%) stddev-sans-first:3.57 16:05:31 INFO - PROCESS | 2832 | Values: 63.0 72.0 79.0 75.0 69.0 72.0 68.0 69.0 70.0 69.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.79 (1.0%) stddev-sans-first:0.71 16:05:31 INFO - PROCESS | 2832 | Values: 84.0 82.0 83.0 83.0 83.0 82.0 83.0 82.0 82.0 84.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:145.50 stddev:12.48 (8.6%) stddev-sans-first:13.05 16:05:31 INFO - PROCESS | 2832 | Values: 140.0 138.0 136.0 137.0 137.0 143.0 148.0 153.0 177.0 150.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.00 stddev:2.64 (1.6%) stddev-sans-first:1.39 16:05:31 INFO - PROCESS | 2832 | Values: 169.0 162.0 163.0 163.0 163.0 161.0 163.0 161.0 161.0 159.0 16:05:31 INFO - PROCESS | 2832 | 16:05:31 INFO - PROCESS | 2832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 16:05:31 INFO - PROCESS | 2832 | Values: 67.0 66.0 68.0 65.0 65.0 64.0 66.0 65.0 64.0 66.0 16:05:31 INFO - PROCESS | 2832 | -------- Summary: end -------- 16:05:31 INFO - PROCESS | 2832 | 16:05:32 INFO - TEST-INFO | 2832: exit 0 16:05:32 INFO - TEST-OK | kraken | took 58763ms 16:05:32 INFO - SUITE-END | took 1176s 16:05:32 INFO - Completed test suite (00:19:37) 16:05:32 INFO - javascript benchmark 16:05:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.6968172864445, 3369.0566641340424, 3371.7302615790722, 3379.2565635560168, 3432.3478539077587, 5523.1163013917785, 5577.498025177733, 5578.386377498472, 5581.134924086763, 5586.525145362649, 5613.214150019001, 5667.263255776754, 5681.034224181889, 5694.088945768678, 5699.173619825123, 5110.6422550421485, 5124.359455068116, 5128.8461346159675, 5150.356205474316, 5177.637565370425, 5080.41575218849, 5091.312672789163, 5091.389033316007, 5171.0, 5225.320708307915, 5184.429712731597, 5198.350206224222, 5200.505951934579, 5204.583633309345, 5210.426853046162, 5108.131617625013, 5136.922946155811, 5155.226715992593, 5159.0, 5168.250603662448, 4810.759462026919, 5102.489751024905, 5150.407703114115, 5152.862646450025, 5155.40712818027, 5680.829575112712, 5731.570132240098, 5788.710564471759, 5794.333651630074, 5818.679972601505, 6019.277686677583, 6074.696265186723, 6083.543734219951, 6114.449699527019, 6140.0789881517685, 6171.981623032194, 6206.379362063803, 6228.0, 6237.126802247689, 6288.685565721696, 5735.856603584902, 5740.311162660508, 5750.741216645261, 5754.5971781975695, 5795.507381872546, 6156.261248650101, 6213.565050446516, 6230.283517395467, 6296.0, 6304.590201636879, 6034.974054410761, 6080.558673151266, 6107.317848872468, 6115.270764408881, 6141.508679305645, 5194.68831870089, 6180.536459765535, 6233.34549872266, 6237.095621135, 6239.500839932794, 5980.252468441445, 6043.456088952015, 6071.635701857903, 6089.208402907594, 6106.900578982698, 6113.789106610777, 6114.9694251529345, 6169.537284703665, 6176.629402235881, 6186.783462578788, 4902.460729319772, 4912.680675756064, 4914.459409464956, 4915.827946021872, 4939.777710003059, 4331.177076355545, 4378.956210437918, 4407.515173330931, 4426.247537918562, 4429.800658970354, 4801.4958429365115, 5705.800296989585, 5756.1653560233535, 5776.249087618583, 5883.264591926009, 6232.220972378453, 6243.43809057187, 6252.3122456529745, 6260.060990851318, 6274.937250627527, 5822.621529600562, 5830.679312637761, 5844.970775146097, 5852.795152169739, 5894.911576326359, 4291.442112525414, 5223.843284701465, 5309.681419114865, 5337.919931201035, 5340.813071542478, 6248.875022499616, 6285.842853928597, 6297.338779428094, 6297.370262973666, 6299.559030867796, 6257.843553911007, 6260.186175797117, 6260.499160067093, 6289.685515724287, 6295.905561416491, 6110.358412366638, 6173.166622505904, 6174.25908890918, 6191.504679625709, 6240.5319601031015, 6163.3836616338, 6174.783882564088, 6175.783847565313, 6181.103739957591, 6186.536009799193, 6217.720202590985, 6246.718897649525, 6259.96870015647, 6263.3736626337, 6270.341614130451, 5849.356570777126, 5916.911246331395, 5920.052791553331, 5977.22296101504, 5992.0, 5997.160397544434, 6049.818505444844, 6069.817905462844, 6071.514278857592, 6088.817335479943, 5829.213056237523, 5881.500072493886, 5889.705514724161, 5907.586468947133, 5958.463738263404, 4955.2567114933045, 5846.123081537803, 5893.145493903446, 5910.704464776658, 5956.0, 5841.795537156179, 5860.0, 5867.882642347215, 5872.1778950946045, 5917.615355001911], "value": 5639.2012694954865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.6354497671723, 495.45994865596515, 538.1174873207939, 538.7898719499395, 541.5207541325925, 31166.532502012487, 31868.0, 33117.0, 33177.83411082947, 33272.667273327286, 33852.32295354091, 34604.65395346046, 35931.922042338774, 41665.16669666612, 43127.78436107815, 9534.952325238399, 9668.419894806299, 9669.854952175689, 9672.226221902267, 9677.0, 9531.80936381272, 9631.422114673107, 9637.469939153343, 9642.2768292378, 9655.758606034835, 8875.467471951672, 9097.090290970917, 11450.713732156679, 11694.8245776313, 11790.0, 11614.709632259177, 11674.824877626843, 11693.824592631117, 11694.122940779476, 11705.414729263588, 10730.463476826206, 10979.737330207048, 11627.244229125165, 11724.765504689944, 11731.296122232694, 40261.0, 40590.0, 40747.59252407467, 40765.38851917224, 40782.77651670454, 3198.2484116232667, 3299.4390953537954, 3358.2611825398617, 3652.3425783358985, 3947.230290093433, 29718.257043573867, 29721.55417668737, 29793.851030744925, 30352.241193970105, 30439.847800760854, 3098.5048547544984, 3216.903492895217, 3288.556044933951, 3407.557017587698, 3410.931781364359, 469108.0, 472543.0, 473131.6343418261, 474188.629056856, 474997.0, 62615.0, 62711.059334110025, 62853.371466285666, 62926.37073629296, 63035.684821575596, 61281.0, 61378.69310653507, 61397.38602614006, 61476.0, 61485.77028459406, 17211.741823872653, 17472.0, 17487.0, 17489.387871424693, 17494.912525437292, 13267.469301228035, 13353.46586136563, 13385.866141338656, 13389.464421423228, 13407.731845363232, 15726.928796268616, 16956.406525771537, 17327.787054906286, 19569.02794077244, 19598.02009899528, 5417.241586177938, 7015.824604384931, 7321.487495875344, 7842.725609573274, 7949.801254968672, 806.8305655812228, 865.7359505350803, 958.3100167879115, 1096.8683757949098, 1101.6970333158445, 29961.550576741367, 30036.0, 30086.398272034876, 30616.23459413488, 30809.075727728203, 913.4062859141611, 959.5729900194347, 979.2117345536911, 1111.3165403277087, 1166.719987203065, 15285.694286114438, 15587.454439094578, 15587.454439094578, 15609.204941431653, 15926.840731592767, 646040.0, 656020.0, 657091.0, 658211.0, 658443.0, 51945.48054519482, 52118.0, 59336.0, 59813.700931495936, 60390.39609603935, 1368.548379034916, 1373.8694823991905, 1413.314542446933, 1415.8442571317146, 1416.242310363971, 29921.606271497792, 31259.53110703387, 31367.05898823039, 31463.685363146076, 32184.517232241065, 52378.0, 52914.0, 52919.47080529299, 52987.4701252998, 53021.204681930576, 569105.0, 580540.6810761603, 587757.0, 763668.0, 775569.0, 24574.894129763845, 24833.0, 25034.874825625757, 25041.499170016134, 25098.37254068663, 44647.33029004503, 45008.77495612501, 45532.089358213314, 45744.313835293164, 46457.07085858197, 36385.0, 36951.26097477982, 37138.62861371352, 38125.0, 38180.590449142575, 36727.26545469129, 36982.44526332054, 37952.62047379491, 37976.81011594924, 38054.619453805106, 36015.0996225086, 36459.0, 36828.26343473062, 37157.62842371542, 37296.81351593225, 25581.872090639426, 33706.0, 33755.0, 33830.492542612374, 33846.81536146223, 24571.64855932941, 24799.13203037885, 25095.49809003846, 25671.358216044748, 25674.871625641754], "value": 20074.45920755896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.61346844625143, 385.2487649084286, 389.53061560819197, 394.3001172918071, 422.06091446531474, 19921.800781992177, 20460.59078818423, 21068.367948961517, 21145.894270528646, 21241.0, 20599.485012874648, 20641.483962900937, 20659.17363305466, 20913.790862091373, 20923.16307347708, 5197.688138711689, 5453.945460545393, 5921.0, 5975.52195824333, 5984.401559844025, 5731.14032895067, 5950.642961422307, 5988.970055149718, 6025.216721826157, 6043.0, 5860.648361098348, 5922.851928701795, 5928.584999050068, 5929.436703513159, 5931.525477961753, 5639.943600563983, 5889.352171261158, 5917.112433135043, 5927.585069045147, 5932.940670593303, 5782.9421705782825, 5787.826365209051, 5791.82624521265, 5794.246747922785, 5795.275590551181, 13538.390772415265, 13692.931535342359, 13741.381637826322, 13758.65603359914, 20471.0, 2220.2673117871063, 2443.3647251714506, 2464.8521088734556, 2729.290384500044, 2798.538241190201, 9452.621895124186, 9847.16299114576, 10153.238507111922, 10380.532876020598, 10454.79090418195, 1870.523016630764, 1895.6682580548486, 1920.1359388275332, 1935.129191863667, 1951.668216403215, 97543.51228243884, 111923.0, 113613.0, 116045.0, 116269.0, 11420.486078126503, 11516.1362897783, 11630.825537616942, 11648.184627076193, 11806.989217749418, 13636.250006249751, 14651.706965860623, 14700.926495367668, 14703.044302120328, 14726.926365368105, 7946.523208607502, 7966.681332746625, 8591.226789588967, 8616.439931404439, 8802.515861627544, 8499.065102838806, 8509.574521273911, 8689.739307820775, 8692.087740697036, 8708.825823483496, 4512.120136573337, 4549.112922980054, 4557.430321209848, 4609.308603709471, 4653.255479123324, 1921.154691935544, 1971.960560788805, 1975.9901200493905, 1976.1305025788606, 1977.6440240756515, 856.2892798976834, 882.7395918204145, 897.9506127163069, 971.218169373661, 984.5913945712592, 20689.689654654892, 21608.24371147034, 21666.89166554157, 21673.566528669337, 21708.45728856791, 902.120432578244, 917.5824999625155, 925.2413021322451, 942.2838642631649, 1017.6082208349691, 10553.683389498327, 10977.668981365776, 11019.889801101886, 11119.166062545342, 11237.381943992996, 610468.0, 621641.0, 625459.0, 628581.0, 629916.0, 75392.0, 117598.41200793942, 121230.39384803196, 121426.0, 130086.34956825155, 905.4748246017294, 906.8639704044314, 965.5124162297994, 973.9123478886934, 975.4050029482011, 18707.90646046761, 19104.8089519103, 19300.0, 19382.0, 19464.0, 48521.0, 51323.23015154701, 53004.46995529995, 53243.81208536798, 53570.196447054106, 66604.0009399869, 74812.62593686997, 77123.0, 78199.0, 79266.60366698129, 7823.335016523659, 7929.484583502054, 7978.920210797818, 8251.463654862655, 8290.963629546306, 10738.624148154777, 11826.64520064365, 12583.622491325275, 12838.229706217657, 12987.675308116995, 10822.945885270523, 10840.349579025284, 10863.0, 10896.727581810519, 11225.775484490428, 7563.924360756322, 9212.0, 10929.234953553176, 11039.116870650489, 11187.776244475228, 10536.262461627612, 10768.569257229623, 10960.890391096305, 11146.0, 11187.105031597615, 6857.417119544894, 8065.919340806751, 8117.918820811717, 8230.506169629842, 8334.874791903016, 8116.391270654843, 9867.358621689567, 10114.089731924161, 10737.785244294913, 11421.428928553372], "value": 9376.528044520759, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.4978758284267, 1522.3606085444112, 1638.1809095452275, 1830.1398342778905, 1871.354382737955, 7910.683572657094, 8365.58172091396, 8365.790855228623, 8379.24586787189, 8379.790505237364, 7441.665125069371, 7658.54048757075, 7934.960325198366, 8136.0, 8190.344772418207, 2323.8605683658993, 2359.6814430051895, 2360.7639236076343, 2361.468669549346, 2368.834181607288, 2343.0, 2375.2043065572966, 2388.4028992751814, 2389.6893403857475, 2395.9880200598973, 2302.7466978632337, 2306.123673004256, 2324.5118525109747, 2325.2094287942095, 2327.441414060622, 2253.7408198057105, 2259.29961711869, 2285.9771402286096, 2290.4159439342943, 2291.4844160064017, 2345.3550273674878, 2362.208660098869, 2362.362162216209, 2363.0, 2363.4327761337327, 8208.753737387888, 8274.213949674831, 8312.625931833081, 8338.541380224146, 8359.373047021438, 4855.951440485621, 4972.502749725035, 5125.0, 5125.231215317732, 5129.897402051938, 3271.775192868848, 3336.182635254354, 3418.9487157692406, 3467.7052450541732, 3471.427214509603, 1015.7206768138747, 1062.7290041039562, 1081.691717860414, 1092.3336764573603, 1098.5550851904911, 10619.522121504551, 10711.678649640524, 10744.409057501834, 10752.032317091422, 10781.191410644155, 4394.428724265825, 4542.500324964251, 4630.490646028934, 4630.606398456169, 4683.227267500824, 9227.984921658612, 9260.305477089245, 9266.907330926604, 9271.768205794775, 9281.39670921388, 5171.663841850268, 5175.663581867167, 5176.275321454999, 5177.534021937969, 5178.585713142939, 3932.4494570760116, 4297.376880352332, 4387.3857659927635, 4734.124187025412, 4758.119747846659, 3709.0, 3753.155540003477, 3830.444585535082, 3858.8070596470066, 3865.1303456722576, 1122.8820973797797, 1219.6584956212275, 1263.5830176041884, 1266.7529831682734, 1281.493809945085, 806.6934564865313, 835.7492752174323, 896.9282457403392, 901.8456375838937, 913.5751875377981, 5351.170568561879, 5499.175123731392, 5617.971910140505, 5783.739731712083, 5981.252343457068, 950.9239260859254, 963.0754475703263, 986.4475893499663, 986.4673076538588, 997.8574532160635, 3668.4313931340685, 3679.8528058877882, 3777.0, 3803.752756070902, 3826.426036094608, 9644.517774111266, 9875.160611348116, 9896.802063958681, 9941.850872236922, 9991.400515969066, 9305.534723263945, 9652.372595781251, 9656.37233579815, 9850.458224797705, 9964.701058968243, 7617.961910190525, 7837.216278372117, 7841.843163136819, 7857.685692572348, 7895.60521973899, 4707.0, 5588.580856435702, 5663.178839068394, 5755.53955683536, 5761.39505351932, 9101.453912765255, 9129.041450647586, 9222.077792220723, 9227.400218985744, 9275.118863707938, 9160.496172710298, 9413.529323533932, 9440.716778496657, 9461.38500997433, 9553.713388598353, 6556.868862622816, 6869.347411995853, 7117.181524124792, 7172.892406614009, 7286.380657644159, 7800.726974555863, 7922.762317130495, 7947.642356093874, 7947.84104317922, 7953.363730901629, 6908.723651053901, 7052.576845389088, 7080.433565314659, 7105.25394833535, 7234.6020968847215, 6789.355011273921, 6961.443084553122, 6986.126734158231, 6989.685464154024, 6990.0, 5526.91709624364, 6493.155889734304, 6590.143281373391, 6603.471722262111, 6654.068430419648, 4552.157850797613, 4577.954220457886, 4637.9536204637525, 4667.883302917454, 4738.407699037621, 4652.464966528757, 4701.9529804701515, 4724.267738500538, 4872.853814385574, 4916.901661966812], "value": 4390.2746326004435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.6587336866132, 316.39726321357807, 317.2133109887478, 322.29256781364916, 324.8343344894103, 5065.1389263825195, 5090.5164009419095, 5125.487451254872, 5133.3839939207255, 5157.458466860972, 4714.0772720913, 5009.972955544114, 5039.647224694273, 5077.441481437048, 5102.693838369701, 3229.4509933311274, 3744.3634582121035, 3825.7236944018405, 3879.5538513071074, 3944.1717239379764, 3483.937399093288, 3901.609839016104, 3903.843846246161, 3906.921861562767, 3944.5266568011734, 3848.6914449087303, 3849.749766265184, 3885.5531613864487, 3899.278633452806, 3930.842766289345, 3360.3447327771096, 3514.6836784689244, 3726.6149664214654, 3822.522184726909, 3888.47505586745, 2825.7174282571577, 2833.4474777418413, 2995.011646156763, 3050.6796786337336, 3081.6764239754953, 4935.975320123376, 4961.454240033593, 4967.701937883702, 4974.353334066548, 4974.651774375795, 4258.829646814123, 4404.757738324391, 4431.6233120184825, 4444.355588432269, 4465.754383508905, 5188.766505507261, 5259.0, 5265.315508983846, 5281.151596941078, 5336.959292937879, 3095.8886319249236, 3323.8005719656658, 3629.1108678373703, 3768.5854555998817, 3772.1889793694486, 4976.104301225778, 5423.701696406657, 5427.701476418795, 5527.778888844441, 5566.805161819317, 3761.3041587306434, 3807.6192380761704, 3822.3884178531857, 3839.404892241707, 3845.250176215667, 3278.9836050819595, 3293.75296852737, 3896.473976013202, 3918.647321741057, 3941.2708648900043, 4067.4102255173425, 4440.7335559866515, 4456.732596044248, 4496.886463362214, 4505.7296562206375, 4541.841035563805, 4944.480829512921, 5070.299119767402, 5224.425313215544, 5267.130923397596, 1112.4938153140301, 1120.5461787975883, 1200.2978257719158, 1267.1700036476122, 1276.3809552367095, 849.6134258912303, 881.5107615273456, 896.1486587741672, 898.4025622960658, 899.1547944931743, 4086.3053280942313, 4432.960838014485, 4839.943024214695, 5004.84985450437, 5012.749362531932, 4994.451719966822, 5344.225087362311, 5474.370447398521, 5528.102687605228, 5535.944640553543, 3922.4116382542848, 4489.266100848727, 4528.69405334108, 4825.083234185494, 5092.28707980883, 2031.6444622191057, 2344.812415006795, 2367.43181636406, 2386.1052105460453, 2736.7706106794176, 5172.896542069213, 5376.462353764592, 5399.109146990702, 5433.897407457344, 5446.564274858002, 4099.831548008803, 4793.23308270675, 5071.163258062452, 5082.5349705392855, 5265.657732247391, 4441.333799929972, 4848.702882040247, 5298.364196296392, 5422.40353561108, 5427.538659214011, 5156.381234251764, 5178.844634660966, 5201.011807756514, 5227.18978558324, 5259.947400525945, 3954.426608141861, 4130.617076900335, 4688.960302268524, 4996.625927869864, 5126.897462050663, 4657.906841863211, 4855.684380515255, 4942.752862356796, 5411.350637923474, 5533.012173426305, 3053.6106071736863, 3123.6407813100877, 3518.574977134265, 3528.594211665691, 3578.2843431314363, 4895.853124406273, 5078.568321692697, 5111.469822437917, 5119.590432765295, 5130.12787826063, 4568.17772800899, 4703.38961876162, 4747.691400058985, 5007.397632757483, 5021.610412971157, 4784.976075119602, 4975.527324904128, 4981.227909674007, 4985.451600324034, 4987.376577927759, 4464.799084041291, 4845.3216549682365, 4909.607231421549, 4913.427703134963, 4923.409190897115, 4829.372181616367, 4892.92660610084, 5050.898982020412, 5095.26118712792, 5257.342832145981, 4252.957470425256, 5231.9536092782355, 5286.286351342674, 5331.893362132658, 5336.759845807026], "value": 3801.6737426404047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.9101362329709, 729.1723893381013, 795.4869109424418, 808.7250334886138, 810.8621534339162, 14670.266486675664, 14942.402303907858, 15502.457413990513, 15558.844411555881, 15612.2974466149, 14164.433422663082, 14200.644983875409, 14388.784168237486, 14397.424103035866, 14414.711705765878, 687.7902239816854, 700.1982729774405, 823.8887750153742, 825.6325934958945, 852.0159216105408, 716.8960500727392, 850.3792231670884, 872.4590753732695, 877.6533269358599, 878.9912100878973, 917.0829170829171, 918.2424499787669, 920.0523460835317, 920.1626519866923, 920.1718453391934, 912.447968978765, 916.3402350307767, 917.8760867282898, 918.4489306416164, 918.6830543462495, 680.1837794646394, 681.2676372899103, 682.0144890633037, 682.2631557917438, 682.4267615203204, 13855.515056972958, 14227.644308892257, 14254.501092461818, 14258.500952466718, 14598.70802583953, 14033.508827190999, 14319.212443315613, 14379.137251764823, 14385.85614143866, 14503.347349369304, 10940.4529773511, 11148.331100133937, 11434.256773309708, 11568.0, 11663.183577149603, 4388.341748737683, 4471.463424389061, 4528.026474308007, 4546.909061818778, 4585.564371384713, 87714.5614271931, 92125.0, 93370.0, 93722.0, 94821.52589237079, 10396.324238924446, 10424.895751042393, 10619.203559732896, 10672.199585030998, 11028.834567481494, 20252.392428227176, 20610.79389206119, 20621.072051757707, 20631.071601777956, 20692.172313107607, 7717.884231736529, 7814.921850781533, 8098.190180981855, 8183.631736571869, 8184.099749027602, 4403.0, 4415.646748260196, 4474.440694913136, 4518.819247230074, 4630.282306242538, 3358.882439114619, 3477.2697733475748, 3488.389531831919, 3495.9825200873834, 3501.7548771585743, 630.1807650055002, 636.2651137935692, 664.3223911610131, 664.7606861529846, 665.6372277108987, 553.7729530892315, 583.6264790534061, 669.2136739331266, 676.736072931557, 686.3891136888174, 7773.805654858561, 8658.913410865936, 8887.73336799897, 8928.866067009, 9545.427274363561, 606.5450911816138, 613.7483631710977, 659.8713250916121, 682.0281099433288, 690.7340673840607, 4225.218334608107, 4370.781460926941, 4550.408446901882, 4559.430071241095, 4638.188317044571, 101363.0, 106039.46980265203, 114886.82631456084, 115896.42051789687, 116903.0, 33121.50317745236, 33149.3370132596, 44278.77860610676, 57860.42139578635, 78957.0, 50900.95897339294, 77106.22893771103, 77409.61295193601, 78358.21641783738, 78794.60602697065, 9233.769155771159, 9532.23742100644, 9655.517224138624, 9871.309008369346, 9875.0, 49325.506744933526, 52010.479895200566, 52454.688632782956, 52920.20619690631, 53726.92546149133, 72241.27758722345, 73732.0, 74404.62797685977, 74585.62707186646, 76124.61937690276, 10825.404602746925, 11831.0, 12103.818442723543, 12270.386480676108, 12512.624621261377, 13100.410481528545, 13848.515301964382, 13881.930590346983, 14211.218382988622, 14608.123512589278, 12341.62975110748, 13390.464381424634, 13728.244946528037, 13870.167789932637, 13873.0, 12865.292408917225, 13297.716227173341, 13479.123856949267, 13580.864191358356, 13862.792058118934, 12207.657043736835, 12962.092653514164, 13112.737745245233, 13118.475260989453, 13549.25479098659, 10143.442110683984, 11075.05862001739, 11534.302296741109, 11556.94221528887, 11659.358735269641, 10940.39827809478, 11137.498812553293, 11243.494042767932, 11318.886811131782, 11356.772864542829], "value": 7311.677629167926, "unit": "score"}], "name": "dromaeo_css", "value": 7113.331414399226, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 116.0, 114.0, 116.0, 115.0, 115.0, 115.0, 115.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 108.0, 107.0, 145.0, 134.0, 137.0, 107.0, 119.0, 147.0, 134.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 184.0, 187.0, 185.0, 183.0, 183.0, 185.0, 184.0, 184.0, 185.0], "value": 185.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 69.0, 60.0, 90.0, 63.0, 58.0, 58.0, 58.0, 82.0, 58.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 94.0, 72.0, 70.0, 68.0, 88.0, 67.0, 69.0, 91.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 83.0, 87.0, 84.0, 86.0, 83.0, 86.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 97.0, 95.0, 96.0, 95.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 83.0, 129.0, 85.0, 82.0, 82.0, 83.0, 81.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 53.0, 56.0, 56.0, 58.0, 57.0, 58.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 79.0, 75.0, 69.0, 72.0, 68.0, 69.0, 70.0, 69.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 83.0, 83.0, 82.0, 83.0, 82.0, 82.0, 84.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 136.0, 137.0, 137.0, 143.0, 148.0, 153.0, 177.0, 150.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 162.0, 163.0, 163.0, 163.0, 161.0, 163.0, 161.0, 161.0, 159.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 65.0, 65.0, 64.0, 66.0, 65.0, 64.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1425.2, "alertThreshold": 2.0}]} 16:05:32 INFO - Return code: 0 16:05:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:05:32 INFO - # TBPL SUCCESS # 16:05:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:05:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:05:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:05:32 INFO - 2017-02-17 16:05:32.743 screenresolution[2836:38431] starting screenresolution argv=screenresolution get 16:05:32 INFO - 2017-02-17 16:05:32.746 screenresolution[2836:38431] Display 0: 1600x1200x32@60 16:05:32 INFO - 2017-02-17 16:05:32.752 screenresolution[2837:38434] starting screenresolution argv=screenresolution list 16:05:32 INFO - Available Modes on Display 0 16:05:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:05:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:05:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:05:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:05:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:05:32 INFO - Intel Iris: 16:05:32 INFO - Chipset Model: Intel Iris 16:05:32 INFO - Type: GPU 16:05:32 INFO - Bus: Built-In 16:05:32 INFO - VRAM (Dynamic, Max): 1536 MB 16:05:32 INFO - Vendor: Intel (0x8086) 16:05:32 INFO - Device ID: 0x0a2e 16:05:32 INFO - Revision ID: 0x0009 16:05:32 INFO - Displays: 16:05:32 INFO - Display: 16:05:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:05:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:05:32 INFO - Display Serial Number: 1600x1200 60 16:05:32 INFO - Main Display: Yes 16:05:32 INFO - Mirror: Off 16:05:32 INFO - Online: Yes 16:05:32 INFO - Rotation: Supported 16:05:32 INFO - Return code: 0 16:05:32 INFO - Running post-action listener: _resource_record_post_action 16:05:32 INFO - [mozharness: 2017-02-18 00:05:32.995394Z] Finished run-tests step (success) 16:05:32 INFO - Running post-run listener: _resource_record_post_run 16:05:33 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 409600; Write bytes: 500909056; Read time: 4; Write time: 1559 16:05:33 INFO - TinderboxPrint: CPU usage
53.5% 16:05:33 INFO - TinderboxPrint: I/O read bytes / time
409,600 / 4 16:05:33 INFO - TinderboxPrint: I/O write bytes / time
500,909,056 / 1,559 16:05:33 INFO - TinderboxPrint: CPU idle
2,229.0 (46.5%) 16:05:33 INFO - TinderboxPrint: CPU system
959.2 (20.0%) 16:05:33 INFO - TinderboxPrint: CPU user
1,609.5 (33.5%) 16:05:33 INFO - TinderboxPrint: Swap in / out
191,512,576 / 0 16:05:33 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183312896; Write bytes: 175923200; Read time: 16910; Write time: 317 16:05:33 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 409600; Write bytes: 308298752; Read time: 4; Write time: 1187 16:05:33 INFO - Running post-run listener: _upload_blobber_files 16:05:33 INFO - Blob upload gear active. 16:05:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:05:33 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 16:05:33 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:05:33 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:05:33 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:05:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:05:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:34 INFO - (blobuploader) - INFO - Done attempting. 16:05:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:05:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:05:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:35 INFO - (blobuploader) - INFO - Done attempting. 16:05:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:05:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:38 INFO - (blobuploader) - INFO - Done attempting. 16:05:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:38 INFO - Return code: 0 16:05:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:05:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79ffd81085268d97d0bf69e704f2621a210dd819de76ce7deacccf98e548b55a1aee29508d90a68f8f53df2f157e9dfa27b65223a821130832efead70bd4aee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/141e95bf04455eff2509feedcfe6249b4d0a0167f36f78fbb4371577014e1e9b087b8b2fa44f91c26fc80b99569159d878958c85f8ac6bc83e45290f50ead3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9faffc23207a445abc56648d7955b527172a4aaff38fc4d9e759711a02109e43b8275e91365fbc3188a4467ccd64e4257d5b3ebc8eda323f053175daeb9960f0"} 16:05:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:05:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:05:38 INFO - Contents: 16:05:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79ffd81085268d97d0bf69e704f2621a210dd819de76ce7deacccf98e548b55a1aee29508d90a68f8f53df2f157e9dfa27b65223a821130832efead70bd4aee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/141e95bf04455eff2509feedcfe6249b4d0a0167f36f78fbb4371577014e1e9b087b8b2fa44f91c26fc80b99569159d878958c85f8ac6bc83e45290f50ead3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9faffc23207a445abc56648d7955b527172a4aaff38fc4d9e759711a02109e43b8275e91365fbc3188a4467ccd64e4257d5b3ebc8eda323f053175daeb9960f0"} 16:05:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:05:38 INFO - Copying logs to upload dir... 16:05:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:05:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.133554 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-17 16:05:38.246716) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 16:05:38.250162) ========= 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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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/Mozilla-Beta/sha512/79ffd81085268d97d0bf69e704f2621a210dd819de76ce7deacccf98e548b55a1aee29508d90a68f8f53df2f157e9dfa27b65223a821130832efead70bd4aee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/141e95bf04455eff2509feedcfe6249b4d0a0167f36f78fbb4371577014e1e9b087b8b2fa44f91c26fc80b99569159d878958c85f8ac6bc83e45290f50ead3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9faffc23207a445abc56648d7955b527172a4aaff38fc4d9e759711a02109e43b8275e91365fbc3188a4467ccd64e4257d5b3ebc8eda323f053175daeb9960f0"} build_url:https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/YFehOiFURAKFx5Rf3GKjEg/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/79ffd81085268d97d0bf69e704f2621a210dd819de76ce7deacccf98e548b55a1aee29508d90a68f8f53df2f157e9dfa27b65223a821130832efead70bd4aee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/141e95bf04455eff2509feedcfe6249b4d0a0167f36f78fbb4371577014e1e9b087b8b2fa44f91c26fc80b99569159d878958c85f8ac6bc83e45290f50ead3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9faffc23207a445abc56648d7955b527172a4aaff38fc4d9e759711a02109e43b8275e91365fbc3188a4467ccd64e4257d5b3ebc8eda323f053175daeb9960f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 16:05:38.283803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 16:05:38.284126) ========= 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.H0nQPVJYXv/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.4kYpfp1IcA/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.005264 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 16:05:38.333795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 16:05:38.334136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 16:05:38.334488) ========= ========= Total master_lag: 0.20 =========