builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0283 starttime: 1491321038.78 results: success (0) buildid: 20170404072227 builduid: 5e8d17cf2bd64bec80cf02c9e39f72fe revision: cdb05bd2d1ceca24851b2329dc7c8fa10e001718 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:38.779407) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:38.779901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:38.780182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:38.806195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:38.806564) ========= 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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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-04-04 08:50:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.1M=0.001s 2017-04-04 08:50:39 (23.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.294341 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:39.128548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:39.129229) ========= 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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.027066 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:39.179341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-04 08:50:39.179704) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cdb05bd2d1ceca24851b2329dc7c8fa10e001718 --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 cdb05bd2d1ceca24851b2329dc7c8fa10e001718 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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-04-04 08:50:39,287 truncating revision to first 12 chars 2017-04-04 08:50:39,287 Setting DEBUG logging. 2017-04-04 08:50:39,287 attempt 1/10 2017-04-04 08:50:39,287 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cdb05bd2d1ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 08:50:42,062 unpacking tar archive at: mozilla-beta-cdb05bd2d1ce/testing/mozharness/ program finished with exit code 0 elapsedTime=3.050653 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-04 08:50:42.256632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:42.257019) ========= script_repo_revision: cdb05bd2d1ceca24851b2329dc7c8fa10e001718 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:42.257507) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:42.257817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 08:50:42.278106) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-04-04 08:50:42.278437) ========= /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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:50:42 INFO - MultiFileLogger online at 20170404 08:50:42 in /builds/slave/test 08:50:42 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 08:50:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:42 INFO - {'append_to_log': False, 08:50:42 INFO - 'base_work_dir': '/builds/slave/test', 08:50:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:50:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:42 INFO - 'branch': 'Mozilla-Beta', 08:50:42 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:42 INFO - 'config_files': ('talos/mac_config.py',), 08:50:42 INFO - 'default_actions': ('clobber', 08:50:42 INFO - 'read-buildbot-config', 08:50:42 INFO - 'download-and-extract', 08:50:42 INFO - 'populate-webroot', 08:50:42 INFO - 'create-virtualenv', 08:50:42 INFO - 'install', 08:50:42 INFO - 'run-tests'), 08:50:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:42 INFO - 'download_minidump_stackwalk': True, 08:50:42 INFO - 'download_symbols': 'ondemand', 08:50:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:42 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:42 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:42 INFO - 'installer_path': 'installer.exe', 08:50:42 INFO - 'log_level': 'info', 08:50:42 INFO - 'log_name': 'talos', 08:50:42 INFO - 'log_to_console': True, 08:50:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:50:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:50:42 INFO - 'opt_config_files': (), 08:50:42 INFO - 'pip_index': False, 08:50:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:42 INFO - 'cmd': ('bash', 08:50:42 INFO - '-c', 08:50:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:42 INFO - 'enabled': True, 08:50:42 INFO - 'halt_on_failure': False, 08:50:42 INFO - 'name': 'check_screen_resolution'},), 08:50:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:42 INFO - 'cmd': ('bash', 08:50:42 INFO - '-c', 08:50:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:42 INFO - 'enabled': True, 08:50:42 INFO - 'halt_on_failure': False, 08:50:42 INFO - 'name': 'check_screen_resolution'},), 08:50:42 INFO - 'run_cmd_checks_enabled': True, 08:50:42 INFO - 'sps_profile': False, 08:50:42 INFO - 'sps_profile_interval': 0, 08:50:42 INFO - 'suite': 'dromaeojs', 08:50:42 INFO - 'system_bits': '32', 08:50:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:42 INFO - 'title': 't-yosemite-r7-0283', 08:50:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:42 INFO - 'use_talos_json': True, 08:50:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:42 INFO - 'work_dir': 'build'} 08:50:42 INFO - [mozharness: 2017-04-04 15:50:42.494482Z] Running clobber step. 08:50:42 INFO - Running pre-action listener: _resource_record_pre_action 08:50:42 INFO - Running main action method: clobber 08:50:42 INFO - rmtree: /builds/slave/test/build 08:50:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:45 INFO - Running post-action listener: _resource_record_post_action 08:50:45 INFO - [mozharness: 2017-04-04 15:50:45.012044Z] Finished clobber step (success) 08:50:45 INFO - [mozharness: 2017-04-04 15:50:45.012196Z] Running read-buildbot-config step. 08:50:45 INFO - Running pre-action listener: _resource_record_pre_action 08:50:45 INFO - Running main action method: read_buildbot_config 08:50:45 INFO - Using buildbot properties: 08:50:45 INFO - { 08:50:45 INFO - "project": "", 08:50:45 INFO - "product": "firefox", 08:50:45 INFO - "script_repo_revision": "production", 08:50:45 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:50:45 INFO - "repository": "", 08:50:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:50:45 INFO - "buildid": "20170404072227", 08:50:45 INFO - "pgo_build": "False", 08:50:45 INFO - "basedir": "/builds/slave/test", 08:50:45 INFO - "buildnumber": 14, 08:50:45 INFO - "slavename": "t-yosemite-r7-0283", 08:50:45 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:50:45 INFO - "platform": "yosemite_r7", 08:50:45 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:50:45 INFO - "branch": "mozilla-beta", 08:50:45 INFO - "repo_path": "releases/mozilla-beta", 08:50:45 INFO - "revision": "cdb05bd2d1ceca24851b2329dc7c8fa10e001718", 08:50:45 INFO - "stage_platform": "macosx64", 08:50:45 INFO - "builduid": "5e8d17cf2bd64bec80cf02c9e39f72fe", 08:50:45 INFO - "slavebuilddir": "test" 08:50:45 INFO - } 08:50:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 08:50:45 INFO - Running post-action listener: _resource_record_post_action 08:50:45 INFO - [mozharness: 2017-04-04 15:50:45.015551Z] Finished read-buildbot-config step (success) 08:50:45 INFO - [mozharness: 2017-04-04 15:50:45.015696Z] Running download-and-extract step. 08:50:45 INFO - Running pre-action listener: _resource_record_pre_action 08:50:45 INFO - Running main action method: download_and_extract 08:50:45 INFO - mkdir: /builds/slave/test/build/tests 08:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:45 INFO - trying https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 08:50:45 INFO - Downloading https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 08:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 08:50:46 INFO - Downloaded 1165 bytes. 08:50:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 08:50:46 INFO - Using the following test package requirements: 08:50:46 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:50:46 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:50:46 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 08:50:46 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:50:46 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 08:50:46 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:50:46 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:50:46 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 08:50:46 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:50:46 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:50:46 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 08:50:46 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:50:46 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 08:50:46 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:50:46 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 08:50:46 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:50:46 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 08:50:46 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 08:50:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:50:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:50:46 INFO - Fetch https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:50:47 INFO - Expected file size: 16116799 08:50:47 INFO - Obtained file size: 16116799 08:50:54 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:50:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:50:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:50:54 INFO - Fetch https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:50:55 INFO - Expected file size: 16116799 08:50:55 INFO - Obtained file size: 16116799 08:51:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 08:51:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 08:51:01 INFO - Fetch https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 08:51:03 INFO - Expected file size: 14403663 08:51:03 INFO - Obtained file size: 14403663 08:51: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')]} 08:51:04 INFO - trying https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:51:04 INFO - Downloading https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 08:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 08:51:06 INFO - Downloaded 58738278 bytes. 08:51:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:51:06 INFO - mkdir: /builds/slave/test/properties 08:51:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:06 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:06 INFO - Contents: 08:51:06 INFO - build_url:https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:51:06 INFO - Running post-action listener: _resource_record_post_action 08:51:06 INFO - Running post-action listener: set_extra_try_arguments 08:51:06 INFO - [mozharness: 2017-04-04 15:51:06.944359Z] Finished download-and-extract step (success) 08:51:06 INFO - [mozharness: 2017-04-04 15:51:06.944523Z] Running populate-webroot step. 08:51:06 INFO - Running pre-action listener: _resource_record_pre_action 08:51:06 INFO - Running main action method: populate_webroot 08:51:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:06 INFO - '--tppagecycles', 08:51:06 INFO - '7'], 08:51:06 INFO - 'tests': ['tsvgm']}}, 08:51:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:51:06 INFO - 'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:51:06 INFO - 'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['damp', 'tps']}, 08:51:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:51:06 INFO - 'tests': ['damp', 'tps']}, 08:51:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['dromaeo_dom']}, 08:51:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['basic_compositor_video']}, 08:51:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:51:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['a11yr', 08:51:06 INFO - 'ts_paint', 08:51:06 INFO - 'tpaint', 08:51:06 INFO - 'sessionrestore', 08:51:06 INFO - 'sessionrestore_no_auto_restore', 08:51:06 INFO - 'tabpaint']}, 08:51:06 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:06 INFO - 'ts_paint', 08:51:06 INFO - 'tpaint', 08:51:06 INFO - 'sessionrestore', 08:51:06 INFO - 'sessionrestore_no_auto_restore', 08:51:06 INFO - 'tabpaint']}, 08:51:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:06 INFO - 'ts_paint', 08:51:06 INFO - 'tpaint', 08:51:06 INFO - 'sessionrestore', 08:51:06 INFO - 'sessionrestore_no_auto_restore', 08:51:06 INFO - 'tabpaint']}, 08:51:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:06 INFO - 'ts_paint', 08:51:06 INFO - 'tpaint', 08:51:06 INFO - 'sessionrestore', 08:51:06 INFO - 'sessionrestore_no_auto_restore', 08:51:06 INFO - 'tabpaint']}, 08:51:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['a11yr', 08:51:06 INFO - 'ts_paint', 08:51:06 INFO - 'tpaint', 08:51:06 INFO - 'sessionrestore', 08:51:06 INFO - 'sessionrestore_no_auto_restore', 08:51:06 INFO - 'tabpaint']}, 08:51:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['a11yr', 08:51:06 INFO - 'ts_paint', 08:51:06 INFO - 'tpaint', 08:51:06 INFO - 'sessionrestore', 08:51:06 INFO - 'sessionrestore_no_auto_restore', 08:51:06 INFO - 'tabpaint']}, 08:51:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['tsvgx', 08:51:06 INFO - 'tsvgr_opacity', 08:51:06 INFO - 'tart', 08:51:06 INFO - 'tscrollx', 08:51:06 INFO - 'cart', 08:51:06 INFO - 'tsvg_static']}, 08:51:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:06 INFO - 'tsvgr_opacity', 08:51:06 INFO - 'tart', 08:51:06 INFO - 'tscrollx', 08:51:06 INFO - 'cart', 08:51:06 INFO - 'tsvg_static']}, 08:51:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:51:06 INFO - 'talos_options': ['--disable-e10s'], 08:51:06 INFO - 'tests': ['tp5o']}, 08:51:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:51:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:51:06 INFO - 'talos_options': ['--disable-e10s', 08:51:06 INFO - '--xperf_path', 08:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:06 INFO - 'tests': ['tp5n']}, 08:51:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:51:06 INFO - 'talos_options': ['--xperf_path', 08:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:06 INFO - 'tests': ['tp5n']}}, 08:51:06 INFO - 'talos.zip': {'path': '', 08:51:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:06 INFO - Running post-action listener: _resource_record_post_action 08:51:06 INFO - [mozharness: 2017-04-04 15:51:06.962727Z] Finished populate-webroot step (success) 08:51:06 INFO - [mozharness: 2017-04-04 15:51:06.962857Z] Running create-virtualenv step. 08:51:06 INFO - Running pre-action listener: _resource_record_pre_action 08:51:06 INFO - Running main action method: create_virtualenv 08:51:06 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:51:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:07 INFO - Using real prefix '/tools/python27' 08:51:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:07 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:10 INFO - Installing pip.................done. 08:51:10 INFO - Return code: 0 08:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:51:10 INFO - Reading from file tmpfile_stdout 08:51:10 INFO - Output received: 08:51:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:51:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:11 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 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:11 INFO - 'HOME': '/Users/cltbld', 08:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:11 INFO - 'LOGNAME': 'cltbld', 08:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:11 INFO - 'MOZ_NO_REMOTE': '1', 08:51:11 INFO - 'NO_EM_RESTART': '1', 08:51:11 INFO - 'PAGER': '/bin/cat', 08:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:11 INFO - 'PWD': '/builds/slave/test', 08:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:11 INFO - 'SHELL': '/bin/bash', 08:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:11 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:11 INFO - 'USER': 'cltbld', 08:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:11 INFO - 'XPC_FLAGS': '0x0', 08:51:11 INFO - 'XPC_SERVICE_NAME': '0', 08:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:51:11 INFO - Cleaning up... 08:51:11 INFO - Return code: 0 08:51:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:11 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 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:11 INFO - 'HOME': '/Users/cltbld', 08:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:11 INFO - 'LOGNAME': 'cltbld', 08:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:11 INFO - 'MOZ_NO_REMOTE': '1', 08:51:11 INFO - 'NO_EM_RESTART': '1', 08:51:11 INFO - 'PAGER': '/bin/cat', 08:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:11 INFO - 'PWD': '/builds/slave/test', 08:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:11 INFO - 'SHELL': '/bin/bash', 08:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:11 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:11 INFO - 'USER': 'cltbld', 08:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:11 INFO - 'XPC_FLAGS': '0x0', 08:51:11 INFO - 'XPC_SERVICE_NAME': '0', 08:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:11 INFO - Downloading/unpacking psutil>=3.1.1 08:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:15 INFO - Installing collected packages: psutil 08:51:15 INFO - Running setup.py install for psutil 08:51:16 INFO - building 'psutil._psutil_osx' extension 08:51:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:51:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:51:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:51:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:51:16 INFO - building 'psutil._psutil_posix' extension 08:51:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:51:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:51:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:51:16 INFO - ^ 08:51:16 INFO - 1 warning generated. 08:51:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:17 INFO - Successfully installed psutil 08:51:17 INFO - Cleaning up... 08:51:17 INFO - Return code: 0 08:51:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:17 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 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:17 INFO - 'HOME': '/Users/cltbld', 08:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:17 INFO - 'LOGNAME': 'cltbld', 08:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:17 INFO - 'MOZ_NO_REMOTE': '1', 08:51:17 INFO - 'NO_EM_RESTART': '1', 08:51:17 INFO - 'PAGER': '/bin/cat', 08:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:17 INFO - 'PWD': '/builds/slave/test', 08:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:17 INFO - 'SHELL': '/bin/bash', 08:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:17 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:17 INFO - 'USER': 'cltbld', 08:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:17 INFO - 'XPC_FLAGS': '0x0', 08:51:17 INFO - 'XPC_SERVICE_NAME': '0', 08:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:51:20 INFO - Installing collected packages: mozsystemmonitor 08:51:20 INFO - Running setup.py install for mozsystemmonitor 08:51:20 INFO - Successfully installed mozsystemmonitor 08:51:20 INFO - Cleaning up... 08:51:20 INFO - Return code: 0 08:51:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:20 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 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:20 INFO - 'HOME': '/Users/cltbld', 08:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:20 INFO - 'LOGNAME': 'cltbld', 08:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:20 INFO - 'MOZ_NO_REMOTE': '1', 08:51:20 INFO - 'NO_EM_RESTART': '1', 08:51:20 INFO - 'PAGER': '/bin/cat', 08:51:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:20 INFO - 'PWD': '/builds/slave/test', 08:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:20 INFO - 'SHELL': '/bin/bash', 08:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:20 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:20 INFO - 'USER': 'cltbld', 08:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:20 INFO - 'XPC_FLAGS': '0x0', 08:51:20 INFO - 'XPC_SERVICE_NAME': '0', 08:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:51:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:51:24 INFO - warning: no files found matching '*.txt' 08:51:24 INFO - no previously-included directories found matching 'build' 08:51:24 INFO - no previously-included directories found matching 'dist' 08:51:24 INFO - no previously-included directories found matching '.git*' 08:51:24 INFO - Installing collected packages: jsonschema, functools32 08:51:24 INFO - Running setup.py install for functools32 08:51:24 INFO - warning: no files found matching '*.txt' 08:51:24 INFO - no previously-included directories found matching 'build' 08:51:24 INFO - no previously-included directories found matching 'dist' 08:51:24 INFO - no previously-included directories found matching '.git*' 08:51:24 INFO - Successfully installed jsonschema functools32 08:51:24 INFO - Cleaning up... 08:51:24 INFO - Return code: 0 08:51:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:24 INFO - 'HOME': '/Users/cltbld', 08:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:24 INFO - 'LOGNAME': 'cltbld', 08:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:24 INFO - 'MOZ_NO_REMOTE': '1', 08:51:24 INFO - 'NO_EM_RESTART': '1', 08:51:24 INFO - 'PAGER': '/bin/cat', 08:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:24 INFO - 'PWD': '/builds/slave/test', 08:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:24 INFO - 'SHELL': '/bin/bash', 08:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:24 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:24 INFO - 'USER': 'cltbld', 08:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:24 INFO - 'XPC_FLAGS': '0x0', 08:51:24 INFO - 'XPC_SERVICE_NAME': '0', 08:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:51:24 INFO - Cleaning up... 08:51:24 INFO - Return code: 0 08:51:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:24 INFO - 'HOME': '/Users/cltbld', 08:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:24 INFO - 'LOGNAME': 'cltbld', 08:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:24 INFO - 'MOZ_NO_REMOTE': '1', 08:51:24 INFO - 'NO_EM_RESTART': '1', 08:51:24 INFO - 'PAGER': '/bin/cat', 08:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:24 INFO - 'PWD': '/builds/slave/test', 08:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:24 INFO - 'SHELL': '/bin/bash', 08:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:24 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:24 INFO - 'USER': 'cltbld', 08:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:24 INFO - 'XPC_FLAGS': '0x0', 08:51:24 INFO - 'XPC_SERVICE_NAME': '0', 08:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:25 INFO - Downloading/unpacking blobuploader==1.2.4 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51:28 INFO - Downloading docopt-0.6.1.tar.gz 08:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:29 INFO - Running setup.py install for blobuploader 08:51:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:29 INFO - Running setup.py install for requests 08:51:29 INFO - Running setup.py install for docopt 08:51:29 INFO - Successfully installed blobuploader requests docopt 08:51:29 INFO - Cleaning up... 08:51:29 INFO - Return code: 0 08:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:29 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 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:29 INFO - 'HOME': '/Users/cltbld', 08:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:29 INFO - 'LOGNAME': 'cltbld', 08:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:29 INFO - 'MOZ_NO_REMOTE': '1', 08:51:29 INFO - 'NO_EM_RESTART': '1', 08:51:29 INFO - 'PAGER': '/bin/cat', 08:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:29 INFO - 'PWD': '/builds/slave/test', 08:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:29 INFO - 'SHELL': '/bin/bash', 08:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:29 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:29 INFO - 'USER': 'cltbld', 08:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:29 INFO - 'XPC_FLAGS': '0x0', 08:51:29 INFO - 'XPC_SERVICE_NAME': '0', 08:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:30 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-frTKxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:30 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-HKqeVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:30 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-UN7eGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:30 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-U3tUrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:30 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-zoRxTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:30 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-nSWwAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:30 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-T0Kf65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:30 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-bLGWvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:30 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-xlNt6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:31 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-QHsUJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:31 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-xv95nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:31 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-JZr_KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:31 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Li8hKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:31 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-37pZ4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:31 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Wh30mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:31 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-8Z8vrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:31 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-iRqy_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:31 INFO - Running setup.py install for manifestparser 08:51:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozcrash 08:51:32 INFO - Running setup.py install for mozdebug 08:51:32 INFO - Running setup.py install for mozdevice 08:51:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozfile 08:51:32 INFO - Running setup.py install for mozhttpd 08:51:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozinfo 08:51:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozInstall 08:51:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for mozleak 08:51:33 INFO - Running setup.py install for mozlog 08:51:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for moznetwork 08:51:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for mozprocess 08:51:33 INFO - Running setup.py install for mozprofile 08:51:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for mozrunner 08:51:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozscreenshot 08:51:34 INFO - Running setup.py install for moztest 08:51:34 INFO - Running setup.py install for mozversion 08:51:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:34 INFO - Cleaning up... 08:51:34 INFO - Return code: 0 08:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:35 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 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:35 INFO - 'HOME': '/Users/cltbld', 08:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:35 INFO - 'LOGNAME': 'cltbld', 08:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:35 INFO - 'MOZ_NO_REMOTE': '1', 08:51:35 INFO - 'NO_EM_RESTART': '1', 08:51:35 INFO - 'PAGER': '/bin/cat', 08:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:35 INFO - 'PWD': '/builds/slave/test', 08:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:35 INFO - 'SHELL': '/bin/bash', 08:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:35 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:35 INFO - 'USER': 'cltbld', 08:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:35 INFO - 'XPC_FLAGS': '0x0', 08:51:35 INFO - 'XPC_SERVICE_NAME': '0', 08:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:36 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-wg9lzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:36 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Uj7EVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:36 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-XoRxDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:36 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-LwGAvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:36 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-ChTIDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:36 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-fZy5i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:36 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-NYxPBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:36 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-UWeJxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:36 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-6MKRn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-gDn2Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-M_R7Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-N2WmrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-zg1FG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-fVq7sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:37 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)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-uukDwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-FRbZQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:37 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)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-gA8sze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:51:37 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)) 08:51:37 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)) 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:41 INFO - Downloading blessings-1.6.tar.gz 08:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:41 INFO - Installing collected packages: blessings 08:51:41 INFO - Running setup.py install for blessings 08:51:41 INFO - Successfully installed blessings 08:51:41 INFO - Cleaning up... 08:51:41 INFO - Return code: 0 08:51:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:41 INFO - Reading from file tmpfile_stdout 08:51:41 INFO - Current package versions: 08:51:41 INFO - blessings == 1.6 08:51:41 INFO - blobuploader == 1.2.4 08:51:41 INFO - docopt == 0.6.1 08:51:41 INFO - functools32 == 3.2.3-2 08:51:41 INFO - jsonschema == 2.5.1 08:51:41 INFO - manifestparser == 1.1 08:51:41 INFO - mozInstall == 1.12 08:51:41 INFO - mozcrash == 1.0 08:51:41 INFO - mozdebug == 0.1 08:51:41 INFO - mozdevice == 0.49 08:51:41 INFO - mozfile == 1.2 08:51:41 INFO - mozhttpd == 0.7 08:51:41 INFO - mozinfo == 0.9 08:51:41 INFO - mozleak == 0.1 08:51:41 INFO - mozlog == 3.4 08:51:41 INFO - moznetwork == 0.27 08:51:41 INFO - mozprocess == 0.24 08:51:41 INFO - mozprofile == 0.28 08:51:41 INFO - mozrunner == 6.13 08:51:41 INFO - mozscreenshot == 0.1 08:51:41 INFO - mozsystemmonitor == 0.3 08:51:41 INFO - moztest == 0.8 08:51:41 INFO - mozversion == 1.4 08:51:41 INFO - psutil == 3.1.1 08:51:41 INFO - requests == 1.2.3 08:51:41 INFO - wsgiref == 0.1.2 08:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:41 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 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:41 INFO - 'HOME': '/Users/cltbld', 08:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:41 INFO - 'LOGNAME': 'cltbld', 08:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:41 INFO - 'MOZ_NO_REMOTE': '1', 08:51:41 INFO - 'NO_EM_RESTART': '1', 08:51:41 INFO - 'PAGER': '/bin/cat', 08:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:41 INFO - 'PWD': '/builds/slave/test', 08:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:41 INFO - 'SHELL': '/bin/bash', 08:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:41 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:41 INFO - 'USER': 'cltbld', 08:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:41 INFO - 'XPC_FLAGS': '0x0', 08:51:41 INFO - 'XPC_SERVICE_NAME': '0', 08:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:51:41 INFO - Cleaning up... 08:51:41 INFO - Return code: 0 08:51:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103692b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103695768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193ded0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, '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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:41 INFO - 'HOME': '/Users/cltbld', 08:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:41 INFO - 'LOGNAME': 'cltbld', 08:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:41 INFO - 'MOZ_NO_REMOTE': '1', 08:51:41 INFO - 'NO_EM_RESTART': '1', 08:51:41 INFO - 'PAGER': '/bin/cat', 08:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:41 INFO - 'PWD': '/builds/slave/test', 08:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:41 INFO - 'SHELL': '/bin/bash', 08:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:41 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:41 INFO - 'USER': 'cltbld', 08:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:41 INFO - 'XPC_FLAGS': '0x0', 08:51:41 INFO - 'XPC_SERVICE_NAME': '0', 08:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:51:42 INFO - Cleaning up... 08:51:42 INFO - Return code: 0 08:51:42 INFO - Running post-action listener: _resource_record_post_action 08:51:42 INFO - Running post-action listener: _start_resource_monitoring 08:51:42 INFO - Starting resource monitoring. 08:51:42 INFO - [mozharness: 2017-04-04 15:51:42.245205Z] Finished create-virtualenv step (success) 08:51:42 INFO - [mozharness: 2017-04-04 15:51:42.245978Z] Running install step. 08:51:42 INFO - Running pre-action listener: _resource_record_pre_action 08:51:42 INFO - Running main action method: install 08:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:42 INFO - Reading from file tmpfile_stdout 08:51:42 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:42 INFO - Reading from file tmpfile_stdout 08:51:42 INFO - Output received: 08:51:42 INFO - Usage: mozinstall [options] installer 08:51:42 INFO - Options: 08:51:42 INFO - -h, --help show this help message and exit 08:51:42 INFO - -d DEST, --destination=DEST 08:51:42 INFO - Directory to install application into. [default: 08:51:42 INFO - "/builds/slave/test"] 08:51:42 INFO - --app=APP Application being installed. [default: firefox] 08:51:42 INFO - mkdir: /builds/slave/test/build/application 08:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:51:57 INFO - Reading from file tmpfile_stdout 08:51:57 INFO - Output received: 08:51:57 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:51:57 INFO - Running post-action listener: _resource_record_post_action 08:51:57 INFO - [mozharness: 2017-04-04 15:51:57.151056Z] Finished install step (success) 08:51:57 INFO - [mozharness: 2017-04-04 15:51:57.151189Z] Running run-tests step. 08:51:57 INFO - Running pre-action listener: _resource_record_pre_action 08:51:57 INFO - Running main action method: run_tests 08:51:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:51:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:51:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:51:57 INFO - 2017-04-04 08:51:57.165 screenresolution[1627:7495] starting screenresolution argv=screenresolution get 08:51:57 INFO - 2017-04-04 08:51:57.168 screenresolution[1627:7495] Display 0: 1600x1200x32@60 08:51:57 INFO - 2017-04-04 08:51:57.173 screenresolution[1628:7497] starting screenresolution argv=screenresolution list 08:51:57 INFO - Available Modes on Display 0 08:51:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:51:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:51:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:51:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:51:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:51:57 INFO - Intel Iris: 08:51:57 INFO - Chipset Model: Intel Iris 08:51:57 INFO - Type: GPU 08:51:57 INFO - Bus: Built-In 08:51:57 INFO - VRAM (Dynamic, Max): 1536 MB 08:51:57 INFO - Vendor: Intel (0x8086) 08:51:57 INFO - Device ID: 0x0a2e 08:51:57 INFO - Revision ID: 0x0009 08:51:57 INFO - Displays: 08:51:57 INFO - Display: 08:51:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:51:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:51:57 INFO - Display Serial Number: 1600x1200 60 08:51:57 INFO - Main Display: Yes 08:51:57 INFO - Mirror: Off 08:51:57 INFO - Online: Yes 08:51:57 INFO - Rotation: Supported 08:51:57 INFO - Return code: 0 08:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:51:57 INFO - Python 2.7.3 08:51:57 INFO - Return code: 0 08:51:57 INFO - grabbing minidump binary from tooltool 08:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:57 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 0x103470d30>, '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 0x103397db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103465be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:51:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:51:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:51:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:51:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:51:57 INFO - Return code: 0 08:51:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:51:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:51:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:51:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:51:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:51:57 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/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:51:57 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/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0283 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:51:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7Hw0S6Ec5h/Render', 08:51:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:57 INFO - 'HOME': '/Users/cltbld', 08:51:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:57 INFO - 'LOGNAME': 'cltbld', 08:51:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:51:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:57 INFO - 'MOZ_NO_REMOTE': '1', 08:51:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:51:57 INFO - 'NO_EM_RESTART': '1', 08:51:57 INFO - 'PAGER': '/bin/cat', 08:51:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:57 INFO - 'PWD': '/builds/slave/test', 08:51:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:51:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:57 INFO - 'SHELL': '/bin/bash', 08:51:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vqMo0C52s/Listeners', 08:51:57 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:51:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:57 INFO - 'USER': 'cltbld', 08:51:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:57 INFO - 'XPC_FLAGS': '0x0', 08:51:57 INFO - 'XPC_SERVICE_NAME': '0', 08:51:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:57 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/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:51:57 INFO - mozversion application_buildid: 20170404072227 08:51:57 INFO - mozversion application_changeset: cdb05bd2d1ceca24851b2329dc7c8fa10e001718 08:51:57 INFO - mozversion application_display_name: Firefox 08:51:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:51:57 INFO - mozversion application_name: Firefox 08:51:57 INFO - mozversion application_remotingname: firefox 08:51:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:51:57 INFO - mozversion application_vendor: Mozilla 08:51:57 INFO - mozversion application_version: 53.0 08:51:57 INFO - mozversion platform_buildid: 20170404072227 08:51:57 INFO - mozversion platform_changeset: cdb05bd2d1ceca24851b2329dc7c8fa10e001718 08:51:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:51:57 INFO - mozversion platform_version: 53.0 08:51:57 INFO - using testdate: 1491321117 08:51:57 INFO - actual date: 1491321117 08:51:57 INFO - starting webserver on 'localhost:49245' 08:51:57 INFO - SUITE-START | Running 2 tests 08:51:57 INFO - TEST-START | dromaeo_css 08:51:57 INFO - operating with platform_type : mac_ 08:51:57 INFO - Initialising browser for dromaeo_css test... 08:51:57 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpRMGZbu/profile http://localhost:49245/getInfo.html) 08:52:00 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 08:52:00 INFO - PROCESS | 1638 | colorDepth:24 08:52:00 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 08:52:00 INFO - PROCESS | 1638 | __metrics 08:52:00 INFO - PROCESS | 1638 | 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" 08:52:00 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:01 INFO - TEST-INFO | 1638: exit 0 08:52:01 INFO - Browser initialized. 08:52:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:01 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpRMGZbu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:13 INFO - PROCESS | 1641 | RSS: Main: 164270080 08:52:13 INFO - PROCESS | 1641 | 08:55:16 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 08:55:17 INFO - PROCESS | 1641 | RSS: Main: 315105280 08:55:17 INFO - PROCESS | 1641 | 08:58:20 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 08:58:21 INFO - PROCESS | 1641 | RSS: Main: 304340992 08:58:21 INFO - PROCESS | 1641 | 09:01:23 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 09:01:23 INFO - PROCESS | 1641 | RSS: Main: 286998528 09:01:23 INFO - PROCESS | 1641 | 09:04:26 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 09:04:26 INFO - PROCESS | 1641 | RSS: Main: 271237120 09:04:26 INFO - PROCESS | 1641 | 09:07:29 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 09:07:30 INFO - PROCESS | 1641 | RSS: Main: 278712320 09:07:30 INFO - PROCESS | 1641 | 09:10:33 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 09:10:33 INFO - PROCESS | 1641 | RSS: Main: 470519808 09:10:33 INFO - PROCESS | 1641 | 09:10:33 INFO - PROCESS | 1641 | __start_tp_report 09:10:33 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 09:10:33 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 09:10:33 INFO - PROCESS | 1641 | |i|pagename|runs| 09:10:33 INFO - PROCESS | 1641 | |0;dojo.html;3432.8455219515117;3454.378211921853;3470.982645086774;3477.2523907359914;3523.4186359250725;5813.06990881459;5826.912596311054;5895.086261629449;5914.733836977335;5920.763169473226;5809.709514524278;5899.292084949801;5902.822915312537;5903.940960590404;5917.970410147954;5036.017976494585;5207.843764687065;5240.082985477527;5251.711155886424;5277.973610131944;5222.712750798704;5254.947450525484;5261.289725886994;5345.679259244438;5355.732213389334;5268.473152684739;5299;5303.098473259555;5335;5357.517823395893;5320.361556613192;5324.627276090675;5341.706206158659;5360;5361;5174.146265866128;5194.480551944813;5279.894402111936;5302.337207849019;5328.067588172094;5774.364819869811;5774.711264436762;5817.592768506206;5834.6790926499025;5863.912041319383;6157.138000679864;6172.074188871705;6200.875982480326;6207.131001659771;6218.81343559694;6185.87628247437;6239.032949892774;6244.531660125509;6250.468710159596;6256.217972753406;5833.912491312592;5932.2881254248905;6009.789657361971;6060.33336333003;6069.757209711651;6238.189035425366;6253.312135665074;6263.31103578606;6277.466415354746;6293.1504246927;6195.721192546346;6250.124982502453;6256.812295631138;6267.71795269214;6274.6548939808745;6152.89247935367;6191.876162476815;6204.410580994799;6210.596311239755;6221.471174950089;6218.378162183745;6221.968890155611;6244.188255526752;6246.968765156145;6255.624662520263;6227.96886015567;6233.781817636361;6239.719212635442;6243.875122497525;6249.875002500015;4991.775370108354;5089.592832573385;5093.490650934877;5094.133997220407;5104;4497.752623605667;4511.345854851028;4511.390962220124;4523.434570678665;4580.954190458119;5932.79235226765;6029.487493563096;6030.306514750772;6034.818955431344;6037.879242415127;6175.783847565313;6224.595401298901;6233.625982440977;6244.46922011625;6251.28110267316;5889.646621202742;5935.376785437553;5942.049272116441;5951.613145145551;5961.970190149022;5436.293281873332;5491.203775452537;5503.559715222773;5543.750531226105;5570.637908535932;6360.204974378203;6380.649064301415;6394.328595497405;6407.551471396958;6430.453411460078;6189.412005859436;6204.317525072148;6231.2522497300615;6238.6880655966115;6255.937440625536;6186.845328866814;6220.7511699531515;6249.96875015622;6391.96804015977;6394.392532709385;6180.258368995749;6238.469730072813;6247.875042499034;6250.312465628868;6256.7810126645345;6246.1255424239735;6257.342978987141;6267.435930766071;6276.843078923063;6284.748610055546;5342.097400657429;6047.606905551125;6106.572539922163;6138.570300078952;6194.318624951162;6125.235451818428;6137.652792202512;6139.737467782926;6198.938010620016;6228.875422491616;6179.0422484514975;6186.597871138361;6187.3503282154725;6198.504119670325;6203.658798766111;6161.507079433724;6181.35095814933;6207.193064901534;6211.9068213977735;6214.689265536796;6049.153118563317;6094.238220222473;6102.908456373069;6122.724477398617;6143.447089761943 09:10:33 INFO - PROCESS | 1641 | |1;ext.html;477.9115863565241;479.63547703745155;538.690253104465;539.1804457225018;561.2535328013743;32217;41478.75563733089;43077.92305192372;43215.35176972344;45406;44800.77599612006;45097;45174;45232;45256;8621.13788621139;9584.233261339075;9800.950995245013;9833.016698330146;9851.90148098517;8289.336853051771;8988.505632190227;9350.485723285217;11859.407029648526;12082.879171208308;12076;12135.757284854297;12152.08859335549;12171.57399491018;12172.81740773889;12028.398580071005;12069.698257543543;12080.15438919276;12096.879031209708;12101.273923564615;11967.700807479883;12022.879771202352;12028.759424811455;12031;12038.879611203864;41620.37569436461;41673.541426050244;41783.79108104471;41827.372589411185;41878.371824422655;4051.351783714621;4055.4322394864744;4110.979445102786;4119.155573107506;4134.772587507686;30369.696303036908;31088.37823243545;31389.215269618442;32476;32718.6728132718;3397.575303087114;3420.6921377076183;3434.9141271468166;3558.217192217708;3564.7861128332383;383933;388431;389025;389111;390464.09535904846;62959;63283.6835815818;63331.05003424952;63442.0483692745;63442.36557634457;62231.377686223466;62311;67234;67245;67322.66338668275;17175.31298748036;17634.470965871045;17652.940823550627;17660.558486037695;17661.470155895342;13566.321683915961;13602.93198534001;13609.455621775216;13619.591412257649;13640.045196836127;14721;15085.47200847965;15089.170095644626;15335.539933801781;15383.307751151226;6491.383318584727;7130.500864939509;7130.964345178241;7138.464615153885;7233.168185658611;791.8218400859761;882.668999125328;886.5478605910903;887.4763889305211;910.927125829932;25332.493350132892;25501.132474581787;29182.124536263946;29930.70069299323;30808.229794254876;881.4358810361374;1077.6820837852852;1132.224426268009;1173.6713720158368;1220.9389530523438;14461.27693615315;14545.34545945435;14858.102669979466;14890.181040042686;14894.925525372304;408574;410915;411051;411292;411813;49892.25161622579;50532;56145.1578226327;56599.71700141473;56717.71641141851;1457.7813328000673;1465.7728052151933;1488.3302513868587;1492.8731057859986;1503.443725821453;28179.43641127125;30120.84939575288;30188.84905575458;30832.383352333276;31033.844830775703;39162.80418597889;47227.29159062548;48397.75801120972;48430.757846210545;48626;358263;359138;359397;359772;360605;37222.069448262926;37878.62121378751;38078.238435231695;38100.42849357317;38213.23573528569;35841.64158358383;43932.12135757203;44819.679795483644;45161.77419112883;45891;29948.85025574858;31292.374152517277;31426.371472570878;31902;32190.03429897107;30456.238594035327;31736;31914.84042579865;31930.88241911522;32082.51876221812;35509.1122721934;36221.456678150375;36352;36655.45016824803;36860.81569592135;30536.82921243198;31153.221169470944;31624.525632115077;31677.36645267128;31783.84108079445;24424.51150976935;24436.633450497902;24708.382290442165;24948.875255623607;25004.749952500242 09:10:33 INFO - PROCESS | 1641 | |2;jquery.html;404.1996846244434;406.8311650664973;410.26253815093094;418.5960548071111;437.24575107938807;20452.386428407135;20532.973351332428;21744.13023479059;21923.12307507698;21964.45088872779;18620.62758744824;22201.44496387591;22924.770752292472;22929.656055159143;23262.069517219334;5946.821595352147;6327.335629758878;6353.872922541546;6356;6364.427201551859;5192.376914770233;5573.916391254114;6186.226721659793;6205;6222;6147.815565533041;6151.753929842801;6152.784652537162;6152.938470615281;6154.015357542794;5950.642961422307;6186.412290832363;6230.532710046719;6239.906401403982;6254.155688981998;5246.160614301693;5363.758630861621;5476.726163691799;5483.040467918138;5484.287042684426;27186.184414467596;27297.45405091887;27334;27365.905363785423;27595;2525.6085306777295;2657.906973255927;2856.901444852556;2858.3278781912604;2875.3674191677796;15883.92058039714;16424.42514511998;16575.585610359718;16627.418040368528;16650.944102541023;1864.254298280685;1890.0644181130428;1904.1526520698294;1928.758905136858;1949.3469687654654;121232.1815172773;123537.38231308876;124939.37530312382;125863;127787.99999999907;11164.274322169033;11667.708307292385;11676.649700508999;11773.293602383885;11839.704007399883;15113.09321440717;15123.546293611209;15148.318325675371;15149.924250378677;15206.543803685907;8837.381383303236;8989.41568798026;9068.093190681011;9071.909280907239;9171.715959765505;7318.505834096594;8998.190162885372;9005.189532942066;9148.496832674267;9173.81652366949;7304.259826074886;7460.813479662943;7487.363574096154;7494.288042635941;7496.662650180755;1685.957851053709;1970.9014549272479;1988.9403317900485;1998.3005947918402;2000.1699294792788;905.5019739143445;975.531744762518;995.8298998676526;1000.5247507433911;1015.5480811039017;19043.61912761737;19587.314443994394;20461.18155273802;20628.48428789262;20706.896465517577;1057.5875408590655;1058.6982709927788;1083.182197440927;1093.4204871418;1104.4256986367045;8870.64517419296;10675.89324106749;10911.781764364669;10943.233973621771;10948.781024379468;748267;756086;763161;768553;792064;93112.05216907174;122570;123054;126821;127795.36102319429;1048.7011201807447;1054.99472502637;1092.8415379770047;1095.3592148593002;1096.270979798425;17954.102294884942;17976.01131937756;18384.356547520772;18405.723914141567;18643.813561864208;54036.18945715896;54495;54847.45152548583;55026.89946201134;55878;74487.51024979579;75357.24642753502;76309.85535216866;76459.61770191336;77558;8099.8380032397845;8126.55303958288;8406.579671016547;8461.06928237881;8604.397692161489;11663.125265604944;13023.609291721263;13240.47038118503;13703.794443083561;13743.725125497635;8986.505742184243;11308.547658093585;11456.541738330374;11782.823257651313;11790.94104529472;10380.740481488023;10502.949705029436;10586;10698.73253168677;10890.237683362406;11572.768544628892;11672.766544669228;11674.241174323643;11775.52897884075;11970.940145299217;6999.825004374931;8225.753227403187;8314.501129931981;8399.874001890099;8582.871256931276;11368.78222966967;11537.423128843691;11833.171677982458;11855.822162667395;11886.762264754829 09:10:33 INFO - PROCESS | 1641 | |3;mootools.html;1205.7467931734336;1465.7728052151913;1488.903221290616;1497.1092200140913;1498.625343664084;7612;7997.200279972;8279.710210142646;8502.574871256444;8512.829743405127;8432.789180270496;8485.575721213945;8493.872591911126;8496.49021058737;8502.234798868101;2366.337425520853;2404.8917798699013;2409.92758222591;2410.554047501209;2416.35966468885;2137.668661357492;2213.612617791888;2332.568474832153;2401.1475926046264;2404.338806828119;2355.1521452277166;2361.811055115595;2363.444590521226;2364.0425627620757;2371.490129622131;2327.592671282527;2360.799332056777;2362.11420717231;2363.95272094558;2365.503244318695;2351.58847201739;2358.3986083548757;2369.57347677418;2399.9760002399926;2401.951960960771;8520.914790852135;8583.52790596517;8586.613602387908;8593.871091933626;8611.698590549364;5210.635255532115;5384.380796208447;5386.649867758622;5394.514493695547;5396.541293990015;3391.6608339166132;3553.3603951288756;3592.604813470516;3650.543682039745;3660.68884144848;1070.689500044986;1208.64949164743;1244.8319476870688;1311.2853494845333;1312.08154291996;10836.187285953507;10918.344899306067;10931.453427328603;10937.617183398623;10944.835827462515;4547.1815073287125;4738.691985020962;4745.715257084586;4754.286856971482;4763.785629646674;9705.951470242604;9710.465924374086;9720.416774993522;9729.221662267002;9741.977092405195;5437.510624043776;5438.428964958702;5442.782288708408;5452.154915988028;5455.072637651609;4460.687751857339;4792.2092854678585;4918.3360246367;4985.426675932242;4986.551210391082;3747.6252374762307;3810.1236715555024;3811.19964807388;3813.923721525554;3816.656500914931;1243.8445194350707;1250.9499620015097;1284.7302066566126;1285.479380850757;1289.2457912121326;899.8605216191501;925.4031149908271;927.4342650982895;931.8276118918022;978.2418625565244;5738.713064346766;5755.079187330007;5888.381719919433;6069.484093852072;6079.452849243589;955.9330846840794;962.552413127899;995.3430735714394;1015.8730158730159;1032.7211652853687;3898.2203559288255;3915.295246855593;3917.666998305119;3978.76127432355;4055.270051390719;9794.853077203705;9984.950075249722;10031.498425078717;10063.949680251699;10328.328658637165;9967.80064398708;10011.099001089937;10019.549120289605;10026.147777438999;10035.899641003643;6302.621842689362;7881.724139655084;7886.723964661324;8012.919870801217;8040.195980401913;5482.616216864941;5742.109972954198;5870.148828419769;6014.939850601438;6064.3935606439;9227.492487913229;9243.983161852057;9337.813243735223;9438.716838494856;9447.81104377895;8214.05538363096;9022.909770902206;9324.487153206639;9472;9584.28117891175;7160.033395491542;7176.892346614701;7225.060742103493;7339.74310899116;7348.191698913009;7357.117145942521;8049.27556519916;8116.026076870813;8126.512409255463;8141.674333026613;6017.939820601738;7030.859382812213;7087.574745515286;7122.287771223044;7161.677724502514;6934.410575101173;7042.823929401806;7062.39969602569;7062.788116356517;7087.7164913402885;5877.735501902339;6644.700988455627;6645.800625981228;6653.268140504638;6672.366125218096;4964.404271487445;5006.3992320921725;5013.035085275276;5108.897822043464;5268.841934741964;5117.257997590403;5142.794288228429;5166.483351664803;5209.76556054986;5246.186841039645 09:10:33 INFO - PROCESS | 1641 | |4;prototype.html;370.2391585292225;372.12550506310157;382.5428612807696;382.6364953294371;384.3005729572178;5343.358796944362;5360.3299587551555;5401.621886467939;5427.1316589345715;5462.371827239868;5111.926495435963;5328.774381892167;5390.460953904608;5419.287787865315;5425.810096646618;3522.4716292556195;4153.760067147629;4191.434156388894;4247.5964783345535;4262.275413179751;3695.8173384516967;3914.2367238388524;4035.267377675653;4053.574374690659;4274.764887931163;3179.2210908327374;3406.386850366933;3534.964650353489;3625.4380571011534;4250.128723611652;4033.415154802552;4195.622393984556;4212.641925436311;4219.38818871265;4249.043965107857;3751.681107105899;3753.887383378503;3755.1738617504107;3765.8305376258136;3770.0584199137465;4450.132224216279;4659.881628409191;4749.815085060842;4872.221639101738;4893.972265824181;4628.305754136873;4826.975865120652;4874.268859671042;4883.8779030524165;4896.436909755353;4919.425783749201;5573.41479144692;5680.358633235565;5681.57388195887;5748.770049198069;3629.7096232301615;4118.670506359484;4150.252954468195;4193.727407718488;4231.217224813419;4758.690685105492;5435.619506634537;5969.432903874125;5998.790042348497;6050.546209034296;3785;3798.525184351956;3908.355121404936;3918.9020274493364;3929.092471571074;3986.0034991252187;3999.200159968018;4006.258842114218;4012.0972781124597;4022.4948058174446;4304.5910638489295;4385.473743150842;4648.349231107648;4656.930146047812;4697.248440249612;5697.886042279214;5706.4864162225595;5728.513076388554;5769.711514424262;5786.350889996415;1168.760404117154;1312.665270356053;1321.9405126769318;1328.6912391294568;1334.9599512014654;784.1296161260996;791.4459878085363;891.5542228885557;903.7379160043514;904.3669431398048;4867;5095.490450954875;5096.286519887219;5099.719515426687;5197.8180763673845;4752.857414277577;4874.319124481521;5144.562712169508;5311.468853114658;5738.569607279387;4652.534156896782;4810.5670489656095;4950.430700469492;5034.295198672189;5159.303494028258;2688.6639170103736;2707.742764437375;2922.509520144699;2944.8822047118306;3016.9245768855953;5234.816781412708;5565.693886836263;5756.33802112754;5759.078547432475;5780.624259423208;4882.853514394574;5391.2182733504205;5661.886762264731;5728.885422291531;5766.913496297559;5190.572592537007;5291.989044163271;5697.772089116389;5855.765769369263;5882.176495290662;5036.773345199402;5570.966597192077;5648.293963254593;5791.8552036199435;5868.122200895672;4782.354382158364;5472.972635136799;5516.062269414129;5580.74433252515;5766.596338256281;4986.825461108844;5300.727825321972;6030.306514750684;6059.697015149313;6135.11040899076;3349.497575363715;3662;3968.66266367362;3972.5828787978003;3974.20515896816;4869.831240502324;5503.972480137573;5756.568257380797;5841.824745257649;5858.355580886014;5430.782768689208;5462.481064298885;5607.691576963306;5663;5692.51613612831;4850.466448690711;5331.866703332447;5698.914516282176;5738.512226460798;5744.965906136768;4803.327534145293;4897.828575999965;4901.362822833152;4948.901021979612;5561.610687252015;4648.767561621973;4924.8276310328965;5016.974915125401;5593.748281327432;5714.428532153524;5239.554637855673;5486.827319265826;5526.392096869261;5532.5020748132865;5535.837474130478 09:10:33 INFO - PROCESS | 1641 | |5;yui.html;754.2344520311881;777.3392616276166;792.759857342963;869.7173418638941;888.2006194425016;15263.923680381597;15451;16118.7582186267;16133.677326453479;16160.27278772455;14464.421423143089;14881.627959300995;15890.126043067627;16432.342706291733;16568.00591964483;906.5331354352497;927.4713413354391;927.9860802087974;929.2287401456808;929.7815013471828;735.2206660939421;755.9508631938934;890.3856339126015;914.73015460439;917.5137177296044;951.5813042261383;957.2533423929311;957.7461972577238;958.966436174734;959.4003747657714;952.2857856607544;954.4273435938451;954.9856752148723;954.9972528844754;956.3257903178243;713.0979311171373;713.1121753416977;713.3401603516726;713.8393861381147;715.141829804237;13585.864141358657;13835.446582136703;15769.526914192593;16131.435399761069;16222.026678399216;14453.277336133151;14632.195229262386;14672.10922096834;14730.042547234396;15070.472533461276;11583.36291503967;11736;11806.409679516075;11892;12040.759184816254;3742.0644838790304;3845.5193100862393;3853.364194907837;4016.879493615196;4021.2761702893467;109904;112036.4398178012;113135.30297045551;113286;113378.43310783476;11312.264702794457;11317.60388386419;11446.54213831454;11566.42167891602;11998.820017699742;19229.326973556137;21796.237131700633;22619.773802262094;23332.7666723334;23732;8173.182681731898;8177.71378001779;8263.586820658944;8278.172182781795;8569.571521423904;4462.620677242471;4526.660500462479;4591.931121033187;4783.210770222874;4785.258284965836;3753.418220175877;3793.1844653399653;3820.426935959573;3821.808909554511;3857.3828187490426;696.3976160621128;701.6246308225075;708.3624737736079;714.8927660850914;716.358858821352;686.8214264291221;687.9380855722909;700.2297472779901;720.5784615999698;758.0940775772898;9950.522264980787;10263.846042309371;10449.84325235122;10674.73313167177;10777.62278320255;703.3810246982724;725.4812808841704;743.4164181117796;746.2127455534355;777.2654841175148;4734.100520901018;5075.416327122354;5191.9480805192225;5192.247124166975;5204.7918083276245;113092;116266.83733162729;116430;116970.41514792542;117462.23806642907;85961.57019214863;94051.0594894056;97603.51198244105;100139;101796;68562.65718671474;73309;74062.62968685121;75964.62017689766;81968.18031819606;10777.424696773063;10823.621173258898;10974.286671366335;11092.33445993243;11120.332780033224;47105.52894471012;49417.787843790036;49656.75171624119;51969.74015130052;53565.732171338896;62581.68709156425;67105;73749.6312518434;74309;75214;13181.868181318065;13448.798268026183;13578.660533486742;13643.79534307006;14002;12416.627501174979;13791.724165516835;14602.269886505845;15057.774133388228;15520;13583.660408489866;14011.579652610439;14105.294735263402;14129.788053179416;14283.928580357448;11510.482028308914;12123.393830308272;13364.264965426995;14163.787543186654;14342.067765595202;12799.872001279868;13778.724425511635;13824.820914955088;14265.964352432069;14440.205788681304;9319.254459643076;9987;10079.395236285847;10125.392476451436;10345.689629311133;8509.343113040342;9185.586648600696;10402.295403195072;11103.5558577656;11351.716207094889 09:10:33 INFO - PROCESS | 1641 | __end_tp_report 09:10:33 INFO - PROCESS | 1641 | __start_cc_report 09:10:33 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1514 09:10:33 INFO - PROCESS | 1641 | __end_cc_report 09:10:33 INFO - PROCESS | 1641 | __startTimestamp1491322233866__endTimestamp 09:10:33 INFO - PROCESS | 1641 | 09:10:33 INFO - PROCESS | 1641 | ------- Summary: start ------- 09:10:33 INFO - PROCESS | 1641 | Number of tests: 6 09:10:33 INFO - PROCESS | 1641 | 09:10:33 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5828.91 Median:6125.24 stddev:616.79 (10.1%) stddev-sans-first:589.34 09:10:33 INFO - PROCESS | 1641 | Values: 3432.8 3454.4 3471.0 3477.3 3523.4 5813.1 5826.9 5895.1 5914.7 5920.8 5809.7 5899.3 5902.8 5903.9 5918.0 5036.0 5207.8 5240.1 5251.7 5278.0 5222.7 5254.9 5261.3 5345.7 5355.7 5268.5 5299.0 5303.1 5335.0 5357.5 5320.4 5324.6 5341.7 5360.0 5361.0 5174.1 5194.5 5279.9 5302.3 5328.1 5774.4 5774.7 5817.6 5834.7 5863.9 6157.1 6172.1 6200.9 6207.1 6218.8 6185.9 6239.0 6244.5 6250.5 6256.2 5833.9 5932.3 6009.8 6060.3 6069.8 6238.2 6253.3 6263.3 6277.5 6293.2 6195.7 6250.1 6256.8 6267.7 6274.7 6152.9 6191.9 6204.4 6210.6 6221.5 6218.4 6222.0 6244.2 6247.0 6255.6 6228.0 6233.8 6239.7 6243.9 6249.9 4991.8 5089.6 5093.5 5094.1 5104.0 4497.8 4511.3 4511.4 4523.4 4581.0 5932.8 6029.5 6030.3 6034.8 6037.9 6175.8 6224.6 6233.6 6244.5 6251.3 5889.6 5935.4 5942.0 5951.6 5962.0 5436.3 5491.2 5503.6 5543.8 5570.6 6360.2 6380.6 6394.3 6407.6 6430.5 6189.4 6204.3 6231.3 6238.7 6255.9 6186.8 6220.8 6250.0 6392.0 6394.4 6180.3 6238.5 6247.9 6250.3 6256.8 6246.1 6257.3 6267.4 6276.8 6284.7 5342.1 6047.6 6106.6 6138.6 6194.3 6125.2 6137.7 6139.7 6198.9 6228.9 6179.0 6186.6 6187.4 6198.5 6203.7 6161.5 6181.4 6207.2 6211.9 6214.7 6049.2 6094.2 6102.9 6122.7 6143.4 09:10:33 INFO - PROCESS | 1641 | 09:10:33 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:54913.72 Median:359267.50 stddev:101860.49 (28.4%) stddev-sans-first:102064.24 09:10:33 INFO - PROCESS | 1641 | Values: 477.9 479.6 538.7 539.2 561.3 32217.0 41478.8 43077.9 43215.4 45406.0 44800.8 45097.0 45174.0 45232.0 45256.0 8621.1 9584.2 9801.0 9833.0 9851.9 8289.3 8988.5 9350.5 11859.4 12082.9 12076.0 12135.8 12152.1 12171.6 12172.8 12028.4 12069.7 12080.2 12096.9 12101.3 11967.7 12022.9 12028.8 12031.0 12038.9 41620.4 41673.5 41783.8 41827.4 41878.4 4051.4 4055.4 4111.0 4119.2 4134.8 30369.7 31088.4 31389.2 32476.0 32718.7 3397.6 3420.7 3434.9 3558.2 3564.8 383933.0 388431.0 389025.0 389111.0 390464.1 62959.0 63283.7 63331.1 63442.0 63442.4 62231.4 62311.0 67234.0 67245.0 67322.7 17175.3 17634.5 17652.9 17660.6 17661.5 13566.3 13602.9 13609.5 13619.6 13640.0 14721.0 15085.5 15089.2 15335.5 15383.3 6491.4 7130.5 7131.0 7138.5 7233.2 791.8 882.7 886.5 887.5 910.9 25332.5 25501.1 29182.1 29930.7 30808.2 881.4 1077.7 1132.2 1173.7 1220.9 14461.3 14545.3 14858.1 14890.2 14894.9 408574.0 410915.0 411051.0 411292.0 411813.0 49892.3 50532.0 56145.2 56599.7 56717.7 1457.8 1465.8 1488.3 1492.9 1503.4 28179.4 30120.8 30188.8 30832.4 31033.8 39162.8 47227.3 48397.8 48430.8 48626.0 358263.0 359138.0 359397.0 359772.0 360605.0 37222.1 37878.6 38078.2 38100.4 38213.2 35841.6 43932.1 44819.7 45161.8 45891.0 29948.9 31292.4 31426.4 31902.0 32190.0 30456.2 31736.0 31914.8 31930.9 32082.5 35509.1 36221.5 36352.0 36655.5 36860.8 30536.8 31153.2 31624.5 31677.4 31783.8 24424.5 24436.6 24708.4 24948.9 25004.7 09:10:33 INFO - PROCESS | 1641 | 09:10:33 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:40067.05 Median:22563.11 stddev:126358.93 (560.0%) stddev-sans-first:126678.30 09:10:33 INFO - PROCESS | 1641 | Values: 404.2 406.8 410.3 418.6 437.2 20452.4 20533.0 21744.1 21923.1 21964.5 18620.6 22201.4 22924.8 22929.7 23262.1 5946.8 6327.3 6353.9 6356.0 6364.4 5192.4 5573.9 6186.2 6205.0 6222.0 6147.8 6151.8 6152.8 6152.9 6154.0 5950.6 6186.4 6230.5 6239.9 6254.2 5246.2 5363.8 5476.7 5483.0 5484.3 27186.2 27297.5 27334.0 27365.9 27595.0 2525.6 2657.9 2856.9 2858.3 2875.4 15883.9 16424.4 16575.6 16627.4 16650.9 1864.3 1890.1 1904.2 1928.8 1949.3 121232.2 123537.4 124939.4 125863.0 127788.0 11164.3 11667.7 11676.6 11773.3 11839.7 15113.1 15123.5 15148.3 15149.9 15206.5 8837.4 8989.4 9068.1 9071.9 9171.7 7318.5 8998.2 9005.2 9148.5 9173.8 7304.3 7460.8 7487.4 7494.3 7496.7 1686.0 1970.9 1988.9 1998.3 2000.2 905.5 975.5 995.8 1000.5 1015.5 19043.6 19587.3 20461.2 20628.5 20706.9 1057.6 1058.7 1083.2 1093.4 1104.4 8870.6 10675.9 10911.8 10943.2 10948.8 748267.0 756086.0 763161.0 768553.0 792064.0 93112.1 122570.0 123054.0 126821.0 127795.4 1048.7 1055.0 1092.8 1095.4 1096.3 17954.1 17976.0 18384.4 18405.7 18643.8 54036.2 54495.0 54847.5 55026.9 55878.0 74487.5 75357.2 76309.9 76459.6 77558.0 8099.8 8126.6 8406.6 8461.1 8604.4 11663.1 13023.6 13240.5 13703.8 13743.7 8986.5 11308.5 11456.5 11782.8 11790.9 10380.7 10502.9 10586.0 10698.7 10890.2 11572.8 11672.8 11674.2 11775.5 11970.9 6999.8 8225.8 8314.5 8399.9 8582.9 11368.8 11537.4 11833.2 11855.8 11886.8 09:10:33 INFO - PROCESS | 1641 | 09:10:33 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5526.38 Median:5385.52 stddev:2969.51 (55.1%) stddev-sans-first:2960.08 09:10:33 INFO - PROCESS | 1641 | Values: 1205.7 1465.8 1488.9 1497.1 1498.6 7612.0 7997.2 8279.7 8502.6 8512.8 8432.8 8485.6 8493.9 8496.5 8502.2 2366.3 2404.9 2409.9 2410.6 2416.4 2137.7 2213.6 2332.6 2401.1 2404.3 2355.2 2361.8 2363.4 2364.0 2371.5 2327.6 2360.8 2362.1 2364.0 2365.5 2351.6 2358.4 2369.6 2400.0 2402.0 8520.9 8583.5 8586.6 8593.9 8611.7 5210.6 5384.4 5386.6 5394.5 5396.5 3391.7 3553.4 3592.6 3650.5 3660.7 1070.7 1208.6 1244.8 1311.3 1312.1 10836.2 10918.3 10931.5 10937.6 10944.8 4547.2 4738.7 4745.7 4754.3 4763.8 9706.0 9710.5 9720.4 9729.2 9742.0 5437.5 5438.4 5442.8 5452.2 5455.1 4460.7 4792.2 4918.3 4985.4 4986.6 3747.6 3810.1 3811.2 3813.9 3816.7 1243.8 1250.9 1284.7 1285.5 1289.2 899.9 925.4 927.4 931.8 978.2 5738.7 5755.1 5888.4 6069.5 6079.5 955.9 962.6 995.3 1015.9 1032.7 3898.2 3915.3 3917.7 3978.8 4055.3 9794.9 9985.0 10031.5 10063.9 10328.3 9967.8 10011.1 10019.5 10026.1 10035.9 6302.6 7881.7 7886.7 8012.9 8040.2 5482.6 5742.1 5870.1 6014.9 6064.4 9227.5 9244.0 9337.8 9438.7 9447.8 8214.1 9022.9 9324.5 9472.0 9584.3 7160.0 7176.9 7225.1 7339.7 7348.2 7357.1 8049.3 8116.0 8126.5 8141.7 6017.9 7030.9 7087.6 7122.3 7161.7 6934.4 7042.8 7062.4 7062.8 7087.7 5877.7 6644.7 6645.8 6653.3 6672.4 4964.4 5006.4 5013.0 5108.9 5268.8 5117.3 5142.8 5166.5 5209.8 5246.2 09:10:33 INFO - PROCESS | 1641 | 09:10:33 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4535.30 Median:4936.86 stddev:1366.53 (27.7%) stddev-sans-first:1334.12 09:10:33 INFO - PROCESS | 1641 | Values: 370.2 372.1 382.5 382.6 384.3 5343.4 5360.3 5401.6 5427.1 5462.4 5111.9 5328.8 5390.5 5419.3 5425.8 3522.5 4153.8 4191.4 4247.6 4262.3 3695.8 3914.2 4035.3 4053.6 4274.8 3179.2 3406.4 3535.0 3625.4 4250.1 4033.4 4195.6 4212.6 4219.4 4249.0 3751.7 3753.9 3755.2 3765.8 3770.1 4450.1 4659.9 4749.8 4872.2 4894.0 4628.3 4827.0 4874.3 4883.9 4896.4 4919.4 5573.4 5680.4 5681.6 5748.8 3629.7 4118.7 4150.3 4193.7 4231.2 4758.7 5435.6 5969.4 5998.8 6050.5 3785.0 3798.5 3908.4 3918.9 3929.1 3986.0 3999.2 4006.3 4012.1 4022.5 4304.6 4385.5 4648.3 4656.9 4697.2 5697.9 5706.5 5728.5 5769.7 5786.4 1168.8 1312.7 1321.9 1328.7 1335.0 784.1 791.4 891.6 903.7 904.4 4867.0 5095.5 5096.3 5099.7 5197.8 4752.9 4874.3 5144.6 5311.5 5738.6 4652.5 4810.6 4950.4 5034.3 5159.3 2688.7 2707.7 2922.5 2944.9 3016.9 5234.8 5565.7 5756.3 5759.1 5780.6 4882.9 5391.2 5661.9 5728.9 5766.9 5190.6 5292.0 5697.8 5855.8 5882.2 5036.8 5571.0 5648.3 5791.9 5868.1 4782.4 5473.0 5516.1 5580.7 5766.6 4986.8 5300.7 6030.3 6059.7 6135.1 3349.5 3662.0 3968.7 3972.6 3974.2 4869.8 5504.0 5756.6 5841.8 5858.4 5430.8 5462.5 5607.7 5663.0 5692.5 4850.5 5331.9 5698.9 5738.5 5745.0 4803.3 4897.8 4901.4 4948.9 5561.6 4648.8 4924.8 5017.0 5593.7 5714.4 5239.6 5486.8 5526.4 5532.5 5535.8 09:10:33 INFO - PROCESS | 1641 | 09:10:33 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:21392.13 Median:3821.12 stddev:31377.45 (821.2%) stddev-sans-first:31427.20 09:10:33 INFO - PROCESS | 1641 | Values: 754.2 777.3 792.8 869.7 888.2 15263.9 15451.0 16118.8 16133.7 16160.3 14464.4 14881.6 15890.1 16432.3 16568.0 906.5 927.5 928.0 929.2 929.8 735.2 756.0 890.4 914.7 917.5 951.6 957.3 957.7 959.0 959.4 952.3 954.4 955.0 955.0 956.3 713.1 713.1 713.3 713.8 715.1 13585.9 13835.4 15769.5 16131.4 16222.0 14453.3 14632.2 14672.1 14730.0 15070.5 11583.4 11736.0 11806.4 11892.0 12040.8 3742.1 3845.5 3853.4 4016.9 4021.3 109904.0 112036.4 113135.3 113286.0 113378.4 11312.3 11317.6 11446.5 11566.4 11998.8 19229.3 21796.2 22619.8 23332.8 23732.0 8173.2 8177.7 8263.6 8278.2 8569.6 4462.6 4526.7 4591.9 4783.2 4785.3 3753.4 3793.2 3820.4 3821.8 3857.4 696.4 701.6 708.4 714.9 716.4 686.8 687.9 700.2 720.6 758.1 9950.5 10263.8 10449.8 10674.7 10777.6 703.4 725.5 743.4 746.2 777.3 4734.1 5075.4 5191.9 5192.2 5204.8 113092.0 116266.8 116430.0 116970.4 117462.2 85961.6 94051.1 97603.5 100139.0 101796.0 68562.7 73309.0 74062.6 75964.6 81968.2 10777.4 10823.6 10974.3 11092.3 11120.3 47105.5 49417.8 49656.8 51969.7 53565.7 62581.7 67105.0 73749.6 74309.0 75214.0 13181.9 13448.8 13578.7 13643.8 14002.0 12416.6 13791.7 14602.3 15057.8 15520.0 13583.7 14011.6 14105.3 14129.8 14283.9 11510.5 12123.4 13364.3 14163.8 14342.1 12799.9 13778.7 13824.8 14266.0 14440.2 9319.3 9987.0 10079.4 10125.4 10345.7 8509.3 9185.6 10402.3 11103.6 11351.7 09:10:33 INFO - PROCESS | 1641 | -------- Summary: end -------- 09:10:33 INFO - PROCESS | 1641 | 09:10:34 INFO - TEST-INFO | 1641: exit 0 09:10:34 INFO - TEST-OK | dromaeo_css | took 1116693ms 09:10:34 INFO - TEST-START | kraken 09:10:34 INFO - operating with platform_type : mac_ 09:10:34 INFO - Initialising browser for kraken test... 09:10:34 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpqPh0ch/profile http://localhost:49245/getInfo.html) 09:10:36 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 09:10:36 INFO - PROCESS | 1650 | colorDepth:24 09:10:36 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 09:10:36 INFO - PROCESS | 1650 | __metrics 09:10:36 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:10:36 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:37 INFO - TEST-INFO | 1650: exit 0 09:10:37 INFO - Browser initialized. 09:10:37 INFO - Running cycle 1/1 for kraken test... 09:10:37 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpqPh0ch/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:49 INFO - PROCESS | 1652 | RSS: Main: 163594240 09:10:49 INFO - PROCESS | 1652 | 09:10:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 09:10:52 INFO - PROCESS | 1652 | RSS: Main: 213643264 09:10:52 INFO - PROCESS | 1652 | 09:10:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 09:10:56 INFO - PROCESS | 1652 | RSS: Main: 227975168 09:10:56 INFO - PROCESS | 1652 | 09:10:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 09:11:00 INFO - PROCESS | 1652 | RSS: Main: 326156288 09:11:00 INFO - PROCESS | 1652 | 09:11:02 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 09:11:02 INFO - PROCESS | 1652 | RSS: Main: 227864576 09:11:02 INFO - PROCESS | 1652 | 09:11:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:05 INFO - PROCESS | 1652 | RSS: Main: 229122048 09:11:05 INFO - PROCESS | 1652 | 09:11:08 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:08 INFO - PROCESS | 1652 | RSS: Main: 268722176 09:11:08 INFO - PROCESS | 1652 | 09:11:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:12 INFO - PROCESS | 1652 | RSS: Main: 267718656 09:11:12 INFO - PROCESS | 1652 | 09:11:15 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 09:11:15 INFO - PROCESS | 1652 | RSS: Main: 266264576 09:11:15 INFO - PROCESS | 1652 | 09:11:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:18 INFO - PROCESS | 1652 | RSS: Main: 242688000 09:11:18 INFO - PROCESS | 1652 | 09:11:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:20 INFO - PROCESS | 1652 | RSS: Main: 245690368 09:11:20 INFO - PROCESS | 1652 | 09:11:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:23 INFO - PROCESS | 1652 | RSS: Main: 253284352 09:11:23 INFO - PROCESS | 1652 | 09:11:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:26 INFO - PROCESS | 1652 | RSS: Main: 269017088 09:11:26 INFO - PROCESS | 1652 | 09:11:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:30 INFO - PROCESS | 1652 | RSS: Main: 263036928 09:11:30 INFO - PROCESS | 1652 | 09:11:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 09:11:32 INFO - PROCESS | 1652 | RSS: Main: 307154944 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | __start_tp_report 09:11:32 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 09:11:32 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 09:11:32 INFO - PROCESS | 1652 | |i|pagename|runs| 09:11:32 INFO - PROCESS | 1652 | |0;ai-astar;102;114;112;113;112;115;113;113;113;112 09:11:32 INFO - PROCESS | 1652 | |1;audio-beat-detection;150;135;139;148;108;107;103;107;125;107 09:11:32 INFO - PROCESS | 1652 | |2;audio-dft;181;181;181;196;258;201;182;195;257;200 09:11:32 INFO - PROCESS | 1652 | |3;audio-fft;80;59;60;90;61;58;58;58;72;57 09:11:32 INFO - PROCESS | 1652 | |4;audio-oscillator;87;71;85;70;89;90;103;94;99;109 09:11:32 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;87;85;88;85;92;83;87;85;88;84 09:11:32 INFO - PROCESS | 1652 | |6;imaging-darkroom;96;104;97;98;95;95;96;96;96;95 09:11:32 INFO - PROCESS | 1652 | |7;imaging-desaturate;85;81;88;84;88;85;86;85;87;85 09:11:32 INFO - PROCESS | 1652 | |8;json-parse-financial;53;50;53;49;55;55;53;52;76;85 09:11:32 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;63;74;76;70;69;66;68;68;71;68 09:11:32 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;84;83;80;94;81;80;78;87;82;83 09:11:32 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;133;131;129;137;123;132;131;138;170;144 09:11:32 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;161;160;200;162;159;216;161;161;164;160 09:11:32 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;63;65;64;64;65;64;61;62;62;64 09:11:32 INFO - PROCESS | 1652 | __end_tp_report 09:11:32 INFO - PROCESS | 1652 | __start_cc_report 09:11:32 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1914 09:11:32 INFO - PROCESS | 1652 | __end_cc_report 09:11:32 INFO - PROCESS | 1652 | __startTimestamp1491322292124__endTimestamp 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | ------- Summary: start ------- 09:11:32 INFO - PROCESS | 1652 | Number of tests: 14 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.60 (3.2%) stddev-sans-first:1.00 09:11:32 INFO - PROCESS | 1652 | Values: 102.0 114.0 112.0 113.0 112.0 115.0 113.0 113.0 113.0 112.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:130.00 stddev:18.71 (14.4%) stddev-sans-first:17.08 09:11:32 INFO - PROCESS | 1652 | Values: 150.0 135.0 139.0 148.0 108.0 107.0 103.0 107.0 125.0 107.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:203.20 Median:198.00 stddev:29.74 (15.0%) stddev-sans-first:30.44 09:11:32 INFO - PROCESS | 1652 | Values: 181.0 181.0 181.0 196.0 258.0 201.0 182.0 195.0 257.0 200.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.30 Median:60.50 stddev:11.48 (19.0%) stddev-sans-first:10.87 09:11:32 INFO - PROCESS | 1652 | Values: 80.0 59.0 60.0 90.0 61.0 58.0 58.0 58.0 72.0 57.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:88.00 stddev:12.57 (14.3%) stddev-sans-first:13.29 09:11:32 INFO - PROCESS | 1652 | Values: 87.0 71.0 85.0 70.0 89.0 90.0 103.0 94.0 99.0 109.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.00 stddev:2.59 (3.0%) stddev-sans-first:2.74 09:11:32 INFO - PROCESS | 1652 | Values: 87.0 85.0 88.0 85.0 92.0 83.0 87.0 85.0 88.0 84.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:96.00 stddev:2.70 (2.8%) stddev-sans-first:2.85 09:11:32 INFO - PROCESS | 1652 | Values: 96.0 104.0 97.0 98.0 95.0 95.0 96.0 96.0 96.0 95.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:2.07 (2.4%) stddev-sans-first:2.19 09:11:32 INFO - PROCESS | 1652 | Values: 85.0 81.0 88.0 84.0 88.0 85.0 86.0 85.0 87.0 85.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:54.00 stddev:12.14 (22.5%) stddev-sans-first:12.74 09:11:32 INFO - PROCESS | 1652 | Values: 53.0 50.0 53.0 49.0 55.0 55.0 53.0 52.0 76.0 85.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:3.74 (5.4%) stddev-sans-first:3.20 09:11:32 INFO - PROCESS | 1652 | Values: 63.0 74.0 76.0 70.0 69.0 66.0 68.0 68.0 71.0 68.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:4.54 (5.5%) stddev-sans-first:4.81 09:11:32 INFO - PROCESS | 1652 | Values: 84.0 83.0 80.0 94.0 81.0 80.0 78.0 87.0 82.0 83.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:135.00 stddev:12.96 (9.6%) stddev-sans-first:13.67 09:11:32 INFO - PROCESS | 1652 | Values: 133.0 131.0 129.0 137.0 123.0 132.0 131.0 138.0 170.0 144.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:161.50 stddev:20.22 (12.5%) stddev-sans-first:21.15 09:11:32 INFO - PROCESS | 1652 | Values: 161.0 160.0 200.0 162.0 159.0 216.0 161.0 161.0 164.0 160.0 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 09:11:32 INFO - PROCESS | 1652 | Values: 63.0 65.0 64.0 64.0 65.0 64.0 61.0 62.0 62.0 64.0 09:11:32 INFO - PROCESS | 1652 | -------- Summary: end -------- 09:11:32 INFO - PROCESS | 1652 | 09:11:32 INFO - TEST-INFO | 1652: exit 0 09:11:32 INFO - TEST-OK | kraken | took 58525ms 09:11:32 INFO - SUITE-END | took 1175s 09:11:33 INFO - Completed test suite (00:19:35) 09:11:33 INFO - javascript benchmark 09:11:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3432.8455219515117, 3454.378211921853, 3470.982645086774, 3477.2523907359914, 3523.4186359250725, 5813.06990881459, 5826.912596311054, 5895.086261629449, 5914.733836977335, 5920.763169473226, 5809.709514524278, 5899.292084949801, 5902.822915312537, 5903.940960590404, 5917.970410147954, 5036.017976494585, 5207.843764687065, 5240.082985477527, 5251.711155886424, 5277.973610131944, 5222.712750798704, 5254.947450525484, 5261.289725886994, 5345.679259244438, 5355.732213389334, 5268.473152684739, 5299.0, 5303.098473259555, 5335.0, 5357.517823395893, 5320.361556613192, 5324.627276090675, 5341.706206158659, 5360.0, 5361.0, 5174.146265866128, 5194.480551944813, 5279.894402111936, 5302.337207849019, 5328.067588172094, 5774.364819869811, 5774.711264436762, 5817.592768506206, 5834.6790926499025, 5863.912041319383, 6157.138000679864, 6172.074188871705, 6200.875982480326, 6207.131001659771, 6218.81343559694, 6185.87628247437, 6239.032949892774, 6244.531660125509, 6250.468710159596, 6256.217972753406, 5833.912491312592, 5932.2881254248905, 6009.789657361971, 6060.33336333003, 6069.757209711651, 6238.189035425366, 6253.312135665074, 6263.31103578606, 6277.466415354746, 6293.1504246927, 6195.721192546346, 6250.124982502453, 6256.812295631138, 6267.71795269214, 6274.6548939808745, 6152.89247935367, 6191.876162476815, 6204.410580994799, 6210.596311239755, 6221.471174950089, 6218.378162183745, 6221.968890155611, 6244.188255526752, 6246.968765156145, 6255.624662520263, 6227.96886015567, 6233.781817636361, 6239.719212635442, 6243.875122497525, 6249.875002500015, 4991.775370108354, 5089.592832573385, 5093.490650934877, 5094.133997220407, 5104.0, 4497.752623605667, 4511.345854851028, 4511.390962220124, 4523.434570678665, 4580.954190458119, 5932.79235226765, 6029.487493563096, 6030.306514750772, 6034.818955431344, 6037.879242415127, 6175.783847565313, 6224.595401298901, 6233.625982440977, 6244.46922011625, 6251.28110267316, 5889.646621202742, 5935.376785437553, 5942.049272116441, 5951.613145145551, 5961.970190149022, 5436.293281873332, 5491.203775452537, 5503.559715222773, 5543.750531226105, 5570.637908535932, 6360.204974378203, 6380.649064301415, 6394.328595497405, 6407.551471396958, 6430.453411460078, 6189.412005859436, 6204.317525072148, 6231.2522497300615, 6238.6880655966115, 6255.937440625536, 6186.845328866814, 6220.7511699531515, 6249.96875015622, 6391.96804015977, 6394.392532709385, 6180.258368995749, 6238.469730072813, 6247.875042499034, 6250.312465628868, 6256.7810126645345, 6246.1255424239735, 6257.342978987141, 6267.435930766071, 6276.843078923063, 6284.748610055546, 5342.097400657429, 6047.606905551125, 6106.572539922163, 6138.570300078952, 6194.318624951162, 6125.235451818428, 6137.652792202512, 6139.737467782926, 6198.938010620016, 6228.875422491616, 6179.0422484514975, 6186.597871138361, 6187.3503282154725, 6198.504119670325, 6203.658798766111, 6161.507079433724, 6181.35095814933, 6207.193064901534, 6211.9068213977735, 6214.689265536796, 6049.153118563317, 6094.238220222473, 6102.908456373069, 6122.724477398617, 6143.447089761943], "value": 5790.46751457265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.9115863565241, 479.63547703745155, 538.690253104465, 539.1804457225018, 561.2535328013743, 32217.0, 41478.75563733089, 43077.92305192372, 43215.35176972344, 45406.0, 44800.77599612006, 45097.0, 45174.0, 45232.0, 45256.0, 8621.13788621139, 9584.233261339075, 9800.950995245013, 9833.016698330146, 9851.90148098517, 8289.336853051771, 8988.505632190227, 9350.485723285217, 11859.407029648526, 12082.879171208308, 12076.0, 12135.757284854297, 12152.08859335549, 12171.57399491018, 12172.81740773889, 12028.398580071005, 12069.698257543543, 12080.15438919276, 12096.879031209708, 12101.273923564615, 11967.700807479883, 12022.879771202352, 12028.759424811455, 12031.0, 12038.879611203864, 41620.37569436461, 41673.541426050244, 41783.79108104471, 41827.372589411185, 41878.371824422655, 4051.351783714621, 4055.4322394864744, 4110.979445102786, 4119.155573107506, 4134.772587507686, 30369.696303036908, 31088.37823243545, 31389.215269618442, 32476.0, 32718.6728132718, 3397.575303087114, 3420.6921377076183, 3434.9141271468166, 3558.217192217708, 3564.7861128332383, 383933.0, 388431.0, 389025.0, 389111.0, 390464.09535904846, 62959.0, 63283.6835815818, 63331.05003424952, 63442.0483692745, 63442.36557634457, 62231.377686223466, 62311.0, 67234.0, 67245.0, 67322.66338668275, 17175.31298748036, 17634.470965871045, 17652.940823550627, 17660.558486037695, 17661.470155895342, 13566.321683915961, 13602.93198534001, 13609.455621775216, 13619.591412257649, 13640.045196836127, 14721.0, 15085.47200847965, 15089.170095644626, 15335.539933801781, 15383.307751151226, 6491.383318584727, 7130.500864939509, 7130.964345178241, 7138.464615153885, 7233.168185658611, 791.8218400859761, 882.668999125328, 886.5478605910903, 887.4763889305211, 910.927125829932, 25332.493350132892, 25501.132474581787, 29182.124536263946, 29930.70069299323, 30808.229794254876, 881.4358810361374, 1077.6820837852852, 1132.224426268009, 1173.6713720158368, 1220.9389530523438, 14461.27693615315, 14545.34545945435, 14858.102669979466, 14890.181040042686, 14894.925525372304, 408574.0, 410915.0, 411051.0, 411292.0, 411813.0, 49892.25161622579, 50532.0, 56145.1578226327, 56599.71700141473, 56717.71641141851, 1457.7813328000673, 1465.7728052151933, 1488.3302513868587, 1492.8731057859986, 1503.443725821453, 28179.43641127125, 30120.84939575288, 30188.84905575458, 30832.383352333276, 31033.844830775703, 39162.80418597889, 47227.29159062548, 48397.75801120972, 48430.757846210545, 48626.0, 358263.0, 359138.0, 359397.0, 359772.0, 360605.0, 37222.069448262926, 37878.62121378751, 38078.238435231695, 38100.42849357317, 38213.23573528569, 35841.64158358383, 43932.12135757203, 44819.679795483644, 45161.77419112883, 45891.0, 29948.85025574858, 31292.374152517277, 31426.371472570878, 31902.0, 32190.03429897107, 30456.238594035327, 31736.0, 31914.84042579865, 31930.88241911522, 32082.51876221812, 35509.1122721934, 36221.456678150375, 36352.0, 36655.45016824803, 36860.81569592135, 30536.82921243198, 31153.221169470944, 31624.525632115077, 31677.36645267128, 31783.84108079445, 24424.51150976935, 24436.633450497902, 24708.382290442165, 24948.875255623607, 25004.749952500242], "value": 19664.950804389966, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.1996846244434, 406.8311650664973, 410.26253815093094, 418.5960548071111, 437.24575107938807, 20452.386428407135, 20532.973351332428, 21744.13023479059, 21923.12307507698, 21964.45088872779, 18620.62758744824, 22201.44496387591, 22924.770752292472, 22929.656055159143, 23262.069517219334, 5946.821595352147, 6327.335629758878, 6353.872922541546, 6356.0, 6364.427201551859, 5192.376914770233, 5573.916391254114, 6186.226721659793, 6205.0, 6222.0, 6147.815565533041, 6151.753929842801, 6152.784652537162, 6152.938470615281, 6154.015357542794, 5950.642961422307, 6186.412290832363, 6230.532710046719, 6239.906401403982, 6254.155688981998, 5246.160614301693, 5363.758630861621, 5476.726163691799, 5483.040467918138, 5484.287042684426, 27186.184414467596, 27297.45405091887, 27334.0, 27365.905363785423, 27595.0, 2525.6085306777295, 2657.906973255927, 2856.901444852556, 2858.3278781912604, 2875.3674191677796, 15883.92058039714, 16424.42514511998, 16575.585610359718, 16627.418040368528, 16650.944102541023, 1864.254298280685, 1890.0644181130428, 1904.1526520698294, 1928.758905136858, 1949.3469687654654, 121232.1815172773, 123537.38231308876, 124939.37530312382, 125863.0, 127787.99999999907, 11164.274322169033, 11667.708307292385, 11676.649700508999, 11773.293602383885, 11839.704007399883, 15113.09321440717, 15123.546293611209, 15148.318325675371, 15149.924250378677, 15206.543803685907, 8837.381383303236, 8989.41568798026, 9068.093190681011, 9071.909280907239, 9171.715959765505, 7318.505834096594, 8998.190162885372, 9005.189532942066, 9148.496832674267, 9173.81652366949, 7304.259826074886, 7460.813479662943, 7487.363574096154, 7494.288042635941, 7496.662650180755, 1685.957851053709, 1970.9014549272479, 1988.9403317900485, 1998.3005947918402, 2000.1699294792788, 905.5019739143445, 975.531744762518, 995.8298998676526, 1000.5247507433911, 1015.5480811039017, 19043.61912761737, 19587.314443994394, 20461.18155273802, 20628.48428789262, 20706.896465517577, 1057.5875408590655, 1058.6982709927788, 1083.182197440927, 1093.4204871418, 1104.4256986367045, 8870.64517419296, 10675.89324106749, 10911.781764364669, 10943.233973621771, 10948.781024379468, 748267.0, 756086.0, 763161.0, 768553.0, 792064.0, 93112.05216907174, 122570.0, 123054.0, 126821.0, 127795.36102319429, 1048.7011201807447, 1054.99472502637, 1092.8415379770047, 1095.3592148593002, 1096.270979798425, 17954.102294884942, 17976.01131937756, 18384.356547520772, 18405.723914141567, 18643.813561864208, 54036.18945715896, 54495.0, 54847.45152548583, 55026.89946201134, 55878.0, 74487.51024979579, 75357.24642753502, 76309.85535216866, 76459.61770191336, 77558.0, 8099.8380032397845, 8126.55303958288, 8406.579671016547, 8461.06928237881, 8604.397692161489, 11663.125265604944, 13023.609291721263, 13240.47038118503, 13703.794443083561, 13743.725125497635, 8986.505742184243, 11308.547658093585, 11456.541738330374, 11782.823257651313, 11790.94104529472, 10380.740481488023, 10502.949705029436, 10586.0, 10698.73253168677, 10890.237683362406, 11572.768544628892, 11672.766544669228, 11674.241174323643, 11775.52897884075, 11970.940145299217, 6999.825004374931, 8225.753227403187, 8314.501129931981, 8399.874001890099, 8582.871256931276, 11368.78222966967, 11537.423128843691, 11833.171677982458, 11855.822162667395, 11886.762264754829], "value": 10202.041154347957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1205.7467931734336, 1465.7728052151913, 1488.903221290616, 1497.1092200140913, 1498.625343664084, 7612.0, 7997.200279972, 8279.710210142646, 8502.574871256444, 8512.829743405127, 8432.789180270496, 8485.575721213945, 8493.872591911126, 8496.49021058737, 8502.234798868101, 2366.337425520853, 2404.8917798699013, 2409.92758222591, 2410.554047501209, 2416.35966468885, 2137.668661357492, 2213.612617791888, 2332.568474832153, 2401.1475926046264, 2404.338806828119, 2355.1521452277166, 2361.811055115595, 2363.444590521226, 2364.0425627620757, 2371.490129622131, 2327.592671282527, 2360.799332056777, 2362.11420717231, 2363.95272094558, 2365.503244318695, 2351.58847201739, 2358.3986083548757, 2369.57347677418, 2399.9760002399926, 2401.951960960771, 8520.914790852135, 8583.52790596517, 8586.613602387908, 8593.871091933626, 8611.698590549364, 5210.635255532115, 5384.380796208447, 5386.649867758622, 5394.514493695547, 5396.541293990015, 3391.6608339166132, 3553.3603951288756, 3592.604813470516, 3650.543682039745, 3660.68884144848, 1070.689500044986, 1208.64949164743, 1244.8319476870688, 1311.2853494845333, 1312.08154291996, 10836.187285953507, 10918.344899306067, 10931.453427328603, 10937.617183398623, 10944.835827462515, 4547.1815073287125, 4738.691985020962, 4745.715257084586, 4754.286856971482, 4763.785629646674, 9705.951470242604, 9710.465924374086, 9720.416774993522, 9729.221662267002, 9741.977092405195, 5437.510624043776, 5438.428964958702, 5442.782288708408, 5452.154915988028, 5455.072637651609, 4460.687751857339, 4792.2092854678585, 4918.3360246367, 4985.426675932242, 4986.551210391082, 3747.6252374762307, 3810.1236715555024, 3811.19964807388, 3813.923721525554, 3816.656500914931, 1243.8445194350707, 1250.9499620015097, 1284.7302066566126, 1285.479380850757, 1289.2457912121326, 899.8605216191501, 925.4031149908271, 927.4342650982895, 931.8276118918022, 978.2418625565244, 5738.713064346766, 5755.079187330007, 5888.381719919433, 6069.484093852072, 6079.452849243589, 955.9330846840794, 962.552413127899, 995.3430735714394, 1015.8730158730159, 1032.7211652853687, 3898.2203559288255, 3915.295246855593, 3917.666998305119, 3978.76127432355, 4055.270051390719, 9794.853077203705, 9984.950075249722, 10031.498425078717, 10063.949680251699, 10328.328658637165, 9967.80064398708, 10011.099001089937, 10019.549120289605, 10026.147777438999, 10035.899641003643, 6302.621842689362, 7881.724139655084, 7886.723964661324, 8012.919870801217, 8040.195980401913, 5482.616216864941, 5742.109972954198, 5870.148828419769, 6014.939850601438, 6064.3935606439, 9227.492487913229, 9243.983161852057, 9337.813243735223, 9438.716838494856, 9447.81104377895, 8214.05538363096, 9022.909770902206, 9324.487153206639, 9472.0, 9584.28117891175, 7160.033395491542, 7176.892346614701, 7225.060742103493, 7339.74310899116, 7348.191698913009, 7357.117145942521, 8049.27556519916, 8116.026076870813, 8126.512409255463, 8141.674333026613, 6017.939820601738, 7030.859382812213, 7087.574745515286, 7122.287771223044, 7161.677724502514, 6934.410575101173, 7042.823929401806, 7062.39969602569, 7062.788116356517, 7087.7164913402885, 5877.735501902339, 6644.700988455627, 6645.800625981228, 6653.268140504638, 6672.366125218096, 4964.404271487445, 5006.3992320921725, 5013.035085275276, 5108.897822043464, 5268.841934741964, 5117.257997590403, 5142.794288228429, 5166.483351664803, 5209.76556054986, 5246.186841039645], "value": 4513.567975629635, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2391585292225, 372.12550506310157, 382.5428612807696, 382.6364953294371, 384.3005729572178, 5343.358796944362, 5360.3299587551555, 5401.621886467939, 5427.1316589345715, 5462.371827239868, 5111.926495435963, 5328.774381892167, 5390.460953904608, 5419.287787865315, 5425.810096646618, 3522.4716292556195, 4153.760067147629, 4191.434156388894, 4247.5964783345535, 4262.275413179751, 3695.8173384516967, 3914.2367238388524, 4035.267377675653, 4053.574374690659, 4274.764887931163, 3179.2210908327374, 3406.386850366933, 3534.964650353489, 3625.4380571011534, 4250.128723611652, 4033.415154802552, 4195.622393984556, 4212.641925436311, 4219.38818871265, 4249.043965107857, 3751.681107105899, 3753.887383378503, 3755.1738617504107, 3765.8305376258136, 3770.0584199137465, 4450.132224216279, 4659.881628409191, 4749.815085060842, 4872.221639101738, 4893.972265824181, 4628.305754136873, 4826.975865120652, 4874.268859671042, 4883.8779030524165, 4896.436909755353, 4919.425783749201, 5573.41479144692, 5680.358633235565, 5681.57388195887, 5748.770049198069, 3629.7096232301615, 4118.670506359484, 4150.252954468195, 4193.727407718488, 4231.217224813419, 4758.690685105492, 5435.619506634537, 5969.432903874125, 5998.790042348497, 6050.546209034296, 3785.0, 3798.525184351956, 3908.355121404936, 3918.9020274493364, 3929.092471571074, 3986.0034991252187, 3999.200159968018, 4006.258842114218, 4012.0972781124597, 4022.4948058174446, 4304.5910638489295, 4385.473743150842, 4648.349231107648, 4656.930146047812, 4697.248440249612, 5697.886042279214, 5706.4864162225595, 5728.513076388554, 5769.711514424262, 5786.350889996415, 1168.760404117154, 1312.665270356053, 1321.9405126769318, 1328.6912391294568, 1334.9599512014654, 784.1296161260996, 791.4459878085363, 891.5542228885557, 903.7379160043514, 904.3669431398048, 4867.0, 5095.490450954875, 5096.286519887219, 5099.719515426687, 5197.8180763673845, 4752.857414277577, 4874.319124481521, 5144.562712169508, 5311.468853114658, 5738.569607279387, 4652.534156896782, 4810.5670489656095, 4950.430700469492, 5034.295198672189, 5159.303494028258, 2688.6639170103736, 2707.742764437375, 2922.509520144699, 2944.8822047118306, 3016.9245768855953, 5234.816781412708, 5565.693886836263, 5756.33802112754, 5759.078547432475, 5780.624259423208, 4882.853514394574, 5391.2182733504205, 5661.886762264731, 5728.885422291531, 5766.913496297559, 5190.572592537007, 5291.989044163271, 5697.772089116389, 5855.765769369263, 5882.176495290662, 5036.773345199402, 5570.966597192077, 5648.293963254593, 5791.8552036199435, 5868.122200895672, 4782.354382158364, 5472.972635136799, 5516.062269414129, 5580.74433252515, 5766.596338256281, 4986.825461108844, 5300.727825321972, 6030.306514750684, 6059.697015149313, 6135.11040899076, 3349.497575363715, 3662.0, 3968.66266367362, 3972.5828787978003, 3974.20515896816, 4869.831240502324, 5503.972480137573, 5756.568257380797, 5841.824745257649, 5858.355580886014, 5430.782768689208, 5462.481064298885, 5607.691576963306, 5663.0, 5692.51613612831, 4850.466448690711, 5331.866703332447, 5698.914516282176, 5738.512226460798, 5744.965906136768, 4803.327534145293, 4897.828575999965, 4901.362822833152, 4948.901021979612, 5561.610687252015, 4648.767561621973, 4924.8276310328965, 5016.974915125401, 5593.748281327432, 5714.428532153524, 5239.554637855673, 5486.827319265826, 5526.392096869261, 5532.5020748132865, 5535.837474130478], "value": 4113.697419181134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.2344520311881, 777.3392616276166, 792.759857342963, 869.7173418638941, 888.2006194425016, 15263.923680381597, 15451.0, 16118.7582186267, 16133.677326453479, 16160.27278772455, 14464.421423143089, 14881.627959300995, 15890.126043067627, 16432.342706291733, 16568.00591964483, 906.5331354352497, 927.4713413354391, 927.9860802087974, 929.2287401456808, 929.7815013471828, 735.2206660939421, 755.9508631938934, 890.3856339126015, 914.73015460439, 917.5137177296044, 951.5813042261383, 957.2533423929311, 957.7461972577238, 958.966436174734, 959.4003747657714, 952.2857856607544, 954.4273435938451, 954.9856752148723, 954.9972528844754, 956.3257903178243, 713.0979311171373, 713.1121753416977, 713.3401603516726, 713.8393861381147, 715.141829804237, 13585.864141358657, 13835.446582136703, 15769.526914192593, 16131.435399761069, 16222.026678399216, 14453.277336133151, 14632.195229262386, 14672.10922096834, 14730.042547234396, 15070.472533461276, 11583.36291503967, 11736.0, 11806.409679516075, 11892.0, 12040.759184816254, 3742.0644838790304, 3845.5193100862393, 3853.364194907837, 4016.879493615196, 4021.2761702893467, 109904.0, 112036.4398178012, 113135.30297045551, 113286.0, 113378.43310783476, 11312.264702794457, 11317.60388386419, 11446.54213831454, 11566.42167891602, 11998.820017699742, 19229.326973556137, 21796.237131700633, 22619.773802262094, 23332.7666723334, 23732.0, 8173.182681731898, 8177.71378001779, 8263.586820658944, 8278.172182781795, 8569.571521423904, 4462.620677242471, 4526.660500462479, 4591.931121033187, 4783.210770222874, 4785.258284965836, 3753.418220175877, 3793.1844653399653, 3820.426935959573, 3821.808909554511, 3857.3828187490426, 696.3976160621128, 701.6246308225075, 708.3624737736079, 714.8927660850914, 716.358858821352, 686.8214264291221, 687.9380855722909, 700.2297472779901, 720.5784615999698, 758.0940775772898, 9950.522264980787, 10263.846042309371, 10449.84325235122, 10674.73313167177, 10777.62278320255, 703.3810246982724, 725.4812808841704, 743.4164181117796, 746.2127455534355, 777.2654841175148, 4734.100520901018, 5075.416327122354, 5191.9480805192225, 5192.247124166975, 5204.7918083276245, 113092.0, 116266.83733162729, 116430.0, 116970.41514792542, 117462.23806642907, 85961.57019214863, 94051.0594894056, 97603.51198244105, 100139.0, 101796.0, 68562.65718671474, 73309.0, 74062.62968685121, 75964.62017689766, 81968.18031819606, 10777.424696773063, 10823.621173258898, 10974.286671366335, 11092.33445993243, 11120.332780033224, 47105.52894471012, 49417.787843790036, 49656.75171624119, 51969.74015130052, 53565.732171338896, 62581.68709156425, 67105.0, 73749.6312518434, 74309.0, 75214.0, 13181.868181318065, 13448.798268026183, 13578.660533486742, 13643.79534307006, 14002.0, 12416.627501174979, 13791.724165516835, 14602.269886505845, 15057.774133388228, 15520.0, 13583.660408489866, 14011.579652610439, 14105.294735263402, 14129.788053179416, 14283.928580357448, 11510.482028308914, 12123.393830308272, 13364.264965426995, 14163.787543186654, 14342.067765595202, 12799.872001279868, 13778.724425511635, 13824.820914955088, 14265.964352432069, 14440.205788681304, 9319.254459643076, 9987.0, 10079.395236285847, 10125.392476451436, 10345.689629311133, 8509.343113040342, 9185.586648600696, 10402.295403195072, 11103.5558577656, 11351.716207094889], "value": 7816.245823387607, "unit": "score"}], "name": "dromaeo_css", "value": 7432.731092428912, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 112.0, 113.0, 112.0, 115.0, 113.0, 113.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 135.0, 139.0, 148.0, 108.0, 107.0, 103.0, 107.0, 125.0, 107.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 181.0, 196.0, 258.0, 201.0, 182.0, 195.0, 257.0, 200.0], "value": 203.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 90.0, 61.0, 58.0, 58.0, 58.0, 72.0, 57.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 85.0, 70.0, 89.0, 90.0, 103.0, 94.0, 99.0, 109.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 92.0, 83.0, 87.0, 85.0, 88.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 104.0, 97.0, 98.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 88.0, 84.0, 88.0, 85.0, 86.0, 85.0, 87.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 53.0, 49.0, 55.0, 55.0, 53.0, 52.0, 76.0, 85.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 74.0, 76.0, 70.0, 69.0, 66.0, 68.0, 68.0, 71.0, 68.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 80.0, 94.0, 81.0, 80.0, 78.0, 87.0, 82.0, 83.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 129.0, 137.0, 123.0, 132.0, 131.0, 138.0, 170.0, 144.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 200.0, 162.0, 159.0, 216.0, 161.0, 161.0, 164.0, 160.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 65.0, 64.0, 61.0, 62.0, 62.0, 64.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1442.8, "alertThreshold": 2.0}]} 09:11:33 INFO - Return code: 0 09:11:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:11:33 INFO - # TBPL SUCCESS # 09:11:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:11:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:11:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:11:33 INFO - 2017-04-04 09:11:33.433 screenresolution[1656:10130] starting screenresolution argv=screenresolution get 09:11:33 INFO - 2017-04-04 09:11:33.435 screenresolution[1656:10130] Display 0: 1600x1200x32@60 09:11:33 INFO - 2017-04-04 09:11:33.441 screenresolution[1657:10133] starting screenresolution argv=screenresolution list 09:11:33 INFO - Available Modes on Display 0 09:11:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:11:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:11:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:11:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:11:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:11:33 INFO - Intel Iris: 09:11:33 INFO - Chipset Model: Intel Iris 09:11:33 INFO - Type: GPU 09:11:33 INFO - Bus: Built-In 09:11:33 INFO - VRAM (Dynamic, Max): 1536 MB 09:11:33 INFO - Vendor: Intel (0x8086) 09:11:33 INFO - Device ID: 0x0a2e 09:11:33 INFO - Revision ID: 0x0009 09:11:33 INFO - Displays: 09:11:33 INFO - Display: 09:11:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:11:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:11:33 INFO - Display Serial Number: 1600x1200 60 09:11:33 INFO - Main Display: Yes 09:11:33 INFO - Mirror: Off 09:11:33 INFO - Online: Yes 09:11:33 INFO - Rotation: Supported 09:11:33 INFO - Return code: 0 09:11:33 INFO - Running post-action listener: _resource_record_post_action 09:11:33 INFO - [mozharness: 2017-04-04 16:11:33.670040Z] Finished run-tests step (success) 09:11:33 INFO - Running post-run listener: _resource_record_post_run 09:11:33 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38323200; Write bytes: 419677184; Read time: 243; Write time: 1368 09:11:33 INFO - TinderboxPrint: CPU usage
53.7% 09:11:33 INFO - TinderboxPrint: I/O read bytes / time
38,323,200 / 243 09:11:33 INFO - TinderboxPrint: I/O write bytes / time
419,677,184 / 1,368 09:11:33 INFO - TinderboxPrint: CPU idle
2,206.3 (46.3%) 09:11:33 INFO - TinderboxPrint: CPU system
950.9 (20.0%) 09:11:33 INFO - TinderboxPrint: CPU user
1,604.6 (33.7%) 09:11:33 INFO - TinderboxPrint: Swap in / out
159,895,552 / 0 09:11:33 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 113101312; Write bytes: 104202240; Read time: 10138; Write time: 217 09:11:33 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37393408; Write bytes: 296920064; Read time: 232; Write time: 1094 09:11:34 INFO - Running post-run listener: _upload_blobber_files 09:11:34 INFO - Blob upload gear active. 09:11:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11:34 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 09:11:34 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'] 09:11:34 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 09:11:34 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:11:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:11:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:35 INFO - (blobuploader) - INFO - Done attempting. 09:11:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:11:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:11:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:36 INFO - (blobuploader) - INFO - Done attempting. 09:11:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:11:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:11:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:37 INFO - (blobuploader) - INFO - Done attempting. 09:11:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:11:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:40 INFO - (blobuploader) - INFO - Done attempting. 09:11:40 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:40 INFO - Return code: 0 09:11:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc2719d1db84d6421098330e1676b87d26db5f4c0c5498cb4502e1dc83c0f0eec07d464b3689123df7ae4ddb3a5e15328c1d74b07bb44792daa475210f8c21f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2535d972e906b04910f6a36b0d8e9146a76c49cf06de8cc7027cff6ac6b730b9529eb54c607d7321e9f4e7127c106ed7a5b5f2578b06b5d478403ffeb7ac9611", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9cb6bf56bec63a043704800aab00ca8050f5cdbef60d0af82d4cd21fa64bcd180a5f4cd359e3a79639a3f8557c521eddd28818a764e3e46e53ac9c5d8834d37", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/52f0d09760408926c2c519f4c55f0947262cf9f9699c67a1f5880f25202d1410fb2becdca5e514b4343cbcc084ed990e7f5807ac786dda37961358ee3b8050e5"} 09:11:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:40 INFO - Contents: 09:11:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc2719d1db84d6421098330e1676b87d26db5f4c0c5498cb4502e1dc83c0f0eec07d464b3689123df7ae4ddb3a5e15328c1d74b07bb44792daa475210f8c21f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2535d972e906b04910f6a36b0d8e9146a76c49cf06de8cc7027cff6ac6b730b9529eb54c607d7321e9f4e7127c106ed7a5b5f2578b06b5d478403ffeb7ac9611", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9cb6bf56bec63a043704800aab00ca8050f5cdbef60d0af82d4cd21fa64bcd180a5f4cd359e3a79639a3f8557c521eddd28818a764e3e46e53ac9c5d8834d37", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/52f0d09760408926c2c519f4c55f0947262cf9f9699c67a1f5880f25202d1410fb2becdca5e514b4343cbcc084ed990e7f5807ac786dda37961358ee3b8050e5"} 09:11:40 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:40 INFO - Copying logs to upload dir... 09:11:40 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.789909 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-04-04 09:11:40.110675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 09:11:40.113853) ========= 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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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/bc2719d1db84d6421098330e1676b87d26db5f4c0c5498cb4502e1dc83c0f0eec07d464b3689123df7ae4ddb3a5e15328c1d74b07bb44792daa475210f8c21f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2535d972e906b04910f6a36b0d8e9146a76c49cf06de8cc7027cff6ac6b730b9529eb54c607d7321e9f4e7127c106ed7a5b5f2578b06b5d478403ffeb7ac9611", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9cb6bf56bec63a043704800aab00ca8050f5cdbef60d0af82d4cd21fa64bcd180a5f4cd359e3a79639a3f8557c521eddd28818a764e3e46e53ac9c5d8834d37", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/52f0d09760408926c2c519f4c55f0947262cf9f9699c67a1f5880f25202d1410fb2becdca5e514b4343cbcc084ed990e7f5807ac786dda37961358ee3b8050e5"} build_url:https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011097 build_url: 'https://queue.taskcluster.net/v1/task/LwfaW6o3TSK1fo7hrgLz-A/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc2719d1db84d6421098330e1676b87d26db5f4c0c5498cb4502e1dc83c0f0eec07d464b3689123df7ae4ddb3a5e15328c1d74b07bb44792daa475210f8c21f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2535d972e906b04910f6a36b0d8e9146a76c49cf06de8cc7027cff6ac6b730b9529eb54c607d7321e9f4e7127c106ed7a5b5f2578b06b5d478403ffeb7ac9611", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9cb6bf56bec63a043704800aab00ca8050f5cdbef60d0af82d4cd21fa64bcd180a5f4cd359e3a79639a3f8557c521eddd28818a764e3e46e53ac9c5d8834d37", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/52f0d09760408926c2c519f4c55f0947262cf9f9699c67a1f5880f25202d1410fb2becdca5e514b4343cbcc084ed990e7f5807ac786dda37961358ee3b8050e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 09:11:40.148215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:11:40.148569) ========= 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.7Hw0S6Ec5h/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.3vqMo0C52s/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.005218 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:11:40.197629) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 09:11:40.197977) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 09:11:40.198355) ========= ========= Total master_lag: 0.19 =========