builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0121 starttime: 1494465785.51 results: success (0) revision: d8762cb967423618ff0a488f14745f60964e5c49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:05.508168) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:05.508605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:05.508879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:05.534784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:05.535095) ========= 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.dJzTkqT80I/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.XtpvRrLUsb/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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-05-10 18:23:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.60M=0.001s 2017-05-10 18:23:05 (9.60 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:05.658938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:05.659401) ========= 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.dJzTkqT80I/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.XtpvRrLUsb/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.027199 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:05.707807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-10 18:23:05.708187) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d8762cb967423618ff0a488f14745f60964e5c49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev d8762cb967423618ff0a488f14745f60964e5c49 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dJzTkqT80I/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.XtpvRrLUsb/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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-05-10 18:23:05,868 truncating revision to first 12 chars 2017-05-10 18:23:05,869 Setting DEBUG logging. 2017-05-10 18:23:05,869 attempt 1/10 2017-05-10 18:23:05,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d8762cb96742?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 18:23:07,938 unpacking tar archive at: mozilla-central-d8762cb96742/testing/mozharness/ program finished with exit code 0 elapsedTime=2.349110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-10 18:23:08.079422) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:08.079777) ========= script_repo_revision: d8762cb967423618ff0a488f14745f60964e5c49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:08.080204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:08.080501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 18:23:08.099610) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-05-10 18:23:08.100037) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dJzTkqT80I/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.XtpvRrLUsb/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:23:08 INFO - MultiFileLogger online at 20170510 18:23:08 in /builds/slave/test 18:23:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:23:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:23:08 INFO - {'append_to_log': False, 18:23:08 INFO - 'base_work_dir': '/builds/slave/test', 18:23:08 INFO - 'blob_upload_branch': 'Firefox', 18:23:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:23:08 INFO - 'branch': 'Firefox', 18:23:08 INFO - 'buildbot_json_path': 'buildprops.json', 18:23:08 INFO - 'config_files': ('talos/mac_config.py',), 18:23:08 INFO - 'default_actions': ('clobber', 18:23:08 INFO - 'read-buildbot-config', 18:23:08 INFO - 'download-and-extract', 18:23:08 INFO - 'populate-webroot', 18:23:08 INFO - 'create-virtualenv', 18:23:08 INFO - 'install', 18:23:08 INFO - 'run-tests'), 18:23:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:23:08 INFO - 'download_minidump_stackwalk': True, 18:23:08 INFO - 'download_symbols': 'ondemand', 18:23:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:23:08 INFO - 'tooltool.py': '/tools/tooltool.py', 18:23:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:23:08 INFO - '/tools/misc-python/virtualenv.py')}, 18:23:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:23:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:23:08 INFO - 'gecko_profile': False, 18:23:08 INFO - 'gecko_profile_interval': 0, 18:23:08 INFO - 'installer_path': 'installer.exe', 18:23:08 INFO - 'log_level': 'info', 18:23:08 INFO - 'log_name': 'talos', 18:23:08 INFO - 'log_to_console': True, 18:23:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:23:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:23:08 INFO - 'opt_config_files': (), 18:23:08 INFO - 'pip_index': False, 18:23:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:23:08 INFO - 'cmd': ('bash', 18:23:08 INFO - '-c', 18:23:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:23:08 INFO - 'enabled': True, 18:23:08 INFO - 'halt_on_failure': False, 18:23:08 INFO - 'name': 'check_screen_resolution'},), 18:23:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:23:08 INFO - 'cmd': ('bash', 18:23:08 INFO - '-c', 18:23:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:23:08 INFO - 'enabled': True, 18:23:08 INFO - 'halt_on_failure': False, 18:23:08 INFO - 'name': 'check_screen_resolution'},), 18:23:08 INFO - 'run_cmd_checks_enabled': True, 18:23:08 INFO - 'suite': 'dromaeojs', 18:23:08 INFO - 'system_bits': '32', 18:23:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:23:08 INFO - 'title': 't-yosemite-r7-0121', 18:23:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:23:08 INFO - 'use_talos_json': True, 18:23:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:23:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:23:08 INFO - 'work_dir': 'build'} 18:23:08 INFO - [mozharness: 2017-05-11 01:23:08.375187Z] Running clobber step. 18:23:08 INFO - Running pre-action listener: _resource_record_pre_action 18:23:08 INFO - Running main action method: clobber 18:23:08 INFO - rmtree: /builds/slave/test/build 18:23:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:23:10 INFO - Running post-action listener: _resource_record_post_action 18:23:10 INFO - [mozharness: 2017-05-11 01:23:10.875263Z] Finished clobber step (success) 18:23:10 INFO - [mozharness: 2017-05-11 01:23:10.875392Z] Running read-buildbot-config step. 18:23:10 INFO - Running pre-action listener: _resource_record_pre_action 18:23:10 INFO - Running main action method: read_buildbot_config 18:23:10 INFO - Using buildbot properties: 18:23:10 INFO - { 18:23:10 INFO - "project": "", 18:23:10 INFO - "product": "firefox", 18:23:10 INFO - "who": "kwierso@gmail.com", 18:23:10 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 18:23:10 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:23:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:23:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:23:10 INFO - "stage_platform": "macosx64", 18:23:10 INFO - "basedir": "/builds/slave/test", 18:23:10 INFO - "buildnumber": 30, 18:23:10 INFO - "platform": "yosemite_r7", 18:23:10 INFO - "parent_task_id": "Ys3BKH0eQmWa1KnDy7DyhA", 18:23:10 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 18:23:10 INFO - "slavebuilddir": "test", 18:23:10 INFO - "taskId": "aKPgLgrbQNqw2woDy6jHgA", 18:23:10 INFO - "branch": "mozilla-central", 18:23:10 INFO - "script_repo_revision": "production", 18:23:10 INFO - "revision": "d8762cb967423618ff0a488f14745f60964e5c49", 18:23:10 INFO - "slavename": "t-yosemite-r7-0121", 18:23:10 INFO - "repo_path": "mozilla-central" 18:23:10 INFO - } 18:23:10 INFO - Finding installer, test and symbols from parent task. 18:23:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aKPgLgrbQNqw2woDy6jHgA'}, attempt #1 18:23:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aKPgLgrbQNqw2woDy6jHgA'}, attempt #1 18:23:12 INFO - Task dependencies: UpZmctepSIiKRvgq2AmMDg 18:23:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA'}, attempt #1 18:23:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:23:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/test_packages.json 18:23:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/target.crashreporter-symbols.zip 18:23:12 INFO - Running post-action listener: _resource_record_post_action 18:23:12 INFO - [mozharness: 2017-05-11 01:23:12.646121Z] Finished read-buildbot-config step (success) 18:23:12 INFO - [mozharness: 2017-05-11 01:23:12.646276Z] Running download-and-extract step. 18:23:12 INFO - Running pre-action listener: _resource_record_pre_action 18:23:12 INFO - Running main action method: download_and_extract 18:23:12 INFO - mkdir: /builds/slave/test/build/tests 18:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:12 INFO - trying https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:23:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 18:23:13 INFO - Downloaded 1325 bytes. 18:23:13 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:23:13 INFO - Using the following test package requirements: 18:23:13 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:23:13 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 18:23:13 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:23:13 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:23:13 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:23:13 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:23:13 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:23:13 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:23:13 INFO - u'jsshell-mac.zip'], 18:23:13 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:23:13 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:23:13 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:23:13 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:23:13 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:23:13 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:23:13 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:23:13 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:23:13 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:23:13 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:23:13 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:23:13 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:23:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:23:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:23:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:23:15 INFO - Content-Length response header: 52707557 18:23:15 INFO - Bytes received: 52707557 18:23:31 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:23:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:23:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:23:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:23:33 INFO - Content-Length response header: 52707557 18:23:33 INFO - Bytes received: 52707557 18:23:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:23:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:23:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:23:50 INFO - Content-Length response header: 14409362 18:23:50 INFO - Bytes received: 14409362 18:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:50 INFO - trying https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:23:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:23:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 18:23:53 INFO - Downloaded 75526176 bytes. 18:23:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:23:53 INFO - mkdir: /builds/slave/test/properties 18:23:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:23:53 INFO - Writing to file /builds/slave/test/properties/build_url 18:23:53 INFO - Contents: 18:23:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:23:53 INFO - Running post-action listener: _resource_record_post_action 18:23:53 INFO - Running post-action listener: set_extra_try_arguments 18:23:53 INFO - [mozharness: 2017-05-11 01:23:53.128425Z] Finished download-and-extract step (success) 18:23:53 INFO - [mozharness: 2017-05-11 01:23:53.128560Z] Running populate-webroot step. 18:23:53 INFO - Running pre-action listener: _resource_record_pre_action 18:23:53 INFO - Running main action method: populate_webroot 18:23:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:23:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:23:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:23:53 INFO - '--tppagecycles', 18:23:53 INFO - '7'], 18:23:53 INFO - 'tests': ['tsvgm']}}, 18:23:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:23:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:23:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:23:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:23:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:23:53 INFO - 'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:23:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:23:53 INFO - 'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['damp', 'tps']}, 18:23:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:23:53 INFO - 'tests': ['damp', 'tps']}, 18:23:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['dromaeo_dom']}, 18:23:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:23:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:23:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:23:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['a11yr', 18:23:53 INFO - 'ts_paint', 18:23:53 INFO - 'tpaint', 18:23:53 INFO - 'sessionrestore', 18:23:53 INFO - 'sessionrestore_no_auto_restore', 18:23:53 INFO - 'tabpaint']}, 18:23:53 INFO - 'other-e10s': {'tests': ['a11yr', 18:23:53 INFO - 'ts_paint', 18:23:53 INFO - 'tpaint', 18:23:53 INFO - 'sessionrestore', 18:23:53 INFO - 'sessionrestore_no_auto_restore', 18:23:53 INFO - 'tabpaint']}, 18:23:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:23:53 INFO - 'ts_paint', 18:23:53 INFO - 'tpaint', 18:23:53 INFO - 'sessionrestore', 18:23:53 INFO - 'sessionrestore_no_auto_restore', 18:23:53 INFO - 'tabpaint']}, 18:23:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:23:53 INFO - 'ts_paint', 18:23:53 INFO - 'tpaint', 18:23:53 INFO - 'sessionrestore', 18:23:53 INFO - 'sessionrestore_no_auto_restore', 18:23:53 INFO - 'tabpaint']}, 18:23:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['a11yr', 18:23:53 INFO - 'ts_paint', 18:23:53 INFO - 'tpaint', 18:23:53 INFO - 'sessionrestore', 18:23:53 INFO - 'sessionrestore_no_auto_restore', 18:23:53 INFO - 'tabpaint']}, 18:23:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['a11yr', 18:23:53 INFO - 'ts_paint', 18:23:53 INFO - 'tpaint', 18:23:53 INFO - 'sessionrestore', 18:23:53 INFO - 'sessionrestore_no_auto_restore', 18:23:53 INFO - 'tabpaint']}, 18:23:53 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:23:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:23:53 INFO - 'bloom_basic_ref']}, 18:23:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['tsvgx', 18:23:53 INFO - 'tsvgr_opacity', 18:23:53 INFO - 'tart', 18:23:53 INFO - 'tscrollx', 18:23:53 INFO - 'cart', 18:23:53 INFO - 'tsvg_static']}, 18:23:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:23:53 INFO - 'tsvgr_opacity', 18:23:53 INFO - 'tart', 18:23:53 INFO - 'tscrollx', 18:23:53 INFO - 'cart', 18:23:53 INFO - 'tsvg_static']}, 18:23:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:23:53 INFO - 'talos_options': ['--disable-e10s'], 18:23:53 INFO - 'tests': ['tp5o']}, 18:23:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:23:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:23:53 INFO - 'talos_options': ['--disable-e10s', 18:23:53 INFO - '--xperf_path', 18:23:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:53 INFO - 'tests': ['tp5n']}, 18:23:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:23:53 INFO - 'talos_options': ['--xperf_path', 18:23:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:53 INFO - 'tests': ['tp5n']}}, 18:23:53 INFO - 'talos.zip': {'path': '', 18:23:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:23:53 INFO - Running post-action listener: _resource_record_post_action 18:23:53 INFO - [mozharness: 2017-05-11 01:23:53.149777Z] Finished populate-webroot step (success) 18:23:53 INFO - [mozharness: 2017-05-11 01:23:53.149925Z] Running create-virtualenv step. 18:23:53 INFO - Running pre-action listener: _resource_record_pre_action 18:23:53 INFO - Running main action method: create_virtualenv 18:23:53 INFO - Creating virtualenv /builds/slave/test/build/venv 18:23:53 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 18:23:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:23:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:23:53 INFO - Using real prefix '/tools/python27' 18:23:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:23:54 INFO - Installing distribute.............................................................................................................................................................................................done. 18:23:56 INFO - Installing pip.................done. 18:23:56 INFO - Return code: 0 18:23:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:23:57 INFO - Reading from file tmpfile_stdout 18:23:57 INFO - Output received: 18:23:57 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) 18:23:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:57 INFO - 'HOME': '/Users/cltbld', 18:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:57 INFO - 'LOGNAME': 'cltbld', 18:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:57 INFO - 'MOZ_NO_REMOTE': '1', 18:23:57 INFO - 'NO_EM_RESTART': '1', 18:23:57 INFO - 'PAGER': '/bin/cat', 18:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:57 INFO - 'PWD': '/builds/slave/test', 18:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:57 INFO - 'SHELL': '/bin/bash', 18:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:23:57 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:57 INFO - 'USER': 'cltbld', 18:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:57 INFO - 'XPC_FLAGS': '0x0', 18:23:57 INFO - 'XPC_SERVICE_NAME': '0', 18:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:57 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 18:23:57 INFO - Cleaning up... 18:23:57 INFO - Return code: 0 18:23:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:57 INFO - 'HOME': '/Users/cltbld', 18:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:57 INFO - 'LOGNAME': 'cltbld', 18:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:57 INFO - 'MOZ_NO_REMOTE': '1', 18:23:57 INFO - 'NO_EM_RESTART': '1', 18:23:57 INFO - 'PAGER': '/bin/cat', 18:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:57 INFO - 'PWD': '/builds/slave/test', 18:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:57 INFO - 'SHELL': '/bin/bash', 18:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:23:57 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:57 INFO - 'USER': 'cltbld', 18:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:57 INFO - 'XPC_FLAGS': '0x0', 18:23:57 INFO - 'XPC_SERVICE_NAME': '0', 18:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:57 INFO - Downloading/unpacking psutil>=3.1.1 18:23:57 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 18:23:57 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 18:23:57 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 18:23:57 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 18:23:57 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 18:23:57 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 18:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:24:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:00 INFO - Installing collected packages: psutil 18:24:00 INFO - Running setup.py install for psutil 18:24:00 INFO - building 'psutil._psutil_osx' extension 18:24:00 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 18:24:00 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 18:24:00 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 18:24:00 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 18:24:00 INFO - building 'psutil._psutil_posix' extension 18:24:00 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 18:24:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:24:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:24:01 INFO - ^ 18:24:01 INFO - 1 warning generated. 18:24:01 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 18:24:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:01 INFO - Successfully installed psutil 18:24:01 INFO - Cleaning up... 18:24:01 INFO - Return code: 0 18:24:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:24:01 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')]} 18:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:02 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')]} 18:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:02 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 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:24:02 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 18:24:02 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 18:24:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:24:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:02 INFO - 'HOME': '/Users/cltbld', 18:24:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:02 INFO - 'LOGNAME': 'cltbld', 18:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:02 INFO - 'MOZ_NO_REMOTE': '1', 18:24:02 INFO - 'NO_EM_RESTART': '1', 18:24:02 INFO - 'PAGER': '/bin/cat', 18:24:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:02 INFO - 'PWD': '/builds/slave/test', 18:24:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:02 INFO - 'SHELL': '/bin/bash', 18:24:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:24:02 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:24:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:02 INFO - 'USER': 'cltbld', 18:24:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:02 INFO - 'XPC_FLAGS': '0x0', 18:24:02 INFO - 'XPC_SERVICE_NAME': '0', 18:24:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:24:02 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 18:24:02 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 18:24:02 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 18:24:02 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 18:24:02 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 18:24:02 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 18:24:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:24:04 INFO - Installing collected packages: mozsystemmonitor 18:24:04 INFO - Running setup.py install for mozsystemmonitor 18:24:04 INFO - Successfully installed mozsystemmonitor 18:24:04 INFO - Cleaning up... 18:24:04 INFO - Return code: 0 18:24:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:04 INFO - 'HOME': '/Users/cltbld', 18:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:04 INFO - 'LOGNAME': 'cltbld', 18:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:04 INFO - 'MOZ_NO_REMOTE': '1', 18:24:04 INFO - 'NO_EM_RESTART': '1', 18:24:04 INFO - 'PAGER': '/bin/cat', 18:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:04 INFO - 'PWD': '/builds/slave/test', 18:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:04 INFO - 'SHELL': '/bin/bash', 18:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:24:04 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:04 INFO - 'USER': 'cltbld', 18:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:04 INFO - 'XPC_FLAGS': '0x0', 18:24:04 INFO - 'XPC_SERVICE_NAME': '0', 18:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:04 INFO - Downloading/unpacking jsonschema==2.5.1 18:24:04 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 18:24:04 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 18:24:04 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 18:24:04 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 18:24:04 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 18:24:04 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 18:24:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:24:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:24:06 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 18:24:06 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 18:24:06 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 18:24:06 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 18:24:06 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 18:24:06 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 18:24:06 INFO - Downloading functools32-3.2.3-2.tar.gz 18:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:24:06 INFO - warning: no files found matching '*.txt' 18:24:06 INFO - no previously-included directories found matching 'build' 18:24:06 INFO - no previously-included directories found matching 'dist' 18:24:06 INFO - no previously-included directories found matching '.git*' 18:24:06 INFO - Installing collected packages: jsonschema, functools32 18:24:07 INFO - Running setup.py install for functools32 18:24:07 INFO - warning: no files found matching '*.txt' 18:24:07 INFO - no previously-included directories found matching 'build' 18:24:07 INFO - no previously-included directories found matching 'dist' 18:24:07 INFO - no previously-included directories found matching '.git*' 18:24:07 INFO - Successfully installed jsonschema functools32 18:24:07 INFO - Cleaning up... 18:24:07 INFO - Return code: 0 18:24:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:24:07 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')]} 18:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 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')]} 18:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 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 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:24:07 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 18:24:07 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 18:24:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:24:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:07 INFO - 'HOME': '/Users/cltbld', 18:24:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:07 INFO - 'LOGNAME': 'cltbld', 18:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:07 INFO - 'MOZ_NO_REMOTE': '1', 18:24:07 INFO - 'NO_EM_RESTART': '1', 18:24:07 INFO - 'PAGER': '/bin/cat', 18:24:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:07 INFO - 'PWD': '/builds/slave/test', 18:24:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:07 INFO - 'SHELL': '/bin/bash', 18:24:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:24:07 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:24:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:07 INFO - 'USER': 'cltbld', 18:24:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:07 INFO - 'XPC_FLAGS': '0x0', 18:24:07 INFO - 'XPC_SERVICE_NAME': '0', 18:24:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:24:07 INFO - Cleaning up... 18:24:07 INFO - Return code: 0 18:24:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:24:07 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')]} 18:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 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')]} 18:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 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 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:24:07 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 18:24:07 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 18:24:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:24:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:07 INFO - 'HOME': '/Users/cltbld', 18:24:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:07 INFO - 'LOGNAME': 'cltbld', 18:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:07 INFO - 'MOZ_NO_REMOTE': '1', 18:24:07 INFO - 'NO_EM_RESTART': '1', 18:24:07 INFO - 'PAGER': '/bin/cat', 18:24:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:07 INFO - 'PWD': '/builds/slave/test', 18:24:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:07 INFO - 'SHELL': '/bin/bash', 18:24:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:24:07 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:24:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:07 INFO - 'USER': 'cltbld', 18:24:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:07 INFO - 'XPC_FLAGS': '0x0', 18:24:07 INFO - 'XPC_SERVICE_NAME': '0', 18:24:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:07 INFO - Downloading/unpacking blobuploader==1.2.4 18:24:07 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 18:24:07 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 18:24:07 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 18:24:07 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 18:24:07 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 18:24:07 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 18:24:09 INFO - Downloading blobuploader-1.2.4.tar.gz 18:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:24:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:24:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:10 INFO - Downloading docopt-0.6.1.tar.gz 18:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:24:10 INFO - Installing collected packages: blobuploader, requests, docopt 18:24:10 INFO - Running setup.py install for blobuploader 18:24:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:24:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:24:10 INFO - Running setup.py install for requests 18:24:10 INFO - Running setup.py install for docopt 18:24:10 INFO - Successfully installed blobuploader requests docopt 18:24:10 INFO - Cleaning up... 18:24:10 INFO - Return code: 0 18:24:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:10 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 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:24:10 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 18:24:10 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 18:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:10 INFO - 'HOME': '/Users/cltbld', 18:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:10 INFO - 'LOGNAME': 'cltbld', 18:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:10 INFO - 'MOZ_NO_REMOTE': '1', 18:24:10 INFO - 'NO_EM_RESTART': '1', 18:24:10 INFO - 'PAGER': '/bin/cat', 18:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:10 INFO - 'PWD': '/builds/slave/test', 18:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:10 INFO - 'SHELL': '/bin/bash', 18:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:24:10 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:10 INFO - 'USER': 'cltbld', 18:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:10 INFO - 'XPC_FLAGS': '0x0', 18:24:10 INFO - 'XPC_SERVICE_NAME': '0', 18:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-dBb2JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-OZSULk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-kcAduc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ocF5c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-6Fwt9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-PzcNRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-HjLTOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:11 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Uc09RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:12 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-9_lWGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:12 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-0_ppKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:12 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-BdDhKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:12 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-oBmqPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:12 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-O7Phna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:12 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-4aSItX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:12 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-_C295L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:12 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-UhAGO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:12 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Z6f9A0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:24:13 INFO - Running setup.py install for manifestparser 18:24:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:24:13 INFO - Running setup.py install for mozcrash 18:24:13 INFO - Running setup.py install for mozdebug 18:24:13 INFO - Running setup.py install for mozdevice 18:24:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:24:13 INFO - Running setup.py install for mozfile 18:24:13 INFO - Running setup.py install for mozhttpd 18:24:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:24:13 INFO - Running setup.py install for mozinfo 18:24:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Running setup.py install for mozInstall 18:24:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Running setup.py install for mozleak 18:24:14 INFO - Running setup.py install for mozlog 18:24:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Running setup.py install for moznetwork 18:24:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Running setup.py install for mozprocess 18:24:14 INFO - Running setup.py install for mozprofile 18:24:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:24:14 INFO - Running setup.py install for mozrunner 18:24:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:24:15 INFO - Running setup.py install for mozscreenshot 18:24:15 INFO - Running setup.py install for moztest 18:24:15 INFO - Running setup.py install for mozversion 18:24:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:24:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:24:15 INFO - Cleaning up... 18:24:15 INFO - Return code: 0 18:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:15 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 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:24:15 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 18:24:15 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 18:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:15 INFO - 'HOME': '/Users/cltbld', 18:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:15 INFO - 'LOGNAME': 'cltbld', 18:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:15 INFO - 'MOZ_NO_REMOTE': '1', 18:24:15 INFO - 'NO_EM_RESTART': '1', 18:24:15 INFO - 'PAGER': '/bin/cat', 18:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:15 INFO - 'PWD': '/builds/slave/test', 18:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:15 INFO - 'SHELL': '/bin/bash', 18:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:24:15 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:15 INFO - 'USER': 'cltbld', 18:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:15 INFO - 'XPC_FLAGS': '0x0', 18:24:15 INFO - 'XPC_SERVICE_NAME': '0', 18:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-_vyhvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:15 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)) 18:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:15 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-E6i2Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:16 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)) 18:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-MMf7_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:16 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)) 18:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-6MmoXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 18:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ekvc1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:16 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)) 18:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-USWGFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:16 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)) 18:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ygNlPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:16 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)) 18:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-aNL0a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:16 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)) 18:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-fwi5I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:16 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)) 18:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ChFzgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:16 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)) 18:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:16 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-YfujBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:17 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)) 18:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-2Hvs11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 18:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ls6oOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:17 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)) 18:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-vIDMBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:17 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)) 18:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-g0Nibs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:17 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)) 18:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-9QuIQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:17 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)) 18:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:17 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-03mb4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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)) 18:24:17 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:24:17 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:24:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:19 INFO - Downloading blessings-1.6.tar.gz 18:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:24:19 INFO - Installing collected packages: blessings 18:24:19 INFO - Running setup.py install for blessings 18:24:19 INFO - Successfully installed blessings 18:24:19 INFO - Cleaning up... 18:24:19 INFO - Return code: 0 18:24:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:19 INFO - Reading from file tmpfile_stdout 18:24:19 INFO - Current package versions: 18:24:19 INFO - blessings == 1.6 18:24:19 INFO - blobuploader == 1.2.4 18:24:19 INFO - docopt == 0.6.1 18:24:19 INFO - functools32 == 3.2.3-2 18:24:19 INFO - jsonschema == 2.5.1 18:24:19 INFO - manifestparser == 1.1 18:24:19 INFO - mozInstall == 1.12 18:24:19 INFO - mozcrash == 1.0 18:24:19 INFO - mozdebug == 0.1 18:24:19 INFO - mozdevice == 0.50 18:24:19 INFO - mozfile == 1.2 18:24:19 INFO - mozhttpd == 0.7 18:24:19 INFO - mozinfo == 0.9 18:24:19 INFO - mozleak == 0.1 18:24:19 INFO - mozlog == 3.4 18:24:19 INFO - moznetwork == 0.27 18:24:19 INFO - mozprocess == 0.25 18:24:19 INFO - mozprofile == 0.28 18:24:19 INFO - mozrunner == 6.13 18:24:19 INFO - mozscreenshot == 0.1 18:24:19 INFO - mozsystemmonitor == 0.3 18:24:19 INFO - moztest == 0.8 18:24:19 INFO - mozversion == 1.4 18:24:19 INFO - psutil == 3.1.1 18:24:19 INFO - requests == 1.2.3 18:24:19 INFO - wsgiref == 0.1.2 18:24:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:19 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 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:24:19 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 18:24:19 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 18:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:19 INFO - 'HOME': '/Users/cltbld', 18:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:19 INFO - 'LOGNAME': 'cltbld', 18:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:19 INFO - 'MOZ_NO_REMOTE': '1', 18:24:19 INFO - 'NO_EM_RESTART': '1', 18:24:19 INFO - 'PAGER': '/bin/cat', 18:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:19 INFO - 'PWD': '/builds/slave/test', 18:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:19 INFO - 'SHELL': '/bin/bash', 18:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:24:19 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:19 INFO - 'USER': 'cltbld', 18:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:19 INFO - 'XPC_FLAGS': '0x0', 18:24:19 INFO - 'XPC_SERVICE_NAME': '0', 18:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:19 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)) 18:24:19 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)) 18:24:19 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)) 18:24:19 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)) 18:24:19 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)) 18:24:19 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)) 18:24:19 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)) 18:24:19 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)) 18:24:19 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)) 18:24:19 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)) 18:24:19 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)) 18:24:19 INFO - Cleaning up... 18:24:19 INFO - Return code: 0 18:24:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff833d63d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, '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.dJzTkqT80I/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.XtpvRrLUsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 18:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:19 INFO - 'HOME': '/Users/cltbld', 18:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:19 INFO - 'LOGNAME': 'cltbld', 18:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:19 INFO - 'MOZ_NO_REMOTE': '1', 18:24:19 INFO - 'NO_EM_RESTART': '1', 18:24:19 INFO - 'PAGER': '/bin/cat', 18:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:19 INFO - 'PWD': '/builds/slave/test', 18:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:19 INFO - 'SHELL': '/bin/bash', 18:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:24:19 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:19 INFO - 'USER': 'cltbld', 18:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:19 INFO - 'XPC_FLAGS': '0x0', 18:24:19 INFO - 'XPC_SERVICE_NAME': '0', 18:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:24:20 INFO - Cleaning up... 18:24:20 INFO - Return code: 0 18:24:20 INFO - Running post-action listener: _resource_record_post_action 18:24:20 INFO - Running post-action listener: _start_resource_monitoring 18:24:20 INFO - Starting resource monitoring. 18:24:20 INFO - [mozharness: 2017-05-11 01:24:20.226568Z] Finished create-virtualenv step (success) 18:24:20 INFO - [mozharness: 2017-05-11 01:24:20.227496Z] Running install step. 18:24:20 INFO - Running pre-action listener: _resource_record_pre_action 18:24:20 INFO - Running main action method: install 18:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:20 INFO - Reading from file tmpfile_stdout 18:24:20 INFO - Detecting whether we're running mozinstall >=1.0... 18:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:24:20 INFO - Reading from file tmpfile_stdout 18:24:20 INFO - Output received: 18:24:20 INFO - Usage: mozinstall [options] installer 18:24:20 INFO - Options: 18:24:20 INFO - -h, --help show this help message and exit 18:24:20 INFO - -d DEST, --destination=DEST 18:24:20 INFO - Directory to install application into. [default: 18:24:20 INFO - "/builds/slave/test"] 18:24:20 INFO - --app=APP Application being installed. [default: firefox] 18:24:20 INFO - mkdir: /builds/slave/test/build/application 18:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:24:41 INFO - Reading from file tmpfile_stdout 18:24:41 INFO - Output received: 18:24:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:24:41 INFO - Running post-action listener: _resource_record_post_action 18:24:41 INFO - [mozharness: 2017-05-11 01:24:41.113803Z] Finished install step (success) 18:24:41 INFO - [mozharness: 2017-05-11 01:24:41.113958Z] Running run-tests step. 18:24:41 INFO - Running pre-action listener: _resource_record_pre_action 18:24:41 INFO - Running main action method: run_tests 18:24:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:24:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:24:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:24:41 INFO - 2017-05-10 18:24:41.128 screenresolution[1631:7438] starting screenresolution argv=screenresolution get 18:24:41 INFO - 2017-05-10 18:24:41.131 screenresolution[1631:7438] Display 0: 1600x1200x32@60 18:24:41 INFO - 2017-05-10 18:24:41.136 screenresolution[1632:7440] starting screenresolution argv=screenresolution list 18:24:41 INFO - Available Modes on Display 0 18:24:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:24:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:24:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:24:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:24:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:24:41 INFO - Intel Iris: 18:24:41 INFO - Chipset Model: Intel Iris 18:24:41 INFO - Type: GPU 18:24:41 INFO - Bus: Built-In 18:24:41 INFO - VRAM (Dynamic, Max): 1536 MB 18:24:41 INFO - Vendor: Intel (0x8086) 18:24:41 INFO - Device ID: 0x0a2e 18:24:41 INFO - Revision ID: 0x0009 18:24:41 INFO - Displays: 18:24:41 INFO - Display: 18:24:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:24:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:24:41 INFO - Display Serial Number: 1600x1200 60 18:24:41 INFO - Main Display: Yes 18:24:41 INFO - Mirror: Off 18:24:41 INFO - Online: Yes 18:24:41 INFO - Rotation: Supported 18:24:41 INFO - Return code: 0 18:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:24:41 INFO - Python 2.7.3 18:24:41 INFO - Return code: 0 18:24:41 INFO - grabbing minidump binary from tooltool 18:24: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')]} 18:24:41 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 0x107a7cd30>, '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 0x107a2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a70be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:24:41 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 18:24:41 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 18:24:41 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 18:24:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:24:41 INFO - Return code: 0 18:24:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:24:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:24:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:24:41 INFO - ENV: RUST_BACKTRACE is now 1 18:24:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:24:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--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 18:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0121 --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 18:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dJzTkqT80I/Render', 18:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:41 INFO - 'HOME': '/Users/cltbld', 18:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:41 INFO - 'LOGNAME': 'cltbld', 18:24:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:24:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:41 INFO - 'MOZ_NO_REMOTE': '1', 18:24:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:24:41 INFO - 'NO_EM_RESTART': '1', 18:24:41 INFO - 'PAGER': '/bin/cat', 18:24:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:41 INFO - 'PWD': '/builds/slave/test', 18:24:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:41 INFO - 'RUST_BACKTRACE': '1', 18:24:41 INFO - 'SHELL': '/bin/bash', 18:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XtpvRrLUsb/Listeners', 18:24:41 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 18:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:41 INFO - 'USER': 'cltbld', 18:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:41 INFO - 'XPC_FLAGS': '0x0', 18:24:41 INFO - 'XPC_SERVICE_NAME': '0', 18:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--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 18:24:41 INFO - mozversion application_buildid: 20170510165125 18:24:41 INFO - mozversion application_changeset: d8762cb967423618ff0a488f14745f60964e5c49 18:24:41 INFO - mozversion application_display_name: Nightly 18:24:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:24:41 INFO - mozversion application_name: Firefox 18:24:41 INFO - mozversion application_remotingname: firefox 18:24:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:24:41 INFO - mozversion application_vendor: Mozilla 18:24:41 INFO - mozversion application_version: 55.0a1 18:24:41 INFO - mozversion platform_buildid: 20170510165125 18:24:41 INFO - mozversion platform_changeset: d8762cb967423618ff0a488f14745f60964e5c49 18:24:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:24:41 INFO - mozversion platform_version: 55.0a1 18:24:41 INFO - using testdate: 1494465881 18:24:41 INFO - actual date: 1494465881 18:24:41 INFO - starting webserver on 'localhost:49243' 18:24:41 INFO - SUITE-START | Running 2 tests 18:24:41 INFO - TEST-START | dromaeo_css 18:24:41 INFO - operating with platform_type : mac_ 18:24:41 INFO - Initialising browser for dromaeo_css test... 18:24:41 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpuYabRo/profile http://localhost:49243/getInfo.html) 18:24:43 INFO - PID 1642 | __metrics Screen width/height:1600/1200 18:24:43 INFO - PID 1642 | colorDepth:24 18:24:43 INFO - PID 1642 | Browser inner width/height: 1024/691 18:24:43 INFO - PID 1642 | __metrics 18:24:44 INFO - PID 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:24:44 INFO - PID 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:24:44 INFO - TEST-INFO | 1642: exit 0 18:24:44 INFO - Browser initialized. 18:24:44 INFO - Running cycle 1/1 for dromaeo_css test... 18:24:44 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpuYabRo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:56 INFO - PID 1644 | RSS: Main: 233541632 18:24:56 INFO - PID 1644 | 18:28:00 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 18:28:03 INFO - PID 1644 | RSS: Main: 417091584 18:28:03 INFO - PID 1644 | 18:31:05 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 18:31:06 INFO - PID 1644 | RSS: Main: 367669248 18:31:06 INFO - PID 1644 | 18:34:08 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 18:34:09 INFO - PID 1644 | RSS: Main: 330498048 18:34:09 INFO - PID 1644 | 18:37:11 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 18:37:11 INFO - PID 1644 | RSS: Main: 334450688 18:37:11 INFO - PID 1644 | 18:40:15 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 18:40:16 INFO - PID 1644 | RSS: Main: 331374592 18:40:16 INFO - PID 1644 | 18:43:18 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 18:43:18 INFO - PID 1644 | RSS: Main: 373616640 18:43:18 INFO - PID 1644 | 18:43:18 INFO - PID 1644 | __start_tp_report 18:43:18 INFO - PID 1644 | _x_x_mozilla_page_load 18:43:18 INFO - PID 1644 | _x_x_mozilla_page_load_details 18:43:18 INFO - PID 1644 | |i|pagename|runs| 18:43:18 INFO - PID 1644 | |0;dojo.html;3107.968920310797;3183.8697262471824;3442.3803715331233;3582.8029458379797;3584.2652256287465;6109.602875813069;6167;6227.844303892405;6245.687715614218;6250.093736408224;6155.507559395249;6189.412005859447;6204.472619827309;6209.751609935597;6261.718222679979;5279;5312.681239125645;5424.105022671254;5455.8363249102495;5508.531774799127;5474.698891560963;5545.889082218353;5548.77804887804;5555.861103472425;5563.499285064343;4503.301988191835;5373.489518495776;5419.620626556142;5481.780728770845;5507.008738427102;5154.433012368637;5478.753456094485;5491.450854914517;5514.779408823642;5559.27729395176;5384.111621582434;5424.294841670597;5455.1271796512365;5474.206240095164;5479.972600137014;6120.60216085953;6163.98294281443;6210.813675589739;6215.440610345046;6232.532560058014;6534.052562378476;6598.109255250528;6665.333466653345;6666.133402657672;6685;5300.761465734051;6757.898631520531;6769.492288078364;6791.015302781118;6791.592504449749;5280.445553216934;6242.063690446424;6261.5616906816085;6274.058891166362;6287.717052732638;6650.467962562983;6744.291849355845;6808.5914845109455;6893.517453778288;6913.619750913748;6536.7712130075215;6542.640154791532;6551.934480655228;6556.704948277339;6566.474682025427;5970.13433052205;6431.678416079178;6633.86732265352;6726;6730.32696730323;6419.935800642027;6479.222493300834;6638.86722265552;6655.567388119756;6659.134312539339;6109.829807539378;6347.619142851444;6544.54188206821;6607.669616519155;6639.966800165968;4494.4606647202545;4550.726956382628;5073.365829271341;5265.447128051576;5270.657407268515;4730.030343779517;4736.7631618418945;4749.453812811571;4763.904721905543;4803.78382972767;5158.871028224325;6196.287426945959;6267.874642507216;6271.874562508724;6272.498200143978;6544.9672751635935;6545.312742162005;6555.410013098844;6557.737690492422;6567.277599464151;6210.689465526796;6230.563860529719;6248.625082495065;6299.960506516465;6338.968305158444;5810.6513609183585;5834.299884013861;5872.207252020922;5877;5908.763649453974;6924.8277987059055;6979.127609048869;6984.580925144508;6989.405900498413;6991.685374158277;6536.477081833346;6610.438112760276;6620.569662971891;6782.593044417351;6785.016172655036;6877;6933.583984960918;6960.37356637905;6971.093757811452;6973.755918542826;6602.636854973022;6617.239017513048;6624.105745724266;6633.701483433354;6639.634820084942;5484;6517.837054073686;6746.021826835179;6748.392644662004;6750.898736519054;6296.212973378328;6343.270523889812;6447.967760161169;6455.677216139268;6490;6540.672966351568;6540.967295163684;6544.770933017321;6551.312112228147;6568.6058836469965;6401.423871851555;6451.322611125952;6456.160699109086;6459.450946669585;6463.482921366185;6303.810885673437;6364.299927008118;6369.172007638977;6387.169667943138;6570.671466426564;6317.052442133533;6319.46284565817;6327.746890124344;6329.90505142414;6331.683415829282 18:43:18 INFO - PID 1644 | |1;ext.html;784.6704384158653;795.7572940253223;1101.4767985207027;1122.6014764758515;1124.4265424633434;31449.842750786243;34846;34869;34884.95345139643;34977.3004539909;29976.850115749392;36822.815885920536;37089;37113.07217319568;37163;5715.828525144252;5818.5926985111055;7859.764207073797;8001.1198768135455;8001.919980800176;7884.093329267151;7952;7980.800479987989;7980.8403831923615;8007.279344858962;8011.759647210564;8059.5164290142775;8071.031476222862;8074.273315401612;8106.918930810675;5765.308163020464;5863.355030946593;8000.959995200045;8018.438709290352;8052.43632945694;7813.140554538996;7922.088959769642;7934.801629959239;7942.324902383304;7958;34851.6514834851;35206;35234.766783162726;35241.64758352409;35285;3519.9296014079573;3571.4285714285847;3607.801570913599;3615.8192090395373;3619.040954147153;28567;28795.856020719762;28807.279818004718;28820.279493012633;28825.135245942656;2715.660542432196;2732.330579008156;2748.1206014075506;2759.572266298727;2765.806393552452;293671.99999999785;293821;293955;294022.52988734917;297379;36973;37143.814280928425;37185.25629487395;45973.70131493412;46126.769366153625;47141.292880606816;47160.76419617949;47162.76418617885;47222.52777472181;47719.761401193464;13073.803892941614;13135.737285254241;13142.60572182836;13145.934270328587;13159.342032898317;10677.412742299248;10695.03744662984;10719.464026798629;10728.195385345975;10759.677209683565;11529.077673786078;11572.363520006313;11597.536098555964;11697;11703.356315402734;4343.348497725303;5199.246109314128;5231.633785634969;5235.685858848481;5244.5542128918705;898.2006014646969;972.8929817720045;983.9114479696862;986.6201512417771;1043.801677681238;20614.17543298281;23111.7688823113;23173.42066448352;23198.072077117064;23306.883465582563;1090.5528733219342;1095.4358505369742;1127.1039523578775;1128.4752590045505;1149.5114576305036;11434.771304573862;11899.88100119005;11904.047676185884;11953.940230298793;12111.636650900487;309035.9096409052;309237;309384;309538.452307737;310964.44517777266;48156;48335.758321208166;48344.75827620839;48503.514964850605;48564.51435485671;1340.751960887239;1454.861788130126;1490.821101467809;1536.0246243635372;1538.5845821628322;22731.204407846308;22807.657885131404;22841.543169136858;23007.849607519893;23174.1889033883;35592.28815423625;35606.465903011995;35610;35632;35639.93080207598;281385;282138;282467.5876620604;282676;283915.188905162;25333.87333063323;27268;27417.314567135185;30615.693843061283;31589.842050790518;39420.21159576735;39431.60568394279;39442;39671.2065758689;39776;26894.61190129422;27552.586711198946;29182.708172918;29215.707842922147;29509.557356639238;26535.469290613695;28053.01814436485;28186.01348952777;28477.857610711813;29295.560566591943;34615.826920865235;34623;34681.479777803856;34728.479072813425;34760;24129.793510324766;27241.455170896075;28052.85973570119;29034.709652904046;29555.408891822473;20175.79824201739;20929;22586.322410327717;23162.768372316736;23193.88403057974 18:43:18 INFO - PID 1644 | |2;jquery.html;376.85302731934553;423.95760423957626;424.9766262855546;440.3834631515878;452.9524399938006;18931.810681893177;20705.275315363964;21279.468013299676;21547.892260538694;21575.46061348467;22178.223762168327;22758.88620556899;23403.5319293614;23463.530729385402;23619.29142125739;6112.480439162677;6374.17135772349;6377.617342959414;6381.585196962183;6387.073874288226;5929.525637948954;6168.043953187241;6256.843578910518;6260.4991600672065;6262.780802671908;4868.707877527359;6157.0456579230295;6201.317855035943;6208.50331973441;6232.535354191761;6085.817425477243;6227.813165605039;6228.22147231596;6230.750769969196;6249.843753906121;5334.226537152092;5465.344158700942;5535.58483113768;5549.556035517189;5558.527525160366;20871.478213044644;27524.03665871705;27682.584761228598;27696.584551231746;28116.297092572644;1897.3643829317195;2121.7772133926023;2175.760666326703;2177.3903307074042;2182.770809065057;16844.326226950907;17573.20920558578;17652.382166624106;17656.558586035324;18222.726659100124;2123.9893800531054;2171.7176767020187;2183.787997661297;2185.2460900989136;2196.1544805249932;119760;151251;152738.23630881886;152754.7086793699;153653;11553.711157221136;11939.582114625946;11987.520499179935;12006.159568830099;12075.698107547207;15944.760828587581;15945.68108637844;15951;15954.840451595568;15962.521124366287;8647.956760216159;8887.911120888837;8905.866412003825;8939.73180804577;9061.365704400629;8463.53450560225;8491.622306468462;8493.915060849313;8644.654213831376;8678.609462574199;7624.504407213513;7742.993410856552;7746.690132394754;7765.53406795594;7772.844543109106;1805.521536792751;1813.1840671697526;2153.515459021739;2154.1060459908963;2340.1107579119825;924.902885197058;934.8737920380797;978.6819283732815;987.7579992901641;988.4958671077802;19876.204951802054;21603.67594486084;24136.03455861781;25892;25972.09097681572;1002.3134153105146;1006.4565134827111;1019.8470229465491;1038.3147122899002;1043.7599352148895;10743.51654175564;11164;11214.102871770401;11245.381504017194;11257.94371028156;545116;552878;554334;573570;577221;87078;106678.33304167457;108016;124344.37827810804;128474;1125.960591379314;1194.3550482739397;1238.0776321640435;1240.8883200512178;1242.0250103668757;20928.37214883556;22182;22489.662655060514;22509.549809004056;22627.321180364615;55837;56199.71900140473;56340.71829640825;56755.148672769115;56831.43168568261;73214.63392683002;73371.89942150765;75286;77052;79620.80568791588;8411.3270938326;8694.391392602458;8851.601677924638;8980.326475514494;9067.002629710594;13629.591112266648;13641.454341826216;13741;13825.861741382458;14003.789943150658;11718.472668729757;11906.880931190577;11959.644818436773;12003.63989080329;12016.63950081499;10853.45732713377;10872;11036.282641628268;11171.99452049287;11359.602413915803;11723.648290551297;11752.353620550952;11846.585369512026;12018.939905300418;12118.272903625812;8669.439500889648;8732;8743.256823170103;8887.822243555222;8950.23922966529;11704.122190835551;11902;11903.94048029789;11970.341631210367;12013.399330033288 18:43:18 INFO - PID 1644 | |3;mootools.html;1379.5171689908534;1434.1251836379806;1448.2830998655668;1455.4396557325433;1457.948971785987;11203.439828008597;11709.941450292747;11721.824172637407;11726.237794543349;11728.35494047827;11068.446577671104;11403.030742386887;11714.238574492652;11723.355215463145;11735.53057877686;2472.171822439485;2518.0305582350743;2521.5965445528627;2522.255934499318;2527.747225277476;2435.2450740270483;2475.282168171228;2477.6283557466345;2478.4175718706088;2480.8635525046116;2396.532676128156;2508.611165269386;2509.3099397665605;2512.170983575425;2512.459821138455;2489.3776555861036;2491.9377015574573;2511.4474815540552;2515.4717509322973;2516.798656107507;2254.3462395905167;2273.545290941818;2277.453411181321;2282.5549017941507;2286.342401758728;11542.653720388402;11584.884151158465;11693.883061169365;11697.3566453845;11721.296722196696;6546.9017964730565;6771.830704232384;6772.2211945626395;6786.59280443175;6791.660416979181;3916.295066887959;4216.704830661855;4261.957380426187;4274.807633656493;4275.038116423811;1143.4935218606104;1162.3897453836719;1201.783678937791;1202.128456868772;1205.8552973643132;14941.327640256106;15282.159481228638;15316.157611331373;16320.020798752113;16443.58891027722;5348.331458567679;5492.450754924475;5648.181013752983;5648.237487939075;5651.547876169897;11625.011873990805;11632.592859249886;11635.825462618068;11652.708682283012;11670.533178672928;6540.607563546202;6544.116544266463;6548.934510654928;6549.639769812706;6553.508486863504;6112.113743507255;6154.630722156596;6178.3255452489475;6179.62922224659;6261.499080073583;4219.78901054946;4314.69797114199;4362.236608593484;4407.206702793528;4408.184485870124;1226.907981901361;1245.227958665615;1261.2369516442604;1262.8610852806185;1263.1915574032625;781.7537475695137;784.7135795434625;787.551095875357;788.8777239527882;793.8213901872148;6003.519718422515;6311.684415779285;6528.281888992207;6584.958662814543;6615.702293396713;938.938968967015;955.4171955107379;955.8661787349638;959.12240300126;959.1511512311655;3538.610752817188;3772.849086036583;3809.3904975203836;3816.2367526494813;3827.6937844972335;14147.575572732834;14855.182964936816;14864.331105100297;14879.404823807143;14912.62718432048;13935.88512918964;14766.335514901855;14775.852241477447;14776.113433194043;14796.48212312564;8145.592720363839;8160.591970401456;8252.752417427488;8510.702125425703;8516.40385173032;5468.835934921959;6523.31505191967;6769.289224631343;6802.387785099167;6813.965930170516;12238.326892021025;12933.712972675807;13005.804912926125;13389.129706569041;13389.464421423034;12909.225446473241;13015.284159371326;13287.06990510655;13313.733725325634;13416.195028298333;8069.515829050276;8337.041240257206;8341.124181960808;8354.958225208835;8357.623906924324;10469.633562825264;10503.264771465923;10522.684319470429;10711.143108551452;10713.410762408143;9006.50464224474;9089.227415669742;9103.453792772454;9149.268058555166;9190.954045229731;7712.688842896609;8721.171488708562;8923.375363724737;8962.73111806647;9013.18881300686;7841.607919603883;7996.080450748238;8003.359731221604;8005.39959503028;8014.519128852287;5830.358660547421;5904.202932604044;5935.525157987265;5985.072313791369;6059;5489.862753431196;5907.17299578068;5953.345132035559;6071.726772295346;6107.6640784757265 18:43:18 INFO - PID 1644 | |4;prototype.html;400.5753900865083;401.53221496956047;407.61073175117764;408.80173116038696;410.79049684660833;5135.05001574709;6022.675011497464;6038.154658347829;6060.000099983508;6113.32753397126;4072.755634661915;5948.970255148729;5986.760529578812;6013.1581578579035;6041.818745437644;3792.905177370574;4650.465196502395;4658.208104622222;4659.557342052508;4675.298705194231;4651.97656515566;4661.44062712475;4661.743604101773;4671.369365135714;4689.343491911118;4052.696047796412;4502.302143167814;4617.746023968681;4650.0932318197965;4674.953250467486;3884.8057597120173;4115.36211887158;4509.413776209105;4549.044700612875;4625.953740462586;3268.4116858965376;3600;4090.6931980101313;4159.126583417486;4178.26880295947;4746.905061898778;5821.708914554255;5853.707314634294;5893.263342082239;5923.614965027259;5490.91763623542;5496.450354964471;5520.696361700105;5523.309586301712;5529.087700529408;5073.594112470993;5095.955329157551;5284.339457567804;6465.288818229991;6509.707063182168;4265.317549192115;4398.714083584557;4707.152712511746;4731.952680473186;4756.476787553366;6506.772262970773;6643.534952553275;6694.43097336727;6774.322567743236;6779.0509328694025;4328.350747387917;4657.580817726421;4751.429828420612;4819;4847.636427267969;4162.91674166515;4891.948231130324;4947.056501381672;4952.975235123801;4966.652334336562;4792.400949881265;5313.388960269618;5436.972815135899;5437;5502.9174562381595;6372.649504277217;6407.295197528269;6518.217813862367;6524.086627872101;6544.036788963387;1420.3395421129019;1562.2266977845811;1663.9417620383228;1703.9829601703825;1704.1734758642049;1002.9448380339005;1166.1894982986744;1178.1458442629025;1186.4067966016992;1202.464903118104;5354.518093371616;5616.297962754656;6108;6124.8775024500155;6144.539159563051;5185.896282074337;5764.74058667361;6649.700763465656;6654.86690266192;6709.859323914946;5972.40275972408;6009.639421634716;6053.909191362133;6108.664023478663;6172.444479996732;2995.251187203199;3018.758499320049;3320.236345640468;3463.9826800865835;3471.4272145096284;6619.702113404908;6799.558028728117;6830.702166588332;6903.5167538271835;6924.688389022506;6743.898841517381;6792.422644075309;6826.283240259801;6843.555168914005;6878.69045892936;6003.969980150071;6770.6979626926095;6835.624040677611;6881.827954301182;6906.343897329745;6065.878682426415;6569.441597464078;6641.236257830411;6673.7298723626045;6686.632235227109;5711.139081183016;6159.753609855735;6548.901766473411;6562.475001999924;6584.378591774601;6734.461243100638;6865.588064716133;6865.794026179223;6886.2769409213315;6932.341427564374;4293.720908140961;4333.848315308949;4346.739195648272;4350.282203436397;4351.390805287199;5912.497437717842;6285.779997700059;6443.355664433707;6526.771562995463;6643.335666433318;6446.8388290293115;6449.774257900951;6463.967680161569;6467.741290348334;6485.54601177913;5560.749766260609;6298;6320;6391.32891046452;6415.743370265137;6326.841828954313;6336.873262534816;6337.6197428154455;6352.587081839665;6361.363863613602;5591.860203494945;6166.938330616636;6365.204349456318;6376.458001069961;6423.775167869102;6285.811425657238;6298;6305.495560355069;6313.810585682437;6332.430081292706 18:43:18 INFO - PID 1644 | |5;yui.html;741.9369353604943;764.8087978005499;860.707359497771;865.8354912566612;878.6046279174374;16441.849070565037;16464;16930.830691693078;16989.40537081201;16993.40523081691;13036.283004434752;15616;15668.216589170554;15680.607984800357;15782.131982740944;978.7699890525721;993.2749093161996;995.4077323992213;997.917259773147;998.5456617239139;1006.1598565198068;1007.0634310091611;1007.3150257824676;1010.242318261304;1012.4077414712402;1015.4364327798069;1017.96946091617;1018.3024628129717;1020.0513522424143;1041.286718597759;1013.245132376377;1014.0164040880335;1014.3609525998611;1015.4567306490992;1053.2416660004785;771.0708596141636;771.1132197972321;772.420684486635;772.7643068863994;777.7005852746677;15967.920160399124;16060.036397816051;16943.237554309962;17087.401940932006;17501.649967000714;17132.400365987254;17175.227114779864;17382.739258911126;17538.649227015387;17602.647947040987;12142;14066.648333791738;14070.296485175802;14257.859371250275;14587.635309117251;3520.2431477232517;3535.681788639035;3536.929261414783;3538.5930617979006;3538.6461353864665;90456;127159;127300.36349818284;129072.35463822715;131149;10736.892631073746;10996.395198264172;13417.194968301934;13825.377857996415;13856.792148117785;24010.7598924012;24768.25695229146;24894.128705495583;25486.617700734503;25508.97964081416;7621.504602200839;7661.233876612406;7684.923150768421;7699.345555627722;7706.113796913427;3737.2151848111657;3747.737658363943;3758.3798673219158;3819.2934307153264;3836.8081595920094;4250.447441832542;4318.913621727548;4324.56754324565;4328.09110086879;4331.566843315706;887.4497811356871;899.7930475990559;909.7043460875242;910.8178364327161;917.1516347378648;647.9352064793483;653.7189008726293;655.0926966151819;660.4683229999896;686.3205426627603;10214.189425333296;10851.837222441669;10933.343999360064;11250.831237531444;12062.035037197003;637.5664548107331;647.8833809914261;668.5320275806955;672.0725398949419;685.6331862453563;5491.36849262332;5542.445755424506;5727.3699893011735;5768.1636162757;6209.813705588839;107172.4641376788;107964.92035079705;108783;110825;115048;92247.53876230576;92588.7593934209;93416.53291733497;93689.5315523418;95032;82643;83843;84377;84588;84879.15120848836;11852.229605075643;12235.816462752888;12399.690007749878;12438.564650237198;12498.25010499373;37730.43404348992;40061.59938400695;42244.788776057154;42558.787206063775;43299.567004329554;52681.736591316796;53823.73088134534;53930.19104713511;54823.629409265086;54946.175807362124;15960.441384551485;16066.518004459886;16586.502404927873;16662.916685416494;16756.497305080866;17760.023198724193;18055.187516561524;18223.271069157086;18356.541086472946;18502.629947401245;16490.670186596442;16622.75065874037;17037.82962170412;17161.914190429467;17208;15926.28331725052;15929.442469513511;16240.837591624406;16429;16488.752668710218;16399.508014759576;16526.504204873872;17020.404285850433;17554.91222543879;18457.261709531467;9552.474613896302;10237.74405639865;11924.70188245266;11987.34069626144;12149.939250303692;13243.47026118983;13379.799303010657;13515.662108447368;13549.390277437737;13555.525556605471 18:43:18 INFO - PID 1644 | __end_tp_report 18:43:18 INFO - PID 1644 | __start_cc_report 18:43:18 INFO - PID 1644 | _x_x_mozilla_cycle_collect,2174 18:43:18 INFO - PID 1644 | __end_cc_report 18:43:18 INFO - PID 1644 | __startTimestamp1494466998516__endTimestamp 18:43:18 INFO - PID 1644 | 18:43:18 INFO - PID 1644 | ------- Summary: start ------- 18:43:18 INFO - PID 1644 | Number of tests: 6 18:43:18 INFO - PID 1644 | 18:43:18 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:6099.55 Median:6327.75 stddev:763.20 (12.1%) stddev-sans-first:728.57 18:43:18 INFO - PID 1644 | Values: 3108.0 3183.9 3442.4 3582.8 3584.3 6109.6 6167.0 6227.8 6245.7 6250.1 6155.5 6189.4 6204.5 6209.8 6261.7 5279.0 5312.7 5424.1 5455.8 5508.5 5474.7 5545.9 5548.8 5555.9 5563.5 4503.3 5373.5 5419.6 5481.8 5507.0 5154.4 5478.8 5491.5 5514.8 5559.3 5384.1 5424.3 5455.1 5474.2 5480.0 6120.6 6164.0 6210.8 6215.4 6232.5 6534.1 6598.1 6665.3 6666.1 6685.0 5300.8 6757.9 6769.5 6791.0 6791.6 5280.4 6242.1 6261.6 6274.1 6287.7 6650.5 6744.3 6808.6 6893.5 6913.6 6536.8 6542.6 6551.9 6556.7 6566.5 5970.1 6431.7 6633.9 6726.0 6730.3 6419.9 6479.2 6638.9 6655.6 6659.1 6109.8 6347.6 6544.5 6607.7 6640.0 4494.5 4550.7 5073.4 5265.4 5270.7 4730.0 4736.8 4749.5 4763.9 4803.8 5158.9 6196.3 6267.9 6271.9 6272.5 6545.0 6545.3 6555.4 6557.7 6567.3 6210.7 6230.6 6248.6 6300.0 6339.0 5810.7 5834.3 5872.2 5877.0 5908.8 6924.8 6979.1 6984.6 6989.4 6991.7 6536.5 6610.4 6620.6 6782.6 6785.0 6877.0 6933.6 6960.4 6971.1 6973.8 6602.6 6617.2 6624.1 6633.7 6639.6 5484.0 6517.8 6746.0 6748.4 6750.9 6296.2 6343.3 6448.0 6455.7 6490.0 6540.7 6541.0 6544.8 6551.3 6568.6 6401.4 6451.3 6456.2 6459.5 6463.5 6303.8 6364.3 6369.2 6387.2 6570.7 6317.1 6319.5 6327.7 6329.9 6331.7 18:43:18 INFO - PID 1644 | 18:43:18 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:43009.07 Median:309310.50 stddev:77727.37 (25.1%) stddev-sans-first:77880.77 18:43:18 INFO - PID 1644 | Values: 784.7 795.8 1101.5 1122.6 1124.4 31449.8 34846.0 34869.0 34885.0 34977.3 29976.9 36822.8 37089.0 37113.1 37163.0 5715.8 5818.6 7859.8 8001.1 8001.9 7884.1 7952.0 7980.8 7980.8 8007.3 8011.8 8059.5 8071.0 8074.3 8106.9 5765.3 5863.4 8001.0 8018.4 8052.4 7813.1 7922.1 7934.8 7942.3 7958.0 34851.7 35206.0 35234.8 35241.6 35285.0 3519.9 3571.4 3607.8 3615.8 3619.0 28567.0 28795.9 28807.3 28820.3 28825.1 2715.7 2732.3 2748.1 2759.6 2765.8 293672.0 293821.0 293955.0 294022.5 297379.0 36973.0 37143.8 37185.3 45973.7 46126.8 47141.3 47160.8 47162.8 47222.5 47719.8 13073.8 13135.7 13142.6 13145.9 13159.3 10677.4 10695.0 10719.5 10728.2 10759.7 11529.1 11572.4 11597.5 11697.0 11703.4 4343.3 5199.2 5231.6 5235.7 5244.6 898.2 972.9 983.9 986.6 1043.8 20614.2 23111.8 23173.4 23198.1 23306.9 1090.6 1095.4 1127.1 1128.5 1149.5 11434.8 11899.9 11904.0 11953.9 12111.6 309035.9 309237.0 309384.0 309538.5 310964.4 48156.0 48335.8 48344.8 48503.5 48564.5 1340.8 1454.9 1490.8 1536.0 1538.6 22731.2 22807.7 22841.5 23007.8 23174.2 35592.3 35606.5 35610.0 35632.0 35639.9 281385.0 282138.0 282467.6 282676.0 283915.2 25333.9 27268.0 27417.3 30615.7 31589.8 39420.2 39431.6 39442.0 39671.2 39776.0 26894.6 27552.6 29182.7 29215.7 29509.6 26535.5 28053.0 28186.0 28477.9 29295.6 34615.8 34623.0 34681.5 34728.5 34760.0 24129.8 27241.5 28052.9 29034.7 29555.4 20175.8 20929.0 22586.3 23162.8 23193.9 18:43:18 INFO - PID 1644 | 18:43:18 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:35154.47 Median:22568.44 stddev:94211.48 (417.4%) stddev-sans-first:94439.58 18:43:18 INFO - PID 1644 | Values: 376.9 424.0 425.0 440.4 453.0 18931.8 20705.3 21279.5 21547.9 21575.5 22178.2 22758.9 23403.5 23463.5 23619.3 6112.5 6374.2 6377.6 6381.6 6387.1 5929.5 6168.0 6256.8 6260.5 6262.8 4868.7 6157.0 6201.3 6208.5 6232.5 6085.8 6227.8 6228.2 6230.8 6249.8 5334.2 5465.3 5535.6 5549.6 5558.5 20871.5 27524.0 27682.6 27696.6 28116.3 1897.4 2121.8 2175.8 2177.4 2182.8 16844.3 17573.2 17652.4 17656.6 18222.7 2124.0 2171.7 2183.8 2185.2 2196.2 119760.0 151251.0 152738.2 152754.7 153653.0 11553.7 11939.6 11987.5 12006.2 12075.7 15944.8 15945.7 15951.0 15954.8 15962.5 8648.0 8887.9 8905.9 8939.7 9061.4 8463.5 8491.6 8493.9 8644.7 8678.6 7624.5 7743.0 7746.7 7765.5 7772.8 1805.5 1813.2 2153.5 2154.1 2340.1 924.9 934.9 978.7 987.8 988.5 19876.2 21603.7 24136.0 25892.0 25972.1 1002.3 1006.5 1019.8 1038.3 1043.8 10743.5 11164.0 11214.1 11245.4 11257.9 545116.0 552878.0 554334.0 573570.0 577221.0 87078.0 106678.3 108016.0 124344.4 128474.0 1126.0 1194.4 1238.1 1240.9 1242.0 20928.4 22182.0 22489.7 22509.5 22627.3 55837.0 56199.7 56340.7 56755.1 56831.4 73214.6 73371.9 75286.0 77052.0 79620.8 8411.3 8694.4 8851.6 8980.3 9067.0 13629.6 13641.5 13741.0 13825.9 14003.8 11718.5 11906.9 11959.6 12003.6 12016.6 10853.5 10872.0 11036.3 11172.0 11359.6 11723.6 11752.4 11846.6 12018.9 12118.3 8669.4 8732.0 8743.3 8887.8 8950.2 11704.1 11902.0 11903.9 11970.3 12013.4 18:43:18 INFO - PID 1644 | 18:43:18 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:6957.08 Median:3655.73 stddev:4377.16 (119.7%) stddev-sans-first:4369.37 18:43:18 INFO - PID 1644 | Values: 1379.5 1434.1 1448.3 1455.4 1457.9 11203.4 11709.9 11721.8 11726.2 11728.4 11068.4 11403.0 11714.2 11723.4 11735.5 2472.2 2518.0 2521.6 2522.3 2527.7 2435.2 2475.3 2477.6 2478.4 2480.9 2396.5 2508.6 2509.3 2512.2 2512.5 2489.4 2491.9 2511.4 2515.5 2516.8 2254.3 2273.5 2277.5 2282.6 2286.3 11542.7 11584.9 11693.9 11697.4 11721.3 6546.9 6771.8 6772.2 6786.6 6791.7 3916.3 4216.7 4262.0 4274.8 4275.0 1143.5 1162.4 1201.8 1202.1 1205.9 14941.3 15282.2 15316.2 16320.0 16443.6 5348.3 5492.5 5648.2 5648.2 5651.5 11625.0 11632.6 11635.8 11652.7 11670.5 6540.6 6544.1 6548.9 6549.6 6553.5 6112.1 6154.6 6178.3 6179.6 6261.5 4219.8 4314.7 4362.2 4407.2 4408.2 1226.9 1245.2 1261.2 1262.9 1263.2 781.8 784.7 787.6 788.9 793.8 6003.5 6311.7 6528.3 6585.0 6615.7 938.9 955.4 955.9 959.1 959.2 3538.6 3772.8 3809.4 3816.2 3827.7 14147.6 14855.2 14864.3 14879.4 14912.6 13935.9 14766.3 14775.9 14776.1 14796.5 8145.6 8160.6 8252.8 8510.7 8516.4 5468.8 6523.3 6769.3 6802.4 6814.0 12238.3 12933.7 13005.8 13389.1 13389.5 12909.2 13015.3 13287.1 13313.7 13416.2 8069.5 8337.0 8341.1 8355.0 8357.6 10469.6 10503.3 10522.7 10711.1 10713.4 9006.5 9089.2 9103.5 9149.3 9191.0 7712.7 8721.2 8923.4 8962.7 9013.2 7841.6 7996.1 8003.4 8005.4 8014.5 5830.4 5904.2 5935.5 5985.1 6059.0 5489.9 5907.2 5953.3 6071.7 6107.7 18:43:18 INFO - PID 1644 | 18:43:18 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5261.54 Median:5902.88 stddev:1605.18 (27.2%) stddev-sans-first:1567.67 18:43:18 INFO - PID 1644 | Values: 400.6 401.5 407.6 408.8 410.8 5135.1 6022.7 6038.2 6060.0 6113.3 4072.8 5949.0 5986.8 6013.2 6041.8 3792.9 4650.5 4658.2 4659.6 4675.3 4652.0 4661.4 4661.7 4671.4 4689.3 4052.7 4502.3 4617.7 4650.1 4675.0 3884.8 4115.4 4509.4 4549.0 4626.0 3268.4 3600.0 4090.7 4159.1 4178.3 4746.9 5821.7 5853.7 5893.3 5923.6 5490.9 5496.5 5520.7 5523.3 5529.1 5073.6 5096.0 5284.3 6465.3 6509.7 4265.3 4398.7 4707.2 4732.0 4756.5 6506.8 6643.5 6694.4 6774.3 6779.1 4328.4 4657.6 4751.4 4819.0 4847.6 4162.9 4891.9 4947.1 4953.0 4966.7 4792.4 5313.4 5437.0 5437.0 5502.9 6372.6 6407.3 6518.2 6524.1 6544.0 1420.3 1562.2 1663.9 1704.0 1704.2 1002.9 1166.2 1178.1 1186.4 1202.5 5354.5 5616.3 6108.0 6124.9 6144.5 5185.9 5764.7 6649.7 6654.9 6709.9 5972.4 6009.6 6053.9 6108.7 6172.4 2995.3 3018.8 3320.2 3464.0 3471.4 6619.7 6799.6 6830.7 6903.5 6924.7 6743.9 6792.4 6826.3 6843.6 6878.7 6004.0 6770.7 6835.6 6881.8 6906.3 6065.9 6569.4 6641.2 6673.7 6686.6 5711.1 6159.8 6548.9 6562.5 6584.4 6734.5 6865.6 6865.8 6886.3 6932.3 4293.7 4333.8 4346.7 4350.3 4351.4 5912.5 6285.8 6443.4 6526.8 6643.3 6446.8 6449.8 6464.0 6467.7 6485.5 5560.7 6298.0 6320.0 6391.3 6415.7 6326.8 6336.9 6337.6 6352.6 6361.4 5591.9 6166.9 6365.2 6376.5 6423.8 6285.8 6298.0 6305.5 6313.8 6332.4 18:43:18 INFO - PID 1644 | 18:43:18 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:21854.42 Median:17578.78 stddev:31014.77 (176.4%) stddev-sans-first:31061.26 18:43:18 INFO - PID 1644 | Values: 741.9 764.8 860.7 865.8 878.6 16441.8 16464.0 16930.8 16989.4 16993.4 13036.3 15616.0 15668.2 15680.6 15782.1 978.8 993.3 995.4 997.9 998.5 1006.2 1007.1 1007.3 1010.2 1012.4 1015.4 1018.0 1018.3 1020.1 1041.3 1013.2 1014.0 1014.4 1015.5 1053.2 771.1 771.1 772.4 772.8 777.7 15967.9 16060.0 16943.2 17087.4 17501.6 17132.4 17175.2 17382.7 17538.6 17602.6 12142.0 14066.6 14070.3 14257.9 14587.6 3520.2 3535.7 3536.9 3538.6 3538.6 90456.0 127159.0 127300.4 129072.4 131149.0 10736.9 10996.4 13417.2 13825.4 13856.8 24010.8 24768.3 24894.1 25486.6 25509.0 7621.5 7661.2 7684.9 7699.3 7706.1 3737.2 3747.7 3758.4 3819.3 3836.8 4250.4 4318.9 4324.6 4328.1 4331.6 887.4 899.8 909.7 910.8 917.2 647.9 653.7 655.1 660.5 686.3 10214.2 10851.8 10933.3 11250.8 12062.0 637.6 647.9 668.5 672.1 685.6 5491.4 5542.4 5727.4 5768.2 6209.8 107172.5 107964.9 108783.0 110825.0 115048.0 92247.5 92588.8 93416.5 93689.5 95032.0 82643.0 83843.0 84377.0 84588.0 84879.2 11852.2 12235.8 12399.7 12438.6 12498.3 37730.4 40061.6 42244.8 42558.8 43299.6 52681.7 53823.7 53930.2 54823.6 54946.2 15960.4 16066.5 16586.5 16662.9 16756.5 17760.0 18055.2 18223.3 18356.5 18502.6 16490.7 16622.8 17037.8 17161.9 17208.0 15926.3 15929.4 16240.8 16429.0 16488.8 16399.5 16526.5 17020.4 17554.9 18457.3 9552.5 10237.7 11924.7 11987.3 12149.9 13243.5 13379.8 13515.7 13549.4 13555.5 18:43:18 INFO - PID 1644 | -------- Summary: end -------- 18:43:18 INFO - PID 1644 | 18:43:19 INFO - TEST-INFO | 1644: exit 0 18:43:19 INFO - TEST-OK | dromaeo_css | took 1117476ms 18:43:19 INFO - TEST-START | kraken 18:43:19 INFO - operating with platform_type : mac_ 18:43:19 INFO - Initialising browser for kraken test... 18:43:19 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpL5HFv9/profile http://localhost:49243/getInfo.html) 18:43:21 INFO - PID 1655 | __metrics Screen width/height:1600/1200 18:43:21 INFO - PID 1655 | colorDepth:24 18:43:21 INFO - PID 1655 | Browser inner width/height: 1024/691 18:43:21 INFO - PID 1655 | __metrics 18:43:21 INFO - PID 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:43:21 INFO - PID 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:43:22 INFO - TEST-INFO | 1655: exit 0 18:43:22 INFO - Browser initialized. 18:43:22 INFO - Running cycle 1/1 for kraken test... 18:43:22 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpL5HFv9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:43:34 INFO - PID 1656 | RSS: Main: 234946560 18:43:34 INFO - PID 1656 | 18:43:36 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 18:43:37 INFO - PID 1656 | RSS: Main: 303681536 18:43:37 INFO - PID 1656 | 18:43:40 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 18:43:40 INFO - PID 1656 | RSS: Main: 286380032 18:43:40 INFO - PID 1656 | 18:43:44 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 18:43:44 INFO - PID 1656 | RSS: Main: 375087104 18:43:44 INFO - PID 1656 | 18:43:46 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 18:43:47 INFO - PID 1656 | RSS: Main: 281079808 18:43:47 INFO - PID 1656 | 18:43:49 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:43:49 INFO - PID 1656 | RSS: Main: 283791360 18:43:49 INFO - PID 1656 | 18:43:52 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 18:43:53 INFO - PID 1656 | RSS: Main: 347381760 18:43:53 INFO - PID 1656 | 18:43:56 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 18:43:56 INFO - PID 1656 | RSS: Main: 363036672 18:43:56 INFO - PID 1656 | 18:43:59 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 18:44:00 INFO - PID 1656 | RSS: Main: 368197632 18:44:00 INFO - PID 1656 | 18:44:01 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:44:02 INFO - PID 1656 | RSS: Main: 323870720 18:44:02 INFO - PID 1656 | 18:44:03 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:44:04 INFO - PID 1656 | RSS: Main: 327544832 18:44:04 INFO - PID 1656 | 18:44:06 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:44:07 INFO - PID 1656 | RSS: Main: 329773056 18:44:07 INFO - PID 1656 | 18:44:10 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:44:11 INFO - PID 1656 | RSS: Main: 340176896 18:44:11 INFO - PID 1656 | 18:44:14 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:44:14 INFO - PID 1656 | RSS: Main: 337678336 18:44:14 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 18:44:16 INFO - PID 1656 | RSS: Main: 380932096 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | __start_tp_report 18:44:16 INFO - PID 1656 | _x_x_mozilla_page_load 18:44:16 INFO - PID 1656 | _x_x_mozilla_page_load_details 18:44:16 INFO - PID 1656 | |i|pagename|runs| 18:44:16 INFO - PID 1656 | |0;ai-astar;111;116;112;110;111;112;110;110;111;110 18:44:16 INFO - PID 1656 | |1;audio-beat-detection;140;110;107;145;111;109;108;111;156;115 18:44:16 INFO - PID 1656 | |2;audio-dft;185;184;182;184;185;183;185;184;186;184 18:44:16 INFO - PID 1656 | |3;audio-fft;79;57;58;87;59;59;58;57;82;60 18:44:16 INFO - PID 1656 | |4;audio-oscillator;93;69;85;69;69;69;90;69;69;89 18:44:16 INFO - PID 1656 | |5;imaging-gaussian-blur;87;87;88;87;87;87;87;88;87;87 18:44:16 INFO - PID 1656 | |6;imaging-darkroom;95;94;95;95;94;94;95;95;94;94 18:44:16 INFO - PID 1656 | |7;imaging-desaturate;88;84;83;85;86;83;86;84;85;85 18:44:16 INFO - PID 1656 | |8;json-parse-financial;51;47;47;47;47;49;49;49;47;47 18:44:16 INFO - PID 1656 | |9;json-stringify-tinderbox;54;54;55;64;64;58;57;59;58;58 18:44:16 INFO - PID 1656 | |10;stanford-crypto-aes;83;82;80;83;80;83;82;81;81;82 18:44:16 INFO - PID 1656 | |11;stanford-crypto-ccm;142;153;131;151;145;148;130;140;261;138 18:44:16 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;184;221;184;182;184;183;192;185;216;178 18:44:16 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;70;68;67;68;68;68;67;70;67;68 18:44:16 INFO - PID 1656 | __end_tp_report 18:44:16 INFO - PID 1656 | __start_cc_report 18:44:16 INFO - PID 1656 | _x_x_mozilla_cycle_collect,2148 18:44:16 INFO - PID 1656 | __end_cc_report 18:44:16 INFO - PID 1656 | __startTimestamp1494467056863__endTimestamp 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | ------- Summary: start ------- 18:44:16 INFO - PID 1656 | Number of tests: 14 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:1.83 (1.6%) stddev-sans-first:1.94 18:44:16 INFO - PID 1656 | Values: 111.0 116.0 112.0 110.0 111.0 112.0 110.0 110.0 111.0 110.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:113.00 stddev:18.34 (16.2%) stddev-sans-first:18.15 18:44:16 INFO - PID 1656 | Values: 140.0 110.0 107.0 145.0 111.0 109.0 108.0 111.0 156.0 115.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:1.14 (0.6%) stddev-sans-first:1.17 18:44:16 INFO - PID 1656 | Values: 185.0 184.0 182.0 184.0 185.0 183.0 185.0 184.0 186.0 184.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:65.60 Median:59.50 stddev:11.96 (20.1%) stddev-sans-first:11.67 18:44:16 INFO - PID 1656 | Values: 79.0 57.0 58.0 87.0 59.0 59.0 58.0 57.0 82.0 60.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.00 stddev:10.63 (13.8%) stddev-sans-first:9.59 18:44:16 INFO - PID 1656 | Values: 93.0 69.0 85.0 69.0 69.0 69.0 90.0 69.0 69.0 89.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:87.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 18:44:16 INFO - PID 1656 | Values: 87.0 87.0 88.0 87.0 87.0 87.0 87.0 88.0 87.0 87.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 18:44:16 INFO - PID 1656 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.52 (1.8%) stddev-sans-first:1.13 18:44:16 INFO - PID 1656 | Values: 88.0 84.0 83.0 85.0 86.0 83.0 86.0 84.0 85.0 85.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:48.00 stddev:1.41 (2.9%) stddev-sans-first:1.00 18:44:16 INFO - PID 1656 | Values: 51.0 47.0 47.0 47.0 47.0 49.0 49.0 49.0 47.0 47.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:3.57 (6.2%) stddev-sans-first:3.47 18:44:16 INFO - PID 1656 | Values: 54.0 54.0 55.0 64.0 64.0 58.0 57.0 59.0 58.0 58.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:1.16 (1.4%) stddev-sans-first:1.13 18:44:16 INFO - PID 1656 | Values: 83.0 82.0 80.0 83.0 80.0 83.0 82.0 81.0 81.0 82.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:146.50 stddev:38.41 (26.2%) stddev-sans-first:40.50 18:44:16 INFO - PID 1656 | Values: 142.0 153.0 131.0 151.0 145.0 148.0 130.0 140.0 261.0 138.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:184.50 stddev:14.99 (8.1%) stddev-sans-first:15.69 18:44:16 INFO - PID 1656 | Values: 184.0 221.0 184.0 182.0 184.0 183.0 192.0 185.0 216.0 178.0 18:44:16 INFO - PID 1656 | 18:44:16 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:0.93 18:44:16 INFO - PID 1656 | Values: 70.0 68.0 67.0 68.0 68.0 68.0 67.0 70.0 67.0 68.0 18:44:16 INFO - PID 1656 | -------- Summary: end -------- 18:44:16 INFO - PID 1656 | 18:44:17 INFO - TEST-INFO | 1656: exit 0 18:44:17 INFO - TEST-OK | kraken | took 58737ms 18:44:17 INFO - SUITE-END | took 1176s 18:44:18 INFO - Completed test suite (00:19:36) 18:44:18 INFO - javascript benchmark 18:44:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7741.089805537228, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.968920310797, 3183.8697262471824, 3442.3803715331233, 3582.8029458379797, 3584.2652256287465, 6109.602875813069, 6167.0, 6227.844303892405, 6245.687715614218, 6250.093736408224, 6155.507559395249, 6189.412005859447, 6204.472619827309, 6209.751609935597, 6261.718222679979, 5279.0, 5312.681239125645, 5424.105022671254, 5455.8363249102495, 5508.531774799127, 5474.698891560963, 5545.889082218353, 5548.77804887804, 5555.861103472425, 5563.499285064343, 4503.301988191835, 5373.489518495776, 5419.620626556142, 5481.780728770845, 5507.008738427102, 5154.433012368637, 5478.753456094485, 5491.450854914517, 5514.779408823642, 5559.27729395176, 5384.111621582434, 5424.294841670597, 5455.1271796512365, 5474.206240095164, 5479.972600137014, 6120.60216085953, 6163.98294281443, 6210.813675589739, 6215.440610345046, 6232.532560058014, 6534.052562378476, 6598.109255250528, 6665.333466653345, 6666.133402657672, 6685.0, 5300.761465734051, 6757.898631520531, 6769.492288078364, 6791.015302781118, 6791.592504449749, 5280.445553216934, 6242.063690446424, 6261.5616906816085, 6274.058891166362, 6287.717052732638, 6650.467962562983, 6744.291849355845, 6808.5914845109455, 6893.517453778288, 6913.619750913748, 6536.7712130075215, 6542.640154791532, 6551.934480655228, 6556.704948277339, 6566.474682025427, 5970.13433052205, 6431.678416079178, 6633.86732265352, 6726.0, 6730.32696730323, 6419.935800642027, 6479.222493300834, 6638.86722265552, 6655.567388119756, 6659.134312539339, 6109.829807539378, 6347.619142851444, 6544.54188206821, 6607.669616519155, 6639.966800165968, 4494.4606647202545, 4550.726956382628, 5073.365829271341, 5265.447128051576, 5270.657407268515, 4730.030343779517, 4736.7631618418945, 4749.453812811571, 4763.904721905543, 4803.78382972767, 5158.871028224325, 6196.287426945959, 6267.874642507216, 6271.874562508724, 6272.498200143978, 6544.9672751635935, 6545.312742162005, 6555.410013098844, 6557.737690492422, 6567.277599464151, 6210.689465526796, 6230.563860529719, 6248.625082495065, 6299.960506516465, 6338.968305158444, 5810.6513609183585, 5834.299884013861, 5872.207252020922, 5877.0, 5908.763649453974, 6924.8277987059055, 6979.127609048869, 6984.580925144508, 6989.405900498413, 6991.685374158277, 6536.477081833346, 6610.438112760276, 6620.569662971891, 6782.593044417351, 6785.016172655036, 6877.0, 6933.583984960918, 6960.37356637905, 6971.093757811452, 6973.755918542826, 6602.636854973022, 6617.239017513048, 6624.105745724266, 6633.701483433354, 6639.634820084942, 5484.0, 6517.837054073686, 6746.021826835179, 6748.392644662004, 6750.898736519054, 6296.212973378328, 6343.270523889812, 6447.967760161169, 6455.677216139268, 6490.0, 6540.672966351568, 6540.967295163684, 6544.770933017321, 6551.312112228147, 6568.6058836469965, 6401.423871851555, 6451.322611125952, 6456.160699109086, 6459.450946669585, 6463.482921366185, 6303.810885673437, 6364.299927008118, 6369.172007638977, 6387.169667943138, 6570.671466426564, 6317.052442133533, 6319.46284565817, 6327.746890124344, 6329.90505142414, 6331.683415829282], "value": 6046.506124391914, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.6704384158653, 795.7572940253223, 1101.4767985207027, 1122.6014764758515, 1124.4265424633434, 31449.842750786243, 34846.0, 34869.0, 34884.95345139643, 34977.3004539909, 29976.850115749392, 36822.815885920536, 37089.0, 37113.07217319568, 37163.0, 5715.828525144252, 5818.5926985111055, 7859.764207073797, 8001.1198768135455, 8001.919980800176, 7884.093329267151, 7952.0, 7980.800479987989, 7980.8403831923615, 8007.279344858962, 8011.759647210564, 8059.5164290142775, 8071.031476222862, 8074.273315401612, 8106.918930810675, 5765.308163020464, 5863.355030946593, 8000.959995200045, 8018.438709290352, 8052.43632945694, 7813.140554538996, 7922.088959769642, 7934.801629959239, 7942.324902383304, 7958.0, 34851.6514834851, 35206.0, 35234.766783162726, 35241.64758352409, 35285.0, 3519.9296014079573, 3571.4285714285847, 3607.801570913599, 3615.8192090395373, 3619.040954147153, 28567.0, 28795.856020719762, 28807.279818004718, 28820.279493012633, 28825.135245942656, 2715.660542432196, 2732.330579008156, 2748.1206014075506, 2759.572266298727, 2765.806393552452, 293671.99999999785, 293821.0, 293955.0, 294022.52988734917, 297379.0, 36973.0, 37143.814280928425, 37185.25629487395, 45973.70131493412, 46126.769366153625, 47141.292880606816, 47160.76419617949, 47162.76418617885, 47222.52777472181, 47719.761401193464, 13073.803892941614, 13135.737285254241, 13142.60572182836, 13145.934270328587, 13159.342032898317, 10677.412742299248, 10695.03744662984, 10719.464026798629, 10728.195385345975, 10759.677209683565, 11529.077673786078, 11572.363520006313, 11597.536098555964, 11697.0, 11703.356315402734, 4343.348497725303, 5199.246109314128, 5231.633785634969, 5235.685858848481, 5244.5542128918705, 898.2006014646969, 972.8929817720045, 983.9114479696862, 986.6201512417771, 1043.801677681238, 20614.17543298281, 23111.7688823113, 23173.42066448352, 23198.072077117064, 23306.883465582563, 1090.5528733219342, 1095.4358505369742, 1127.1039523578775, 1128.4752590045505, 1149.5114576305036, 11434.771304573862, 11899.88100119005, 11904.047676185884, 11953.940230298793, 12111.636650900487, 309035.9096409052, 309237.0, 309384.0, 309538.452307737, 310964.44517777266, 48156.0, 48335.758321208166, 48344.75827620839, 48503.514964850605, 48564.51435485671, 1340.751960887239, 1454.861788130126, 1490.821101467809, 1536.0246243635372, 1538.5845821628322, 22731.204407846308, 22807.657885131404, 22841.543169136858, 23007.849607519893, 23174.1889033883, 35592.28815423625, 35606.465903011995, 35610.0, 35632.0, 35639.93080207598, 281385.0, 282138.0, 282467.5876620604, 282676.0, 283915.188905162, 25333.87333063323, 27268.0, 27417.314567135185, 30615.693843061283, 31589.842050790518, 39420.21159576735, 39431.60568394279, 39442.0, 39671.2065758689, 39776.0, 26894.61190129422, 27552.586711198946, 29182.708172918, 29215.707842922147, 29509.557356639238, 26535.469290613695, 28053.01814436485, 28186.01348952777, 28477.857610711813, 29295.560566591943, 34615.826920865235, 34623.0, 34681.479777803856, 34728.479072813425, 34760.0, 24129.793510324766, 27241.455170896075, 28052.85973570119, 29034.709652904046, 29555.408891822473, 20175.79824201739, 20929.0, 22586.322410327717, 23162.768372316736, 23193.88403057974], "value": 16271.950942096624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.85302731934553, 423.95760423957626, 424.9766262855546, 440.3834631515878, 452.9524399938006, 18931.810681893177, 20705.275315363964, 21279.468013299676, 21547.892260538694, 21575.46061348467, 22178.223762168327, 22758.88620556899, 23403.5319293614, 23463.530729385402, 23619.29142125739, 6112.480439162677, 6374.17135772349, 6377.617342959414, 6381.585196962183, 6387.073874288226, 5929.525637948954, 6168.043953187241, 6256.843578910518, 6260.4991600672065, 6262.780802671908, 4868.707877527359, 6157.0456579230295, 6201.317855035943, 6208.50331973441, 6232.535354191761, 6085.817425477243, 6227.813165605039, 6228.22147231596, 6230.750769969196, 6249.843753906121, 5334.226537152092, 5465.344158700942, 5535.58483113768, 5549.556035517189, 5558.527525160366, 20871.478213044644, 27524.03665871705, 27682.584761228598, 27696.584551231746, 28116.297092572644, 1897.3643829317195, 2121.7772133926023, 2175.760666326703, 2177.3903307074042, 2182.770809065057, 16844.326226950907, 17573.20920558578, 17652.382166624106, 17656.558586035324, 18222.726659100124, 2123.9893800531054, 2171.7176767020187, 2183.787997661297, 2185.2460900989136, 2196.1544805249932, 119760.0, 151251.0, 152738.23630881886, 152754.7086793699, 153653.0, 11553.711157221136, 11939.582114625946, 11987.520499179935, 12006.159568830099, 12075.698107547207, 15944.760828587581, 15945.68108637844, 15951.0, 15954.840451595568, 15962.521124366287, 8647.956760216159, 8887.911120888837, 8905.866412003825, 8939.73180804577, 9061.365704400629, 8463.53450560225, 8491.622306468462, 8493.915060849313, 8644.654213831376, 8678.609462574199, 7624.504407213513, 7742.993410856552, 7746.690132394754, 7765.53406795594, 7772.844543109106, 1805.521536792751, 1813.1840671697526, 2153.515459021739, 2154.1060459908963, 2340.1107579119825, 924.902885197058, 934.8737920380797, 978.6819283732815, 987.7579992901641, 988.4958671077802, 19876.204951802054, 21603.67594486084, 24136.03455861781, 25892.0, 25972.09097681572, 1002.3134153105146, 1006.4565134827111, 1019.8470229465491, 1038.3147122899002, 1043.7599352148895, 10743.51654175564, 11164.0, 11214.102871770401, 11245.381504017194, 11257.94371028156, 545116.0, 552878.0, 554334.0, 573570.0, 577221.0, 87078.0, 106678.33304167457, 108016.0, 124344.37827810804, 128474.0, 1125.960591379314, 1194.3550482739397, 1238.0776321640435, 1240.8883200512178, 1242.0250103668757, 20928.37214883556, 22182.0, 22489.662655060514, 22509.549809004056, 22627.321180364615, 55837.0, 56199.71900140473, 56340.71829640825, 56755.148672769115, 56831.43168568261, 73214.63392683002, 73371.89942150765, 75286.0, 77052.0, 79620.80568791588, 8411.3270938326, 8694.391392602458, 8851.601677924638, 8980.326475514494, 9067.002629710594, 13629.591112266648, 13641.454341826216, 13741.0, 13825.861741382458, 14003.789943150658, 11718.472668729757, 11906.880931190577, 11959.644818436773, 12003.63989080329, 12016.63950081499, 10853.45732713377, 10872.0, 11036.282641628268, 11171.99452049287, 11359.602413915803, 11723.648290551297, 11752.353620550952, 11846.585369512026, 12018.939905300418, 12118.272903625812, 8669.439500889648, 8732.0, 8743.256823170103, 8887.822243555222, 8950.23922966529, 11704.122190835551, 11902.0, 11903.94048029789, 11970.341631210367, 12013.399330033288], "value": 10405.689075022314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.5171689908534, 1434.1251836379806, 1448.2830998655668, 1455.4396557325433, 1457.948971785987, 11203.439828008597, 11709.941450292747, 11721.824172637407, 11726.237794543349, 11728.35494047827, 11068.446577671104, 11403.030742386887, 11714.238574492652, 11723.355215463145, 11735.53057877686, 2472.171822439485, 2518.0305582350743, 2521.5965445528627, 2522.255934499318, 2527.747225277476, 2435.2450740270483, 2475.282168171228, 2477.6283557466345, 2478.4175718706088, 2480.8635525046116, 2396.532676128156, 2508.611165269386, 2509.3099397665605, 2512.170983575425, 2512.459821138455, 2489.3776555861036, 2491.9377015574573, 2511.4474815540552, 2515.4717509322973, 2516.798656107507, 2254.3462395905167, 2273.545290941818, 2277.453411181321, 2282.5549017941507, 2286.342401758728, 11542.653720388402, 11584.884151158465, 11693.883061169365, 11697.3566453845, 11721.296722196696, 6546.9017964730565, 6771.830704232384, 6772.2211945626395, 6786.59280443175, 6791.660416979181, 3916.295066887959, 4216.704830661855, 4261.957380426187, 4274.807633656493, 4275.038116423811, 1143.4935218606104, 1162.3897453836719, 1201.783678937791, 1202.128456868772, 1205.8552973643132, 14941.327640256106, 15282.159481228638, 15316.157611331373, 16320.020798752113, 16443.58891027722, 5348.331458567679, 5492.450754924475, 5648.181013752983, 5648.237487939075, 5651.547876169897, 11625.011873990805, 11632.592859249886, 11635.825462618068, 11652.708682283012, 11670.533178672928, 6540.607563546202, 6544.116544266463, 6548.934510654928, 6549.639769812706, 6553.508486863504, 6112.113743507255, 6154.630722156596, 6178.3255452489475, 6179.62922224659, 6261.499080073583, 4219.78901054946, 4314.69797114199, 4362.236608593484, 4407.206702793528, 4408.184485870124, 1226.907981901361, 1245.227958665615, 1261.2369516442604, 1262.8610852806185, 1263.1915574032625, 781.7537475695137, 784.7135795434625, 787.551095875357, 788.8777239527882, 793.8213901872148, 6003.519718422515, 6311.684415779285, 6528.281888992207, 6584.958662814543, 6615.702293396713, 938.938968967015, 955.4171955107379, 955.8661787349638, 959.12240300126, 959.1511512311655, 3538.610752817188, 3772.849086036583, 3809.3904975203836, 3816.2367526494813, 3827.6937844972335, 14147.575572732834, 14855.182964936816, 14864.331105100297, 14879.404823807143, 14912.62718432048, 13935.88512918964, 14766.335514901855, 14775.852241477447, 14776.113433194043, 14796.48212312564, 8145.592720363839, 8160.591970401456, 8252.752417427488, 8510.702125425703, 8516.40385173032, 5468.835934921959, 6523.31505191967, 6769.289224631343, 6802.387785099167, 6813.965930170516, 12238.326892021025, 12933.712972675807, 13005.804912926125, 13389.129706569041, 13389.464421423034, 12909.225446473241, 13015.284159371326, 13287.06990510655, 13313.733725325634, 13416.195028298333, 8069.515829050276, 8337.041240257206, 8341.124181960808, 8354.958225208835, 8357.623906924324, 10469.633562825264, 10503.264771465923, 10522.684319470429, 10711.143108551452, 10713.410762408143, 9006.50464224474, 9089.227415669742, 9103.453792772454, 9149.268058555166, 9190.954045229731, 7712.688842896609, 8721.171488708562, 8923.375363724737, 8962.73111806647, 9013.18881300686, 7841.607919603883, 7996.080450748238, 8003.359731221604, 8005.39959503028, 8014.519128852287, 5830.358660547421, 5904.202932604044, 5935.525157987265, 5985.072313791369, 6059.0, 5489.862753431196, 5907.17299578068, 5953.345132035559, 6071.726772295346, 6107.6640784757265], "value": 5278.122432214958, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.5753900865083, 401.53221496956047, 407.61073175117764, 408.80173116038696, 410.79049684660833, 5135.05001574709, 6022.675011497464, 6038.154658347829, 6060.000099983508, 6113.32753397126, 4072.755634661915, 5948.970255148729, 5986.760529578812, 6013.1581578579035, 6041.818745437644, 3792.905177370574, 4650.465196502395, 4658.208104622222, 4659.557342052508, 4675.298705194231, 4651.97656515566, 4661.44062712475, 4661.743604101773, 4671.369365135714, 4689.343491911118, 4052.696047796412, 4502.302143167814, 4617.746023968681, 4650.0932318197965, 4674.953250467486, 3884.8057597120173, 4115.36211887158, 4509.413776209105, 4549.044700612875, 4625.953740462586, 3268.4116858965376, 3600.0, 4090.6931980101313, 4159.126583417486, 4178.26880295947, 4746.905061898778, 5821.708914554255, 5853.707314634294, 5893.263342082239, 5923.614965027259, 5490.91763623542, 5496.450354964471, 5520.696361700105, 5523.309586301712, 5529.087700529408, 5073.594112470993, 5095.955329157551, 5284.339457567804, 6465.288818229991, 6509.707063182168, 4265.317549192115, 4398.714083584557, 4707.152712511746, 4731.952680473186, 4756.476787553366, 6506.772262970773, 6643.534952553275, 6694.43097336727, 6774.322567743236, 6779.0509328694025, 4328.350747387917, 4657.580817726421, 4751.429828420612, 4819.0, 4847.636427267969, 4162.91674166515, 4891.948231130324, 4947.056501381672, 4952.975235123801, 4966.652334336562, 4792.400949881265, 5313.388960269618, 5436.972815135899, 5437.0, 5502.9174562381595, 6372.649504277217, 6407.295197528269, 6518.217813862367, 6524.086627872101, 6544.036788963387, 1420.3395421129019, 1562.2266977845811, 1663.9417620383228, 1703.9829601703825, 1704.1734758642049, 1002.9448380339005, 1166.1894982986744, 1178.1458442629025, 1186.4067966016992, 1202.464903118104, 5354.518093371616, 5616.297962754656, 6108.0, 6124.8775024500155, 6144.539159563051, 5185.896282074337, 5764.74058667361, 6649.700763465656, 6654.86690266192, 6709.859323914946, 5972.40275972408, 6009.639421634716, 6053.909191362133, 6108.664023478663, 6172.444479996732, 2995.251187203199, 3018.758499320049, 3320.236345640468, 3463.9826800865835, 3471.4272145096284, 6619.702113404908, 6799.558028728117, 6830.702166588332, 6903.5167538271835, 6924.688389022506, 6743.898841517381, 6792.422644075309, 6826.283240259801, 6843.555168914005, 6878.69045892936, 6003.969980150071, 6770.6979626926095, 6835.624040677611, 6881.827954301182, 6906.343897329745, 6065.878682426415, 6569.441597464078, 6641.236257830411, 6673.7298723626045, 6686.632235227109, 5711.139081183016, 6159.753609855735, 6548.901766473411, 6562.475001999924, 6584.378591774601, 6734.461243100638, 6865.588064716133, 6865.794026179223, 6886.2769409213315, 6932.341427564374, 4293.720908140961, 4333.848315308949, 4346.739195648272, 4350.282203436397, 4351.390805287199, 5912.497437717842, 6285.779997700059, 6443.355664433707, 6526.771562995463, 6643.335666433318, 6446.8388290293115, 6449.774257900951, 6463.967680161569, 6467.741290348334, 6485.54601177913, 5560.749766260609, 6298.0, 6320.0, 6391.32891046452, 6415.743370265137, 6326.841828954313, 6336.873262534816, 6337.6197428154455, 6352.587081839665, 6361.363863613602, 5591.860203494945, 6166.938330616636, 6365.204349456318, 6376.458001069961, 6423.775167869102, 6285.811425657238, 6298.0, 6305.495560355069, 6313.810585682437, 6332.430081292706], "value": 4775.774482674997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.9369353604943, 764.8087978005499, 860.707359497771, 865.8354912566612, 878.6046279174374, 16441.849070565037, 16464.0, 16930.830691693078, 16989.40537081201, 16993.40523081691, 13036.283004434752, 15616.0, 15668.216589170554, 15680.607984800357, 15782.131982740944, 978.7699890525721, 993.2749093161996, 995.4077323992213, 997.917259773147, 998.5456617239139, 1006.1598565198068, 1007.0634310091611, 1007.3150257824676, 1010.242318261304, 1012.4077414712402, 1015.4364327798069, 1017.96946091617, 1018.3024628129717, 1020.0513522424143, 1041.286718597759, 1013.245132376377, 1014.0164040880335, 1014.3609525998611, 1015.4567306490992, 1053.2416660004785, 771.0708596141636, 771.1132197972321, 772.420684486635, 772.7643068863994, 777.7005852746677, 15967.920160399124, 16060.036397816051, 16943.237554309962, 17087.401940932006, 17501.649967000714, 17132.400365987254, 17175.227114779864, 17382.739258911126, 17538.649227015387, 17602.647947040987, 12142.0, 14066.648333791738, 14070.296485175802, 14257.859371250275, 14587.635309117251, 3520.2431477232517, 3535.681788639035, 3536.929261414783, 3538.5930617979006, 3538.6461353864665, 90456.0, 127159.0, 127300.36349818284, 129072.35463822715, 131149.0, 10736.892631073746, 10996.395198264172, 13417.194968301934, 13825.377857996415, 13856.792148117785, 24010.7598924012, 24768.25695229146, 24894.128705495583, 25486.617700734503, 25508.97964081416, 7621.504602200839, 7661.233876612406, 7684.923150768421, 7699.345555627722, 7706.113796913427, 3737.2151848111657, 3747.737658363943, 3758.3798673219158, 3819.2934307153264, 3836.8081595920094, 4250.447441832542, 4318.913621727548, 4324.56754324565, 4328.09110086879, 4331.566843315706, 887.4497811356871, 899.7930475990559, 909.7043460875242, 910.8178364327161, 917.1516347378648, 647.9352064793483, 653.7189008726293, 655.0926966151819, 660.4683229999896, 686.3205426627603, 10214.189425333296, 10851.837222441669, 10933.343999360064, 11250.831237531444, 12062.035037197003, 637.5664548107331, 647.8833809914261, 668.5320275806955, 672.0725398949419, 685.6331862453563, 5491.36849262332, 5542.445755424506, 5727.3699893011735, 5768.1636162757, 6209.813705588839, 107172.4641376788, 107964.92035079705, 108783.0, 110825.0, 115048.0, 92247.53876230576, 92588.7593934209, 93416.53291733497, 93689.5315523418, 95032.0, 82643.0, 83843.0, 84377.0, 84588.0, 84879.15120848836, 11852.229605075643, 12235.816462752888, 12399.690007749878, 12438.564650237198, 12498.25010499373, 37730.43404348992, 40061.59938400695, 42244.788776057154, 42558.787206063775, 43299.567004329554, 52681.736591316796, 53823.73088134534, 53930.19104713511, 54823.629409265086, 54946.175807362124, 15960.441384551485, 16066.518004459886, 16586.502404927873, 16662.916685416494, 16756.497305080866, 17760.023198724193, 18055.187516561524, 18223.271069157086, 18356.541086472946, 18502.629947401245, 16490.670186596442, 16622.75065874037, 17037.82962170412, 17161.914190429467, 17208.0, 15926.28331725052, 15929.442469513511, 16240.837591624406, 16429.0, 16488.752668710218, 16399.508014759576, 16526.504204873872, 17020.404285850433, 17554.91222543879, 18457.261709531467, 9552.474613896302, 10237.74405639865, 11924.70188245266, 11987.34069626144, 12149.939250303692, 13243.47026118983, 13379.799303010657, 13515.662108447368, 13549.390277437737, 13555.525556605471], "value": 8337.684541997995, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1426.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 112.0, 110.0, 111.0, 112.0, 110.0, 110.0, 111.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 107.0, 145.0, 111.0, 109.0, 108.0, 111.0, 156.0, 115.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 182.0, 184.0, 185.0, 183.0, 185.0, 184.0, 186.0, 184.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 87.0, 59.0, 59.0, 58.0, 57.0, 82.0, 60.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 69.0, 85.0, 69.0, 69.0, 69.0, 90.0, 69.0, 69.0, 89.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 87.0, 87.0, 87.0, 87.0, 88.0, 87.0, 87.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 83.0, 85.0, 86.0, 83.0, 86.0, 84.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 47.0, 47.0, 47.0, 47.0, 49.0, 49.0, 49.0, 47.0, 47.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 64.0, 64.0, 58.0, 57.0, 59.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 80.0, 83.0, 80.0, 83.0, 82.0, 81.0, 81.0, 82.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 153.0, 131.0, 151.0, 145.0, 148.0, 130.0, 140.0, 261.0, 138.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 221.0, 184.0, 182.0, 184.0, 183.0, 192.0, 185.0, 216.0, 178.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 70.0, 67.0, 68.0], "value": 68.1, "unit": "score"}]}]} 18:44:18 INFO - Return code: 0 18:44:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:44:18 INFO - # TBPL SUCCESS # 18:44:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:44:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:44:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:44:18 INFO - 2017-05-10 18:44:18.210 screenresolution[1661:9843] starting screenresolution argv=screenresolution get 18:44:18 INFO - 2017-05-10 18:44:18.214 screenresolution[1661:9843] Display 0: 1600x1200x32@60 18:44:18 INFO - 2017-05-10 18:44:18.220 screenresolution[1662:9846] starting screenresolution argv=screenresolution list 18:44:18 INFO - Available Modes on Display 0 18:44:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:44:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:44:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:44:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:44:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:44:18 INFO - Intel Iris: 18:44:18 INFO - Chipset Model: Intel Iris 18:44:18 INFO - Type: GPU 18:44:18 INFO - Bus: Built-In 18:44:18 INFO - VRAM (Dynamic, Max): 1536 MB 18:44:18 INFO - Vendor: Intel (0x8086) 18:44:18 INFO - Device ID: 0x0a2e 18:44:18 INFO - Revision ID: 0x0009 18:44:18 INFO - Displays: 18:44:18 INFO - Display: 18:44:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:44:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:44:18 INFO - Display Serial Number: 1600x1200 60 18:44:18 INFO - Main Display: Yes 18:44:18 INFO - Mirror: Off 18:44:18 INFO - Online: Yes 18:44:18 INFO - Rotation: Supported 18:44:18 INFO - Return code: 0 18:44:18 INFO - Running post-action listener: _resource_record_post_action 18:44:18 INFO - [mozharness: 2017-05-11 01:44:18.465229Z] Finished run-tests step (success) 18:44:18 INFO - Running post-run listener: _resource_record_post_run 18:44:18 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 39257600; Write bytes: 527215616; Read time: 380; Write time: 1965 18:44:18 INFO - TinderboxPrint: CPU usage
53.3% 18:44:18 INFO - TinderboxPrint: I/O read bytes / time
39,257,600 / 380 18:44:18 INFO - TinderboxPrint: I/O write bytes / time
527,215,616 / 1,965 18:44:18 INFO - TinderboxPrint: CPU idle
2,235.8 (46.7%) 18:44:18 INFO - TinderboxPrint: CPU system
952.0 (19.9%) 18:44:18 INFO - TinderboxPrint: CPU user
1,601.9 (33.4%) 18:44:18 INFO - TinderboxPrint: Swap in / out
252,375,040 / 0 18:44:18 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204806656; Write bytes: 206108672; Read time: 15776; Write time: 403 18:44:18 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 38295040; Write bytes: 311219200; Read time: 365; Write time: 1529 18:44:18 INFO - Running post-run listener: _upload_blobber_files 18:44:18 INFO - Blob upload gear active. 18:44:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:44:18 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 18:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:44:19 INFO - (blobuploader) - INFO - Open directory for files ... 18:44:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:44:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:44:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:20 INFO - (blobuploader) - INFO - Done attempting. 18:44:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:44:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:44:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:21 INFO - (blobuploader) - INFO - Done attempting. 18:44:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:44:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:44:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:22 INFO - (blobuploader) - INFO - Done attempting. 18:44:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:44:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:24 INFO - (blobuploader) - INFO - Done attempting. 18:44:24 INFO - (blobuploader) - INFO - Iteration through files over. 18:44:24 INFO - Return code: 0 18:44:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:44:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:44:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5aafa68d0f00f3271273780d739c51599bdc39c71f340351d3ae0255518af4233aaa5b0a1f4b48cb5461b298d8fff32b71cad59e56f461e4541f44b1797f730a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dfaab12c87711980956fb4390afb4ac2df81688e13aaeae743d980fa4e6fe8e302ea962b4895fbd98e9d90739418ee04a4fed70beda22daa76178aea69960bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5267f4defca2bd24b03c1536a17f09818c5bb4b4e172df152b18dd23f39a684b1080249da7ca0215f1f2a9e4c4389011f92a0da4edcd2e6ad71631d98c212bcb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64e81dd30927fa79b8e2306769ffc1996106bb1096cb21dec98e6a97adaf3a74fb818bd4f209973ca5a36b55bc939c1476e45c702e6a5b1bfcb024c1ba59bc4"} 18:44:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:44:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:44:24 INFO - Contents: 18:44:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5aafa68d0f00f3271273780d739c51599bdc39c71f340351d3ae0255518af4233aaa5b0a1f4b48cb5461b298d8fff32b71cad59e56f461e4541f44b1797f730a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dfaab12c87711980956fb4390afb4ac2df81688e13aaeae743d980fa4e6fe8e302ea962b4895fbd98e9d90739418ee04a4fed70beda22daa76178aea69960bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5267f4defca2bd24b03c1536a17f09818c5bb4b4e172df152b18dd23f39a684b1080249da7ca0215f1f2a9e4c4389011f92a0da4edcd2e6ad71631d98c212bcb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64e81dd30927fa79b8e2306769ffc1996106bb1096cb21dec98e6a97adaf3a74fb818bd4f209973ca5a36b55bc939c1476e45c702e6a5b1bfcb024c1ba59bc4"} 18:44:24 INFO - Running post-run listener: copy_logs_to_upload_dir 18:44:24 INFO - Copying logs to upload dir... 18:44:24 INFO - mkdir: /builds/slave/test/build/upload/logs 18:44:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.666973 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-05-10 18:44:24.816822) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 18:44:24.821008) ========= 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.dJzTkqT80I/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.XtpvRrLUsb/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5aafa68d0f00f3271273780d739c51599bdc39c71f340351d3ae0255518af4233aaa5b0a1f4b48cb5461b298d8fff32b71cad59e56f461e4541f44b1797f730a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dfaab12c87711980956fb4390afb4ac2df81688e13aaeae743d980fa4e6fe8e302ea962b4895fbd98e9d90739418ee04a4fed70beda22daa76178aea69960bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5267f4defca2bd24b03c1536a17f09818c5bb4b4e172df152b18dd23f39a684b1080249da7ca0215f1f2a9e4c4389011f92a0da4edcd2e6ad71631d98c212bcb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64e81dd30927fa79b8e2306769ffc1996106bb1096cb21dec98e6a97adaf3a74fb818bd4f209973ca5a36b55bc939c1476e45c702e6a5b1bfcb024c1ba59bc4"} build_url:https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/Ys3BKH0eQmWa1KnDy7DyhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5aafa68d0f00f3271273780d739c51599bdc39c71f340351d3ae0255518af4233aaa5b0a1f4b48cb5461b298d8fff32b71cad59e56f461e4541f44b1797f730a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dfaab12c87711980956fb4390afb4ac2df81688e13aaeae743d980fa4e6fe8e302ea962b4895fbd98e9d90739418ee04a4fed70beda22daa76178aea69960bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5267f4defca2bd24b03c1536a17f09818c5bb4b4e172df152b18dd23f39a684b1080249da7ca0215f1f2a9e4c4389011f92a0da4edcd2e6ad71631d98c212bcb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c64e81dd30927fa79b8e2306769ffc1996106bb1096cb21dec98e6a97adaf3a74fb818bd4f209973ca5a36b55bc939c1476e45c702e6a5b1bfcb024c1ba59bc4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 18:44:24.855736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 18:44:24.856048) ========= 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.dJzTkqT80I/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.XtpvRrLUsb/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005024 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 18:44:24.903946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 18:44:24.904234) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 18:44:24.904544) ========= ========= Total master_lag: 0.18 =========