builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0270 starttime: 1488413007.08 results: success (0) buildid: 20170301133922 builduid: b67885b8f9e94199842d821a6b095c0f revision: d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:27.077582) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:27.078517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:27.078879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:27.106036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:27.106472) ========= 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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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-03-01 16:03:27-- 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% 155M=0s 2017-03-01 16:03:27 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142527 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:27.277464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:27.277854) ========= 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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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.021496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:27.326761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 16:03:27.327231) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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-03-01 16:03:27,420 truncating revision to first 12 chars 2017-03-01 16:03:27,420 Setting DEBUG logging. 2017-03-01 16:03:27,420 attempt 1/10 2017-03-01 16:03:27,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d1b4c5e38c8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-01 16:03:28,498 unpacking tar archive at: mozilla-beta-d1b4c5e38c8f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 16:03:28.676156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:28.676570) ========= script_repo_revision: d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:28.677064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:28.677375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 16:03:28.698665) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-01 16:03:28.699111) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:03:28 INFO - MultiFileLogger online at 20170301 16:03:28 in /builds/slave/test 16:03:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:03:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:03:28 INFO - {'append_to_log': False, 16:03:28 INFO - 'base_work_dir': '/builds/slave/test', 16:03:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:03:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:03:28 INFO - 'branch': 'Mozilla-Beta', 16:03:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:03:28 INFO - 'config_files': ('talos/mac_config.py',), 16:03:28 INFO - 'default_actions': ('clobber', 16:03:28 INFO - 'read-buildbot-config', 16:03:28 INFO - 'download-and-extract', 16:03:28 INFO - 'populate-webroot', 16:03:28 INFO - 'create-virtualenv', 16:03:28 INFO - 'install', 16:03:28 INFO - 'run-tests'), 16:03:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:03:28 INFO - 'download_minidump_stackwalk': True, 16:03:28 INFO - 'download_symbols': 'ondemand', 16:03:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:03:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:03:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:03:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:03:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:03:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:03:28 INFO - 'installer_path': 'installer.exe', 16:03:28 INFO - 'log_level': 'info', 16:03:28 INFO - 'log_name': 'talos', 16:03:28 INFO - 'log_to_console': True, 16:03:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:03:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:03:28 INFO - 'opt_config_files': (), 16:03:28 INFO - 'pip_index': False, 16:03:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:03:28 INFO - 'cmd': ('bash', 16:03:28 INFO - '-c', 16:03:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:03:28 INFO - 'enabled': True, 16:03:28 INFO - 'halt_on_failure': False, 16:03:28 INFO - 'name': 'check_screen_resolution'},), 16:03:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:03:28 INFO - 'cmd': ('bash', 16:03:28 INFO - '-c', 16:03:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:03:28 INFO - 'enabled': True, 16:03:28 INFO - 'halt_on_failure': False, 16:03:28 INFO - 'name': 'check_screen_resolution'},), 16:03:28 INFO - 'run_cmd_checks_enabled': True, 16:03:28 INFO - 'sps_profile': False, 16:03:28 INFO - 'sps_profile_interval': 0, 16:03:28 INFO - 'suite': 'dromaeojs', 16:03:28 INFO - 'system_bits': '32', 16:03:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:03:28 INFO - 'title': 't-yosemite-r7-0270', 16:03:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:03:28 INFO - 'use_talos_json': True, 16:03:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:03:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:03:28 INFO - 'work_dir': 'build'} 16:03:28 INFO - [mozharness: 2017-03-02 00:03:28.906581Z] Running clobber step. 16:03:28 INFO - Running pre-action listener: _resource_record_pre_action 16:03:28 INFO - Running main action method: clobber 16:03:28 INFO - rmtree: /builds/slave/test/build 16:03:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:03:31 INFO - Running post-action listener: _resource_record_post_action 16:03:31 INFO - [mozharness: 2017-03-02 00:03:31.891393Z] Finished clobber step (success) 16:03:31 INFO - [mozharness: 2017-03-02 00:03:31.891523Z] Running read-buildbot-config step. 16:03:31 INFO - Running pre-action listener: _resource_record_pre_action 16:03:31 INFO - Running main action method: read_buildbot_config 16:03:31 INFO - Using buildbot properties: 16:03:31 INFO - { 16:03:31 INFO - "project": "", 16:03:31 INFO - "product": "firefox", 16:03:31 INFO - "script_repo_revision": "production", 16:03:31 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 16:03:31 INFO - "repository": "", 16:03:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 16:03:31 INFO - "buildid": "20170301133922", 16:03:31 INFO - "pgo_build": "False", 16:03:31 INFO - "basedir": "/builds/slave/test", 16:03:31 INFO - "buildnumber": 1, 16:03:31 INFO - "slavename": "t-yosemite-r7-0270", 16:03:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:03:31 INFO - "platform": "yosemite_r7", 16:03:31 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:03:31 INFO - "branch": "mozilla-beta", 16:03:31 INFO - "repo_path": "releases/mozilla-beta", 16:03:31 INFO - "revision": "d1b4c5e38c8fabe11d2b9e9fb79441e53d568381", 16:03:31 INFO - "stage_platform": "macosx64", 16:03:31 INFO - "builduid": "b67885b8f9e94199842d821a6b095c0f", 16:03:31 INFO - "slavebuilddir": "test" 16:03:31 INFO - } 16:03:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 16:03:31 INFO - Running post-action listener: _resource_record_post_action 16:03:31 INFO - [mozharness: 2017-03-02 00:03:31.894880Z] Finished read-buildbot-config step (success) 16:03:31 INFO - [mozharness: 2017-03-02 00:03:31.895010Z] Running download-and-extract step. 16:03:31 INFO - Running pre-action listener: _resource_record_pre_action 16:03:31 INFO - Running main action method: download_and_extract 16:03:31 INFO - mkdir: /builds/slave/test/build/tests 16:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:31 INFO - trying https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 16:03:31 INFO - Downloading https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 16:03:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 16:03:32 INFO - Downloaded 1165 bytes. 16:03:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 16:03:32 INFO - Using the following test package requirements: 16:03:32 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 16:03:32 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:03:32 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 16:03:32 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:03:32 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 16:03:32 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:03:32 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:03:32 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 16:03:32 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 16:03:32 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:03:32 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 16:03:32 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:03:32 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 16:03:32 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:03:32 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 16:03:32 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:03:32 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 16:03:32 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 16:03:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 16:03:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 16:03:32 INFO - Fetch https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 16:03:33 INFO - Http code: 200 16:03:33 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 16:03:33 INFO - x-amz-cf-id: YOf5V7C4gc5gtyEmnkbfMteU6mazmJN01yAWLvKBYBr5LMZIUFgf-A== 16:03:33 INFO - x-amz-version-id: YbTTkKNAJcZ1n.wAkHOlR1qOgh6_zho_ 16:03:33 INFO - Expected file size: 16093381 16:03:33 INFO - Obtained file size: 16093381 16:03:39 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:03:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 16:03:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 16:03:39 INFO - Fetch https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 16:03:40 INFO - Http code: 200 16:03:40 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 16:03:40 INFO - x-amz-cf-id: 45QKq-XrAGRvMJXyh0qYvwsCdDmjdHbStKVYXqVIC-h4WqB7z2Koqw== 16:03:40 INFO - x-amz-version-id: YbTTkKNAJcZ1n.wAkHOlR1qOgh6_zho_ 16:03:40 INFO - Expected file size: 16093381 16:03:40 INFO - Obtained file size: 16093381 16:03:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 16:03:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 16:03:47 INFO - Fetch https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 16:03:47 INFO - Http code: 200 16:03:47 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 16:03:47 INFO - x-amz-cf-id: c5LThI5WFoAdKmTwAwquE6ztv0bLxLJwN95poXnFmqe4rwJOl_i4wg== 16:03:47 INFO - x-amz-version-id: W33RcCr6ztTGNprHjZjLBFjY8zoW3_Wr 16:03:47 INFO - Expected file size: 14402992 16:03:47 INFO - Obtained file size: 14402992 16:03:48 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')]} 16:03:48 INFO - trying https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 16:03:48 INFO - Downloading https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 16:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 16:03:50 INFO - Downloaded 82115207 bytes. 16:03:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 16:03:50 INFO - mkdir: /builds/slave/test/properties 16:03:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:03:50 INFO - Writing to file /builds/slave/test/properties/build_url 16:03:50 INFO - Contents: 16:03:50 INFO - build_url:https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 16:03:51 INFO - Running post-action listener: _resource_record_post_action 16:03:51 INFO - Running post-action listener: set_extra_try_arguments 16:03:51 INFO - [mozharness: 2017-03-02 00:03:51.130515Z] Finished download-and-extract step (success) 16:03:51 INFO - [mozharness: 2017-03-02 00:03:51.130634Z] Running populate-webroot step. 16:03:51 INFO - Running pre-action listener: _resource_record_pre_action 16:03:51 INFO - Running main action method: populate_webroot 16:03:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:03:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:03:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:03:51 INFO - '--tppagecycles', 16:03:51 INFO - '7'], 16:03:51 INFO - 'tests': ['tsvgm']}}, 16:03:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:03:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:03:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:03:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:03:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:51 INFO - 'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:03:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:03:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:51 INFO - 'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['damp', 'tps']}, 16:03:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:51 INFO - 'tests': ['damp', 'tps']}, 16:03:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['dromaeo_dom']}, 16:03:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:03:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['basic_compositor_video']}, 16:03:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:03:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['a11yr', 16:03:51 INFO - 'ts_paint', 16:03:51 INFO - 'tpaint', 16:03:51 INFO - 'sessionrestore', 16:03:51 INFO - 'sessionrestore_no_auto_restore', 16:03:51 INFO - 'tabpaint']}, 16:03:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:03:51 INFO - 'ts_paint', 16:03:51 INFO - 'tpaint', 16:03:51 INFO - 'sessionrestore', 16:03:51 INFO - 'sessionrestore_no_auto_restore', 16:03:51 INFO - 'tabpaint']}, 16:03:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:03:51 INFO - 'ts_paint', 16:03:51 INFO - 'tpaint', 16:03:51 INFO - 'sessionrestore', 16:03:51 INFO - 'sessionrestore_no_auto_restore', 16:03:51 INFO - 'tabpaint']}, 16:03:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:03:51 INFO - 'ts_paint', 16:03:51 INFO - 'tpaint', 16:03:51 INFO - 'sessionrestore', 16:03:51 INFO - 'sessionrestore_no_auto_restore', 16:03:51 INFO - 'tabpaint']}, 16:03:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['a11yr', 16:03:51 INFO - 'ts_paint', 16:03:51 INFO - 'tpaint', 16:03:51 INFO - 'sessionrestore', 16:03:51 INFO - 'sessionrestore_no_auto_restore', 16:03:51 INFO - 'tabpaint']}, 16:03:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['a11yr', 16:03:51 INFO - 'ts_paint', 16:03:51 INFO - 'tpaint', 16:03:51 INFO - 'sessionrestore', 16:03:51 INFO - 'sessionrestore_no_auto_restore', 16:03:51 INFO - 'tabpaint']}, 16:03:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['tsvgx', 16:03:51 INFO - 'tsvgr_opacity', 16:03:51 INFO - 'tart', 16:03:51 INFO - 'tscrollx', 16:03:51 INFO - 'cart']}, 16:03:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:03:51 INFO - 'tsvgr_opacity', 16:03:51 INFO - 'tart', 16:03:51 INFO - 'tscrollx', 16:03:51 INFO - 'cart']}, 16:03:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:51 INFO - 'talos_options': ['--disable-e10s'], 16:03:51 INFO - 'tests': ['tp5o']}, 16:03:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:51 INFO - 'tests': ['tp5o']}, 16:03:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:51 INFO - 'talos_options': ['--disable-e10s', 16:03:51 INFO - '--xperf_path', 16:03:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:03:51 INFO - 'tests': ['tp5n']}, 16:03:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:03:51 INFO - 'talos_options': ['--xperf_path', 16:03:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:03:51 INFO - 'tests': ['tp5n']}}, 16:03:51 INFO - 'talos.zip': {'path': '', 16:03:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:03:51 INFO - Running post-action listener: _resource_record_post_action 16:03:51 INFO - [mozharness: 2017-03-02 00:03:51.149350Z] Finished populate-webroot step (success) 16:03:51 INFO - [mozharness: 2017-03-02 00:03:51.149456Z] Running create-virtualenv step. 16:03:51 INFO - Running pre-action listener: _resource_record_pre_action 16:03:51 INFO - Running main action method: create_virtualenv 16:03:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:03:51 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 16:03:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:03:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:03:51 INFO - Using real prefix '/tools/python27' 16:03:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:03:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:03:54 INFO - Installing pip.................done. 16:03:54 INFO - Return code: 0 16:03:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:03:55 INFO - Reading from file tmpfile_stdout 16:03:55 INFO - Output received: 16:03:55 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) 16:03:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:55 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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:03:55 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 16:03:55 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 16:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:03:55 INFO - 'HOME': '/Users/cltbld', 16:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:03:55 INFO - 'LOGNAME': 'cltbld', 16:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:55 INFO - 'MOZ_NO_REMOTE': '1', 16:03:55 INFO - 'NO_EM_RESTART': '1', 16:03:55 INFO - 'PAGER': '/bin/cat', 16:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:55 INFO - 'PWD': '/builds/slave/test', 16:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:03:55 INFO - 'SHELL': '/bin/bash', 16:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:03:55 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:03:55 INFO - 'USER': 'cltbld', 16:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:55 INFO - 'XPC_FLAGS': '0x0', 16:03:55 INFO - 'XPC_SERVICE_NAME': '0', 16:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:56 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 16:03:56 INFO - Cleaning up... 16:03:56 INFO - Return code: 0 16:03:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:03:56 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')]} 16:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:56 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')]} 16:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:56 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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:03:56 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 16:03:56 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 16:03:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:03:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:03:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:03:56 INFO - 'HOME': '/Users/cltbld', 16:03:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:03:56 INFO - 'LOGNAME': 'cltbld', 16:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:56 INFO - 'MOZ_NO_REMOTE': '1', 16:03:56 INFO - 'NO_EM_RESTART': '1', 16:03:56 INFO - 'PAGER': '/bin/cat', 16:03:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:56 INFO - 'PWD': '/builds/slave/test', 16:03:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:03:56 INFO - 'SHELL': '/bin/bash', 16:03:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:03:56 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:03:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:03:56 INFO - 'USER': 'cltbld', 16:03:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:03:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:56 INFO - 'XPC_FLAGS': '0x0', 16:03:56 INFO - 'XPC_SERVICE_NAME': '0', 16:03:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:56 INFO - Downloading/unpacking psutil>=3.1.1 16:03:56 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 16:03:56 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 16:03:56 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 16:03:56 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 16:03:56 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 16:03:56 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 16:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:04:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:00 INFO - Installing collected packages: psutil 16:04:00 INFO - Running setup.py install for psutil 16:04:00 INFO - building 'psutil._psutil_osx' extension 16:04: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 16:04: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 16:04: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 16:04: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 16:04:00 INFO - building 'psutil._psutil_posix' extension 16:04: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 16:04:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:04:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:04:00 INFO - ^ 16:04:00 INFO - 1 warning generated. 16:04:00 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 16:04:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:01 INFO - Successfully installed psutil 16:04:01 INFO - Cleaning up... 16:04:01 INFO - Return code: 0 16:04:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:04: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')]} 16:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:01 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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:04:01 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 16:04:01 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 16:04:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:04:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:01 INFO - 'HOME': '/Users/cltbld', 16:04:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:01 INFO - 'LOGNAME': 'cltbld', 16:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:01 INFO - 'MOZ_NO_REMOTE': '1', 16:04:01 INFO - 'NO_EM_RESTART': '1', 16:04:01 INFO - 'PAGER': '/bin/cat', 16:04:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:01 INFO - 'PWD': '/builds/slave/test', 16:04:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:01 INFO - 'SHELL': '/bin/bash', 16:04:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:04:01 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:04:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:01 INFO - 'USER': 'cltbld', 16:04:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:01 INFO - 'XPC_FLAGS': '0x0', 16:04:01 INFO - 'XPC_SERVICE_NAME': '0', 16:04:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:04:01 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 16:04:01 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 16:04:01 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 16:04:01 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 16:04:01 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 16:04:01 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 16:04:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:04:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:04:04 INFO - Installing collected packages: mozsystemmonitor 16:04:04 INFO - Running setup.py install for mozsystemmonitor 16:04:04 INFO - Successfully installed mozsystemmonitor 16:04:04 INFO - Cleaning up... 16:04:04 INFO - Return code: 0 16:04:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:04: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')]} 16:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:04: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 16:04: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 16:04:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:04:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:04 INFO - 'HOME': '/Users/cltbld', 16:04:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:04 INFO - 'LOGNAME': 'cltbld', 16:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:04 INFO - 'MOZ_NO_REMOTE': '1', 16:04:04 INFO - 'NO_EM_RESTART': '1', 16:04:04 INFO - 'PAGER': '/bin/cat', 16:04:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:04 INFO - 'PWD': '/builds/slave/test', 16:04:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:04 INFO - 'SHELL': '/bin/bash', 16:04:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:04:04 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:04:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:04 INFO - 'USER': 'cltbld', 16:04:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:04 INFO - 'XPC_FLAGS': '0x0', 16:04:04 INFO - 'XPC_SERVICE_NAME': '0', 16:04:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:04 INFO - Downloading/unpacking jsonschema==2.5.1 16:04: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 16:04: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 16:04: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 16:04: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 16:04: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 16:04: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 16:04:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:04:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:04: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 16:04: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 16:04: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 16:04: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 16:04: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 16:04: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 16:04:07 INFO - Downloading functools32-3.2.3-2.tar.gz 16:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:04:07 INFO - warning: no files found matching '*.txt' 16:04:07 INFO - no previously-included directories found matching 'build' 16:04:07 INFO - no previously-included directories found matching 'dist' 16:04:07 INFO - no previously-included directories found matching '.git*' 16:04:07 INFO - Installing collected packages: jsonschema, functools32 16:04:07 INFO - Running setup.py install for functools32 16:04:08 INFO - warning: no files found matching '*.txt' 16:04:08 INFO - no previously-included directories found matching 'build' 16:04:08 INFO - no previously-included directories found matching 'dist' 16:04:08 INFO - no previously-included directories found matching '.git*' 16:04:08 INFO - Successfully installed jsonschema functools32 16:04:08 INFO - Cleaning up... 16:04:08 INFO - Return code: 0 16:04:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:04:08 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')]} 16:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:08 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')]} 16:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:08 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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:04:08 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 16:04:08 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 16:04:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:04:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:08 INFO - 'HOME': '/Users/cltbld', 16:04:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:08 INFO - 'LOGNAME': 'cltbld', 16:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:08 INFO - 'MOZ_NO_REMOTE': '1', 16:04:08 INFO - 'NO_EM_RESTART': '1', 16:04:08 INFO - 'PAGER': '/bin/cat', 16:04:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:08 INFO - 'PWD': '/builds/slave/test', 16:04:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:08 INFO - 'SHELL': '/bin/bash', 16:04:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:04:08 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:04:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:08 INFO - 'USER': 'cltbld', 16:04:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:08 INFO - 'XPC_FLAGS': '0x0', 16:04:08 INFO - 'XPC_SERVICE_NAME': '0', 16:04:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:04:08 INFO - Cleaning up... 16:04:08 INFO - Return code: 0 16:04:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:04:08 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')]} 16:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:08 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')]} 16:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:08 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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:04:08 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 16:04:08 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 16:04:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:04:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:08 INFO - 'HOME': '/Users/cltbld', 16:04:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:08 INFO - 'LOGNAME': 'cltbld', 16:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:08 INFO - 'MOZ_NO_REMOTE': '1', 16:04:08 INFO - 'NO_EM_RESTART': '1', 16:04:08 INFO - 'PAGER': '/bin/cat', 16:04:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:08 INFO - 'PWD': '/builds/slave/test', 16:04:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:08 INFO - 'SHELL': '/bin/bash', 16:04:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:04:08 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:04:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:08 INFO - 'USER': 'cltbld', 16:04:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:08 INFO - 'XPC_FLAGS': '0x0', 16:04:08 INFO - 'XPC_SERVICE_NAME': '0', 16:04:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:08 INFO - Downloading/unpacking blobuploader==1.2.4 16:04:08 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 16:04:08 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 16:04:08 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 16:04:08 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 16:04:08 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 16:04:08 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 16:04:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:04:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:04:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:12 INFO - Downloading docopt-0.6.1.tar.gz 16:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:04:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:04:12 INFO - Running setup.py install for blobuploader 16:04:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:04:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:04:12 INFO - Running setup.py install for requests 16:04:13 INFO - Running setup.py install for docopt 16:04:13 INFO - Successfully installed blobuploader requests docopt 16:04:13 INFO - Cleaning up... 16:04:13 INFO - Return code: 0 16:04:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04:13 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')]} 16:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:13 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')]} 16:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:13 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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:04:13 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 16:04:13 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 16:04:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:04:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:13 INFO - 'HOME': '/Users/cltbld', 16:04:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:13 INFO - 'LOGNAME': 'cltbld', 16:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:13 INFO - 'MOZ_NO_REMOTE': '1', 16:04:13 INFO - 'NO_EM_RESTART': '1', 16:04:13 INFO - 'PAGER': '/bin/cat', 16:04:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:13 INFO - 'PWD': '/builds/slave/test', 16:04:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:13 INFO - 'SHELL': '/bin/bash', 16:04:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:04:13 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:04:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:13 INFO - 'USER': 'cltbld', 16:04:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:13 INFO - 'XPC_FLAGS': '0x0', 16:04:13 INFO - 'XPC_SERVICE_NAME': '0', 16:04:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:04:13 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-VXCv8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:04:13 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-wDSL1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-a06Mhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-4X5PAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Wo3Lf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-G87IL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-t9_dC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-4hyArU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-SVAZnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-q8ycse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-7Qzbw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:04:14 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-pRqARc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:04:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-mgh0uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:04:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-gIJ4zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-bAyFgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:04:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-LtvMj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:04:15 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-H9qlKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:04:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:04:15 INFO - Running setup.py install for manifestparser 16:04:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:04:15 INFO - Running setup.py install for mozcrash 16:04:15 INFO - Running setup.py install for mozdebug 16:04:16 INFO - Running setup.py install for mozdevice 16:04:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:04:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:04:16 INFO - Running setup.py install for mozfile 16:04:16 INFO - Running setup.py install for mozhttpd 16:04:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:04:16 INFO - Running setup.py install for mozinfo 16:04:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:04:16 INFO - Running setup.py install for mozInstall 16:04:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:04:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:04:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:04:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:04:16 INFO - Running setup.py install for mozleak 16:04:16 INFO - Running setup.py install for mozlog 16:04:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:04:17 INFO - Running setup.py install for moznetwork 16:04:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:04:17 INFO - Running setup.py install for mozprocess 16:04:17 INFO - Running setup.py install for mozprofile 16:04:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:04:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:04:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:04:17 INFO - Running setup.py install for mozrunner 16:04:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:04:17 INFO - Running setup.py install for mozscreenshot 16:04:17 INFO - Running setup.py install for moztest 16:04:18 INFO - Running setup.py install for mozversion 16:04:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:04:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:04:18 INFO - Cleaning up... 16:04:18 INFO - Return code: 0 16:04:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04:18 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')]} 16:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:18 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')]} 16:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:18 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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:04:18 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 16:04:18 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 16:04:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:04:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:18 INFO - 'HOME': '/Users/cltbld', 16:04:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:18 INFO - 'LOGNAME': 'cltbld', 16:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:18 INFO - 'MOZ_NO_REMOTE': '1', 16:04:18 INFO - 'NO_EM_RESTART': '1', 16:04:18 INFO - 'PAGER': '/bin/cat', 16:04:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:18 INFO - 'PWD': '/builds/slave/test', 16:04:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:18 INFO - 'SHELL': '/bin/bash', 16:04:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:04:18 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:04:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:18 INFO - 'USER': 'cltbld', 16:04:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:18 INFO - 'XPC_FLAGS': '0x0', 16:04:18 INFO - 'XPC_SERVICE_NAME': '0', 16:04:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:04:18 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-vBCUG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:04:18 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)) 16:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:04:18 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-X2KndJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:04:18 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)) 16:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:04:18 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-rrVwEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:04:18 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)) 16:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:04:18 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-bLAzvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:04:18 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-mJoal5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:04:18 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)) 16:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:04:18 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-kkBIOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:04:19 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)) 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:04:19 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Oy9AJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:04:19 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)) 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:04:19 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-FrkuOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:04:19 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)) 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:04:19 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-fRrvLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:04:19 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)) 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:04:19 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-1StJ3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:04:19 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)) 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:04:19 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-BD_ksi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:04:19 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)) 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:04:19 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-rCgb3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:04:19 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-TXpJUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:04:19 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)) 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:04:19 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-jJs0nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:04:19 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)) 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:19 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-zeIxvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:20 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)) 16:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:04:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-qvVAf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:04:20 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)) 16:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:04:20 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-NRXEMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:04:20 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)) 16:04:20 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)) 16:04:20 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)) 16:04:20 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)) 16:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:04:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:22 INFO - Downloading blessings-1.6.tar.gz 16:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:04:22 INFO - Installing collected packages: blessings 16:04:22 INFO - Running setup.py install for blessings 16:04:23 INFO - Successfully installed blessings 16:04:23 INFO - Cleaning up... 16:04:23 INFO - Return code: 0 16:04:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:04:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:23 INFO - Reading from file tmpfile_stdout 16:04:23 INFO - Current package versions: 16:04:23 INFO - blessings == 1.6 16:04:23 INFO - blobuploader == 1.2.4 16:04:23 INFO - docopt == 0.6.1 16:04:23 INFO - functools32 == 3.2.3-2 16:04:23 INFO - jsonschema == 2.5.1 16:04:23 INFO - manifestparser == 1.1 16:04:23 INFO - mozInstall == 1.12 16:04:23 INFO - mozcrash == 1.0 16:04:23 INFO - mozdebug == 0.1 16:04:23 INFO - mozdevice == 0.48 16:04:23 INFO - mozfile == 1.2 16:04:23 INFO - mozhttpd == 0.7 16:04:23 INFO - mozinfo == 0.9 16:04:23 INFO - mozleak == 0.1 16:04:23 INFO - mozlog == 3.4 16:04:23 INFO - moznetwork == 0.27 16:04:23 INFO - mozprocess == 0.23 16:04:23 INFO - mozprofile == 0.28 16:04:23 INFO - mozrunner == 6.13 16:04:23 INFO - mozscreenshot == 0.1 16:04:23 INFO - mozsystemmonitor == 0.3 16:04:23 INFO - moztest == 0.8 16:04:23 INFO - mozversion == 1.4 16:04:23 INFO - psutil == 3.1.1 16:04:23 INFO - requests == 1.2.3 16:04:23 INFO - wsgiref == 0.1.2 16:04:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:23 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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:04:23 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 16:04:23 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 16:04:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:04:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:23 INFO - 'HOME': '/Users/cltbld', 16:04:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:23 INFO - 'LOGNAME': 'cltbld', 16:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:23 INFO - 'MOZ_NO_REMOTE': '1', 16:04:23 INFO - 'NO_EM_RESTART': '1', 16:04:23 INFO - 'PAGER': '/bin/cat', 16:04:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:23 INFO - 'PWD': '/builds/slave/test', 16:04:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:23 INFO - 'SHELL': '/bin/bash', 16:04:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:04:23 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:04:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:23 INFO - 'USER': 'cltbld', 16:04:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:23 INFO - 'XPC_FLAGS': '0x0', 16:04:23 INFO - 'XPC_SERVICE_NAME': '0', 16:04:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:23 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)) 16:04:23 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)) 16:04:23 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)) 16:04:23 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)) 16:04:23 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)) 16:04:23 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)) 16:04:23 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)) 16:04:23 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)) 16:04:23 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)) 16:04:23 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)) 16:04:23 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)) 16:04:23 INFO - Cleaning up... 16:04:23 INFO - Return code: 0 16:04:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:23 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 0x100b37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100aad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8bcb98e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, '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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 16:04:23 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 16:04:23 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 16:04:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:04:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:23 INFO - 'HOME': '/Users/cltbld', 16:04:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:23 INFO - 'LOGNAME': 'cltbld', 16:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:23 INFO - 'MOZ_NO_REMOTE': '1', 16:04:23 INFO - 'NO_EM_RESTART': '1', 16:04:23 INFO - 'PAGER': '/bin/cat', 16:04:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:23 INFO - 'PWD': '/builds/slave/test', 16:04:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:23 INFO - 'SHELL': '/bin/bash', 16:04:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:04:23 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:04:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:23 INFO - 'USER': 'cltbld', 16:04:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:23 INFO - 'XPC_FLAGS': '0x0', 16:04:23 INFO - 'XPC_SERVICE_NAME': '0', 16:04:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:04:24 INFO - Cleaning up... 16:04:24 INFO - Return code: 0 16:04:24 INFO - Running post-action listener: _resource_record_post_action 16:04:24 INFO - Running post-action listener: _start_resource_monitoring 16:04:24 INFO - Starting resource monitoring. 16:04:24 INFO - [mozharness: 2017-03-02 00:04:24.077577Z] Finished create-virtualenv step (success) 16:04:24 INFO - [mozharness: 2017-03-02 00:04:24.078649Z] Running install step. 16:04:24 INFO - Running pre-action listener: _resource_record_pre_action 16:04:24 INFO - Running main action method: install 16:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:24 INFO - Reading from file tmpfile_stdout 16:04:24 INFO - Detecting whether we're running mozinstall >=1.0... 16:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:04:24 INFO - Reading from file tmpfile_stdout 16:04:24 INFO - Output received: 16:04:24 INFO - Usage: mozinstall [options] installer 16:04:24 INFO - Options: 16:04:24 INFO - -h, --help show this help message and exit 16:04:24 INFO - -d DEST, --destination=DEST 16:04:24 INFO - Directory to install application into. [default: 16:04:24 INFO - "/builds/slave/test"] 16:04:24 INFO - --app=APP Application being installed. [default: firefox] 16:04:24 INFO - mkdir: /builds/slave/test/build/application 16:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:04:46 INFO - Reading from file tmpfile_stdout 16:04:46 INFO - Output received: 16:04:46 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:04:46 INFO - Running post-action listener: _resource_record_post_action 16:04:46 INFO - [mozharness: 2017-03-02 00:04:46.003255Z] Finished install step (success) 16:04:46 INFO - [mozharness: 2017-03-02 00:04:46.003400Z] Running run-tests step. 16:04:46 INFO - Running pre-action listener: _resource_record_pre_action 16:04:46 INFO - Running main action method: run_tests 16:04:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:04:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:04:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:04:46 INFO - 2017-03-01 16:04:46.018 screenresolution[10029:55646] starting screenresolution argv=screenresolution get 16:04:46 INFO - 2017-03-01 16:04:46.020 screenresolution[10029:55646] Display 0: 1600x1200x32@60 16:04:46 INFO - 2017-03-01 16:04:46.026 screenresolution[10030:55648] starting screenresolution argv=screenresolution list 16:04:46 INFO - Available Modes on Display 0 16:04:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:04:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:04:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:04:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:04:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:04:46 INFO - Intel Iris: 16:04:46 INFO - Chipset Model: Intel Iris 16:04:46 INFO - Type: GPU 16:04:46 INFO - Bus: Built-In 16:04:46 INFO - VRAM (Dynamic, Max): 1536 MB 16:04:46 INFO - Vendor: Intel (0x8086) 16:04:46 INFO - Device ID: 0x0a2e 16:04:46 INFO - Revision ID: 0x0009 16:04:46 INFO - Displays: 16:04:46 INFO - Display: 16:04:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:04:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:04:46 INFO - Display Serial Number: 1600x1200 60 16:04:46 INFO - Main Display: Yes 16:04:46 INFO - Mirror: Off 16:04:46 INFO - Online: Yes 16:04:46 INFO - Rotation: Supported 16:04:46 INFO - Return code: 0 16:04:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:04:46 INFO - Python 2.7.3 16:04:46 INFO - Return code: 0 16:04:46 INFO - grabbing minidump binary from tooltool 16:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:46 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 0x10094bd30>, '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 0x1007b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100943b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:04:46 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 16:04:46 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 16:04:46 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 16:04:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:04:46 INFO - Return code: 0 16:04:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:04:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:04:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:04:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:04:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:04:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0270', '--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 16:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0270 --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 16:04:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FxeEUUhwar/Render', 16:04:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:46 INFO - 'HOME': '/Users/cltbld', 16:04:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:46 INFO - 'LOGNAME': 'cltbld', 16:04:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:04:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:46 INFO - 'MOZ_NO_REMOTE': '1', 16:04:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:04:46 INFO - 'NO_EM_RESTART': '1', 16:04:46 INFO - 'PAGER': '/bin/cat', 16:04:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:46 INFO - 'PWD': '/builds/slave/test', 16:04:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:04:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:46 INFO - 'SHELL': '/bin/bash', 16:04:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiV6Ndb3Iw/Listeners', 16:04:46 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 16:04:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:46 INFO - 'USER': 'cltbld', 16:04:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:46 INFO - 'XPC_FLAGS': '0x0', 16:04:46 INFO - 'XPC_SERVICE_NAME': '0', 16:04:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0270', '--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 16:04:46 INFO - mozversion application_buildid: 20170301133922 16:04:46 INFO - mozversion application_changeset: d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 16:04:46 INFO - mozversion application_display_name: Firefox 16:04:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:04:46 INFO - mozversion application_name: Firefox 16:04:46 INFO - mozversion application_remotingname: firefox 16:04:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:04:46 INFO - mozversion application_vendor: Mozilla 16:04:46 INFO - mozversion application_version: 52.0 16:04:46 INFO - mozversion platform_buildid: 20170301133922 16:04:46 INFO - mozversion platform_changeset: d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 16:04:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:04:46 INFO - mozversion platform_version: 52.0 16:04:46 INFO - using testdate: 1488413086 16:04:46 INFO - actual date: 1488413086 16:04:46 INFO - starting webserver on 'localhost:53869' 16:04:46 INFO - SUITE-START | Running 2 tests 16:04:46 INFO - TEST-START | dromaeo_css 16:04:46 INFO - operating with platform_type : mac_ 16:04:46 INFO - Initialising browser for dromaeo_css test... 16:04:46 INFO - TEST-INFO | started process 10040 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmpWx_qZf/profile http://localhost:53869/getInfo.html) 16:04:49 INFO - PROCESS | 10040 | __metrics Screen width/height:1600/1200 16:04:49 INFO - PROCESS | 10040 | colorDepth:24 16:04:49 INFO - PROCESS | 10040 | Browser inner width/height: 1024/689 16:04:49 INFO - PROCESS | 10040 | __metrics 16:04:49 INFO - PROCESS | 10040 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:04:49 INFO - PROCESS | 10040 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:50 INFO - TEST-INFO | 10040: exit 0 16:04:50 INFO - Browser initialized. 16:04:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:04:50 INFO - TEST-INFO | started process 10043 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmpWx_qZf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:02 INFO - PROCESS | 10043 | RSS: Main: 167800832 16:05:02 INFO - PROCESS | 10043 | 16:08:04 INFO - PROCESS | 10043 | Cycle 1(1): loaded http://localhost:53869/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53869/tests/dromaeo/cssquery-ext.html) 16:08:06 INFO - PROCESS | 10043 | RSS: Main: 310792192 16:08:06 INFO - PROCESS | 10043 | 16:11:09 INFO - PROCESS | 10043 | Cycle 1(1): loaded http://localhost:53869/tests/dromaeo/cssquery-ext.html (next: http://localhost:53869/tests/dromaeo/cssquery-jquery.html) 16:11:10 INFO - PROCESS | 10043 | RSS: Main: 304611328 16:11:10 INFO - PROCESS | 10043 | 16:14:12 INFO - PROCESS | 10043 | Cycle 1(1): loaded http://localhost:53869/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53869/tests/dromaeo/cssquery-mootools.html) 16:14:13 INFO - PROCESS | 10043 | RSS: Main: 272261120 16:14:13 INFO - PROCESS | 10043 | 16:17:15 INFO - PROCESS | 10043 | Cycle 1(1): loaded http://localhost:53869/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53869/tests/dromaeo/cssquery-prototype.html) 16:17:16 INFO - PROCESS | 10043 | RSS: Main: 281075712 16:17:16 INFO - PROCESS | 10043 | 16:20:19 INFO - PROCESS | 10043 | Cycle 1(1): loaded http://localhost:53869/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53869/tests/dromaeo/cssquery-yui.html) 16:20:20 INFO - PROCESS | 10043 | RSS: Main: 259358720 16:20:20 INFO - PROCESS | 10043 | 16:23:23 INFO - PROCESS | 10043 | Cycle 1(1): loaded http://localhost:53869/tests/dromaeo/cssquery-yui.html (next: http://localhost:53869/tests/dromaeo/cssquery-dojo.html) 16:23:23 INFO - PROCESS | 10043 | RSS: Main: 370466816 16:23:23 INFO - PROCESS | 10043 | 16:23:23 INFO - PROCESS | 10043 | __start_tp_report 16:23:23 INFO - PROCESS | 10043 | _x_x_mozilla_page_load 16:23:23 INFO - PROCESS | 10043 | _x_x_mozilla_page_load_details 16:23:23 INFO - PROCESS | 10043 | |i|pagename|runs| 16:23:23 INFO - PROCESS | 10043 | |0;dojo.html;3414.47075703266;3438.363902678004;3465.220325426778;3499.9125021874465;3525.3830579648557;5878.911816322759;5946.28644562652;5947.88104237915;5974.79088231912;6012.068129439938;5914.645121292726;5988.580799344037;6000.669963152025;6007.759689612421;6008.339082700911;5290;5329.147336426173;5344.946550534483;5361.437049109846;5444.945550544483;5261.736913154346;5275.261463395128;5297.496737809902;5403.675779453226;5418.566514678816;5320.414754377015;5363.329583802025;5400.91898621521;5402.9729851350685;5422.186671999192;5335.466453354672;5343.625946183769;5346.224797404355;5403.756830942597;5417.404085550586;5289.656172348824;5358.196270559447;5363.54409875161;5364.463553644643;5383.111786555213;5766.682832444214;5845.503132233765;5852.063669812852;5946.197263369433;5991.2510936132985;6206.906896396557;6225.906611400833;6240.812775616739;6247.437730604267;6251.343608921089;6220.968895155495;6232.376762323776;6234.470070044052;6242.219722534684;6300.905486417708;5845.7369418376275;5984.192134061933;6007.639541627516;6021.5182785377065;6027.427394397525;5372.167314066326;6282.183316168869;6333.619982800955;6357.872842543124;6362.650054247061;6242.063690446469;6245.0632405139595;6256.655883926337;6266.310705822356;6279.058141278845;6149.13912052313;6299.590526615755;6304.3695630437505;6307.400796924285;6325.240971083499;6187.102870083812;6225.1907252057845;6230.470410015108;6238.251409830758;6280.874382512324;6254.312025677172;6261.436470717657;6267.9373206268265;6269.435750782452;6273.65494897785;5067.113255180328;5102.617303702237;5116;5116.334876466036;5129.743512824344;4506.819727210875;4521.660875434355;4530.524294949048;4544.7045942013665;4588.220002599566;5821.53427725781;5880.059190529495;5888.558358123158;5971.940280597139;5987.221661184105;6246.6876656167005;6274.749010039547;6284.874302514016;6299.716512756937;6302.558820882494;5888.028475301528;5904.0553511437965;5907.7046147692445;5911.379305172895;5969.04495280753;5379;5497.36780270274;5504.80733174337;5524.4199359067525;5539.972300138474;6518.641474718841;6549.574277672032;6556.475481961336;6562.34376562359;6571.572847764975;6256.7810126645345;6271.31015588294;6283.654399007915;6290.339514351111;6300.21247344082;5507.586930980113;6259.78090766821;6320.905186422299;6383.872322553616;6483.319251478527;6194.132821405097;6216.44052035319;6264.843378915563;6266.467350275278;6272.874542509216;6260.217472815898;6263.217097862767;6264.812055638338;6278.15244941927;6281.183446152154;6114.0828875669;6161.876762464815;6193.349698281616;6201.2868520118955;6296.118543403835;6138.9095594588325;6162.383761623802;6205.162303089025;6264.091706702594;6274.403931626488;6146.6004709693725;6148.077788331786;6156.445919867055;6157.32269450369;6181.783637572664;6126.111713801385;6191.4118158774845;6268.091126786499;6272.278687950761;6279.246490421178;5930.881382372415;6010.3088144863905;6020.217371741645;6025.638461692312;6137.254412462313 16:23:23 INFO - PROCESS | 10043 | |1;ext.html;494.60678760385514;495.7892895519403;523.3876364653355;528.9550388217001;554.4012466536142;29013.85493072534;41817.58182418175;43068;43214.351784723214;43303.78348108255;42608.57391426085;42854.7857260714;42917.570824291746;42928;43283.3507497387;9453.810923781502;9645.03549645037;9649.565769540352;9662.5168741563;9679.177269932065;8787.472751634923;8997.145271199226;9011.414258073237;9090.63637454501;9094.363394562382;11234.49444774987;11552.018078463341;11575.189736718434;11768.588099416522;11776.116791240649;11573;11641.243319184226;11672.416379181092;11674.649760507198;11688.29870207786;11436.771264574661;11504.194706370557;11508.884911150864;11526.077913766878;11552.364619945984;39813.60186398157;40067.398989015186;40067.59932400697;40220;40238.19523609511;3255.0560337502097;3349.9832500837583;3354.698077173066;3386.8137252451106;3419.81191034493;29302.560461593093;30322.54516182237;30512.389752204832;31537.52693709596;31638.683613164034;3142.5286207068893;3168.572242747223;3326.7338612910908;3376.6116896556964;3400.5409269748516;428189;495430;504092.4386134211;504812;632749;59933.70033149806;61294.38705612976;61296.693516532134;61297.38702612917;61302.69348653317;33100.33799324048;34798.82600586981;34823.825880870434;64656;65088;16930.238139283763;17143.228554715068;17146.914265428593;17164.39924602658;17185;13073.346332683328;13179;13189.53836615733;13192.604221873358;13205.735885282433;16755.83244167567;17100.828991710172;19108.331208407915;19127.52181195481;19141.947192904525;7350.963245183847;7362.226966168582;7483.625818709152;7845.411594130463;7962.124166341698;816.6406781016334;906.0939060939061;975.3367709957297;984.1487113646788;999.6701088640731;28357;29581;29761.851190743906;29919.756018298714;30328.393432131234;913.4108500017585;951.9048095190564;1068.5191663751343;1072.420892717939;1119.7760447910287;14527.78208326876;15219.771703424458;15299.923500382427;15518;15575.221238938007;632893;652210;678566;688945;691821;48806;49876.75061624669;54856.451435485935;55620.443795562336;55735;1379.7654398752236;1390.867867552581;1401.7336706025822;1418.1207651256286;1421.3461807568635;29247.85376073106;30271.94048208302;30432.630531625688;31079;31091.84454077715;48951.75524122357;49900;49926;49996;50105;608503.9574802098;611367;611886;613090;614611;26196.73803261943;26535.734642653326;26545.469090618466;26554.601680974414;26557.468850623267;43666;44322.55677443184;44595.770211489944;45167;45663;36940.81529592335;37000.44499332566;37017.6298237025;37194.8140259297;38225.61774382221;36648.63351366452;37461.495971694356;37493.81253093717;37811.432828507044;38064.619353806105;36683.44974825433;37131.88604341874;37334.69328573596;37551.05713900001;37605.43591846179;28734.425311494073;32095.679043209268;33242.66757332395;34208.486872697424;34422.96731098071;25298.355606885492;25671.97312107495;25756;26128.73871261263;26834.194974150807 16:23:23 INFO - PROCESS | 10043 | |2;jquery.html;383.601054902901;389.72719096632363;390.4455672944417;398.17577614338313;421.3132593871988;20539.075741591627;20858.89570552149;21333.146674133015;21347.466313342156;21782.782172178275;21349;21351.466213344636;21554;21695.891520542376;21872.23447179349;5655.5475561955045;6058.39416058395;6059.18201042858;6069.08963655453;6075.817725468243;5765.7981970631035;5965.075413310944;5991.580589358747;6098.08528720691;6100.511959043288;5951.494122999528;5956.731947062371;5959.6722180280285;5967.373425790294;5983;5734.397888221739;5948.16725658406;5961.076033214837;5971.5222782177325;6040.033594624839;5297.099493086184;5302.708351040691;5305.495977882095;5310.176922577007;5315.813946511892;25356.74643253581;25794.871025644938;25885.741142588522;25896.093636722624;26077.56573388463;2707.499112664144;2728.31792051987;2785.247983044567;3121.360121175154;3142.120206342228;14276.286185690778;15111.244437778178;15517.224138793015;16025;16040.35838566456;1569.7566877134063;1817.1822679794145;1954.2671498188179;1955.7750858651295;1985.7815640279557;99109;124082;124424;129580.05629915559;133596;11208.831867521994;11698.239614425034;11734.413279335999;11749.353785541707;11938.522459101712;15228.847711522743;15232.314545845464;15250.466233681767;15275.694486110215;15291.006084604465;8391.24478796899;8661.480311181349;8688.000879898766;8792.736217913473;8831.955840220759;8505.787355316166;8519.574021299035;8546;8689.913100869036;8728.476291422536;4576.130535198368;4606;4622.6301895848255;4707.482176960531;4752.809887604526;1708.8034875989172;1919.4049844548235;1966.2331690640663;1967.1541237267827;2014.6675798493377;696.4463251714899;731.9377852882565;801.7193982106216;807.9878801817978;1066.3122286125406;20196.495087622927;22416.76707781055;22437.88781056117;22491.325260242218;22720.772792271866;918.8621706744042;954.9856752148723;969.030969030969;988.6292640259902;1014.705735336744;9265.351425400291;11114.22200445961;11433.199676022765;11537.596184133516;11798;596438;597902;605043;613633;614925;100390;113026;113144.86855131508;113380;113616;777.8638738220789;819.7192439482701;937.0535758883441;939.4504215034282;963.4075043847984;18883;19604.509887252934;19823;20193.39419817408;20214;38842.6115738839;46910;53629.46370536245;55585.44414555802;56872;77922;78752;79311.60344198241;80704.19295806967;80756;7210.855782884418;8096.016475963426;8254.092049874389;8254.958725206336;8463.703770368007;10945.562177512811;12378.70023647504;12729.936350318188;13095.345232738515;13303.733925321245;8414.45306055129;8827.029026807175;10515.263931525025;10841.241113122005;11227.66317010491;11086.778264434504;11358.432078395881;11568.595099171489;11611.129165312805;11781.76436471283;11240;11284.492197851281;11327.376994265394;11457.770844582896;11613.245139066272;8190.877136843072;8228.42401031922;8449.788755281168;8551.747479071093;8553.61508732096;8814.51520166397;11119.27724697892;11237.7752444949;11441.256318339281;11521.711957201138 16:23:23 INFO - PROCESS | 10043 | |3;mootools.html;1476.335648957969;1521.231777952134;1692.8137904830467;1840.5398650337415;1870.1116969439508;8059.194080591938;8475.91524084759;8485.575721213945;8490.363222758302;8501.107383724697;6437.613743175401;7696.307332340089;7988.840223195547;8156.429049966505;8323.500589964591;2333.649952507125;2386.4391867911027;2387;2389.9044038238535;2393.533261014094;2371.27676058802;2394.4971555973266;2412.975870241293;2415.3478560788576;2419.334682962182;1997.8512355395633;2044.1925439451409;2342.7774361435636;2378.870036732547;2381.20229723043;2312.7340355859124;2315.4327189838427;2343.1564636730764;2343.6836027136374;2365.207655435431;2369.7274813396334;2396.3290278721984;2401.8799060046927;2405.0980882169188;2408.14510848648;8344.374171937068;8361.665533378658;8452.366072544522;8454;8456.196661317164;4909.337239472661;5142;5254.395744489394;5254.4220135785035;5255.369355677305;3311.106001379614;3393.3213357328386;3545.8758943436856;3567.8751243706347;3573.910652233689;1033.26121822897;1046.4506134279488;1091.6724982505216;1115.9888401115966;1121.1647322744607;9439.292053095976;10898.945505272502;11024.283421577571;11035.006849383513;11055.391953442557;4464.933026004613;4555.886102847456;4738.691985020962;4738.8341408050555;4745.979614382924;9407.341486096044;9411.952940235393;9416.670416535388;9426.293028022927;9438.669646562337;4528.230200865861;5203.037438073969;5208.817691380859;5210.921836172461;5212.765425555859;4315.525292217853;4447.155040542287;4482.260427029503;4796.37647105881;4797.376341075638;3784.880466938523;3815.8473661053804;3936.881893543198;3943.9802800985813;3946.3883098119836;1086.750047489082;1253.8119282107757;1268.2580690296095;1277.1443133100845;1284.524725851441;849.562475325208;867.0029466113893;911.129870973219;911.5670056723003;912.6805618033635;5372.91940620891;5429.1856221566295;5654.434556544313;5701.315842098892;5805.245318108703;882.7395918204145;911.2118017914456;921.4563407589554;930.8510638297976;964.5563041001078;3789.1663833956486;3799.2781371539318;3810.2760475509563;3847.3074846527893;3912.139329347539;9792.510374481248;10069.194464442828;10141.036601522843;10171.54228059739;10172.338797978107;10087.596496140219;10101.898981010096;10103.545340459697;10134.391936483835;10137.391756494633;7480.551166929893;7796.064472263365;7924.643391047417;7939.325157361689;7948.364130869517;5767.913481297868;5846.6784326862435;5859.2090067842;5956.970215148896;6037.75848966054;7732.961335193288;9034;9194.95402522983;9224.07759224099;9274.211692005985;9292.95353523228;9451.243900488082;9525.618975240914;9550.37922535033;9566.282528810229;6623.834404139935;6842.521023528504;7163.247858974941;7291.125064992235;7291.270872912878;7341.59621220838;7669.118051424158;8011;8077.394195435249;8077.63650635711;7120.857582848417;7238.927610723826;7262.96368518154;7295.015172951584;7381;6892.862142757016;6979;7128.251533588898;7136.892946605909;7188.928110718826;6398.456131228898;6648.966755166193;6746.021826834984;6749.358810912955;6775.254721980479;4211.684123690674;4790.616750660009;4800.831970881002;4872.512748725099;4922.384701912261;4760.642951778561;4779.976100119477;4836.298736683231;4954.108260513142;5054.82308119214 16:23:23 INFO - PROCESS | 10043 | |4;prototype.html;303.88148622037403;310.10534607656916;319.19562701990975;321.09931641744913;326.9722073623742;4392.4289842320495;4656.487786343504;5274.156135018397;5356.3572371315395;5365.409804921465;4783.7801360653075;4988.575971042456;5185.299984502091;5201.203121721146;5279.340082489689;3962.6433620974108;3990.580988996157;4015.4177644241568;4050.6961977851633;4095.26285268653;3990.3415936370466;4002.75983440993;4003.5996400360023;4011.378236373352;4049.7975101244965;3368.882089126881;3842.5023734572474;3960.4851369321946;4026.4161696553983;4040.090979529597;3453.775504592206;3507.754457187998;3998.2203470323298;4020.2562525932794;4033.757974521538;3517.3492903812876;3525.541679581638;3541.9102729389524;3543.698785603201;3545.2023294758733;5070.619703522214;5076.822311219126;5089.796408143707;5089.821856235051;5110.693358398471;3427.1774774054297;4550.385697930803;4607.470140933802;4608.746518941457;4615.976920115411;4715.7877895494785;5647.152927060933;5656;5660.36793390579;5698.772049118031;2944.2050646325374;3144.921376965571;3615.421532554805;3828.2917660232947;3856.9807150964066;5082.898342033212;5314.601404894648;5549.223108764776;5817.854553636193;5897.852553686106;3553.2538166985223;3848.4419759134767;3848.9230215395537;3853.4412510186426;3855.4987851579117;3893.805309734502;3909.863154789569;3915.4909861718365;3920.3923391874305;3935.5277366716177;4232.724872883253;4491.191585514639;4545.181867263925;4574.313852922021;4616.699914505546;5609.943900561024;5615.494605485526;5636.577256705764;5640.492355688008;5643.887122257614;1173.3370645585217;1194.9223300485614;1267.877928033697;1268.3404629592744;1279.4242590834162;822.8189798244376;839.5256679975794;855.2772906893665;875.417847131663;876.9079246679134;3972.801359931992;4288.647023271382;4522.4573051234065;4619.75266677995;4938.925916111261;4872.634552408584;4902.632302577321;5235.005348983681;5471.945280547144;5485.0949593317455;4542.682012259176;4681;4738.928916066262;4765.9523404766205;4863.878403039952;2555.7699807017084;2828.2182225198403;2832.362718388346;2834.803027653585;2852.7432531072304;4357.629601483909;4834.492378300228;5139.691618502902;5586.413426590149;5594.860128496739;5152.510511501401;5508.245877061469;5537.446255374431;5548.833534993957;5581.6371935824045;5124.948750512596;5163.7676304566385;5271.15357706834;5460.153676180198;5539.307586551681;5121.7695203715175;5392.892142157213;5395.217693434509;5408.621396502207;5413.10683737179;4896.853094407174;4960.578350840075;5189.299444574934;5321.148616221386;5366.221897824872;4597.586217240464;4625.074985002945;5041.319421878;5061.645684802029;5619.690916999604;3259;3607.2785442911;3634.9648043883653;3635.5819080806045;3653;4369.344598310152;5164.708822794301;5396.3524377075;5410.891782164414;5446.101393270066;5214.32213812202;5222.843314700565;5234.345706786652;5241.633085683966;5247.737613119405;4234.745915245096;4748.4776674566465;5188.22176673502;5224.8839220115915;5247.134222853339;5061.443241243386;5074.5686616637995;5074.898502030012;5086.21163719624;5127.128388174094;4417.734935903856;5288.4303095411215;5442.863928401822;5513.779448822002;5521.944780552143;4403;4762.714237145644;5449.073657478318;5453.890922181614;5458.563314934716 16:23:23 INFO - PROCESS | 10043 | |5;yui.html;717.7200891652257;719.5538765965102;724.9710011599535;765.3571000359697;806.8224990502091;14348.210848403347;15294.158821264826;15314.846851531482;15358.769618455719;15376.077435353873;13743.175409475438;13921.999999999975;13940.09389389689;13950.93024534876;13995.93002034991;691.5470366909682;712.8574285142967;844.3793811548506;846.2172490446343;860.2988564320059;869.4956924983526;871.424859592669;880.3485420788635;880.4189235104832;883.7437143228456;916.4318122763863;918.164470331998;918.4948278446827;920.6593560382668;921;912.361347057056;912.5163663258484;913.328703402995;913.6984795017662;919.2232563483846;678.9984772460631;679.5413096160122;681.4718593090345;683.043738765727;684.5892464521297;14205;14945.775813362809;15021.474248401253;15091.24543772807;15124.54626361211;13436.865631343757;13670.34213157067;13733.107348022446;13920.512782052681;13943.093698909539;11419.657410277705;11436.885631143748;11585.884141158649;11866.940665296705;12260.325682087481;3712.9071773205887;3714.981425092857;3801.6388443097862;3811.5807261201244;3941.152652179795;98375;99572;99656;103561.4821925893;104173;10643.94678026605;10873.565057397775;10914.290571113012;10960.616378426717;11011.28426652265;22169.778302217095;22189.667154992687;22226.555273907143;22514.437139071655;22638.66042009371;7489.251074892576;7543.396528277724;7622.199669034782;7789.610519474117;7941.563214023168;4308.18144552534;4319.157764236007;4340.283853164193;4384.364267181241;4539.977300113478;3285.7864238824877;3357.5467311913067;3360.764746467724;3401.795892246473;3411.2154204533094;623.4513628007325;623.5230049012509;625.6840295650667;626.0734113511937;631.3812463785516;554.5951455437553;558.3523113188681;575.7581815637442;613.1752792494088;620.2804746494136;7221.133463984355;8488.074215932524;9156.284513475566;10007.693614300113;10038.096571308617;620.7936010505778;654.7021105397033;677.7085853083222;703.4231929817603;725.6117976882342;3679.8712045078296;3902;3949.229900169497;4068.8575899843363;4576.702514336557;85951.57024214839;102075.48962255141;105438.47280763701;108919;109491;72131.27868721246;75751.24248757442;93440.0655993445;95349.52325238468;96666.03333966571;59367.10949335763;78467;80776.78834817365;84946;85323.57338213394;7284.562926224444;8387.496750195009;8684.305255579664;8761.561921903753;8887.066857979818;42731.35902961396;54494.45505544894;55895.72052139713;56463.71768141133;56614.7169264151;65553.68892622217;69910.95133572898;71476.27855821668;72946;77714;11359.48882300282;11619.825702614637;11741.823872641746;11951.462184201559;12094.758104837678;13678.247696376397;13736.450541978209;14493.420263189355;15057.322420491324;15061.548153555412;13150.736985260433;13382.397792099573;13574.59276221715;13636.045476816527;14066;12817.359132043546;13642;13656.522021729192;13807;13929.58211253664;11240.88759112431;11750.412479376168;11902.583409580624;12264.386780660752;12265.938670306592;10545.789084218426;10846.240763146505;11055.281406708538;11178.888211117785;11460.94269528647;9677.758056048655;10789.62236321725;11215.55137794479;11374.431278435879;11427.771444571228 16:23:23 INFO - PROCESS | 10043 | __end_tp_report 16:23:23 INFO - PROCESS | 10043 | __start_cc_report 16:23:23 INFO - PROCESS | 10043 | _x_x_mozilla_cycle_collect,1610 16:23:23 INFO - PROCESS | 10043 | __end_cc_report 16:23:23 INFO - PROCESS | 10043 | __startTimestamp1488414203961__endTimestamp 16:23:23 INFO - PROCESS | 10043 | 16:23:23 INFO - PROCESS | 10043 | ------- Summary: start ------- 16:23:23 INFO - PROCESS | 10043 | Number of tests: 6 16:23:23 INFO - PROCESS | 10043 | 16:23:23 INFO - PROCESS | 10043 | [#0] dojo.html Cycles:165 Average:5857.45 Median:6126.11 stddev:618.60 (10.1%) stddev-sans-first:590.06 16:23:23 INFO - PROCESS | 10043 | Values: 3414.5 3438.4 3465.2 3499.9 3525.4 5878.9 5946.3 5947.9 5974.8 6012.1 5914.6 5988.6 6000.7 6007.8 6008.3 5290.0 5329.1 5344.9 5361.4 5444.9 5261.7 5275.3 5297.5 5403.7 5418.6 5320.4 5363.3 5400.9 5403.0 5422.2 5335.5 5343.6 5346.2 5403.8 5417.4 5289.7 5358.2 5363.5 5364.5 5383.1 5766.7 5845.5 5852.1 5946.2 5991.3 6206.9 6225.9 6240.8 6247.4 6251.3 6221.0 6232.4 6234.5 6242.2 6300.9 5845.7 5984.2 6007.6 6021.5 6027.4 5372.2 6282.2 6333.6 6357.9 6362.7 6242.1 6245.1 6256.7 6266.3 6279.1 6149.1 6299.6 6304.4 6307.4 6325.2 6187.1 6225.2 6230.5 6238.3 6280.9 6254.3 6261.4 6267.9 6269.4 6273.7 5067.1 5102.6 5116.0 5116.3 5129.7 4506.8 4521.7 4530.5 4544.7 4588.2 5821.5 5880.1 5888.6 5971.9 5987.2 6246.7 6274.7 6284.9 6299.7 6302.6 5888.0 5904.1 5907.7 5911.4 5969.0 5379.0 5497.4 5504.8 5524.4 5540.0 6518.6 6549.6 6556.5 6562.3 6571.6 6256.8 6271.3 6283.7 6290.3 6300.2 5507.6 6259.8 6320.9 6383.9 6483.3 6194.1 6216.4 6264.8 6266.5 6272.9 6260.2 6263.2 6264.8 6278.2 6281.2 6114.1 6161.9 6193.3 6201.3 6296.1 6138.9 6162.4 6205.2 6264.1 6274.4 6146.6 6148.1 6156.4 6157.3 6181.8 6126.1 6191.4 6268.1 6272.3 6279.2 5930.9 6010.3 6020.2 6025.6 6137.3 16:23:23 INFO - PROCESS | 10043 | 16:23:23 INFO - PROCESS | 10043 | [#1] ext.html Cycles:180 Average:72076.88 Median:37009.04 stddev:161391.43 (436.1%) stddev-sans-first:161754.69 16:23:23 INFO - PROCESS | 10043 | Values: 494.6 495.8 523.4 529.0 554.4 29013.9 41817.6 43068.0 43214.4 43303.8 42608.6 42854.8 42917.6 42928.0 43283.4 9453.8 9645.0 9649.6 9662.5 9679.2 8787.5 8997.1 9011.4 9090.6 9094.4 11234.5 11552.0 11575.2 11768.6 11776.1 11573.0 11641.2 11672.4 11674.6 11688.3 11436.8 11504.2 11508.9 11526.1 11552.4 39813.6 40067.4 40067.6 40220.0 40238.2 3255.1 3350.0 3354.7 3386.8 3419.8 29302.6 30322.5 30512.4 31537.5 31638.7 3142.5 3168.6 3326.7 3376.6 3400.5 428189.0 495430.0 504092.4 504812.0 632749.0 59933.7 61294.4 61296.7 61297.4 61302.7 33100.3 34798.8 34823.8 64656.0 65088.0 16930.2 17143.2 17146.9 17164.4 17185.0 13073.3 13179.0 13189.5 13192.6 13205.7 16755.8 17100.8 19108.3 19127.5 19141.9 7351.0 7362.2 7483.6 7845.4 7962.1 816.6 906.1 975.3 984.1 999.7 28357.0 29581.0 29761.9 29919.8 30328.4 913.4 951.9 1068.5 1072.4 1119.8 14527.8 15219.8 15299.9 15518.0 15575.2 632893.0 652210.0 678566.0 688945.0 691821.0 48806.0 49876.8 54856.5 55620.4 55735.0 1379.8 1390.9 1401.7 1418.1 1421.3 29247.9 30271.9 30432.6 31079.0 31091.8 48951.8 49900.0 49926.0 49996.0 50105.0 608504.0 611367.0 611886.0 613090.0 614611.0 26196.7 26535.7 26545.5 26554.6 26557.5 43666.0 44322.6 44595.8 45167.0 45663.0 36940.8 37000.4 37017.6 37194.8 38225.6 36648.6 37461.5 37493.8 37811.4 38064.6 36683.4 37131.9 37334.7 37551.1 37605.4 28734.4 32095.7 33242.7 34208.5 34423.0 25298.4 25672.0 25756.0 26128.7 26834.2 16:23:23 INFO - PROCESS | 10043 | 16:23:23 INFO - PROCESS | 10043 | [#2] jquery.html Cycles:180 Average:35150.85 Median:3131.74 stddev:100680.07 (3214.8%) stddev-sans-first:100928.66 16:23:23 INFO - PROCESS | 10043 | Values: 383.6 389.7 390.4 398.2 421.3 20539.1 20858.9 21333.1 21347.5 21782.8 21349.0 21351.5 21554.0 21695.9 21872.2 5655.5 6058.4 6059.2 6069.1 6075.8 5765.8 5965.1 5991.6 6098.1 6100.5 5951.5 5956.7 5959.7 5967.4 5983.0 5734.4 5948.2 5961.1 5971.5 6040.0 5297.1 5302.7 5305.5 5310.2 5315.8 25356.7 25794.9 25885.7 25896.1 26077.6 2707.5 2728.3 2785.2 3121.4 3142.1 14276.3 15111.2 15517.2 16025.0 16040.4 1569.8 1817.2 1954.3 1955.8 1985.8 99109.0 124082.0 124424.0 129580.1 133596.0 11208.8 11698.2 11734.4 11749.4 11938.5 15228.8 15232.3 15250.5 15275.7 15291.0 8391.2 8661.5 8688.0 8792.7 8832.0 8505.8 8519.6 8546.0 8689.9 8728.5 4576.1 4606.0 4622.6 4707.5 4752.8 1708.8 1919.4 1966.2 1967.2 2014.7 696.4 731.9 801.7 808.0 1066.3 20196.5 22416.8 22437.9 22491.3 22720.8 918.9 955.0 969.0 988.6 1014.7 9265.4 11114.2 11433.2 11537.6 11798.0 596438.0 597902.0 605043.0 613633.0 614925.0 100390.0 113026.0 113144.9 113380.0 113616.0 777.9 819.7 937.1 939.5 963.4 18883.0 19604.5 19823.0 20193.4 20214.0 38842.6 46910.0 53629.5 55585.4 56872.0 77922.0 78752.0 79311.6 80704.2 80756.0 7210.9 8096.0 8254.1 8255.0 8463.7 10945.6 12378.7 12729.9 13095.3 13303.7 8414.5 8827.0 10515.3 10841.2 11227.7 11086.8 11358.4 11568.6 11611.1 11781.8 11240.0 11284.5 11327.4 11457.8 11613.2 8190.9 8228.4 8449.8 8551.7 8553.6 8814.5 11119.3 11237.8 11441.3 11521.7 16:23:23 INFO - PROCESS | 10043 | 16:23:23 INFO - PROCESS | 10043 | [#3] mootools.html Cycles:180 Average:5449.03 Median:5172.52 stddev:2953.06 (57.1%) stddev-sans-first:2946.25 16:23:23 INFO - PROCESS | 10043 | Values: 1476.3 1521.2 1692.8 1840.5 1870.1 8059.2 8475.9 8485.6 8490.4 8501.1 6437.6 7696.3 7988.8 8156.4 8323.5 2333.6 2386.4 2387.0 2389.9 2393.5 2371.3 2394.5 2413.0 2415.3 2419.3 1997.9 2044.2 2342.8 2378.9 2381.2 2312.7 2315.4 2343.2 2343.7 2365.2 2369.7 2396.3 2401.9 2405.1 2408.1 8344.4 8361.7 8452.4 8454.0 8456.2 4909.3 5142.0 5254.4 5254.4 5255.4 3311.1 3393.3 3545.9 3567.9 3573.9 1033.3 1046.5 1091.7 1116.0 1121.2 9439.3 10898.9 11024.3 11035.0 11055.4 4464.9 4555.9 4738.7 4738.8 4746.0 9407.3 9412.0 9416.7 9426.3 9438.7 4528.2 5203.0 5208.8 5210.9 5212.8 4315.5 4447.2 4482.3 4796.4 4797.4 3784.9 3815.8 3936.9 3944.0 3946.4 1086.8 1253.8 1268.3 1277.1 1284.5 849.6 867.0 911.1 911.6 912.7 5372.9 5429.2 5654.4 5701.3 5805.2 882.7 911.2 921.5 930.9 964.6 3789.2 3799.3 3810.3 3847.3 3912.1 9792.5 10069.2 10141.0 10171.5 10172.3 10087.6 10101.9 10103.5 10134.4 10137.4 7480.6 7796.1 7924.6 7939.3 7948.4 5767.9 5846.7 5859.2 5957.0 6037.8 7733.0 9034.0 9195.0 9224.1 9274.2 9293.0 9451.2 9525.6 9550.4 9566.3 6623.8 6842.5 7163.2 7291.1 7291.3 7341.6 7669.1 8011.0 8077.4 8077.6 7120.9 7238.9 7263.0 7295.0 7381.0 6892.9 6979.0 7128.3 7136.9 7188.9 6398.5 6649.0 6746.0 6749.4 6775.3 4211.7 4790.6 4800.8 4872.5 4922.4 4760.6 4780.0 4836.3 4954.1 5054.8 16:23:23 INFO - PROCESS | 10043 | 16:23:23 INFO - PROCESS | 10043 | [#4] prototype.html Cycles:180 Average:4342.06 Median:4809.14 stddev:1310.07 (27.2%) stddev-sans-first:1278.20 16:23:23 INFO - PROCESS | 10043 | Values: 303.9 310.1 319.2 321.1 327.0 4392.4 4656.5 5274.2 5356.4 5365.4 4783.8 4988.6 5185.3 5201.2 5279.3 3962.6 3990.6 4015.4 4050.7 4095.3 3990.3 4002.8 4003.6 4011.4 4049.8 3368.9 3842.5 3960.5 4026.4 4040.1 3453.8 3507.8 3998.2 4020.3 4033.8 3517.3 3525.5 3541.9 3543.7 3545.2 5070.6 5076.8 5089.8 5089.8 5110.7 3427.2 4550.4 4607.5 4608.7 4616.0 4715.8 5647.2 5656.0 5660.4 5698.8 2944.2 3144.9 3615.4 3828.3 3857.0 5082.9 5314.6 5549.2 5817.9 5897.9 3553.3 3848.4 3848.9 3853.4 3855.5 3893.8 3909.9 3915.5 3920.4 3935.5 4232.7 4491.2 4545.2 4574.3 4616.7 5609.9 5615.5 5636.6 5640.5 5643.9 1173.3 1194.9 1267.9 1268.3 1279.4 822.8 839.5 855.3 875.4 876.9 3972.8 4288.6 4522.5 4619.8 4938.9 4872.6 4902.6 5235.0 5471.9 5485.1 4542.7 4681.0 4738.9 4766.0 4863.9 2555.8 2828.2 2832.4 2834.8 2852.7 4357.6 4834.5 5139.7 5586.4 5594.9 5152.5 5508.2 5537.4 5548.8 5581.6 5124.9 5163.8 5271.2 5460.2 5539.3 5121.8 5392.9 5395.2 5408.6 5413.1 4896.9 4960.6 5189.3 5321.1 5366.2 4597.6 4625.1 5041.3 5061.6 5619.7 3259.0 3607.3 3635.0 3635.6 3653.0 4369.3 5164.7 5396.4 5410.9 5446.1 5214.3 5222.8 5234.3 5241.6 5247.7 4234.7 4748.5 5188.2 5224.9 5247.1 5061.4 5074.6 5074.9 5086.2 5127.1 4417.7 5288.4 5442.9 5513.8 5521.9 4403.0 4762.7 5449.1 5453.9 5458.6 16:23:23 INFO - PROCESS | 10043 | 16:23:23 INFO - PROCESS | 10043 | [#5] yui.html Cycles:180 Average:20272.15 Median:23400.11 stddev:29283.52 (125.1%) stddev-sans-first:29328.86 16:23:23 INFO - PROCESS | 10043 | Values: 717.7 719.6 725.0 765.4 806.8 14348.2 15294.2 15314.8 15358.8 15376.1 13743.2 13922.0 13940.1 13950.9 13995.9 691.5 712.9 844.4 846.2 860.3 869.5 871.4 880.3 880.4 883.7 916.4 918.2 918.5 920.7 921.0 912.4 912.5 913.3 913.7 919.2 679.0 679.5 681.5 683.0 684.6 14205.0 14945.8 15021.5 15091.2 15124.5 13436.9 13670.3 13733.1 13920.5 13943.1 11419.7 11436.9 11585.9 11866.9 12260.3 3712.9 3715.0 3801.6 3811.6 3941.2 98375.0 99572.0 99656.0 103561.5 104173.0 10643.9 10873.6 10914.3 10960.6 11011.3 22169.8 22189.7 22226.6 22514.4 22638.7 7489.3 7543.4 7622.2 7789.6 7941.6 4308.2 4319.2 4340.3 4384.4 4540.0 3285.8 3357.5 3360.8 3401.8 3411.2 623.5 623.5 625.7 626.1 631.4 554.6 558.4 575.8 613.2 620.3 7221.1 8488.1 9156.3 10007.7 10038.1 620.8 654.7 677.7 703.4 725.6 3679.9 3902.0 3949.2 4068.9 4576.7 85951.6 102075.5 105438.5 108919.0 109491.0 72131.3 75751.2 93440.1 95349.5 96666.0 59367.1 78467.0 80776.8 84946.0 85323.6 7284.6 8387.5 8684.3 8761.6 8887.1 42731.4 54494.5 55895.7 56463.7 56614.7 65553.7 69911.0 71476.3 72946.0 77714.0 11359.5 11619.8 11741.8 11951.5 12094.8 13678.2 13736.5 14493.4 15057.3 15061.5 13150.7 13382.4 13574.6 13636.0 14066.0 12817.4 13642.0 13656.5 13807.0 13929.6 11240.9 11750.4 11902.6 12264.4 12265.9 10545.8 10846.2 11055.3 11178.9 11460.9 9677.8 10789.6 11215.6 11374.4 11427.8 16:23:23 INFO - PROCESS | 10043 | -------- Summary: end -------- 16:23:23 INFO - PROCESS | 10043 | 16:23:24 INFO - TEST-INFO | 10043: exit 0 16:23:24 INFO - TEST-OK | dromaeo_css | took 1117944ms 16:23:24 INFO - TEST-START | kraken 16:23:24 INFO - operating with platform_type : mac_ 16:23:24 INFO - Initialising browser for kraken test... 16:23:24 INFO - TEST-INFO | started process 10045 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmp5qhg9o/profile http://localhost:53869/getInfo.html) 16:23:27 INFO - PROCESS | 10045 | __metrics Screen width/height:1600/1200 16:23:27 INFO - PROCESS | 10045 | colorDepth:24 16:23:27 INFO - PROCESS | 10045 | Browser inner width/height: 1024/689 16:23:27 INFO - PROCESS | 10045 | __metrics 16:23:27 INFO - PROCESS | 10045 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:23:27 INFO - PROCESS | 10045 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:23:27 INFO - TEST-INFO | 10045: exit 0 16:23:27 INFO - Browser initialized. 16:23:27 INFO - Running cycle 1/1 for kraken test... 16:23:27 INFO - TEST-INFO | started process 10047 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmp5qhg9o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:40 INFO - PROCESS | 10047 | RSS: Main: 167731200 16:23:40 INFO - PROCESS | 10047 | 16:23:42 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53869/tests/kraken/driver.html?testName=audio-beat-detection) 16:23:43 INFO - PROCESS | 10047 | RSS: Main: 217899008 16:23:43 INFO - PROCESS | 10047 | 16:23:46 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53869/tests/kraken/driver.html?testName=audio-dft) 16:23:46 INFO - PROCESS | 10047 | RSS: Main: 231419904 16:23:46 INFO - PROCESS | 10047 | 16:23:50 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53869/tests/kraken/driver.html?testName=audio-fft) 16:23:50 INFO - PROCESS | 10047 | RSS: Main: 331530240 16:23:50 INFO - PROCESS | 10047 | 16:23:52 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53869/tests/kraken/driver.html?testName=audio-oscillator) 16:23:53 INFO - PROCESS | 10047 | RSS: Main: 231096320 16:23:53 INFO - PROCESS | 10047 | 16:23:55 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53869/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:23:55 INFO - PROCESS | 10047 | RSS: Main: 232071168 16:23:55 INFO - PROCESS | 10047 | 16:23:58 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53869/tests/kraken/driver.html?testName=imaging-darkroom) 16:23:59 INFO - PROCESS | 10047 | RSS: Main: 272605184 16:23:59 INFO - PROCESS | 10047 | 16:24:02 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53869/tests/kraken/driver.html?testName=imaging-desaturate) 16:24:02 INFO - PROCESS | 10047 | RSS: Main: 272072704 16:24:02 INFO - PROCESS | 10047 | 16:24:05 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53869/tests/kraken/driver.html?testName=json-parse-financial) 16:24:06 INFO - PROCESS | 10047 | RSS: Main: 269811712 16:24:06 INFO - PROCESS | 10047 | 16:24:07 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53869/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:24:08 INFO - PROCESS | 10047 | RSS: Main: 248545280 16:24:08 INFO - PROCESS | 10047 | 16:24:10 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53869/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:24:10 INFO - PROCESS | 10047 | RSS: Main: 249585664 16:24:10 INFO - PROCESS | 10047 | 16:24:12 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53869/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:24:13 INFO - PROCESS | 10047 | RSS: Main: 257859584 16:24:13 INFO - PROCESS | 10047 | 16:24:16 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53869/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:24:17 INFO - PROCESS | 10047 | RSS: Main: 272797696 16:24:17 INFO - PROCESS | 10047 | 16:24:19 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53869/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:24:20 INFO - PROCESS | 10047 | RSS: Main: 266956800 16:24:20 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | Cycle 1(1): loaded http://localhost:53869/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53869/tests/kraken/driver.html?testName=ai-astar) 16:24:22 INFO - PROCESS | 10047 | RSS: Main: 311230464 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | __start_tp_report 16:24:22 INFO - PROCESS | 10047 | _x_x_mozilla_page_load 16:24:22 INFO - PROCESS | 10047 | _x_x_mozilla_page_load_details 16:24:22 INFO - PROCESS | 10047 | |i|pagename|runs| 16:24:22 INFO - PROCESS | 10047 | |0;ai-astar;102;113;114;112;113;113;113;112;113;110 16:24:22 INFO - PROCESS | 10047 | |1;audio-beat-detection;142;110;111;175;113;108;105;109;135;108 16:24:22 INFO - PROCESS | 10047 | |2;audio-dft;184;184;183;183;183;181;179;183;183;204 16:24:22 INFO - PROCESS | 10047 | |3;audio-fft;80;57;58;88;66;58;58;72;106;72 16:24:22 INFO - PROCESS | 10047 | |4;audio-oscillator;81;69;94;69;68;69;88;68;69;91 16:24:22 INFO - PROCESS | 10047 | |5;imaging-gaussian-blur;87;84;87;83;87;83;86;83;87;83 16:24:22 INFO - PROCESS | 10047 | |6;imaging-darkroom;93;99;148;147;93;92;92;93;93;92 16:24:22 INFO - PROCESS | 10047 | |7;imaging-desaturate;83;83;81;81;82;82;83;85;81;83 16:24:22 INFO - PROCESS | 10047 | |8;json-parse-financial;54;53;56;55;56;55;56;54;55;54 16:24:22 INFO - PROCESS | 10047 | |9;json-stringify-tinderbox;63;71;73;75;72;67;69;69;69;70 16:24:22 INFO - PROCESS | 10047 | |10;stanford-crypto-aes;81;81;83;94;97;94;95;80;87;87 16:24:22 INFO - PROCESS | 10047 | |11;stanford-crypto-ccm;139;124;136;143;149;140;136;140;195;155 16:24:22 INFO - PROCESS | 10047 | |12;stanford-crypto-pbkdf2;161;162;161;162;159;160;160;162;160;161 16:24:22 INFO - PROCESS | 10047 | |13;stanford-crypto-sha256-iterative;65;66;65;64;65;66;65;66;65;66 16:24:22 INFO - PROCESS | 10047 | __end_tp_report 16:24:22 INFO - PROCESS | 10047 | __start_cc_report 16:24:22 INFO - PROCESS | 10047 | _x_x_mozilla_cycle_collect,1959 16:24:22 INFO - PROCESS | 10047 | __end_cc_report 16:24:22 INFO - PROCESS | 10047 | __startTimestamp1488414262456__endTimestamp 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | ------- Summary: start ------- 16:24:22 INFO - PROCESS | 10047 | Number of tests: 14 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.50 (3.1%) stddev-sans-first:1.13 16:24:22 INFO - PROCESS | 10047 | Values: 102.0 113.0 114.0 112.0 113.0 113.0 113.0 112.0 113.0 110.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:112.00 stddev:22.54 (20.1%) stddev-sans-first:22.67 16:24:22 INFO - PROCESS | 10047 | Values: 142.0 110.0 111.0 175.0 113.0 108.0 105.0 109.0 135.0 108.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#2] audio-dft Cycles:10 Average:184.70 Median:183.00 stddev:6.95 (3.8%) stddev-sans-first:7.36 16:24:22 INFO - PROCESS | 10047 | Values: 184.0 184.0 183.0 183.0 183.0 181.0 179.0 183.0 183.0 204.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#3] audio-fft Cycles:10 Average:71.50 Median:69.00 stddev:16.06 (23.3%) stddev-sans-first:16.74 16:24:22 INFO - PROCESS | 10047 | Values: 80.0 57.0 58.0 88.0 66.0 58.0 58.0 72.0 106.0 72.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:75.00 stddev:10.74 (14.3%) stddev-sans-first:11.27 16:24:22 INFO - PROCESS | 10047 | Values: 81.0 69.0 94.0 69.0 68.0 69.0 88.0 68.0 69.0 91.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.50 stddev:1.94 (2.2%) stddev-sans-first:1.92 16:24:22 INFO - PROCESS | 10047 | Values: 87.0 84.0 87.0 83.0 87.0 83.0 86.0 83.0 87.0 83.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:93.00 stddev:22.91 (24.6%) stddev-sans-first:23.94 16:24:22 INFO - PROCESS | 10047 | Values: 93.0 99.0 148.0 147.0 93.0 92.0 92.0 93.0 93.0 92.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#7] imaging-desaturate Cycles:10 Average:82.40 Median:83.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 16:24:22 INFO - PROCESS | 10047 | Values: 83.0 83.0 81.0 81.0 82.0 82.0 83.0 85.0 81.0 83.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:1.05 16:24:22 INFO - PROCESS | 10047 | Values: 54.0 53.0 56.0 55.0 56.0 55.0 56.0 54.0 55.0 54.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.50 stddev:3.33 (4.7%) stddev-sans-first:2.46 16:24:22 INFO - PROCESS | 10047 | Values: 63.0 71.0 73.0 75.0 72.0 67.0 69.0 69.0 69.0 70.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:90.50 stddev:6.59 (7.3%) stddev-sans-first:6.50 16:24:22 INFO - PROCESS | 10047 | Values: 81.0 81.0 83.0 94.0 97.0 94.0 95.0 80.0 87.0 87.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:141.50 stddev:19.16 (13.5%) stddev-sans-first:20.17 16:24:22 INFO - PROCESS | 10047 | Values: 139.0 124.0 136.0 143.0 149.0 140.0 136.0 140.0 195.0 155.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 16:24:22 INFO - PROCESS | 10047 | Values: 161.0 162.0 161.0 162.0 159.0 160.0 160.0 162.0 160.0 161.0 16:24:22 INFO - PROCESS | 10047 | 16:24:22 INFO - PROCESS | 10047 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 16:24:22 INFO - PROCESS | 10047 | Values: 65.0 66.0 65.0 64.0 65.0 66.0 65.0 66.0 65.0 66.0 16:24:22 INFO - PROCESS | 10047 | -------- Summary: end -------- 16:24:22 INFO - PROCESS | 10047 | 16:24:23 INFO - TEST-INFO | 10047: exit 0 16:24:23 INFO - TEST-OK | kraken | took 58943ms 16:24:23 INFO - SUITE-END | took 1176s 16:24:23 INFO - Completed test suite (00:19:37) 16:24:23 INFO - javascript benchmark 16:24:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3414.47075703266, 3438.363902678004, 3465.220325426778, 3499.9125021874465, 3525.3830579648557, 5878.911816322759, 5946.28644562652, 5947.88104237915, 5974.79088231912, 6012.068129439938, 5914.645121292726, 5988.580799344037, 6000.669963152025, 6007.759689612421, 6008.339082700911, 5290.0, 5329.147336426173, 5344.946550534483, 5361.437049109846, 5444.945550544483, 5261.736913154346, 5275.261463395128, 5297.496737809902, 5403.675779453226, 5418.566514678816, 5320.414754377015, 5363.329583802025, 5400.91898621521, 5402.9729851350685, 5422.186671999192, 5335.466453354672, 5343.625946183769, 5346.224797404355, 5403.756830942597, 5417.404085550586, 5289.656172348824, 5358.196270559447, 5363.54409875161, 5364.463553644643, 5383.111786555213, 5766.682832444214, 5845.503132233765, 5852.063669812852, 5946.197263369433, 5991.2510936132985, 6206.906896396557, 6225.906611400833, 6240.812775616739, 6247.437730604267, 6251.343608921089, 6220.968895155495, 6232.376762323776, 6234.470070044052, 6242.219722534684, 6300.905486417708, 5845.7369418376275, 5984.192134061933, 6007.639541627516, 6021.5182785377065, 6027.427394397525, 5372.167314066326, 6282.183316168869, 6333.619982800955, 6357.872842543124, 6362.650054247061, 6242.063690446469, 6245.0632405139595, 6256.655883926337, 6266.310705822356, 6279.058141278845, 6149.13912052313, 6299.590526615755, 6304.3695630437505, 6307.400796924285, 6325.240971083499, 6187.102870083812, 6225.1907252057845, 6230.470410015108, 6238.251409830758, 6280.874382512324, 6254.312025677172, 6261.436470717657, 6267.9373206268265, 6269.435750782452, 6273.65494897785, 5067.113255180328, 5102.617303702237, 5116.0, 5116.334876466036, 5129.743512824344, 4506.819727210875, 4521.660875434355, 4530.524294949048, 4544.7045942013665, 4588.220002599566, 5821.53427725781, 5880.059190529495, 5888.558358123158, 5971.940280597139, 5987.221661184105, 6246.6876656167005, 6274.749010039547, 6284.874302514016, 6299.716512756937, 6302.558820882494, 5888.028475301528, 5904.0553511437965, 5907.7046147692445, 5911.379305172895, 5969.04495280753, 5379.0, 5497.36780270274, 5504.80733174337, 5524.4199359067525, 5539.972300138474, 6518.641474718841, 6549.574277672032, 6556.475481961336, 6562.34376562359, 6571.572847764975, 6256.7810126645345, 6271.31015588294, 6283.654399007915, 6290.339514351111, 6300.21247344082, 5507.586930980113, 6259.78090766821, 6320.905186422299, 6383.872322553616, 6483.319251478527, 6194.132821405097, 6216.44052035319, 6264.843378915563, 6266.467350275278, 6272.874542509216, 6260.217472815898, 6263.217097862767, 6264.812055638338, 6278.15244941927, 6281.183446152154, 6114.0828875669, 6161.876762464815, 6193.349698281616, 6201.2868520118955, 6296.118543403835, 6138.9095594588325, 6162.383761623802, 6205.162303089025, 6264.091706702594, 6274.403931626488, 6146.6004709693725, 6148.077788331786, 6156.445919867055, 6157.32269450369, 6181.783637572664, 6126.111713801385, 6191.4118158774845, 6268.091126786499, 6272.278687950761, 6279.246490421178, 5930.881382372415, 6010.3088144863905, 6020.217371741645, 6025.638461692312, 6137.254412462313], "value": 5819.285773526201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.60678760385514, 495.7892895519403, 523.3876364653355, 528.9550388217001, 554.4012466536142, 29013.85493072534, 41817.58182418175, 43068.0, 43214.351784723214, 43303.78348108255, 42608.57391426085, 42854.7857260714, 42917.570824291746, 42928.0, 43283.3507497387, 9453.810923781502, 9645.03549645037, 9649.565769540352, 9662.5168741563, 9679.177269932065, 8787.472751634923, 8997.145271199226, 9011.414258073237, 9090.63637454501, 9094.363394562382, 11234.49444774987, 11552.018078463341, 11575.189736718434, 11768.588099416522, 11776.116791240649, 11573.0, 11641.243319184226, 11672.416379181092, 11674.649760507198, 11688.29870207786, 11436.771264574661, 11504.194706370557, 11508.884911150864, 11526.077913766878, 11552.364619945984, 39813.60186398157, 40067.398989015186, 40067.59932400697, 40220.0, 40238.19523609511, 3255.0560337502097, 3349.9832500837583, 3354.698077173066, 3386.8137252451106, 3419.81191034493, 29302.560461593093, 30322.54516182237, 30512.389752204832, 31537.52693709596, 31638.683613164034, 3142.5286207068893, 3168.572242747223, 3326.7338612910908, 3376.6116896556964, 3400.5409269748516, 428189.0, 495430.0, 504092.4386134211, 504812.0, 632749.0, 59933.70033149806, 61294.38705612976, 61296.693516532134, 61297.38702612917, 61302.69348653317, 33100.33799324048, 34798.82600586981, 34823.825880870434, 64656.0, 65088.0, 16930.238139283763, 17143.228554715068, 17146.914265428593, 17164.39924602658, 17185.0, 13073.346332683328, 13179.0, 13189.53836615733, 13192.604221873358, 13205.735885282433, 16755.83244167567, 17100.828991710172, 19108.331208407915, 19127.52181195481, 19141.947192904525, 7350.963245183847, 7362.226966168582, 7483.625818709152, 7845.411594130463, 7962.124166341698, 816.6406781016334, 906.0939060939061, 975.3367709957297, 984.1487113646788, 999.6701088640731, 28357.0, 29581.0, 29761.851190743906, 29919.756018298714, 30328.393432131234, 913.4108500017585, 951.9048095190564, 1068.5191663751343, 1072.420892717939, 1119.7760447910287, 14527.78208326876, 15219.771703424458, 15299.923500382427, 15518.0, 15575.221238938007, 632893.0, 652210.0, 678566.0, 688945.0, 691821.0, 48806.0, 49876.75061624669, 54856.451435485935, 55620.443795562336, 55735.0, 1379.7654398752236, 1390.867867552581, 1401.7336706025822, 1418.1207651256286, 1421.3461807568635, 29247.85376073106, 30271.94048208302, 30432.630531625688, 31079.0, 31091.84454077715, 48951.75524122357, 49900.0, 49926.0, 49996.0, 50105.0, 608503.9574802098, 611367.0, 611886.0, 613090.0, 614611.0, 26196.73803261943, 26535.734642653326, 26545.469090618466, 26554.601680974414, 26557.468850623267, 43666.0, 44322.55677443184, 44595.770211489944, 45167.0, 45663.0, 36940.81529592335, 37000.44499332566, 37017.6298237025, 37194.8140259297, 38225.61774382221, 36648.63351366452, 37461.495971694356, 37493.81253093717, 37811.432828507044, 38064.619353806105, 36683.44974825433, 37131.88604341874, 37334.69328573596, 37551.05713900001, 37605.43591846179, 28734.425311494073, 32095.679043209268, 33242.66757332395, 34208.486872697424, 34422.96731098071, 25298.355606885492, 25671.97312107495, 25756.0, 26128.73871261263, 26834.194974150807], "value": 20062.656873794367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.601054902901, 389.72719096632363, 390.4455672944417, 398.17577614338313, 421.3132593871988, 20539.075741591627, 20858.89570552149, 21333.146674133015, 21347.466313342156, 21782.782172178275, 21349.0, 21351.466213344636, 21554.0, 21695.891520542376, 21872.23447179349, 5655.5475561955045, 6058.39416058395, 6059.18201042858, 6069.08963655453, 6075.817725468243, 5765.7981970631035, 5965.075413310944, 5991.580589358747, 6098.08528720691, 6100.511959043288, 5951.494122999528, 5956.731947062371, 5959.6722180280285, 5967.373425790294, 5983.0, 5734.397888221739, 5948.16725658406, 5961.076033214837, 5971.5222782177325, 6040.033594624839, 5297.099493086184, 5302.708351040691, 5305.495977882095, 5310.176922577007, 5315.813946511892, 25356.74643253581, 25794.871025644938, 25885.741142588522, 25896.093636722624, 26077.56573388463, 2707.499112664144, 2728.31792051987, 2785.247983044567, 3121.360121175154, 3142.120206342228, 14276.286185690778, 15111.244437778178, 15517.224138793015, 16025.0, 16040.35838566456, 1569.7566877134063, 1817.1822679794145, 1954.2671498188179, 1955.7750858651295, 1985.7815640279557, 99109.0, 124082.0, 124424.0, 129580.05629915559, 133596.0, 11208.831867521994, 11698.239614425034, 11734.413279335999, 11749.353785541707, 11938.522459101712, 15228.847711522743, 15232.314545845464, 15250.466233681767, 15275.694486110215, 15291.006084604465, 8391.24478796899, 8661.480311181349, 8688.000879898766, 8792.736217913473, 8831.955840220759, 8505.787355316166, 8519.574021299035, 8546.0, 8689.913100869036, 8728.476291422536, 4576.130535198368, 4606.0, 4622.6301895848255, 4707.482176960531, 4752.809887604526, 1708.8034875989172, 1919.4049844548235, 1966.2331690640663, 1967.1541237267827, 2014.6675798493377, 696.4463251714899, 731.9377852882565, 801.7193982106216, 807.9878801817978, 1066.3122286125406, 20196.495087622927, 22416.76707781055, 22437.88781056117, 22491.325260242218, 22720.772792271866, 918.8621706744042, 954.9856752148723, 969.030969030969, 988.6292640259902, 1014.705735336744, 9265.351425400291, 11114.22200445961, 11433.199676022765, 11537.596184133516, 11798.0, 596438.0, 597902.0, 605043.0, 613633.0, 614925.0, 100390.0, 113026.0, 113144.86855131508, 113380.0, 113616.0, 777.8638738220789, 819.7192439482701, 937.0535758883441, 939.4504215034282, 963.4075043847984, 18883.0, 19604.509887252934, 19823.0, 20193.39419817408, 20214.0, 38842.6115738839, 46910.0, 53629.46370536245, 55585.44414555802, 56872.0, 77922.0, 78752.0, 79311.60344198241, 80704.19295806967, 80756.0, 7210.855782884418, 8096.016475963426, 8254.092049874389, 8254.958725206336, 8463.703770368007, 10945.562177512811, 12378.70023647504, 12729.936350318188, 13095.345232738515, 13303.733925321245, 8414.45306055129, 8827.029026807175, 10515.263931525025, 10841.241113122005, 11227.66317010491, 11086.778264434504, 11358.432078395881, 11568.595099171489, 11611.129165312805, 11781.76436471283, 11240.0, 11284.492197851281, 11327.376994265394, 11457.770844582896, 11613.245139066272, 8190.877136843072, 8228.42401031922, 8449.788755281168, 8551.747479071093, 8553.61508732096, 8814.51520166397, 11119.27724697892, 11237.7752444949, 11441.256318339281, 11521.711957201138], "value": 9755.28104726564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.335648957969, 1521.231777952134, 1692.8137904830467, 1840.5398650337415, 1870.1116969439508, 8059.194080591938, 8475.91524084759, 8485.575721213945, 8490.363222758302, 8501.107383724697, 6437.613743175401, 7696.307332340089, 7988.840223195547, 8156.429049966505, 8323.500589964591, 2333.649952507125, 2386.4391867911027, 2387.0, 2389.9044038238535, 2393.533261014094, 2371.27676058802, 2394.4971555973266, 2412.975870241293, 2415.3478560788576, 2419.334682962182, 1997.8512355395633, 2044.1925439451409, 2342.7774361435636, 2378.870036732547, 2381.20229723043, 2312.7340355859124, 2315.4327189838427, 2343.1564636730764, 2343.6836027136374, 2365.207655435431, 2369.7274813396334, 2396.3290278721984, 2401.8799060046927, 2405.0980882169188, 2408.14510848648, 8344.374171937068, 8361.665533378658, 8452.366072544522, 8454.0, 8456.196661317164, 4909.337239472661, 5142.0, 5254.395744489394, 5254.4220135785035, 5255.369355677305, 3311.106001379614, 3393.3213357328386, 3545.8758943436856, 3567.8751243706347, 3573.910652233689, 1033.26121822897, 1046.4506134279488, 1091.6724982505216, 1115.9888401115966, 1121.1647322744607, 9439.292053095976, 10898.945505272502, 11024.283421577571, 11035.006849383513, 11055.391953442557, 4464.933026004613, 4555.886102847456, 4738.691985020962, 4738.8341408050555, 4745.979614382924, 9407.341486096044, 9411.952940235393, 9416.670416535388, 9426.293028022927, 9438.669646562337, 4528.230200865861, 5203.037438073969, 5208.817691380859, 5210.921836172461, 5212.765425555859, 4315.525292217853, 4447.155040542287, 4482.260427029503, 4796.37647105881, 4797.376341075638, 3784.880466938523, 3815.8473661053804, 3936.881893543198, 3943.9802800985813, 3946.3883098119836, 1086.750047489082, 1253.8119282107757, 1268.2580690296095, 1277.1443133100845, 1284.524725851441, 849.562475325208, 867.0029466113893, 911.129870973219, 911.5670056723003, 912.6805618033635, 5372.91940620891, 5429.1856221566295, 5654.434556544313, 5701.315842098892, 5805.245318108703, 882.7395918204145, 911.2118017914456, 921.4563407589554, 930.8510638297976, 964.5563041001078, 3789.1663833956486, 3799.2781371539318, 3810.2760475509563, 3847.3074846527893, 3912.139329347539, 9792.510374481248, 10069.194464442828, 10141.036601522843, 10171.54228059739, 10172.338797978107, 10087.596496140219, 10101.898981010096, 10103.545340459697, 10134.391936483835, 10137.391756494633, 7480.551166929893, 7796.064472263365, 7924.643391047417, 7939.325157361689, 7948.364130869517, 5767.913481297868, 5846.6784326862435, 5859.2090067842, 5956.970215148896, 6037.75848966054, 7732.961335193288, 9034.0, 9194.95402522983, 9224.07759224099, 9274.211692005985, 9292.95353523228, 9451.243900488082, 9525.618975240914, 9550.37922535033, 9566.282528810229, 6623.834404139935, 6842.521023528504, 7163.247858974941, 7291.125064992235, 7291.270872912878, 7341.59621220838, 7669.118051424158, 8011.0, 8077.394195435249, 8077.63650635711, 7120.857582848417, 7238.927610723826, 7262.96368518154, 7295.015172951584, 7381.0, 6892.862142757016, 6979.0, 7128.251533588898, 7136.892946605909, 7188.928110718826, 6398.456131228898, 6648.966755166193, 6746.021826834984, 6749.358810912955, 6775.254721980479, 4211.684123690674, 4790.616750660009, 4800.831970881002, 4872.512748725099, 4922.384701912261, 4760.642951778561, 4779.976100119477, 4836.298736683231, 4954.108260513142, 5054.82308119214], "value": 4438.709346758561, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.88148622037403, 310.10534607656916, 319.19562701990975, 321.09931641744913, 326.9722073623742, 4392.4289842320495, 4656.487786343504, 5274.156135018397, 5356.3572371315395, 5365.409804921465, 4783.7801360653075, 4988.575971042456, 5185.299984502091, 5201.203121721146, 5279.340082489689, 3962.6433620974108, 3990.580988996157, 4015.4177644241568, 4050.6961977851633, 4095.26285268653, 3990.3415936370466, 4002.75983440993, 4003.5996400360023, 4011.378236373352, 4049.7975101244965, 3368.882089126881, 3842.5023734572474, 3960.4851369321946, 4026.4161696553983, 4040.090979529597, 3453.775504592206, 3507.754457187998, 3998.2203470323298, 4020.2562525932794, 4033.757974521538, 3517.3492903812876, 3525.541679581638, 3541.9102729389524, 3543.698785603201, 3545.2023294758733, 5070.619703522214, 5076.822311219126, 5089.796408143707, 5089.821856235051, 5110.693358398471, 3427.1774774054297, 4550.385697930803, 4607.470140933802, 4608.746518941457, 4615.976920115411, 4715.7877895494785, 5647.152927060933, 5656.0, 5660.36793390579, 5698.772049118031, 2944.2050646325374, 3144.921376965571, 3615.421532554805, 3828.2917660232947, 3856.9807150964066, 5082.898342033212, 5314.601404894648, 5549.223108764776, 5817.854553636193, 5897.852553686106, 3553.2538166985223, 3848.4419759134767, 3848.9230215395537, 3853.4412510186426, 3855.4987851579117, 3893.805309734502, 3909.863154789569, 3915.4909861718365, 3920.3923391874305, 3935.5277366716177, 4232.724872883253, 4491.191585514639, 4545.181867263925, 4574.313852922021, 4616.699914505546, 5609.943900561024, 5615.494605485526, 5636.577256705764, 5640.492355688008, 5643.887122257614, 1173.3370645585217, 1194.9223300485614, 1267.877928033697, 1268.3404629592744, 1279.4242590834162, 822.8189798244376, 839.5256679975794, 855.2772906893665, 875.417847131663, 876.9079246679134, 3972.801359931992, 4288.647023271382, 4522.4573051234065, 4619.75266677995, 4938.925916111261, 4872.634552408584, 4902.632302577321, 5235.005348983681, 5471.945280547144, 5485.0949593317455, 4542.682012259176, 4681.0, 4738.928916066262, 4765.9523404766205, 4863.878403039952, 2555.7699807017084, 2828.2182225198403, 2832.362718388346, 2834.803027653585, 2852.7432531072304, 4357.629601483909, 4834.492378300228, 5139.691618502902, 5586.413426590149, 5594.860128496739, 5152.510511501401, 5508.245877061469, 5537.446255374431, 5548.833534993957, 5581.6371935824045, 5124.948750512596, 5163.7676304566385, 5271.15357706834, 5460.153676180198, 5539.307586551681, 5121.7695203715175, 5392.892142157213, 5395.217693434509, 5408.621396502207, 5413.10683737179, 4896.853094407174, 4960.578350840075, 5189.299444574934, 5321.148616221386, 5366.221897824872, 4597.586217240464, 4625.074985002945, 5041.319421878, 5061.645684802029, 5619.690916999604, 3259.0, 3607.2785442911, 3634.9648043883653, 3635.5819080806045, 3653.0, 4369.344598310152, 5164.708822794301, 5396.3524377075, 5410.891782164414, 5446.101393270066, 5214.32213812202, 5222.843314700565, 5234.345706786652, 5241.633085683966, 5247.737613119405, 4234.745915245096, 4748.4776674566465, 5188.22176673502, 5224.8839220115915, 5247.134222853339, 5061.443241243386, 5074.5686616637995, 5074.898502030012, 5086.21163719624, 5127.128388174094, 4417.734935903856, 5288.4303095411215, 5442.863928401822, 5513.779448822002, 5521.944780552143, 4403.0, 4762.714237145644, 5449.073657478318, 5453.890922181614, 5458.563314934716], "value": 3929.629434349051, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.7200891652257, 719.5538765965102, 724.9710011599535, 765.3571000359697, 806.8224990502091, 14348.210848403347, 15294.158821264826, 15314.846851531482, 15358.769618455719, 15376.077435353873, 13743.175409475438, 13921.999999999975, 13940.09389389689, 13950.93024534876, 13995.93002034991, 691.5470366909682, 712.8574285142967, 844.3793811548506, 846.2172490446343, 860.2988564320059, 869.4956924983526, 871.424859592669, 880.3485420788635, 880.4189235104832, 883.7437143228456, 916.4318122763863, 918.164470331998, 918.4948278446827, 920.6593560382668, 921.0, 912.361347057056, 912.5163663258484, 913.328703402995, 913.6984795017662, 919.2232563483846, 678.9984772460631, 679.5413096160122, 681.4718593090345, 683.043738765727, 684.5892464521297, 14205.0, 14945.775813362809, 15021.474248401253, 15091.24543772807, 15124.54626361211, 13436.865631343757, 13670.34213157067, 13733.107348022446, 13920.512782052681, 13943.093698909539, 11419.657410277705, 11436.885631143748, 11585.884141158649, 11866.940665296705, 12260.325682087481, 3712.9071773205887, 3714.981425092857, 3801.6388443097862, 3811.5807261201244, 3941.152652179795, 98375.0, 99572.0, 99656.0, 103561.4821925893, 104173.0, 10643.94678026605, 10873.565057397775, 10914.290571113012, 10960.616378426717, 11011.28426652265, 22169.778302217095, 22189.667154992687, 22226.555273907143, 22514.437139071655, 22638.66042009371, 7489.251074892576, 7543.396528277724, 7622.199669034782, 7789.610519474117, 7941.563214023168, 4308.18144552534, 4319.157764236007, 4340.283853164193, 4384.364267181241, 4539.977300113478, 3285.7864238824877, 3357.5467311913067, 3360.764746467724, 3401.795892246473, 3411.2154204533094, 623.4513628007325, 623.5230049012509, 625.6840295650667, 626.0734113511937, 631.3812463785516, 554.5951455437553, 558.3523113188681, 575.7581815637442, 613.1752792494088, 620.2804746494136, 7221.133463984355, 8488.074215932524, 9156.284513475566, 10007.693614300113, 10038.096571308617, 620.7936010505778, 654.7021105397033, 677.7085853083222, 703.4231929817603, 725.6117976882342, 3679.8712045078296, 3902.0, 3949.229900169497, 4068.8575899843363, 4576.702514336557, 85951.57024214839, 102075.48962255141, 105438.47280763701, 108919.0, 109491.0, 72131.27868721246, 75751.24248757442, 93440.0655993445, 95349.52325238468, 96666.03333966571, 59367.10949335763, 78467.0, 80776.78834817365, 84946.0, 85323.57338213394, 7284.562926224444, 8387.496750195009, 8684.305255579664, 8761.561921903753, 8887.066857979818, 42731.35902961396, 54494.45505544894, 55895.72052139713, 56463.71768141133, 56614.7169264151, 65553.68892622217, 69910.95133572898, 71476.27855821668, 72946.0, 77714.0, 11359.48882300282, 11619.825702614637, 11741.823872641746, 11951.462184201559, 12094.758104837678, 13678.247696376397, 13736.450541978209, 14493.420263189355, 15057.322420491324, 15061.548153555412, 13150.736985260433, 13382.397792099573, 13574.59276221715, 13636.045476816527, 14066.0, 12817.359132043546, 13642.0, 13656.522021729192, 13807.0, 13929.58211253664, 11240.88759112431, 11750.412479376168, 11902.583409580624, 12264.386780660752, 12265.938670306592, 10545.789084218426, 10846.240763146505, 11055.281406708538, 11178.888211117785, 11460.94269528647, 9677.758056048655, 10789.62236321725, 11215.55137794479, 11374.431278435879, 11427.771444571228], "value": 7331.598628506354, "unit": "score"}], "name": "dromaeo_css", "value": 7253.690283127534, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 111.0, 175.0, 113.0, 108.0, 105.0, 109.0, 135.0, 108.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 183.0, 183.0, 181.0, 179.0, 183.0, 183.0, 204.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 58.0, 88.0, 66.0, 58.0, 58.0, 72.0, 106.0, 72.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 69.0, 94.0, 69.0, 68.0, 69.0, 88.0, 68.0, 69.0, 91.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 83.0, 87.0, 83.0, 86.0, 83.0, 87.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 148.0, 147.0, 93.0, 92.0, 92.0, 93.0, 93.0, 92.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 81.0, 82.0, 82.0, 83.0, 85.0, 81.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 55.0, 56.0, 55.0, 56.0, 54.0, 55.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 73.0, 75.0, 72.0, 67.0, 69.0, 69.0, 69.0, 70.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 83.0, 94.0, 97.0, 94.0, 95.0, 80.0, 87.0, 87.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 124.0, 136.0, 143.0, 149.0, 140.0, 136.0, 140.0, 195.0, 155.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 159.0, 160.0, 160.0, 162.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1421.8, "alertThreshold": 2.0}]} 16:24:23 INFO - Return code: 0 16:24:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:24:23 INFO - # TBPL SUCCESS # 16:24:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:24:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:24:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:24:23 INFO - 2017-03-01 16:24:23.789 screenresolution[10051:57739] starting screenresolution argv=screenresolution get 16:24:23 INFO - 2017-03-01 16:24:23.792 screenresolution[10051:57739] Display 0: 1600x1200x32@60 16:24:23 INFO - 2017-03-01 16:24:23.798 screenresolution[10052:57742] starting screenresolution argv=screenresolution list 16:24:23 INFO - Available Modes on Display 0 16:24:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:24:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:24:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:24:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:24:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:24:24 INFO - Intel Iris: 16:24:24 INFO - Chipset Model: Intel Iris 16:24:24 INFO - Type: GPU 16:24:24 INFO - Bus: Built-In 16:24:24 INFO - VRAM (Dynamic, Max): 1536 MB 16:24:24 INFO - Vendor: Intel (0x8086) 16:24:24 INFO - Device ID: 0x0a2e 16:24:24 INFO - Revision ID: 0x0009 16:24:24 INFO - Displays: 16:24:24 INFO - Display: 16:24:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:24:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:24:24 INFO - Display Serial Number: 1600x1200 60 16:24:24 INFO - Main Display: Yes 16:24:24 INFO - Mirror: Off 16:24:24 INFO - Online: Yes 16:24:24 INFO - Rotation: Supported 16:24:24 INFO - Return code: 0 16:24:24 INFO - Running post-action listener: _resource_record_post_action 16:24:24 INFO - [mozharness: 2017-03-02 00:24:24.041661Z] Finished run-tests step (success) 16:24:24 INFO - Running post-run listener: _resource_record_post_run 16:24:24 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 212992; Write bytes: 500854272; Read time: 5; Write time: 1587 16:24:24 INFO - TinderboxPrint: CPU usage
53.5% 16:24:24 INFO - TinderboxPrint: I/O read bytes / time
212,992 / 5 16:24:24 INFO - TinderboxPrint: I/O write bytes / time
500,854,272 / 1,587 16:24:24 INFO - TinderboxPrint: CPU idle
2,232.8 (46.5%) 16:24:24 INFO - TinderboxPrint: CPU system
955.8 (19.9%) 16:24:24 INFO - TinderboxPrint: CPU user
1,609.0 (33.5%) 16:24:24 INFO - TinderboxPrint: Swap in / out
191,500,288 / 0 16:24:24 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 177007104; Write bytes: 174850048; Read time: 16614; Write time: 368 16:24:24 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 212992; Write bytes: 308268544; Read time: 5; Write time: 1167 16:24:24 INFO - Running post-run listener: _upload_blobber_files 16:24:24 INFO - Blob upload gear active. 16:24:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:24:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:24:24 INFO - (blobuploader) - INFO - Open directory for files ... 16:24:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:24:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:25 INFO - (blobuploader) - INFO - Done attempting. 16:24:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:24:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:24:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:26 INFO - (blobuploader) - INFO - Done attempting. 16:24:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:24:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:24:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:28 INFO - (blobuploader) - INFO - Done attempting. 16:24:28 INFO - (blobuploader) - INFO - Iteration through files over. 16:24:28 INFO - Return code: 0 16:24:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:24:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:24:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f9048f158a12cec77a2d4f2877b1ceb03d95f0e1b5d3764e0fa52fe1e6f2f7ad8b994e94331a81be595eb1c87039683438873f58de5132ada1d640fe8bf3237", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b830758cc348d011edb0cb6d24c5e7f506576841864333dea5062a7fb97ba7c858c31ab74a9cf24d5e58159320c8f4d33548957f6668ad3d98cf9cd89370f285", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/253500f7b69ecf37cb15663d8148fb27f3f4f6da2eea76f434032b9015dbfdfc9aba9c40b4111b540292f6ce20d4132d34c6f875dc591289695481d7ce0d7ba2"} 16:24:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:24:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:24:28 INFO - Contents: 16:24:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f9048f158a12cec77a2d4f2877b1ceb03d95f0e1b5d3764e0fa52fe1e6f2f7ad8b994e94331a81be595eb1c87039683438873f58de5132ada1d640fe8bf3237", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b830758cc348d011edb0cb6d24c5e7f506576841864333dea5062a7fb97ba7c858c31ab74a9cf24d5e58159320c8f4d33548957f6668ad3d98cf9cd89370f285", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/253500f7b69ecf37cb15663d8148fb27f3f4f6da2eea76f434032b9015dbfdfc9aba9c40b4111b540292f6ce20d4132d34c6f875dc591289695481d7ce0d7ba2"} 16:24:28 INFO - Running post-run listener: copy_logs_to_upload_dir 16:24:28 INFO - Copying logs to upload dir... 16:24:28 INFO - mkdir: /builds/slave/test/build/upload/logs 16:24:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.002839 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-01 16:24:28.748113) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 16:24:28.752082) ========= 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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f9048f158a12cec77a2d4f2877b1ceb03d95f0e1b5d3764e0fa52fe1e6f2f7ad8b994e94331a81be595eb1c87039683438873f58de5132ada1d640fe8bf3237", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b830758cc348d011edb0cb6d24c5e7f506576841864333dea5062a7fb97ba7c858c31ab74a9cf24d5e58159320c8f4d33548957f6668ad3d98cf9cd89370f285", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/253500f7b69ecf37cb15663d8148fb27f3f4f6da2eea76f434032b9015dbfdfc9aba9c40b4111b540292f6ce20d4132d34c6f875dc591289695481d7ce0d7ba2"} build_url:https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010790 build_url: 'https://queue.taskcluster.net/v1/task/XxZCcC0TQUaEtrwd4RAsfQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f9048f158a12cec77a2d4f2877b1ceb03d95f0e1b5d3764e0fa52fe1e6f2f7ad8b994e94331a81be595eb1c87039683438873f58de5132ada1d640fe8bf3237", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b830758cc348d011edb0cb6d24c5e7f506576841864333dea5062a7fb97ba7c858c31ab74a9cf24d5e58159320c8f4d33548957f6668ad3d98cf9cd89370f285", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/253500f7b69ecf37cb15663d8148fb27f3f4f6da2eea76f434032b9015dbfdfc9aba9c40b4111b540292f6ce20d4132d34c6f875dc591289695481d7ce0d7ba2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 16:24:28.786145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 16:24:28.786483) ========= 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.FxeEUUhwar/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.CiV6Ndb3Iw/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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.005302 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 16:24:28.835565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 16:24:28.835930) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 16:24:28.836282) ========= ========= Total master_lag: 0.19 =========