builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0283 starttime: 1488507087.98 results: success (0) buildid: 20170302165138 builduid: a0246c0a7e454465a5c09329466465d7 revision: d5b97a00c7e41b500878d293c16140304e871482 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:27.978880) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:27.979317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:27.979587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:28.006215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:28.006584) ========= 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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-02 18:11:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2017-03-02 18:11:28 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:28.229386) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:28.229695) ========= 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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026719 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:28.278148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-02 18:11:28.278526) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d5b97a00c7e41b500878d293c16140304e871482 --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-aurora --rev d5b97a00c7e41b500878d293c16140304e871482 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-02 18:11:28,385 truncating revision to first 12 chars 2017-03-02 18:11:28,385 Setting DEBUG logging. 2017-03-02 18:11:28,385 attempt 1/10 2017-03-02 18:11:28,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d5b97a00c7e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 18:11:29,725 unpacking tar archive at: mozilla-aurora-d5b97a00c7e4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.613534 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-02 18:11:29.915642) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:29.915971) ========= script_repo_revision: d5b97a00c7e41b500878d293c16140304e871482 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:29.916390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:29.916650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:29.936654) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-02 18:11:29.937128) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:11:30 INFO - MultiFileLogger online at 20170302 18:11:30 in /builds/slave/test 18:11:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:11:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:11:30 INFO - {'append_to_log': False, 18:11:30 INFO - 'base_work_dir': '/builds/slave/test', 18:11:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:11:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:11:30 INFO - 'branch': 'Mozilla-Aurora', 18:11:30 INFO - 'buildbot_json_path': 'buildprops.json', 18:11:30 INFO - 'config_files': ('talos/mac_config.py',), 18:11:30 INFO - 'default_actions': ('clobber', 18:11:30 INFO - 'read-buildbot-config', 18:11:30 INFO - 'download-and-extract', 18:11:30 INFO - 'populate-webroot', 18:11:30 INFO - 'create-virtualenv', 18:11:30 INFO - 'install', 18:11:30 INFO - 'run-tests'), 18:11:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:11:30 INFO - 'download_minidump_stackwalk': True, 18:11:30 INFO - 'download_symbols': 'ondemand', 18:11:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:11:30 INFO - 'tooltool.py': '/tools/tooltool.py', 18:11:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:11:30 INFO - '/tools/misc-python/virtualenv.py')}, 18:11:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:11:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:11:30 INFO - 'installer_path': 'installer.exe', 18:11:30 INFO - 'log_level': 'info', 18:11:30 INFO - 'log_name': 'talos', 18:11:30 INFO - 'log_to_console': True, 18:11:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:11:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:11:30 INFO - 'opt_config_files': (), 18:11:30 INFO - 'pip_index': False, 18:11:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:30 INFO - 'cmd': ('bash', 18:11:30 INFO - '-c', 18:11:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:30 INFO - 'enabled': True, 18:11:30 INFO - 'halt_on_failure': False, 18:11:30 INFO - 'name': 'check_screen_resolution'},), 18:11:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:30 INFO - 'cmd': ('bash', 18:11:30 INFO - '-c', 18:11:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:30 INFO - 'enabled': True, 18:11:30 INFO - 'halt_on_failure': False, 18:11:30 INFO - 'name': 'check_screen_resolution'},), 18:11:30 INFO - 'run_cmd_checks_enabled': True, 18:11:30 INFO - 'sps_profile': False, 18:11:30 INFO - 'sps_profile_interval': 0, 18:11:30 INFO - 'suite': 'dromaeojs', 18:11:30 INFO - 'system_bits': '32', 18:11:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:11:30 INFO - 'title': 't-yosemite-r7-0283', 18:11:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:11:30 INFO - 'use_talos_json': True, 18:11:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:11:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:11:30 INFO - 'work_dir': 'build'} 18:11:30 INFO - [mozharness: 2017-03-03 02:11:30.150111Z] Running clobber step. 18:11:30 INFO - Running pre-action listener: _resource_record_pre_action 18:11:30 INFO - Running main action method: clobber 18:11:30 INFO - rmtree: /builds/slave/test/build 18:11:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:11:32 INFO - Running post-action listener: _resource_record_post_action 18:11:32 INFO - [mozharness: 2017-03-03 02:11:32.734776Z] Finished clobber step (success) 18:11:32 INFO - [mozharness: 2017-03-03 02:11:32.735038Z] Running read-buildbot-config step. 18:11:32 INFO - Running pre-action listener: _resource_record_pre_action 18:11:32 INFO - Running main action method: read_buildbot_config 18:11:32 INFO - Using buildbot properties: 18:11:32 INFO - { 18:11:32 INFO - "project": "", 18:11:32 INFO - "product": "firefox", 18:11:32 INFO - "script_repo_revision": "production", 18:11:32 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 18:11:32 INFO - "repository": "", 18:11:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 18:11:32 INFO - "buildid": "20170302165138", 18:11:32 INFO - "pgo_build": "False", 18:11:32 INFO - "basedir": "/builds/slave/test", 18:11:32 INFO - "buildnumber": 60, 18:11:32 INFO - "slavename": "t-yosemite-r7-0283", 18:11:32 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 18:11:32 INFO - "platform": "yosemite_r7", 18:11:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:11:32 INFO - "branch": "mozilla-aurora", 18:11:32 INFO - "repo_path": "releases/mozilla-aurora", 18:11:32 INFO - "revision": "d5b97a00c7e41b500878d293c16140304e871482", 18:11:32 INFO - "stage_platform": "macosx64", 18:11:32 INFO - "builduid": "a0246c0a7e454465a5c09329466465d7", 18:11:32 INFO - "slavebuilddir": "test" 18:11:32 INFO - } 18:11:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 18:11:32 INFO - Running post-action listener: _resource_record_post_action 18:11:32 INFO - [mozharness: 2017-03-03 02:11:32.740633Z] Finished read-buildbot-config step (success) 18:11:32 INFO - [mozharness: 2017-03-03 02:11:32.740836Z] Running download-and-extract step. 18:11:32 INFO - Running pre-action listener: _resource_record_pre_action 18:11:32 INFO - Running main action method: download_and_extract 18:11:32 INFO - mkdir: /builds/slave/test/build/tests 18:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:32 INFO - trying https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 18:11:32 INFO - Downloading https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 18:11:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 18:11:34 INFO - Downloaded 1199 bytes. 18:11:34 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 18:11:34 INFO - Using the following test package requirements: 18:11:34 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 18:11:34 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 18:11:34 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 18:11:34 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:34 INFO - u'jsshell-mac.zip'], 18:11:34 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 18:11:34 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 18:11:34 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 18:11:34 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 18:11:34 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 18:11:34 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 18:11:34 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:11:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 18:11:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:11:34 INFO - Fetch https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 18:11:34 INFO - Expected file size: 16357808 18:11:34 INFO - Obtained file size: 16357808 18:11:41 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:11:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 18:11:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:11:41 INFO - Fetch https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 18:11:42 INFO - Expected file size: 16357808 18:11:42 INFO - Obtained file size: 16357808 18:11:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 18:11:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:11:48 INFO - Fetch https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 18:11:49 INFO - Expected file size: 14403650 18:11:49 INFO - Obtained file size: 14403650 18:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:50 INFO - trying https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 18:11:50 INFO - Downloading https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 18:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 18:11:52 INFO - Downloaded 73908521 bytes. 18:11:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 18:11:52 INFO - mkdir: /builds/slave/test/properties 18:11:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:11:52 INFO - Writing to file /builds/slave/test/properties/build_url 18:11:52 INFO - Contents: 18:11:52 INFO - build_url:https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 18:11:53 INFO - Running post-action listener: _resource_record_post_action 18:11:53 INFO - Running post-action listener: set_extra_try_arguments 18:11:53 INFO - [mozharness: 2017-03-03 02:11:53.039069Z] Finished download-and-extract step (success) 18:11:53 INFO - [mozharness: 2017-03-03 02:11:53.039210Z] Running populate-webroot step. 18:11:53 INFO - Running pre-action listener: _resource_record_pre_action 18:11:53 INFO - Running main action method: populate_webroot 18:11:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:11:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:11:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:11:53 INFO - '--tppagecycles', 18:11:53 INFO - '7'], 18:11:53 INFO - 'tests': ['tsvgm']}}, 18:11:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:11:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:11:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:11:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:11:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:11:53 INFO - 'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:11:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:11:53 INFO - 'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['damp', 'tps']}, 18:11:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:11:53 INFO - 'tests': ['damp', 'tps']}, 18:11:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['dromaeo_dom']}, 18:11:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:11:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['basic_compositor_video']}, 18:11:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:11:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['a11yr', 18:11:53 INFO - 'ts_paint', 18:11:53 INFO - 'tpaint', 18:11:53 INFO - 'sessionrestore', 18:11:53 INFO - 'sessionrestore_no_auto_restore', 18:11:53 INFO - 'tabpaint']}, 18:11:53 INFO - 'other-e10s': {'tests': ['a11yr', 18:11:53 INFO - 'ts_paint', 18:11:53 INFO - 'tpaint', 18:11:53 INFO - 'sessionrestore', 18:11:53 INFO - 'sessionrestore_no_auto_restore', 18:11:53 INFO - 'tabpaint']}, 18:11:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:11:53 INFO - 'ts_paint', 18:11:53 INFO - 'tpaint', 18:11:53 INFO - 'sessionrestore', 18:11:53 INFO - 'sessionrestore_no_auto_restore', 18:11:53 INFO - 'tabpaint']}, 18:11:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:11:53 INFO - 'ts_paint', 18:11:53 INFO - 'tpaint', 18:11:53 INFO - 'sessionrestore', 18:11:53 INFO - 'sessionrestore_no_auto_restore', 18:11:53 INFO - 'tabpaint']}, 18:11:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['a11yr', 18:11:53 INFO - 'ts_paint', 18:11:53 INFO - 'tpaint', 18:11:53 INFO - 'sessionrestore', 18:11:53 INFO - 'sessionrestore_no_auto_restore', 18:11:53 INFO - 'tabpaint']}, 18:11:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['a11yr', 18:11:53 INFO - 'ts_paint', 18:11:53 INFO - 'tpaint', 18:11:53 INFO - 'sessionrestore', 18:11:53 INFO - 'sessionrestore_no_auto_restore', 18:11:53 INFO - 'tabpaint']}, 18:11:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['tsvgx', 18:11:53 INFO - 'tsvgr_opacity', 18:11:53 INFO - 'tart', 18:11:53 INFO - 'tscrollx', 18:11:53 INFO - 'cart', 18:11:53 INFO - 'tsvg_static']}, 18:11:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:11:53 INFO - 'tsvgr_opacity', 18:11:53 INFO - 'tart', 18:11:53 INFO - 'tscrollx', 18:11:53 INFO - 'cart', 18:11:53 INFO - 'tsvg_static']}, 18:11:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:11:53 INFO - 'talos_options': ['--disable-e10s'], 18:11:53 INFO - 'tests': ['tp5o']}, 18:11:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:11:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:11:53 INFO - 'talos_options': ['--disable-e10s', 18:11:53 INFO - '--xperf_path', 18:11:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:53 INFO - 'tests': ['tp5n']}, 18:11:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:11:53 INFO - 'talos_options': ['--xperf_path', 18:11:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:53 INFO - 'tests': ['tp5n']}}, 18:11:53 INFO - 'talos.zip': {'path': '', 18:11:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:11:53 INFO - Running post-action listener: _resource_record_post_action 18:11:53 INFO - [mozharness: 2017-03-03 02:11:53.057635Z] Finished populate-webroot step (success) 18:11:53 INFO - [mozharness: 2017-03-03 02:11:53.057777Z] Running create-virtualenv step. 18:11:53 INFO - Running pre-action listener: _resource_record_pre_action 18:11:53 INFO - Running main action method: create_virtualenv 18:11:53 INFO - Creating virtualenv /builds/slave/test/build/venv 18:11:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:11:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:11:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:11:53 INFO - Using real prefix '/tools/python27' 18:11:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:11:53 INFO - Installing distribute.............................................................................................................................................................................................done. 18:11:56 INFO - Installing pip.................done. 18:11:56 INFO - Return code: 0 18:11:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:11:57 INFO - Reading from file tmpfile_stdout 18:11:57 INFO - Output received: 18:11:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:11:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:11:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:11:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:57 INFO - 'HOME': '/Users/cltbld', 18:11:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:57 INFO - 'LOGNAME': 'cltbld', 18:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:57 INFO - 'MOZ_NO_REMOTE': '1', 18:11:57 INFO - 'NO_EM_RESTART': '1', 18:11:57 INFO - 'PAGER': '/bin/cat', 18:11:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:57 INFO - 'PWD': '/builds/slave/test', 18:11:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:57 INFO - 'SHELL': '/bin/bash', 18:11:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:11:57 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:11:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:57 INFO - 'USER': 'cltbld', 18:11:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:57 INFO - 'XPC_FLAGS': '0x0', 18:11:57 INFO - 'XPC_SERVICE_NAME': '0', 18:11:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:11:57 INFO - Cleaning up... 18:11:57 INFO - Return code: 0 18:11:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:11:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:11:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:57 INFO - 'HOME': '/Users/cltbld', 18:11:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:57 INFO - 'LOGNAME': 'cltbld', 18:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:57 INFO - 'MOZ_NO_REMOTE': '1', 18:11:57 INFO - 'NO_EM_RESTART': '1', 18:11:57 INFO - 'PAGER': '/bin/cat', 18:11:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:57 INFO - 'PWD': '/builds/slave/test', 18:11:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:57 INFO - 'SHELL': '/bin/bash', 18:11:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:11:57 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:11:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:57 INFO - 'USER': 'cltbld', 18:11:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:57 INFO - 'XPC_FLAGS': '0x0', 18:11:57 INFO - 'XPC_SERVICE_NAME': '0', 18:11:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:57 INFO - Downloading/unpacking psutil>=3.1.1 18:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:12:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:01 INFO - Installing collected packages: psutil 18:12:01 INFO - Running setup.py install for psutil 18:12:01 INFO - building 'psutil._psutil_osx' extension 18:12:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:12:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:12:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:12:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:12:01 INFO - building 'psutil._psutil_posix' extension 18:12:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:12:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:12:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:12:02 INFO - ^ 18:12:02 INFO - 1 warning generated. 18:12:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:12:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:02 INFO - Successfully installed psutil 18:12:02 INFO - Cleaning up... 18:12:02 INFO - Return code: 0 18:12:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:12:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:12:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:02 INFO - 'HOME': '/Users/cltbld', 18:12:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:02 INFO - 'LOGNAME': 'cltbld', 18:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:02 INFO - 'MOZ_NO_REMOTE': '1', 18:12:02 INFO - 'NO_EM_RESTART': '1', 18:12:02 INFO - 'PAGER': '/bin/cat', 18:12:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:02 INFO - 'PWD': '/builds/slave/test', 18:12:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:02 INFO - 'SHELL': '/bin/bash', 18:12:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:12:02 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:12:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:02 INFO - 'USER': 'cltbld', 18:12:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:02 INFO - 'XPC_FLAGS': '0x0', 18:12:02 INFO - 'XPC_SERVICE_NAME': '0', 18:12:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:12:05 INFO - Installing collected packages: mozsystemmonitor 18:12:05 INFO - Running setup.py install for mozsystemmonitor 18:12:05 INFO - Successfully installed mozsystemmonitor 18:12:05 INFO - Cleaning up... 18:12:05 INFO - Return code: 0 18:12:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:05 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 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:12:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:12:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:05 INFO - 'HOME': '/Users/cltbld', 18:12:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:05 INFO - 'LOGNAME': 'cltbld', 18:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:05 INFO - 'MOZ_NO_REMOTE': '1', 18:12:05 INFO - 'NO_EM_RESTART': '1', 18:12:05 INFO - 'PAGER': '/bin/cat', 18:12:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:05 INFO - 'PWD': '/builds/slave/test', 18:12:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:05 INFO - 'SHELL': '/bin/bash', 18:12:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:12:05 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:12:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:05 INFO - 'USER': 'cltbld', 18:12:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:05 INFO - 'XPC_FLAGS': '0x0', 18:12:05 INFO - 'XPC_SERVICE_NAME': '0', 18:12:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:05 INFO - Downloading/unpacking jsonschema==2.5.1 18:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:12:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12:08 INFO - Downloading functools32-3.2.3-2.tar.gz 18:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:12:08 INFO - warning: no files found matching '*.txt' 18:12:08 INFO - no previously-included directories found matching 'build' 18:12:08 INFO - no previously-included directories found matching 'dist' 18:12:08 INFO - no previously-included directories found matching '.git*' 18:12:08 INFO - Installing collected packages: jsonschema, functools32 18:12:08 INFO - Running setup.py install for functools32 18:12:09 INFO - warning: no files found matching '*.txt' 18:12:09 INFO - no previously-included directories found matching 'build' 18:12:09 INFO - no previously-included directories found matching 'dist' 18:12:09 INFO - no previously-included directories found matching '.git*' 18:12:09 INFO - Successfully installed jsonschema functools32 18:12:09 INFO - Cleaning up... 18:12:09 INFO - Return code: 0 18:12:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:09 INFO - 'HOME': '/Users/cltbld', 18:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:09 INFO - 'LOGNAME': 'cltbld', 18:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:09 INFO - 'MOZ_NO_REMOTE': '1', 18:12:09 INFO - 'NO_EM_RESTART': '1', 18:12:09 INFO - 'PAGER': '/bin/cat', 18:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:09 INFO - 'PWD': '/builds/slave/test', 18:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:09 INFO - 'SHELL': '/bin/bash', 18:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:12:09 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:09 INFO - 'USER': 'cltbld', 18:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:09 INFO - 'XPC_FLAGS': '0x0', 18:12:09 INFO - 'XPC_SERVICE_NAME': '0', 18:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:12:09 INFO - Cleaning up... 18:12:09 INFO - Return code: 0 18:12:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:09 INFO - 'HOME': '/Users/cltbld', 18:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:09 INFO - 'LOGNAME': 'cltbld', 18:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:09 INFO - 'MOZ_NO_REMOTE': '1', 18:12:09 INFO - 'NO_EM_RESTART': '1', 18:12:09 INFO - 'PAGER': '/bin/cat', 18:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:09 INFO - 'PWD': '/builds/slave/test', 18:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:09 INFO - 'SHELL': '/bin/bash', 18:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:12:09 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:09 INFO - 'USER': 'cltbld', 18:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:09 INFO - 'XPC_FLAGS': '0x0', 18:12:09 INFO - 'XPC_SERVICE_NAME': '0', 18:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:09 INFO - Downloading/unpacking blobuploader==1.2.4 18:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:12 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:13 INFO - Downloading docopt-0.6.1.tar.gz 18:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:13 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:13 INFO - Running setup.py install for blobuploader 18:12:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:13 INFO - Running setup.py install for requests 18:12:14 INFO - Running setup.py install for docopt 18:12:14 INFO - Successfully installed blobuploader requests docopt 18:12:14 INFO - Cleaning up... 18:12:14 INFO - Return code: 0 18:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:14 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 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:14 INFO - 'HOME': '/Users/cltbld', 18:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:14 INFO - 'LOGNAME': 'cltbld', 18:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:14 INFO - 'MOZ_NO_REMOTE': '1', 18:12:14 INFO - 'NO_EM_RESTART': '1', 18:12:14 INFO - 'PAGER': '/bin/cat', 18:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:14 INFO - 'PWD': '/builds/slave/test', 18:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:14 INFO - 'SHELL': '/bin/bash', 18:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:12:14 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:14 INFO - 'USER': 'cltbld', 18:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:14 INFO - 'XPC_FLAGS': '0x0', 18:12:14 INFO - 'XPC_SERVICE_NAME': '0', 18:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:14 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-z49alw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:14 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-6B4zEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:14 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-txeGMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-gN1QCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-pttEQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-5B0wXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-ENUfYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-M90Fcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-qXAn4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-SwlJzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-NGjOQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-C3Z3pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-xRcOQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-7g0902-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-nPDVgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-EiVUA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-88Wpk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:16 INFO - Running setup.py install for manifestparser 18:12:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Running setup.py install for mozcrash 18:12:16 INFO - Running setup.py install for mozdebug 18:12:16 INFO - Running setup.py install for mozdevice 18:12:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Running setup.py install for mozfile 18:12:17 INFO - Running setup.py install for mozhttpd 18:12:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Running setup.py install for mozinfo 18:12:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Running setup.py install for mozInstall 18:12:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Running setup.py install for mozleak 18:12:17 INFO - Running setup.py install for mozlog 18:12:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Running setup.py install for moznetwork 18:12:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Running setup.py install for mozprocess 18:12:18 INFO - Running setup.py install for mozprofile 18:12:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Running setup.py install for mozrunner 18:12:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Running setup.py install for mozscreenshot 18:12:18 INFO - Running setup.py install for moztest 18:12:18 INFO - Running setup.py install for mozversion 18:12:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:19 INFO - Cleaning up... 18:12:19 INFO - Return code: 0 18:12:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:19 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 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:12:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:19 INFO - 'HOME': '/Users/cltbld', 18:12:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:19 INFO - 'LOGNAME': 'cltbld', 18:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:19 INFO - 'MOZ_NO_REMOTE': '1', 18:12:19 INFO - 'NO_EM_RESTART': '1', 18:12:19 INFO - 'PAGER': '/bin/cat', 18:12:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:19 INFO - 'PWD': '/builds/slave/test', 18:12:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:19 INFO - 'SHELL': '/bin/bash', 18:12:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:12:19 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:12:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:19 INFO - 'USER': 'cltbld', 18:12:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:19 INFO - 'XPC_FLAGS': '0x0', 18:12:19 INFO - 'XPC_SERVICE_NAME': '0', 18:12:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:19 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-0KAFTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:19 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-E928Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:19 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-yY4aaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:19 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-phIPMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:19 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-U0U7d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:19 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-VPUkzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12: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)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-4Vaa3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-MXSd7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-HwFRCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-lQjimB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-UeGDd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-fHZu7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-WZvoJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-cywUGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-dkNo0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12: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)) 18:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:20 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-CVCbcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:21 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-IUbDDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:23 INFO - Downloading blessings-1.6.tar.gz 18:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:23 INFO - Installing collected packages: blessings 18:12:23 INFO - Running setup.py install for blessings 18:12:24 INFO - Successfully installed blessings 18:12:24 INFO - Cleaning up... 18:12:24 INFO - Return code: 0 18:12:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:24 INFO - Reading from file tmpfile_stdout 18:12:24 INFO - Current package versions: 18:12:24 INFO - blessings == 1.6 18:12:24 INFO - blobuploader == 1.2.4 18:12:24 INFO - docopt == 0.6.1 18:12:24 INFO - functools32 == 3.2.3-2 18:12:24 INFO - jsonschema == 2.5.1 18:12:24 INFO - manifestparser == 1.1 18:12:24 INFO - mozInstall == 1.12 18:12:24 INFO - mozcrash == 1.0 18:12:24 INFO - mozdebug == 0.1 18:12:24 INFO - mozdevice == 0.49 18:12:24 INFO - mozfile == 1.2 18:12:24 INFO - mozhttpd == 0.7 18:12:24 INFO - mozinfo == 0.9 18:12:24 INFO - mozleak == 0.1 18:12:24 INFO - mozlog == 3.4 18:12:24 INFO - moznetwork == 0.27 18:12:24 INFO - mozprocess == 0.24 18:12:24 INFO - mozprofile == 0.28 18:12:24 INFO - mozrunner == 6.13 18:12:24 INFO - mozscreenshot == 0.1 18:12:24 INFO - mozsystemmonitor == 0.3 18:12:24 INFO - moztest == 0.8 18:12:24 INFO - mozversion == 1.4 18:12:24 INFO - psutil == 3.1.1 18:12:24 INFO - requests == 1.2.3 18:12:24 INFO - wsgiref == 0.1.2 18:12:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:25 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 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:12:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:25 INFO - 'HOME': '/Users/cltbld', 18:12:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:25 INFO - 'LOGNAME': 'cltbld', 18:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:25 INFO - 'MOZ_NO_REMOTE': '1', 18:12:25 INFO - 'NO_EM_RESTART': '1', 18:12:25 INFO - 'PAGER': '/bin/cat', 18:12:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:25 INFO - 'PWD': '/builds/slave/test', 18:12:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:25 INFO - 'SHELL': '/bin/bash', 18:12:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:12:25 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:12:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:25 INFO - 'USER': 'cltbld', 18:12:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:25 INFO - 'XPC_FLAGS': '0x0', 18:12:25 INFO - 'XPC_SERVICE_NAME': '0', 18:12:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:12:25 INFO - Cleaning up... 18:12:25 INFO - Return code: 0 18:12:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:26 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 0x10533ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10533d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac2a57c170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, '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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:12:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:12:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:26 INFO - 'HOME': '/Users/cltbld', 18:12:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:26 INFO - 'LOGNAME': 'cltbld', 18:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:26 INFO - 'MOZ_NO_REMOTE': '1', 18:12:26 INFO - 'NO_EM_RESTART': '1', 18:12:26 INFO - 'PAGER': '/bin/cat', 18:12:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:26 INFO - 'PWD': '/builds/slave/test', 18:12:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:26 INFO - 'SHELL': '/bin/bash', 18:12:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:12:26 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:12:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:26 INFO - 'USER': 'cltbld', 18:12:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:26 INFO - 'XPC_FLAGS': '0x0', 18:12:26 INFO - 'XPC_SERVICE_NAME': '0', 18:12:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:12:26 INFO - Cleaning up... 18:12:26 INFO - Return code: 0 18:12:26 INFO - Running post-action listener: _resource_record_post_action 18:12:26 INFO - Running post-action listener: _start_resource_monitoring 18:12:26 INFO - Starting resource monitoring. 18:12:26 INFO - [mozharness: 2017-03-03 02:12:26.462538Z] Finished create-virtualenv step (success) 18:12:26 INFO - [mozharness: 2017-03-03 02:12:26.463459Z] Running install step. 18:12:26 INFO - Running pre-action listener: _resource_record_pre_action 18:12:26 INFO - Running main action method: install 18:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:26 INFO - Reading from file tmpfile_stdout 18:12:26 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:26 INFO - Reading from file tmpfile_stdout 18:12:26 INFO - Output received: 18:12:26 INFO - Usage: mozinstall [options] installer 18:12:26 INFO - Options: 18:12:26 INFO - -h, --help show this help message and exit 18:12:26 INFO - -d DEST, --destination=DEST 18:12:26 INFO - Directory to install application into. [default: 18:12:26 INFO - "/builds/slave/test"] 18:12:26 INFO - --app=APP Application being installed. [default: firefox] 18:12:26 INFO - mkdir: /builds/slave/test/build/application 18:12:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:12:46 INFO - Reading from file tmpfile_stdout 18:12:46 INFO - Output received: 18:12:46 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:12:46 INFO - Running post-action listener: _resource_record_post_action 18:12:46 INFO - [mozharness: 2017-03-03 02:12:46.848457Z] Finished install step (success) 18:12:46 INFO - [mozharness: 2017-03-03 02:12:46.848598Z] Running run-tests step. 18:12:46 INFO - Running pre-action listener: _resource_record_pre_action 18:12:46 INFO - Running main action method: run_tests 18:12:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:12:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:12:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:12:46 INFO - 2017-03-02 18:12:46.862 screenresolution[1628:7541] starting screenresolution argv=screenresolution get 18:12:46 INFO - 2017-03-02 18:12:46.865 screenresolution[1628:7541] Display 0: 1600x1200x32@60 18:12:46 INFO - 2017-03-02 18:12:46.871 screenresolution[1629:7543] starting screenresolution argv=screenresolution list 18:12:46 INFO - Available Modes on Display 0 18:12:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:12:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:12:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:12:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:12:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:12:47 INFO - Intel Iris: 18:12:47 INFO - Chipset Model: Intel Iris 18:12:47 INFO - Type: GPU 18:12:47 INFO - Bus: Built-In 18:12:47 INFO - VRAM (Dynamic, Max): 1536 MB 18:12:47 INFO - Vendor: Intel (0x8086) 18:12:47 INFO - Device ID: 0x0a2e 18:12:47 INFO - Revision ID: 0x0009 18:12:47 INFO - Displays: 18:12:47 INFO - Display: 18:12:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:12:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:12:47 INFO - Display Serial Number: 1600x1200 60 18:12:47 INFO - Main Display: Yes 18:12:47 INFO - Mirror: Off 18:12:47 INFO - Online: Yes 18:12:47 INFO - Rotation: Supported 18:12:47 INFO - Return code: 0 18:12:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:12:47 INFO - Python 2.7.3 18:12:47 INFO - Return code: 0 18:12:47 INFO - grabbing minidump binary from tooltool 18:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:47 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 0x105118d30>, '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 0x10503fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10510dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:12:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:12:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:12:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:12:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:12:47 INFO - Return code: 0 18:12:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:12:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:12:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:12:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:12:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:12:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0283 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:12:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wqf5QHiR6S/Render', 18:12:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:47 INFO - 'HOME': '/Users/cltbld', 18:12:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:47 INFO - 'LOGNAME': 'cltbld', 18:12:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:12:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:47 INFO - 'MOZ_NO_REMOTE': '1', 18:12:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:12:47 INFO - 'NO_EM_RESTART': '1', 18:12:47 INFO - 'PAGER': '/bin/cat', 18:12:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:47 INFO - 'PWD': '/builds/slave/test', 18:12:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:12:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:47 INFO - 'SHELL': '/bin/bash', 18:12:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dz4pYS7fi2/Listeners', 18:12:47 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 18:12:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:47 INFO - 'USER': 'cltbld', 18:12:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:47 INFO - 'XPC_FLAGS': '0x0', 18:12:47 INFO - 'XPC_SERVICE_NAME': '0', 18:12:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:12:47 INFO - mozversion application_buildid: 20170302165138 18:12:47 INFO - mozversion application_changeset: d5b97a00c7e41b500878d293c16140304e871482 18:12:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:12:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:12:47 INFO - mozversion application_name: Firefox 18:12:47 INFO - mozversion application_remotingname: firefox-dev 18:12:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:12:47 INFO - mozversion application_vendor: Mozilla 18:12:47 INFO - mozversion application_version: 53.0a2 18:12:47 INFO - mozversion platform_buildid: 20170302165138 18:12:47 INFO - mozversion platform_changeset: d5b97a00c7e41b500878d293c16140304e871482 18:12:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:12:47 INFO - mozversion platform_version: 53.0a2 18:12:47 INFO - using testdate: 1488507167 18:12:47 INFO - actual date: 1488507167 18:12:47 INFO - starting webserver on 'localhost:49250' 18:12:47 INFO - SUITE-START | Running 2 tests 18:12:47 INFO - TEST-START | dromaeo_css 18:12:47 INFO - operating with platform_type : mac_ 18:12:47 INFO - Initialising browser for dromaeo_css test... 18:12:47 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpMjD09a/profile http://localhost:49250/getInfo.html) 18:12:49 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 18:12:49 INFO - PROCESS | 1639 | colorDepth:24 18:12:49 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 18:12:49 INFO - PROCESS | 1639 | __metrics 18:12:49 INFO - PROCESS | 1639 | 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" 18:12:49 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:12:50 INFO - TEST-INFO | 1639: exit 0 18:12:50 INFO - Browser initialized. 18:12:50 INFO - Running cycle 1/1 for dromaeo_css test... 18:12:50 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpMjD09a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:02 INFO - PROCESS | 1641 | RSS: Main: 212758528 18:13:02 INFO - PROCESS | 1641 | 18:16:06 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 18:16:08 INFO - PROCESS | 1641 | RSS: Main: 327598080 18:16:08 INFO - PROCESS | 1641 | 18:17:52 INFO - PROCESS | 1641 | ************************* 18:17:52 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 18:17:52 INFO - PROCESS | 1641 | 18:17:52 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:17:52 INFO - PROCESS | 1641 | Full stack: 18:17:52 INFO - PROCESS | 1641 | ************************* 18:19:11 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 18:19:11 INFO - PROCESS | 1641 | RSS: Main: 347897856 18:19:11 INFO - PROCESS | 1641 | 18:22:14 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 18:22:15 INFO - PROCESS | 1641 | RSS: Main: 345280512 18:22:15 INFO - PROCESS | 1641 | 18:25:17 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 18:25:17 INFO - PROCESS | 1641 | RSS: Main: 319426560 18:25:17 INFO - PROCESS | 1641 | 18:28:21 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 18:28:22 INFO - PROCESS | 1641 | RSS: Main: 312467456 18:28:22 INFO - PROCESS | 1641 | 18:31:25 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 18:31:25 INFO - PROCESS | 1641 | RSS: Main: 434675712 18:31:25 INFO - PROCESS | 1641 | 18:31:25 INFO - PROCESS | 1641 | __start_tp_report 18:31:25 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 18:31:25 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 18:31:25 INFO - PROCESS | 1641 | |i|pagename|runs| 18:31:25 INFO - PROCESS | 1641 | |0;dojo.html;3370.764046516744;3389.593248810143;3391.8643254269846;3409.8124603146816;3453.343864665713;5804.564657650672;5814.447627475393;5822.970885145568;5835.328937172232;5837.854053648661;5400.9189862152;5811.244538210027;5836.795712150076;5837.766489340422;5868.061110222355;5168.3539557555305;5241.9213711794355;5253.947460525404;5260.105782017066;5322.361316641989;5002.624803139779;5007.949920500803;5022.422421421528;5338.06583847827;5349.277847490597;5078.060558796616;5085.771140298695;5104.464031276718;5125.974370128163;5244.134717771563;5281.392639846409;5292.52367286946;5299.867503312409;5326.467353264681;5331.173668081454;5157.11765205701;5250.343707036621;5255.658382205144;5258.973705131488;5285.392179899322;5531.280933478622;5608.130739735348;5741.655500669973;5760.7695692172265;5824.068149096167;6212.378762123797;6259.968700156515;6260.248770147566;6270.46701030413;6301;6202.131701561785;6260.686965651699;6272.56092073555;6279.309275979638;6298.023806309983;5900.026495628216;5933.584649074566;5944.10838374243;5946.89982353266;5965.940340596539;6189.690515474208;6229;6267.9373206267355;6295.24457065146;6351;6285;6289.7169627366875;6302.684865756693;6316.747330106836;6329.525285603599;6159.815205543751;6271.874562508724;6288.465480434214;6299.401556852092;6320.5575609706875;6130.979101202072;6189.257289125334;6224.844378890564;6297.307296197415;6325.841853953688;6281.434670879551;6282.434580887742;6303.46420554258;6307.558470906993;6308.179936608211;4405.634253381462;4991.925121123113;5031.622628302819;5035.899282014412;5042.823501177441;4356.49900261474;4388.012697143181;4480.753558554311;4499.707519011254;4533.161365147393;5719.542436605062;5795.710214489343;5823.097419899837;5825.7378417971295;5879.500242479352;6175.379174656866;6197.008478643395;6240.375962403723;6247.96876015617;6256.249250090018;5690.231818704505;5737.254156959652;5756.798512052058;5819.73811178498;5855.560832937546;5491.258680078138;5505.201745746845;5506.504414602705;5511.311086114236;5537.390887002507;6334.461570766536;6340.651264180515;6350.904736428957;6351.30135685065;6353;6174.38256174379;6216.937830621636;6239.875202496016;6251.781187658592;6271.96864015677;6304.5586808922935;6332.841678958063;6340.461060809883;6357.4596159326975;6363.077353783768;6241.500679945684;6308.495320374451;6314.842128946813;6316.810495685137;6324.968375158095;5657.632253903647;6131.407250743203;6166.969165154145;6271.122042913905;6285.59143655661;6055.727492262947;6081.847953801191;6105.694715264308;6135.2326666699655;6147.631142131487;5994.130851026664;6007.219061522149;6118.571699980958;6131.369379079111;6158.7228574715145;5783.277090363705;5810.970945145247;5911.91132133027;6007.12896629995;6018.21763170785;6001.2498437695285;6112.74665817949;6113.388661133851;6141.823559979257;6213.099100630474;6047.848803779941;6054.697265136813;6057.133176207922;6062.272527296753;6117.96941015292 18:31:25 INFO - PROCESS | 1641 | |1;ext.html;484.57115452824263;484.9054434385294;496.5357390839565;508.97681715182154;517.5109521502181;22280;42501;44306;44516.88707782307;46601.76699116508;44961;45608.31587526182;45611.77194114025;45695.31457028139;45782.542174578244;9347.485888276142;9551.761205969871;9558.713238602853;9561.330706850524;9562.904370956307;8580.828383432328;8774.824503509926;11466.484008219608;11688;11698.532058717641;11676.47455864488;11729.648110556696;11765.705857353549;11773.529058837636;11788.410579471036;11596.594119205829;11676.47455864488;11677.649670509898;11694.239874408137;11698.356590387526;8546.273566746833;8742.388032837704;11380.829287560693;11551.018163456116;11587.536498540048;42790.57209427897;43023.56976430227;43166.13667726659;43236.919077023325;43324.566754332365;3846.615338466159;3967.3255546557157;3997.380406037069;4001.239764444746;4030.496187976503;30137.547936780968;30240.546391804142;30588.54117188244;31060.844695776603;31130.066098017094;2599.3761497240525;3346.6318704942437;3353.748468864845;3355.5302257683943;3359.9328013439595;469851.3014869842;471337;471826;471857;472038;68804.6559767208;69129;69133.3086669127;69194;69274.30725692678;73378.26621733821;73637.26362736411;73704;73718.26281737222;73765;17184.968901865926;17263.827361726475;17541.736873946902;17592.560185995197;17606;11942.343171125498;12260;13294.933525332312;13353.465861365437;13368.39842207103;15548.92225538865;16742.4140155094;17458.825411745973;17541.847891815938;17596.912015440095;7726.111497177784;8109.107998120202;8275.420720549504;8296.336293096538;8658.87011694825;861.9008813986471;868.5743985447211;880.6037283222576;899.2266650680409;912.183595681861;31511.794174407572;31547.369052619277;31692.207694807814;31865.681343186734;32237.032889013368;748.9737859174903;1033.204432586919;1043.3739756146251;1055.767731099157;1074.070928646715;14605.415783368546;15168.924155379153;15286.115643916117;15331.770023449657;15431.845681543266;413231;413422;413612;413764;414888.9255553703;57272.71363643155;57726.71136644374;57812.71093644505;57863.71068144716;58404.41595584075;1422.153818478004;1446.652803327215;1468.9192094434695;1478.36430334957;1479.652281713818;23519.88240058789;27686.86156569204;29511.852440737657;29711;30299.93950211732;51722.70693232699;51877;51911.740441299065;52008.73995629998;52015.73992130015;352514;353377;354446;354781;368139;26388.868055659597;27051;40729.96350182538;41303.1739365217;41435.585644143175;43509.78245108754;44315.55684443114;44998.550014500746;45068;45342;36566.268674625826;36621.450678240384;36790.89627311078;37826.62173378231;38150.80924595359;36233.63766362408;36442.45336319904;37286;37319.44020839635;37533.06167345838;42764.358534622625;43947.78026109849;44092;45527.772361137984;45532.86167845831;39091.6090839088;42706.78646606747;42779.144417112104;43689;43987.56012439835;27600.447991039666;30844.845775771875;32297.295278315425;32635.836820816694;32799.508007380384 18:31:25 INFO - PROCESS | 1641 | |2;jquery.html;364.5406787447815;386.2429637909695;389.5597974289053;394.518687201614;416.1032973941156;14739.557813265606;15214.239288035595;17933.551661208476;20173.59652806943;20765.273215437424;20554.48613784656;21235.57528849422;21367;21955.67066494004;21964.341069767892;5295.391030031547;5475.917861232065;5479.917801232985;5483.643563168402;5992.370801065891;3908.511436070491;5962;6064.4541991220785;6069.666168360738;6069.939300606981;4096.32410652242;6357.141785858896;6642.800715978528;6703.731850725965;6757.526973111884;6089.725962331706;6166.7533298667995;6248.187735594389;6739.6293203873765;6759.695813688396;5968.283805943272;5969.194158788551;5973.581849270553;5986;6002.729877155539;16696.165191740365;25143.37141571457;25160.874195629087;25243.49513009748;25451.61822572663;2847.6440444944383;2916.7958242923005;2969.8663560139844;2994.1317018064733;3019.667836537979;9974.800503989953;10150.086492215736;10181.03280188381;10391.324563903323;10500.78998420035;1739.7564340992271;1822.8723989320754;1848.8243616856378;1923.2018712234405;1930.0735646889432;141223.29388352993;142681.57318426788;147945;148738;150972.2451387736;10032.44821534808;11694.181407301578;11756.529738810523;11931.284122952477;12191.207571507824;15862.682746345008;15988.840111598734;15996.200189990454;16012.199390030451;16050.438234661731;8709.651613935499;8833.116688331116;8874.068222836639;8876.334274929406;8932.06213347589;8582.914170858212;8678.175573320525;8689.478631282143;8811.206991370807;8867.822643547222;4783.354247176587;4788.856334309976;4798.752324395612;4799.448063472675;4863.9513604864205;1724.8102708702033;1790.4091649755549;1959.6472634925851;1975.4073777866583;2025.4531276555542;982.7346616413529;1011.2365164300905;1019.4444028004755;1027.0448482910965;1065.2330322168027;20919.8954005229;21502.032408541654;21533;21534.784652153277;21549;1018.2159737002466;1042.6976176908763;1042.7288904884786;1048.3605000949415;1056.4506456642657;9596.9040309596;10876;10928.267933016747;10962.068224201032;10970.341779493256;742016;747174.2641286759;754398;755552;758284;136624;141823;154987;156061;162592;936.2509992006368;1018.3737001744022;1052.400131924811;1075.349413604758;1078.013617539942;19722.605547888674;20212.595748084663;20218.79781202228;20221.59556808826;20275;51126.23310650269;55093.72453137708;60366.094508581526;62020.689896550226;62250.066249007206;86890.56554717438;87328.12375089925;87758;89171;90622.64066038883;7418.443616728659;7867.9606601966625;8194.30348420367;8350.58247087631;8480.491170529787;8965.058668839678;9216.30877684163;12471.127021108436;12487.93756031214;13081.411336490071;7565.713828649253;7735.342495887912;7974.322182614543;8196;8311.459755115899;6838.803209438229;7444.441666875115;7558.886616700644;7863.095743989285;8215.712450064219;7842.333401660922;8106.83786324282;8170.673173073011;8213.876791848008;8278.213569710868;12546.811797823222;12876.549320774102;12945.805812912626;13012.544560940321;13250.403731832284;11613.6515904523;11759.470823812779;11886.28682279066;11895.881041189477;12066 18:31:25 INFO - PROCESS | 1641 | |3;mootools.html;1424.5655075202071;1440.2222799688168;1452.789345544896;1460.8758255548278;1467.2150399536251;7974.561399123053;8336.333093352532;8338.082810890797;8359.414840961135;8373.706920257791;7387.482876198668;7617.46677732559;7848.48984815988;8117.431779775418;8119.106898241189;2265.0939624150305;2303.55080759252;2309.203324852923;2312.6415405612156;2313.4332088638225;1965.1648049578944;2307.538492301538;2327.2320134355623;2332.8133749300014;2339.7075365579303;2273.7271527416733;2290.713660792401;2300.275413244831;2325.5697695926224;2329.650552417134;2284.9543009139807;2305.101010605865;2307.734610519778;2308.792208701208;2308.9307320780317;2017.5863947890793;2239.3505883293824;2329.0800133947164;2337.7194736631714;2338.6024375856146;8221.79445513861;8274.710385136492;8279.420440569163;8279.50322980623;8289.461185023014;4638.420197475316;4781.043791241731;4783.210770222909;4784.66507344486;4790;3135.146592671823;3288.96711032889;3420.7776494527775;3442.5008373785913;3490.6509349065145;1160.9825852612219;1166.9883301166965;1195.3903509210365;1196.4795314038422;1213.6783752305646;8774.60514276859;10474.004969527883;10476.371417714885;10479.161667066617;10498.737531561696;4375.387445757597;4567.954320456753;4653.069386122789;4661.673682842236;4664.39362882823;8351.624176912053;8969.56486962083;9283.442993420416;9292.256619470427;9333.346665733468;5175.4824517548695;5175.508326708957;5185.248139019821;5190.403103643054;5193.584513239008;3868.7678739275734;4085;4184.665226781911;4649.69776964503;4754.5245475452175;3787.905302367463;3790.223004284115;3866.9613303867163;3880.689544836406;3912.628300311466;1259.716563773162;1264.2477725753163;1271.0911698135876;1281.1736430002595;1288.5168061976758;766.7048186448258;850.7065062553532;899.4288626722079;902.5938327752538;920.1534588178891;5308.23030660552;5437.211604317352;5599.832005039855;5756.079027355603;5992.820215393545;943.7027336389016;969.2052516936045;994.5822754443006;995.7261753017978;1028.475477506477;3581.5344005279667;3620.4931309616672;3627.2745450909924;3744.0826997385816;3752.81235938202;9568.712938611852;9596.808063838684;9778.217742580577;9861.654842080492;9897;9282.582283797245;9665.90334096664;9737.56180971858;9743;9760.121589057018;7272.709091636381;7541.8114547135665;7549.811254718676;7565.508241964255;7578.772636820904;5492.368377636463;5544.445555444423;5629.831105066854;5690.089585666439;5701;8707.738767836974;8950.955245223993;9060.637574496946;9150.679726209552;9229.769255768391;8225.917740822515;9016.594253258489;9273.072692730673;9303.488308143116;9390.95304523473;6383.872322553616;6540.345965403421;6772.356626120511;7049.894251586333;7228.060352154186;7776.183500732342;7881.566513841564;7906.051273847175;7919.247671471201;7933.246341597539;6810.353016463428;6988.8951665724035;7002.3697867192195;7004.019437278887;7050.294970502909;5931.762729490944;6873.931260687329;6923.757668481579;6929.307069293232;6952.061471701256;6268.623882567061;6324.272708638381;6344.651044192429;6426.967865160645;6430.807075787734;4779.593734532604;4785.760711964457;4812.157872372391;4902.632302577393;4938.8765280868265;4400.867973960786;4459.331100334846;4847;4866.464688884149;5014.222795466709 18:31:25 INFO - PROCESS | 1641 | |4;prototype.html;301.4859664272416;345.9619441861395;353.44332676035253;357.8425492783175;368.56444150035594;4323.913521729572;4561.977190114053;4644.187267228234;4807.620227987151;5028.195488721801;4866.270059491078;4900.705957642535;4954.3063971044085;4988.7755051022705;5032.974835125829;3975.662068724162;4006.6394024537785;4007.5792041835625;4012.538558065831;4017.7790221537803;3496.300739852027;3615.3788503335136;4023.9537720192816;4050.7367021143677;4059.4722686050773;3227.967720322802;3795.3168429682646;3810.79040652764;3845.0005996881605;3881.049142959979;3002.384511175204;3518.9296214075703;3847.1151635123797;3862.304785138674;3866.144250759623;3353.916152096217;3359.6472370401;3360.815155166465;3371.718746876196;3383.509391138271;3707.924701836464;3928.626780455852;4354.238008348526;4967.55292023716;5018.799248030111;4284.957150428519;4351.8694439166875;4576.565226303496;4612.262038073892;4656.254999200111;4458.576435238647;5354.902245039758;5363.490468405535;5366.758495867695;5405.324379421992;3822.3884178531302;3945.8618948336957;3953.2686453006286;3993.8602148924647;4017.6785857131654;4554.407926969473;5535.944640553624;5635.5491560675455;5653.717314134276;5734.8243610059835;4025.772139497423;4026.7181297309494;4042;4046.8988275292763;4067.3695577185586;4065.7763822989427;4066.5933406659096;4068.7762173080173;4127.161739582218;4132.5329508024215;3916.353801622757;4406.9559304407185;4536.478304994967;4541.524004698486;4622.653301002439;4515.390422293014;4615.538446155425;4959.801607935642;5334.35949205146;5453.991011662776;1148.0700632487712;1255.2280347586168;1274.7386785708907;1317.4927652853721;1327.5486334646266;939.6664184214642;939.9013103624158;963.7686955130858;964.9710508684751;966.897736580299;4151.398047283127;4414;4734.0826965079195;4764.285357196379;4766.689160480826;4797.928031079537;4860.538248866352;5152.252923326172;5166.535011848877;5238.423773384925;4434.5343738907595;4537.705049171794;4548.63540937724;4758.3100450434495;4770.42754869411;2470.394753285421;2604.6353510508543;2693.7036925938132;2709.878055487508;2735.8905643774424;4752.105331508552;4867.921543815229;5161.045206636709;5329.18807605416;5403.621746477709;4562.61217796491;4826;5284.656497327738;5313.601479889024;5353.724667016502;4461.665375096881;5139.6145289102715;5349.705766182898;5385.865353366197;5446;5096.592272618256;5474.644148130359;5512.283403157564;5522.806701765419;5534.252875861707;4633.907321853477;5448.782048718165;5467.289252397163;5499.862503437446;5586.636868603528;4093.9385909211983;4605.562471565196;5300.867478313073;5329.147336426308;5701.486866182064;3682.8895133146048;3718.950460622372;3731.9626803731617;3742.989392863966;3774.8490060398376;4820.9517904821905;5138.8972220556125;5222.459374484461;5244.895102098013;5561.5272701820795;4867.296446243787;4951.752412379295;5000.574951129195;5228.37259528859;5333.439908877854;4362.520122786555;4899.387576552931;4994.9750251248515;5152.608795625085;5338.57291416678;5163.173892177234;5178.585713143015;5187.028929006953;5188.247704082812;5197.142471492161;5310.840674779763;5352.421035794372;5362.597805164706;5374.973125134349;5401.432849550898;4831.685940413862;4993.725345105909;4996.300517927566;5220.441983428169;5283.735813209248 18:31:25 INFO - PROCESS | 1641 | |5;yui.html;707.1902671441203;720.762148490998;728.4682182007135;785.7878372839333;836.748975307408;14276.286185690713;15392.846071539281;15416.306266218018;15422.383104675813;15427.768583471257;14080.436782528686;14294.642633934156;14323.283835808194;14326.068805527633;14328.426862925471;675.1257122026987;698.4203111417511;699.360085521747;853.5902766671985;868.2706526517724;824.6536454689045;845.213951025546;850.9489430634151;858.682287553606;861.1388611388611;919.0946917286467;924.7318277699459;925.8009527951489;927.3693888156051;930.3812964378714;707.8690442268197;920.5949382271779;920.7145784806731;922.6217250927155;923.5013092929844;540.0710777462758;656.9080328753978;679.2528218959105;681.7204945972177;683.4259222253331;14746.483873064499;14989.850101498954;15033.774493382609;15083.321250543751;15111.697766044617;13264.73470530584;13272.636815920398;13285.800712989312;13382.531611393651;13455.66360840977;12035.699107522294;12068.336241506713;12145.696357591043;12229.388530573524;12593.811092833615;4260;4260.893477663052;4403.977980110111;4436.511983681792;4535.297028960484;87043;93575.53212233963;99528;102195.48902255515;102217;10478.266521343432;10536;10552.103071238877;10694.679159625224;10746.623868164577;21265;21278.468038298855;21303.893480532497;21605.243816466347;21636.675449868264;7176.569405835667;7347.742829000959;7363.889541656879;7581.3934885209055;7616.961915190389;3583.086312990171;4195.769232692171;4234.343676730112;4252.957470425256;4394.890127746768;3331.1339051846694;3387.983060084684;3402.812845293483;3418.504316874089;3427.520147179397;632.0961025733154;635.2630948100182;639.5011890725242;641.8331233879225;648.3840351665937;624.3818619566597;638.6040654793965;640.8333833203308;642.7525402719987;657.4116166031375;7626.771196864103;9403.529823508934;9406.38858474197;9472.95263523678;9566.473843938651;601.7322291580292;627.8336240896166;628.9779857704958;637.7863415755774;652.8433176037717;3996.2207369562657;4390.209762242827;4396.318570621559;4705.12955103307;4806.351142595775;91519.62720559197;108647.37028944572;109138;109252.4537377308;110995;82331;91396;92661.5366923161;96626;97602;80084;81490.59254703688;82405.58349748551;82953.58523207225;83511;7957.244061814118;8652.178043085896;9081.818363632823;9159.22146617545;9272.53637318118;43300.78349608232;52553.7372313136;52908.47091529035;53108.46891531035;53596.39210823682;67262.66368668125;68477.31522684709;69729.65135174495;71772.64113679399;73124.26875731174;9678;11096.223264371416;11136.610218642309;11274.041706454715;11518.308901465938;10578.418186999788;11026.558937642725;11755.353455559683;11973.76052478963;12149.906508414286;10616.044555989998;11177.273477223955;11376.94311528437;11399.829002564802;11483.712907177052;10880.67357979262;11153.386563739072;11275.041621462267;11311.886881131084;11375.886241137483;10437.530311135864;11026.117910566974;11106;11192;11435.873975654176;8531.914680853111;8905.376623636283;8905.910940890508;8948.284137268873;9156.725298241063;7046;7389.815254618463;7734.419918506247;8561.529115898436;8936.28509719234 18:31:25 INFO - PROCESS | 1641 | __end_tp_report 18:31:25 INFO - PROCESS | 1641 | __start_cc_report 18:31:25 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1661 18:31:25 INFO - PROCESS | 1641 | __end_cc_report 18:31:25 INFO - PROCESS | 1641 | __startTimestamp1488508285414__endTimestamp 18:31:25 INFO - PROCESS | 1641 | 18:31:25 INFO - PROCESS | 1641 | ------- Summary: start ------- 18:31:25 INFO - PROCESS | 1641 | Number of tests: 6 18:31:25 INFO - PROCESS | 1641 | 18:31:25 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5782.92 Median:6007.22 stddev:645.53 (10.7%) stddev-sans-first:619.16 18:31:25 INFO - PROCESS | 1641 | Values: 3370.8 3389.6 3391.9 3409.8 3453.3 5804.6 5814.4 5823.0 5835.3 5837.9 5400.9 5811.2 5836.8 5837.8 5868.1 5168.4 5241.9 5253.9 5260.1 5322.4 5002.6 5007.9 5022.4 5338.1 5349.3 5078.1 5085.8 5104.5 5126.0 5244.1 5281.4 5292.5 5299.9 5326.5 5331.2 5157.1 5250.3 5255.7 5259.0 5285.4 5531.3 5608.1 5741.7 5760.8 5824.1 6212.4 6260.0 6260.2 6270.5 6301.0 6202.1 6260.7 6272.6 6279.3 6298.0 5900.0 5933.6 5944.1 5946.9 5965.9 6189.7 6229.0 6267.9 6295.2 6351.0 6285.0 6289.7 6302.7 6316.7 6329.5 6159.8 6271.9 6288.5 6299.4 6320.6 6131.0 6189.3 6224.8 6297.3 6325.8 6281.4 6282.4 6303.5 6307.6 6308.2 4405.6 4991.9 5031.6 5035.9 5042.8 4356.5 4388.0 4480.8 4499.7 4533.2 5719.5 5795.7 5823.1 5825.7 5879.5 6175.4 6197.0 6240.4 6248.0 6256.2 5690.2 5737.3 5756.8 5819.7 5855.6 5491.3 5505.2 5506.5 5511.3 5537.4 6334.5 6340.7 6350.9 6351.3 6353.0 6174.4 6216.9 6239.9 6251.8 6272.0 6304.6 6332.8 6340.5 6357.5 6363.1 6241.5 6308.5 6314.8 6316.8 6325.0 5657.6 6131.4 6167.0 6271.1 6285.6 6055.7 6081.8 6105.7 6135.2 6147.6 5994.1 6007.2 6118.6 6131.4 6158.7 5783.3 5811.0 5911.9 6007.1 6018.2 6001.2 6112.7 6113.4 6141.8 6213.1 6047.8 6054.7 6057.1 6062.3 6118.0 18:31:25 INFO - PROCESS | 1641 | 18:31:25 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:58920.46 Median:3982.35 stddev:109944.59 (2760.8%) stddev-sans-first:110165.47 18:31:25 INFO - PROCESS | 1641 | Values: 484.6 484.9 496.5 509.0 517.5 22280.0 42501.0 44306.0 44516.9 46601.8 44961.0 45608.3 45611.8 45695.3 45782.5 9347.5 9551.8 9558.7 9561.3 9562.9 8580.8 8774.8 11466.5 11688.0 11698.5 11676.5 11729.6 11765.7 11773.5 11788.4 11596.6 11676.5 11677.6 11694.2 11698.4 8546.3 8742.4 11380.8 11551.0 11587.5 42790.6 43023.6 43166.1 43236.9 43324.6 3846.6 3967.3 3997.4 4001.2 4030.5 30137.5 30240.5 30588.5 31060.8 31130.1 2599.4 3346.6 3353.7 3355.5 3359.9 469851.3 471337.0 471826.0 471857.0 472038.0 68804.7 69129.0 69133.3 69194.0 69274.3 73378.3 73637.3 73704.0 73718.3 73765.0 17185.0 17263.8 17541.7 17592.6 17606.0 11942.3 12260.0 13294.9 13353.5 13368.4 15548.9 16742.4 17458.8 17541.8 17596.9 7726.1 8109.1 8275.4 8296.3 8658.9 861.9 868.6 880.6 899.2 912.2 31511.8 31547.4 31692.2 31865.7 32237.0 749.0 1033.2 1043.4 1055.8 1074.1 14605.4 15168.9 15286.1 15331.8 15431.8 413231.0 413422.0 413612.0 413764.0 414888.9 57272.7 57726.7 57812.7 57863.7 58404.4 1422.2 1446.7 1468.9 1478.4 1479.7 23519.9 27686.9 29511.9 29711.0 30299.9 51722.7 51877.0 51911.7 52008.7 52015.7 352514.0 353377.0 354446.0 354781.0 368139.0 26388.9 27051.0 40730.0 41303.2 41435.6 43509.8 44315.6 44998.6 45068.0 45342.0 36566.3 36621.5 36790.9 37826.6 38150.8 36233.6 36442.5 37286.0 37319.4 37533.1 42764.4 43947.8 44092.0 45527.8 45532.9 39091.6 42706.8 42779.1 43689.0 43987.6 27600.4 30844.8 32297.3 32635.8 32799.5 18:31:25 INFO - PROCESS | 1641 | 18:31:25 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:41037.80 Median:2943.33 stddev:125445.62 (4262.0%) stddev-sans-first:125760.35 18:31:25 INFO - PROCESS | 1641 | Values: 364.5 386.2 389.6 394.5 416.1 14739.6 15214.2 17933.6 20173.6 20765.3 20554.5 21235.6 21367.0 21955.7 21964.3 5295.4 5475.9 5479.9 5483.6 5992.4 3908.5 5962.0 6064.5 6069.7 6069.9 4096.3 6357.1 6642.8 6703.7 6757.5 6089.7 6166.8 6248.2 6739.6 6759.7 5968.3 5969.2 5973.6 5986.0 6002.7 16696.2 25143.4 25160.9 25243.5 25451.6 2847.6 2916.8 2969.9 2994.1 3019.7 9974.8 10150.1 10181.0 10391.3 10500.8 1739.8 1822.9 1848.8 1923.2 1930.1 141223.3 142681.6 147945.0 148738.0 150972.2 10032.4 11694.2 11756.5 11931.3 12191.2 15862.7 15988.8 15996.2 16012.2 16050.4 8709.7 8833.1 8874.1 8876.3 8932.1 8582.9 8678.2 8689.5 8811.2 8867.8 4783.4 4788.9 4798.8 4799.4 4864.0 1724.8 1790.4 1959.6 1975.4 2025.5 982.7 1011.2 1019.4 1027.0 1065.2 20919.9 21502.0 21533.0 21534.8 21549.0 1018.2 1042.7 1042.7 1048.4 1056.5 9596.9 10876.0 10928.3 10962.1 10970.3 742016.0 747174.3 754398.0 755552.0 758284.0 136624.0 141823.0 154987.0 156061.0 162592.0 936.3 1018.4 1052.4 1075.3 1078.0 19722.6 20212.6 20218.8 20221.6 20275.0 51126.2 55093.7 60366.1 62020.7 62250.1 86890.6 87328.1 87758.0 89171.0 90622.6 7418.4 7868.0 8194.3 8350.6 8480.5 8965.1 9216.3 12471.1 12487.9 13081.4 7565.7 7735.3 7974.3 8196.0 8311.5 6838.8 7444.4 7558.9 7863.1 8215.7 7842.3 8106.8 8170.7 8213.9 8278.2 12546.8 12876.5 12945.8 13012.5 13250.4 11613.7 11759.5 11886.3 11895.9 12066.0 18:31:25 INFO - PROCESS | 1641 | 18:31:25 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5302.59 Median:5372.72 stddev:2855.80 (53.2%) stddev-sans-first:2848.94 18:31:25 INFO - PROCESS | 1641 | Values: 1424.6 1440.2 1452.8 1460.9 1467.2 7974.6 8336.3 8338.1 8359.4 8373.7 7387.5 7617.5 7848.5 8117.4 8119.1 2265.1 2303.6 2309.2 2312.6 2313.4 1965.2 2307.5 2327.2 2332.8 2339.7 2273.7 2290.7 2300.3 2325.6 2329.7 2285.0 2305.1 2307.7 2308.8 2308.9 2017.6 2239.4 2329.1 2337.7 2338.6 8221.8 8274.7 8279.4 8279.5 8289.5 4638.4 4781.0 4783.2 4784.7 4790.0 3135.1 3289.0 3420.8 3442.5 3490.7 1161.0 1167.0 1195.4 1196.5 1213.7 8774.6 10474.0 10476.4 10479.2 10498.7 4375.4 4568.0 4653.1 4661.7 4664.4 8351.6 8969.6 9283.4 9292.3 9333.3 5175.5 5175.5 5185.2 5190.4 5193.6 3868.8 4085.0 4184.7 4649.7 4754.5 3787.9 3790.2 3867.0 3880.7 3912.6 1259.7 1264.2 1271.1 1281.2 1288.5 766.7 850.7 899.4 902.6 920.2 5308.2 5437.2 5599.8 5756.1 5992.8 943.7 969.2 994.6 995.7 1028.5 3581.5 3620.5 3627.3 3744.1 3752.8 9568.7 9596.8 9778.2 9861.7 9897.0 9282.6 9665.9 9737.6 9743.0 9760.1 7272.7 7541.8 7549.8 7565.5 7578.8 5492.4 5544.4 5629.8 5690.1 5701.0 8707.7 8951.0 9060.6 9150.7 9229.8 8225.9 9016.6 9273.1 9303.5 9391.0 6383.9 6540.3 6772.4 7049.9 7228.1 7776.2 7881.6 7906.1 7919.2 7933.2 6810.4 6988.9 7002.4 7004.0 7050.3 5931.8 6873.9 6923.8 6929.3 6952.1 6268.6 6324.3 6344.7 6427.0 6430.8 4779.6 4785.8 4812.2 4902.6 4938.9 4400.9 4459.3 4847.0 4866.5 5014.2 18:31:25 INFO - PROCESS | 1641 | 18:31:25 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4283.80 Median:4695.17 stddev:1256.61 (26.8%) stddev-sans-first:1224.07 18:31:25 INFO - PROCESS | 1641 | Values: 301.5 346.0 353.4 357.8 368.6 4323.9 4562.0 4644.2 4807.6 5028.2 4866.3 4900.7 4954.3 4988.8 5033.0 3975.7 4006.6 4007.6 4012.5 4017.8 3496.3 3615.4 4024.0 4050.7 4059.5 3228.0 3795.3 3810.8 3845.0 3881.0 3002.4 3518.9 3847.1 3862.3 3866.1 3353.9 3359.6 3360.8 3371.7 3383.5 3707.9 3928.6 4354.2 4967.6 5018.8 4285.0 4351.9 4576.6 4612.3 4656.3 4458.6 5354.9 5363.5 5366.8 5405.3 3822.4 3945.9 3953.3 3993.9 4017.7 4554.4 5535.9 5635.5 5653.7 5734.8 4025.8 4026.7 4042.0 4046.9 4067.4 4065.8 4066.6 4068.8 4127.2 4132.5 3916.4 4407.0 4536.5 4541.5 4622.7 4515.4 4615.5 4959.8 5334.4 5454.0 1148.1 1255.2 1274.7 1317.5 1327.5 939.7 939.9 963.8 965.0 966.9 4151.4 4414.0 4734.1 4764.3 4766.7 4797.9 4860.5 5152.3 5166.5 5238.4 4434.5 4537.7 4548.6 4758.3 4770.4 2470.4 2604.6 2693.7 2709.9 2735.9 4752.1 4867.9 5161.0 5329.2 5403.6 4562.6 4826.0 5284.7 5313.6 5353.7 4461.7 5139.6 5349.7 5385.9 5446.0 5096.6 5474.6 5512.3 5522.8 5534.3 4633.9 5448.8 5467.3 5499.9 5586.6 4093.9 4605.6 5300.9 5329.1 5701.5 3682.9 3719.0 3732.0 3743.0 3774.8 4821.0 5138.9 5222.5 5244.9 5561.5 4867.3 4951.8 5000.6 5228.4 5333.4 4362.5 4899.4 4995.0 5152.6 5338.6 5163.2 5178.6 5187.0 5188.2 5197.1 5310.8 5352.4 5362.6 5375.0 5401.4 4831.7 4993.7 4996.3 5220.4 5283.7 18:31:25 INFO - PROCESS | 1641 | 18:31:25 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20037.65 Median:570.90 stddev:29735.05 (5208.4%) stddev-sans-first:29783.04 18:31:25 INFO - PROCESS | 1641 | Values: 707.2 720.8 728.5 785.8 836.7 14276.3 15392.8 15416.3 15422.4 15427.8 14080.4 14294.6 14323.3 14326.1 14328.4 675.1 698.4 699.4 853.6 868.3 824.7 845.2 850.9 858.7 861.1 919.1 924.7 925.8 927.4 930.4 707.9 920.6 920.7 922.6 923.5 540.1 656.9 679.3 681.7 683.4 14746.5 14989.9 15033.8 15083.3 15111.7 13264.7 13272.6 13285.8 13382.5 13455.7 12035.7 12068.3 12145.7 12229.4 12593.8 4260.0 4260.9 4404.0 4436.5 4535.3 87043.0 93575.5 99528.0 102195.5 102217.0 10478.3 10536.0 10552.1 10694.7 10746.6 21265.0 21278.5 21303.9 21605.2 21636.7 7176.6 7347.7 7363.9 7581.4 7617.0 3583.1 4195.8 4234.3 4253.0 4394.9 3331.1 3388.0 3402.8 3418.5 3427.5 632.1 635.3 639.5 641.8 648.4 624.4 638.6 640.8 642.8 657.4 7626.8 9403.5 9406.4 9473.0 9566.5 601.7 627.8 629.0 637.8 652.8 3996.2 4390.2 4396.3 4705.1 4806.4 91519.6 108647.4 109138.0 109252.5 110995.0 82331.0 91396.0 92661.5 96626.0 97602.0 80084.0 81490.6 82405.6 82953.6 83511.0 7957.2 8652.2 9081.8 9159.2 9272.5 43300.8 52553.7 52908.5 53108.5 53596.4 67262.7 68477.3 69729.7 71772.6 73124.3 9678.0 11096.2 11136.6 11274.0 11518.3 10578.4 11026.6 11755.4 11973.8 12149.9 10616.0 11177.3 11376.9 11399.8 11483.7 10880.7 11153.4 11275.0 11311.9 11375.9 10437.5 11026.1 11106.0 11192.0 11435.9 8531.9 8905.4 8905.9 8948.3 9156.7 7046.0 7389.8 7734.4 8561.5 8936.3 18:31:25 INFO - PROCESS | 1641 | -------- Summary: end -------- 18:31:25 INFO - PROCESS | 1641 | 18:31:26 INFO - TEST-INFO | 1641: exit 0 18:31:26 INFO - TEST-OK | dromaeo_css | took 1118646ms 18:31:26 INFO - TEST-START | kraken 18:31:26 INFO - operating with platform_type : mac_ 18:31:26 INFO - Initialising browser for kraken test... 18:31:26 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmptsEygp/profile http://localhost:49250/getInfo.html) 18:31:28 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 18:31:28 INFO - PROCESS | 1652 | colorDepth:24 18:31:28 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 18:31:28 INFO - PROCESS | 1652 | __metrics 18:31:28 INFO - PROCESS | 1652 | 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" 18:31:28 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:31:29 INFO - TEST-INFO | 1652: exit 0 18:31:29 INFO - Browser initialized. 18:31:29 INFO - Running cycle 1/1 for kraken test... 18:31:29 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmptsEygp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:41 INFO - PROCESS | 1653 | RSS: Main: 212582400 18:31:41 INFO - PROCESS | 1653 | 18:31:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 18:31:44 INFO - PROCESS | 1653 | RSS: Main: 265666560 18:31:44 INFO - PROCESS | 1653 | 18:31:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 18:31:48 INFO - PROCESS | 1653 | RSS: Main: 274923520 18:31:48 INFO - PROCESS | 1653 | 18:31:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 18:31:51 INFO - PROCESS | 1653 | RSS: Main: 371130368 18:31:51 INFO - PROCESS | 1653 | 18:31:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 18:31:54 INFO - PROCESS | 1653 | RSS: Main: 277037056 18:31:54 INFO - PROCESS | 1653 | 18:31:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:31:57 INFO - PROCESS | 1653 | RSS: Main: 278478848 18:31:57 INFO - PROCESS | 1653 | 18:31:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 18:32:00 INFO - PROCESS | 1653 | RSS: Main: 318451712 18:32:00 INFO - PROCESS | 1653 | 18:32:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 18:32:04 INFO - PROCESS | 1653 | RSS: Main: 320180224 18:32:04 INFO - PROCESS | 1653 | 18:32:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 18:32:07 INFO - PROCESS | 1653 | RSS: Main: 315678720 18:32:07 INFO - PROCESS | 1653 | 18:32:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:09 INFO - PROCESS | 1653 | RSS: Main: 294912000 18:32:09 INFO - PROCESS | 1653 | 18:32:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:12 INFO - PROCESS | 1653 | RSS: Main: 297611264 18:32:12 INFO - PROCESS | 1653 | 18:32:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:15 INFO - PROCESS | 1653 | RSS: Main: 303747072 18:32:15 INFO - PROCESS | 1653 | 18:32:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:18 INFO - PROCESS | 1653 | RSS: Main: 309112832 18:32:18 INFO - PROCESS | 1653 | 18:32:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:22 INFO - PROCESS | 1653 | RSS: Main: 310243328 18:32:22 INFO - PROCESS | 1653 | 18:32:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 18:32:24 INFO - PROCESS | 1653 | RSS: Main: 354402304 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | __start_tp_report 18:32:24 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 18:32:24 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 18:32:24 INFO - PROCESS | 1653 | |i|pagename|runs| 18:32:24 INFO - PROCESS | 1653 | |0;ai-astar;115;115;114;113;115;114;114;115;112;115 18:32:24 INFO - PROCESS | 1653 | |1;audio-beat-detection;136;108;109;142;113;109;107;107;128;132 18:32:24 INFO - PROCESS | 1653 | |2;audio-dft;183;188;184;184;184;184;183;184;184;184 18:32:24 INFO - PROCESS | 1653 | |3;audio-fft;79;60;60;88;61;59;59;59;73;57 18:32:24 INFO - PROCESS | 1653 | |4;audio-oscillator;85;70;85;71;69;69;83;67;70;110 18:32:24 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;88;87;89;88;94;90;89;90;88;84 18:32:24 INFO - PROCESS | 1653 | |6;imaging-darkroom;95;95;95;99;145;154;104;95;95;95 18:32:24 INFO - PROCESS | 1653 | |7;imaging-desaturate;86;85;87;87;84;85;86;84;85;87 18:32:24 INFO - PROCESS | 1653 | |8;json-parse-financial;56;54;54;55;54;58;58;56;59;60 18:32:24 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;72;72;74;71;69;68;68;68;72 18:32:24 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;84;86;86;83;84;85;84;89;84;101 18:32:24 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;137;141;139;143;145;145;133;138;166;137 18:32:24 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;168;168;166;168;163;150;218;232;166;166 18:32:24 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;66;66;66;66;66;76;82;82;82 18:32:24 INFO - PROCESS | 1653 | __end_tp_report 18:32:24 INFO - PROCESS | 1653 | __start_cc_report 18:32:24 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2001 18:32:24 INFO - PROCESS | 1653 | __end_cc_report 18:32:24 INFO - PROCESS | 1653 | __startTimestamp1488508344255__endTimestamp 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | ------- Summary: start ------- 18:32:24 INFO - PROCESS | 1653 | Number of tests: 14 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 18:32:24 INFO - PROCESS | 1653 | Values: 115.0 115.0 114.0 113.0 115.0 114.0 114.0 115.0 112.0 115.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:120.50 stddev:13.80 (11.4%) stddev-sans-first:13.21 18:32:24 INFO - PROCESS | 1653 | Values: 136.0 108.0 109.0 142.0 113.0 109.0 107.0 107.0 128.0 132.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.00 stddev:1.40 (0.8%) stddev-sans-first:1.41 18:32:24 INFO - PROCESS | 1653 | Values: 183.0 188.0 184.0 184.0 184.0 184.0 183.0 184.0 184.0 184.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.50 Median:60.50 stddev:10.67 (17.6%) stddev-sans-first:10.14 18:32:24 INFO - PROCESS | 1653 | Values: 79.0 60.0 60.0 88.0 61.0 59.0 59.0 59.0 73.0 57.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:70.50 stddev:13.36 (19.0%) stddev-sans-first:13.92 18:32:24 INFO - PROCESS | 1653 | Values: 85.0 70.0 85.0 71.0 69.0 69.0 83.0 67.0 70.0 110.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.00 stddev:2.54 (2.9%) stddev-sans-first:2.68 18:32:24 INFO - PROCESS | 1653 | Values: 88.0 87.0 89.0 88.0 94.0 90.0 89.0 90.0 88.0 84.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:95.00 stddev:22.58 (23.8%) stddev-sans-first:23.52 18:32:24 INFO - PROCESS | 1653 | Values: 95.0 95.0 95.0 99.0 145.0 154.0 104.0 95.0 95.0 95.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 18:32:24 INFO - PROCESS | 1653 | Values: 86.0 85.0 87.0 87.0 84.0 85.0 86.0 84.0 85.0 87.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:2.22 (3.9%) stddev-sans-first:2.35 18:32:24 INFO - PROCESS | 1653 | Values: 56.0 54.0 54.0 55.0 54.0 58.0 58.0 56.0 59.0 60.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:71.50 stddev:2.73 (3.8%) stddev-sans-first:2.24 18:32:24 INFO - PROCESS | 1653 | Values: 65.0 72.0 72.0 74.0 71.0 69.0 68.0 68.0 68.0 72.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:84.50 stddev:5.34 (6.3%) stddev-sans-first:5.58 18:32:24 INFO - PROCESS | 1653 | Values: 84.0 86.0 86.0 83.0 84.0 85.0 84.0 89.0 84.0 101.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:142.00 stddev:9.13 (6.4%) stddev-sans-first:9.47 18:32:24 INFO - PROCESS | 1653 | Values: 137.0 141.0 139.0 143.0 145.0 145.0 133.0 138.0 166.0 137.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:168.00 stddev:26.32 (15.7%) stddev-sans-first:27.74 18:32:24 INFO - PROCESS | 1653 | Values: 168.0 168.0 166.0 168.0 163.0 150.0 218.0 232.0 166.0 166.0 18:32:24 INFO - PROCESS | 1653 | 18:32:24 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.50 stddev:7.61 (10.6%) stddev-sans-first:7.86 18:32:24 INFO - PROCESS | 1653 | Values: 67.0 66.0 66.0 66.0 66.0 66.0 76.0 82.0 82.0 82.0 18:32:24 INFO - PROCESS | 1653 | -------- Summary: end -------- 18:32:24 INFO - PROCESS | 1653 | 18:32:25 INFO - TEST-INFO | 1653: exit 0 18:32:25 INFO - TEST-OK | kraken | took 59079ms 18:32:25 INFO - SUITE-END | took 1177s 18:32:25 INFO - Completed test suite (00:19:37) 18:32:25 INFO - javascript benchmark 18:32:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.764046516744, 3389.593248810143, 3391.8643254269846, 3409.8124603146816, 3453.343864665713, 5804.564657650672, 5814.447627475393, 5822.970885145568, 5835.328937172232, 5837.854053648661, 5400.9189862152, 5811.244538210027, 5836.795712150076, 5837.766489340422, 5868.061110222355, 5168.3539557555305, 5241.9213711794355, 5253.947460525404, 5260.105782017066, 5322.361316641989, 5002.624803139779, 5007.949920500803, 5022.422421421528, 5338.06583847827, 5349.277847490597, 5078.060558796616, 5085.771140298695, 5104.464031276718, 5125.974370128163, 5244.134717771563, 5281.392639846409, 5292.52367286946, 5299.867503312409, 5326.467353264681, 5331.173668081454, 5157.11765205701, 5250.343707036621, 5255.658382205144, 5258.973705131488, 5285.392179899322, 5531.280933478622, 5608.130739735348, 5741.655500669973, 5760.7695692172265, 5824.068149096167, 6212.378762123797, 6259.968700156515, 6260.248770147566, 6270.46701030413, 6301.0, 6202.131701561785, 6260.686965651699, 6272.56092073555, 6279.309275979638, 6298.023806309983, 5900.026495628216, 5933.584649074566, 5944.10838374243, 5946.89982353266, 5965.940340596539, 6189.690515474208, 6229.0, 6267.9373206267355, 6295.24457065146, 6351.0, 6285.0, 6289.7169627366875, 6302.684865756693, 6316.747330106836, 6329.525285603599, 6159.815205543751, 6271.874562508724, 6288.465480434214, 6299.401556852092, 6320.5575609706875, 6130.979101202072, 6189.257289125334, 6224.844378890564, 6297.307296197415, 6325.841853953688, 6281.434670879551, 6282.434580887742, 6303.46420554258, 6307.558470906993, 6308.179936608211, 4405.634253381462, 4991.925121123113, 5031.622628302819, 5035.899282014412, 5042.823501177441, 4356.49900261474, 4388.012697143181, 4480.753558554311, 4499.707519011254, 4533.161365147393, 5719.542436605062, 5795.710214489343, 5823.097419899837, 5825.7378417971295, 5879.500242479352, 6175.379174656866, 6197.008478643395, 6240.375962403723, 6247.96876015617, 6256.249250090018, 5690.231818704505, 5737.254156959652, 5756.798512052058, 5819.73811178498, 5855.560832937546, 5491.258680078138, 5505.201745746845, 5506.504414602705, 5511.311086114236, 5537.390887002507, 6334.461570766536, 6340.651264180515, 6350.904736428957, 6351.30135685065, 6353.0, 6174.38256174379, 6216.937830621636, 6239.875202496016, 6251.781187658592, 6271.96864015677, 6304.5586808922935, 6332.841678958063, 6340.461060809883, 6357.4596159326975, 6363.077353783768, 6241.500679945684, 6308.495320374451, 6314.842128946813, 6316.810495685137, 6324.968375158095, 5657.632253903647, 6131.407250743203, 6166.969165154145, 6271.122042913905, 6285.59143655661, 6055.727492262947, 6081.847953801191, 6105.694715264308, 6135.2326666699655, 6147.631142131487, 5994.130851026664, 6007.219061522149, 6118.571699980958, 6131.369379079111, 6158.7228574715145, 5783.277090363705, 5810.970945145247, 5911.91132133027, 6007.12896629995, 6018.21763170785, 6001.2498437695285, 6112.74665817949, 6113.388661133851, 6141.823559979257, 6213.099100630474, 6047.848803779941, 6054.697265136813, 6057.133176207922, 6062.272527296753, 6117.96941015292], "value": 5740.989887767225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.57115452824263, 484.9054434385294, 496.5357390839565, 508.97681715182154, 517.5109521502181, 22280.0, 42501.0, 44306.0, 44516.88707782307, 46601.76699116508, 44961.0, 45608.31587526182, 45611.77194114025, 45695.31457028139, 45782.542174578244, 9347.485888276142, 9551.761205969871, 9558.713238602853, 9561.330706850524, 9562.904370956307, 8580.828383432328, 8774.824503509926, 11466.484008219608, 11688.0, 11698.532058717641, 11676.47455864488, 11729.648110556696, 11765.705857353549, 11773.529058837636, 11788.410579471036, 11596.594119205829, 11676.47455864488, 11677.649670509898, 11694.239874408137, 11698.356590387526, 8546.273566746833, 8742.388032837704, 11380.829287560693, 11551.018163456116, 11587.536498540048, 42790.57209427897, 43023.56976430227, 43166.13667726659, 43236.919077023325, 43324.566754332365, 3846.615338466159, 3967.3255546557157, 3997.380406037069, 4001.239764444746, 4030.496187976503, 30137.547936780968, 30240.546391804142, 30588.54117188244, 31060.844695776603, 31130.066098017094, 2599.3761497240525, 3346.6318704942437, 3353.748468864845, 3355.5302257683943, 3359.9328013439595, 469851.3014869842, 471337.0, 471826.0, 471857.0, 472038.0, 68804.6559767208, 69129.0, 69133.3086669127, 69194.0, 69274.30725692678, 73378.26621733821, 73637.26362736411, 73704.0, 73718.26281737222, 73765.0, 17184.968901865926, 17263.827361726475, 17541.736873946902, 17592.560185995197, 17606.0, 11942.343171125498, 12260.0, 13294.933525332312, 13353.465861365437, 13368.39842207103, 15548.92225538865, 16742.4140155094, 17458.825411745973, 17541.847891815938, 17596.912015440095, 7726.111497177784, 8109.107998120202, 8275.420720549504, 8296.336293096538, 8658.87011694825, 861.9008813986471, 868.5743985447211, 880.6037283222576, 899.2266650680409, 912.183595681861, 31511.794174407572, 31547.369052619277, 31692.207694807814, 31865.681343186734, 32237.032889013368, 748.9737859174903, 1033.204432586919, 1043.3739756146251, 1055.767731099157, 1074.070928646715, 14605.415783368546, 15168.924155379153, 15286.115643916117, 15331.770023449657, 15431.845681543266, 413231.0, 413422.0, 413612.0, 413764.0, 414888.9255553703, 57272.71363643155, 57726.71136644374, 57812.71093644505, 57863.71068144716, 58404.41595584075, 1422.153818478004, 1446.652803327215, 1468.9192094434695, 1478.36430334957, 1479.652281713818, 23519.88240058789, 27686.86156569204, 29511.852440737657, 29711.0, 30299.93950211732, 51722.70693232699, 51877.0, 51911.740441299065, 52008.73995629998, 52015.73992130015, 352514.0, 353377.0, 354446.0, 354781.0, 368139.0, 26388.868055659597, 27051.0, 40729.96350182538, 41303.1739365217, 41435.585644143175, 43509.78245108754, 44315.55684443114, 44998.550014500746, 45068.0, 45342.0, 36566.268674625826, 36621.450678240384, 36790.89627311078, 37826.62173378231, 38150.80924595359, 36233.63766362408, 36442.45336319904, 37286.0, 37319.44020839635, 37533.06167345838, 42764.358534622625, 43947.78026109849, 44092.0, 45527.772361137984, 45532.86167845831, 39091.6090839088, 42706.78646606747, 42779.144417112104, 43689.0, 43987.56012439835, 27600.447991039666, 30844.845775771875, 32297.295278315425, 32635.836820816694, 32799.508007380384], "value": 20471.856957857144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.5406787447815, 386.2429637909695, 389.5597974289053, 394.518687201614, 416.1032973941156, 14739.557813265606, 15214.239288035595, 17933.551661208476, 20173.59652806943, 20765.273215437424, 20554.48613784656, 21235.57528849422, 21367.0, 21955.67066494004, 21964.341069767892, 5295.391030031547, 5475.917861232065, 5479.917801232985, 5483.643563168402, 5992.370801065891, 3908.511436070491, 5962.0, 6064.4541991220785, 6069.666168360738, 6069.939300606981, 4096.32410652242, 6357.141785858896, 6642.800715978528, 6703.731850725965, 6757.526973111884, 6089.725962331706, 6166.7533298667995, 6248.187735594389, 6739.6293203873765, 6759.695813688396, 5968.283805943272, 5969.194158788551, 5973.581849270553, 5986.0, 6002.729877155539, 16696.165191740365, 25143.37141571457, 25160.874195629087, 25243.49513009748, 25451.61822572663, 2847.6440444944383, 2916.7958242923005, 2969.8663560139844, 2994.1317018064733, 3019.667836537979, 9974.800503989953, 10150.086492215736, 10181.03280188381, 10391.324563903323, 10500.78998420035, 1739.7564340992271, 1822.8723989320754, 1848.8243616856378, 1923.2018712234405, 1930.0735646889432, 141223.29388352993, 142681.57318426788, 147945.0, 148738.0, 150972.2451387736, 10032.44821534808, 11694.181407301578, 11756.529738810523, 11931.284122952477, 12191.207571507824, 15862.682746345008, 15988.840111598734, 15996.200189990454, 16012.199390030451, 16050.438234661731, 8709.651613935499, 8833.116688331116, 8874.068222836639, 8876.334274929406, 8932.06213347589, 8582.914170858212, 8678.175573320525, 8689.478631282143, 8811.206991370807, 8867.822643547222, 4783.354247176587, 4788.856334309976, 4798.752324395612, 4799.448063472675, 4863.9513604864205, 1724.8102708702033, 1790.4091649755549, 1959.6472634925851, 1975.4073777866583, 2025.4531276555542, 982.7346616413529, 1011.2365164300905, 1019.4444028004755, 1027.0448482910965, 1065.2330322168027, 20919.8954005229, 21502.032408541654, 21533.0, 21534.784652153277, 21549.0, 1018.2159737002466, 1042.6976176908763, 1042.7288904884786, 1048.3605000949415, 1056.4506456642657, 9596.9040309596, 10876.0, 10928.267933016747, 10962.068224201032, 10970.341779493256, 742016.0, 747174.2641286759, 754398.0, 755552.0, 758284.0, 136624.0, 141823.0, 154987.0, 156061.0, 162592.0, 936.2509992006368, 1018.3737001744022, 1052.400131924811, 1075.349413604758, 1078.013617539942, 19722.605547888674, 20212.595748084663, 20218.79781202228, 20221.59556808826, 20275.0, 51126.23310650269, 55093.72453137708, 60366.094508581526, 62020.689896550226, 62250.066249007206, 86890.56554717438, 87328.12375089925, 87758.0, 89171.0, 90622.64066038883, 7418.443616728659, 7867.9606601966625, 8194.30348420367, 8350.58247087631, 8480.491170529787, 8965.058668839678, 9216.30877684163, 12471.127021108436, 12487.93756031214, 13081.411336490071, 7565.713828649253, 7735.342495887912, 7974.322182614543, 8196.0, 8311.459755115899, 6838.803209438229, 7444.441666875115, 7558.886616700644, 7863.095743989285, 8215.712450064219, 7842.333401660922, 8106.83786324282, 8170.673173073011, 8213.876791848008, 8278.213569710868, 12546.811797823222, 12876.549320774102, 12945.805812912626, 13012.544560940321, 13250.403731832284, 11613.6515904523, 11759.470823812779, 11886.28682279066, 11895.881041189477, 12066.0], "value": 9830.960753552052, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.5655075202071, 1440.2222799688168, 1452.789345544896, 1460.8758255548278, 1467.2150399536251, 7974.561399123053, 8336.333093352532, 8338.082810890797, 8359.414840961135, 8373.706920257791, 7387.482876198668, 7617.46677732559, 7848.48984815988, 8117.431779775418, 8119.106898241189, 2265.0939624150305, 2303.55080759252, 2309.203324852923, 2312.6415405612156, 2313.4332088638225, 1965.1648049578944, 2307.538492301538, 2327.2320134355623, 2332.8133749300014, 2339.7075365579303, 2273.7271527416733, 2290.713660792401, 2300.275413244831, 2325.5697695926224, 2329.650552417134, 2284.9543009139807, 2305.101010605865, 2307.734610519778, 2308.792208701208, 2308.9307320780317, 2017.5863947890793, 2239.3505883293824, 2329.0800133947164, 2337.7194736631714, 2338.6024375856146, 8221.79445513861, 8274.710385136492, 8279.420440569163, 8279.50322980623, 8289.461185023014, 4638.420197475316, 4781.043791241731, 4783.210770222909, 4784.66507344486, 4790.0, 3135.146592671823, 3288.96711032889, 3420.7776494527775, 3442.5008373785913, 3490.6509349065145, 1160.9825852612219, 1166.9883301166965, 1195.3903509210365, 1196.4795314038422, 1213.6783752305646, 8774.60514276859, 10474.004969527883, 10476.371417714885, 10479.161667066617, 10498.737531561696, 4375.387445757597, 4567.954320456753, 4653.069386122789, 4661.673682842236, 4664.39362882823, 8351.624176912053, 8969.56486962083, 9283.442993420416, 9292.256619470427, 9333.346665733468, 5175.4824517548695, 5175.508326708957, 5185.248139019821, 5190.403103643054, 5193.584513239008, 3868.7678739275734, 4085.0, 4184.665226781911, 4649.69776964503, 4754.5245475452175, 3787.905302367463, 3790.223004284115, 3866.9613303867163, 3880.689544836406, 3912.628300311466, 1259.716563773162, 1264.2477725753163, 1271.0911698135876, 1281.1736430002595, 1288.5168061976758, 766.7048186448258, 850.7065062553532, 899.4288626722079, 902.5938327752538, 920.1534588178891, 5308.23030660552, 5437.211604317352, 5599.832005039855, 5756.079027355603, 5992.820215393545, 943.7027336389016, 969.2052516936045, 994.5822754443006, 995.7261753017978, 1028.475477506477, 3581.5344005279667, 3620.4931309616672, 3627.2745450909924, 3744.0826997385816, 3752.81235938202, 9568.712938611852, 9596.808063838684, 9778.217742580577, 9861.654842080492, 9897.0, 9282.582283797245, 9665.90334096664, 9737.56180971858, 9743.0, 9760.121589057018, 7272.709091636381, 7541.8114547135665, 7549.811254718676, 7565.508241964255, 7578.772636820904, 5492.368377636463, 5544.445555444423, 5629.831105066854, 5690.089585666439, 5701.0, 8707.738767836974, 8950.955245223993, 9060.637574496946, 9150.679726209552, 9229.769255768391, 8225.917740822515, 9016.594253258489, 9273.072692730673, 9303.488308143116, 9390.95304523473, 6383.872322553616, 6540.345965403421, 6772.356626120511, 7049.894251586333, 7228.060352154186, 7776.183500732342, 7881.566513841564, 7906.051273847175, 7919.247671471201, 7933.246341597539, 6810.353016463428, 6988.8951665724035, 7002.3697867192195, 7004.019437278887, 7050.294970502909, 5931.762729490944, 6873.931260687329, 6923.757668481579, 6929.307069293232, 6952.061471701256, 6268.623882567061, 6324.272708638381, 6344.651044192429, 6426.967865160645, 6430.807075787734, 4779.593734532604, 4785.760711964457, 4812.157872372391, 4902.632302577393, 4938.8765280868265, 4400.867973960786, 4459.331100334846, 4847.0, 4866.464688884149, 5014.222795466709], "value": 4337.245035377893, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.4859664272416, 345.9619441861395, 353.44332676035253, 357.8425492783175, 368.56444150035594, 4323.913521729572, 4561.977190114053, 4644.187267228234, 4807.620227987151, 5028.195488721801, 4866.270059491078, 4900.705957642535, 4954.3063971044085, 4988.7755051022705, 5032.974835125829, 3975.662068724162, 4006.6394024537785, 4007.5792041835625, 4012.538558065831, 4017.7790221537803, 3496.300739852027, 3615.3788503335136, 4023.9537720192816, 4050.7367021143677, 4059.4722686050773, 3227.967720322802, 3795.3168429682646, 3810.79040652764, 3845.0005996881605, 3881.049142959979, 3002.384511175204, 3518.9296214075703, 3847.1151635123797, 3862.304785138674, 3866.144250759623, 3353.916152096217, 3359.6472370401, 3360.815155166465, 3371.718746876196, 3383.509391138271, 3707.924701836464, 3928.626780455852, 4354.238008348526, 4967.55292023716, 5018.799248030111, 4284.957150428519, 4351.8694439166875, 4576.565226303496, 4612.262038073892, 4656.254999200111, 4458.576435238647, 5354.902245039758, 5363.490468405535, 5366.758495867695, 5405.324379421992, 3822.3884178531302, 3945.8618948336957, 3953.2686453006286, 3993.8602148924647, 4017.6785857131654, 4554.407926969473, 5535.944640553624, 5635.5491560675455, 5653.717314134276, 5734.8243610059835, 4025.772139497423, 4026.7181297309494, 4042.0, 4046.8988275292763, 4067.3695577185586, 4065.7763822989427, 4066.5933406659096, 4068.7762173080173, 4127.161739582218, 4132.5329508024215, 3916.353801622757, 4406.9559304407185, 4536.478304994967, 4541.524004698486, 4622.653301002439, 4515.390422293014, 4615.538446155425, 4959.801607935642, 5334.35949205146, 5453.991011662776, 1148.0700632487712, 1255.2280347586168, 1274.7386785708907, 1317.4927652853721, 1327.5486334646266, 939.6664184214642, 939.9013103624158, 963.7686955130858, 964.9710508684751, 966.897736580299, 4151.398047283127, 4414.0, 4734.0826965079195, 4764.285357196379, 4766.689160480826, 4797.928031079537, 4860.538248866352, 5152.252923326172, 5166.535011848877, 5238.423773384925, 4434.5343738907595, 4537.705049171794, 4548.63540937724, 4758.3100450434495, 4770.42754869411, 2470.394753285421, 2604.6353510508543, 2693.7036925938132, 2709.878055487508, 2735.8905643774424, 4752.105331508552, 4867.921543815229, 5161.045206636709, 5329.18807605416, 5403.621746477709, 4562.61217796491, 4826.0, 5284.656497327738, 5313.601479889024, 5353.724667016502, 4461.665375096881, 5139.6145289102715, 5349.705766182898, 5385.865353366197, 5446.0, 5096.592272618256, 5474.644148130359, 5512.283403157564, 5522.806701765419, 5534.252875861707, 4633.907321853477, 5448.782048718165, 5467.289252397163, 5499.862503437446, 5586.636868603528, 4093.9385909211983, 4605.562471565196, 5300.867478313073, 5329.147336426308, 5701.486866182064, 3682.8895133146048, 3718.950460622372, 3731.9626803731617, 3742.989392863966, 3774.8490060398376, 4820.9517904821905, 5138.8972220556125, 5222.459374484461, 5244.895102098013, 5561.5272701820795, 4867.296446243787, 4951.752412379295, 5000.574951129195, 5228.37259528859, 5333.439908877854, 4362.520122786555, 4899.387576552931, 4994.9750251248515, 5152.608795625085, 5338.57291416678, 5163.173892177234, 5178.585713143015, 5187.028929006953, 5188.247704082812, 5197.142471492161, 5310.840674779763, 5352.421035794372, 5362.597805164706, 5374.973125134349, 5401.432849550898, 4831.685940413862, 4993.725345105909, 4996.300517927566, 5220.441983428169, 5283.735813209248], "value": 3905.27678875913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.1902671441203, 720.762148490998, 728.4682182007135, 785.7878372839333, 836.748975307408, 14276.286185690713, 15392.846071539281, 15416.306266218018, 15422.383104675813, 15427.768583471257, 14080.436782528686, 14294.642633934156, 14323.283835808194, 14326.068805527633, 14328.426862925471, 675.1257122026987, 698.4203111417511, 699.360085521747, 853.5902766671985, 868.2706526517724, 824.6536454689045, 845.213951025546, 850.9489430634151, 858.682287553606, 861.1388611388611, 919.0946917286467, 924.7318277699459, 925.8009527951489, 927.3693888156051, 930.3812964378714, 707.8690442268197, 920.5949382271779, 920.7145784806731, 922.6217250927155, 923.5013092929844, 540.0710777462758, 656.9080328753978, 679.2528218959105, 681.7204945972177, 683.4259222253331, 14746.483873064499, 14989.850101498954, 15033.774493382609, 15083.321250543751, 15111.697766044617, 13264.73470530584, 13272.636815920398, 13285.800712989312, 13382.531611393651, 13455.66360840977, 12035.699107522294, 12068.336241506713, 12145.696357591043, 12229.388530573524, 12593.811092833615, 4260.0, 4260.893477663052, 4403.977980110111, 4436.511983681792, 4535.297028960484, 87043.0, 93575.53212233963, 99528.0, 102195.48902255515, 102217.0, 10478.266521343432, 10536.0, 10552.103071238877, 10694.679159625224, 10746.623868164577, 21265.0, 21278.468038298855, 21303.893480532497, 21605.243816466347, 21636.675449868264, 7176.569405835667, 7347.742829000959, 7363.889541656879, 7581.3934885209055, 7616.961915190389, 3583.086312990171, 4195.769232692171, 4234.343676730112, 4252.957470425256, 4394.890127746768, 3331.1339051846694, 3387.983060084684, 3402.812845293483, 3418.504316874089, 3427.520147179397, 632.0961025733154, 635.2630948100182, 639.5011890725242, 641.8331233879225, 648.3840351665937, 624.3818619566597, 638.6040654793965, 640.8333833203308, 642.7525402719987, 657.4116166031375, 7626.771196864103, 9403.529823508934, 9406.38858474197, 9472.95263523678, 9566.473843938651, 601.7322291580292, 627.8336240896166, 628.9779857704958, 637.7863415755774, 652.8433176037717, 3996.2207369562657, 4390.209762242827, 4396.318570621559, 4705.12955103307, 4806.351142595775, 91519.62720559197, 108647.37028944572, 109138.0, 109252.4537377308, 110995.0, 82331.0, 91396.0, 92661.5366923161, 96626.0, 97602.0, 80084.0, 81490.59254703688, 82405.58349748551, 82953.58523207225, 83511.0, 7957.244061814118, 8652.178043085896, 9081.818363632823, 9159.22146617545, 9272.53637318118, 43300.78349608232, 52553.7372313136, 52908.47091529035, 53108.46891531035, 53596.39210823682, 67262.66368668125, 68477.31522684709, 69729.65135174495, 71772.64113679399, 73124.26875731174, 9678.0, 11096.223264371416, 11136.610218642309, 11274.041706454715, 11518.308901465938, 10578.418186999788, 11026.558937642725, 11755.353455559683, 11973.76052478963, 12149.906508414286, 10616.044555989998, 11177.273477223955, 11376.94311528437, 11399.829002564802, 11483.712907177052, 10880.67357979262, 11153.386563739072, 11275.041621462267, 11311.886881131084, 11375.886241137483, 10437.530311135864, 11026.117910566974, 11106.0, 11192.0, 11435.873975654176, 8531.914680853111, 8905.376623636283, 8905.910940890508, 8948.284137268873, 9156.725298241063, 7046.0, 7389.815254618463, 7734.419918506247, 8561.529115898436, 8936.28509719234], "value": 7102.507925462593, "unit": "score"}], "name": "dromaeo_css", "value": 7197.441762292918, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 113.0, 115.0, 114.0, 114.0, 115.0, 112.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 108.0, 109.0, 142.0, 113.0, 109.0, 107.0, 107.0, 128.0, 132.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 188.0, 184.0, 184.0, 184.0, 184.0, 183.0, 184.0, 184.0, 184.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 60.0, 88.0, 61.0, 59.0, 59.0, 59.0, 73.0, 57.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 85.0, 71.0, 69.0, 69.0, 83.0, 67.0, 70.0, 110.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 88.0, 94.0, 90.0, 89.0, 90.0, 88.0, 84.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 99.0, 145.0, 154.0, 104.0, 95.0, 95.0, 95.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 87.0, 84.0, 85.0, 86.0, 84.0, 85.0, 87.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 55.0, 54.0, 58.0, 58.0, 56.0, 59.0, 60.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 72.0, 74.0, 71.0, 69.0, 68.0, 68.0, 68.0, 72.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 83.0, 84.0, 85.0, 84.0, 89.0, 84.0, 101.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 141.0, 139.0, 143.0, 145.0, 145.0, 133.0, 138.0, 166.0, 137.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 166.0, 168.0, 163.0, 150.0, 218.0, 232.0, 166.0, 166.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 76.0, 82.0, 82.0, 82.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1446.1000000000001, "alertThreshold": 2.0}]} 18:32:25 INFO - Return code: 0 18:32:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:32:25 ERROR - # TBPL SUCCESS # 18:32:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:25 INFO - 2017-03-02 18:32:25.528 screenresolution[1657:10019] starting screenresolution argv=screenresolution get 18:32:25 INFO - 2017-03-02 18:32:25.531 screenresolution[1657:10019] Display 0: 1600x1200x32@60 18:32:25 INFO - 2017-03-02 18:32:25.537 screenresolution[1658:10022] starting screenresolution argv=screenresolution list 18:32:25 INFO - Available Modes on Display 0 18:32:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:25 INFO - Intel Iris: 18:32:25 INFO - Chipset Model: Intel Iris 18:32:25 INFO - Type: GPU 18:32:25 INFO - Bus: Built-In 18:32:25 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:25 INFO - Vendor: Intel (0x8086) 18:32:25 INFO - Device ID: 0x0a2e 18:32:25 INFO - Revision ID: 0x0009 18:32:25 INFO - Displays: 18:32:25 INFO - Display: 18:32:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:25 INFO - Display Serial Number: 1600x1200 60 18:32:25 INFO - Main Display: Yes 18:32:25 INFO - Mirror: Off 18:32:25 INFO - Online: Yes 18:32:25 INFO - Rotation: Supported 18:32:25 INFO - Return code: 0 18:32:25 INFO - Running post-action listener: _resource_record_post_action 18:32:25 INFO - [mozharness: 2017-03-03 02:32:25.780195Z] Finished run-tests step (success) 18:32:25 INFO - Running post-run listener: _resource_record_post_run 18:32:25 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 37954560; Write bytes: 507870720; Read time: 245; Write time: 1588 18:32:25 INFO - TinderboxPrint: CPU usage
53.7% 18:32:25 INFO - TinderboxPrint: I/O read bytes / time
37,954,560 / 245 18:32:25 INFO - TinderboxPrint: I/O write bytes / time
507,870,720 / 1,588 18:32:25 INFO - TinderboxPrint: CPU idle
2,218.3 (46.3%) 18:32:25 INFO - TinderboxPrint: CPU system
956.8 (20.0%) 18:32:25 INFO - TinderboxPrint: CPU user
1,618.6 (33.8%) 18:32:25 INFO - TinderboxPrint: Swap in / out
245,739,520 / 0 18:32:25 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205591040; Write bytes: 199004160; Read time: 15740; Write time: 427 18:32:25 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35886080; Write bytes: 297893376; Read time: 227; Write time: 1124 18:32:26 INFO - Running post-run listener: _upload_blobber_files 18:32:26 INFO - Blob upload gear active. 18:32:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:32:26 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:32:26 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:32:26 INFO - (blobuploader) - INFO - Open directory for files ... 18:32:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:32:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:32:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:27 INFO - (blobuploader) - INFO - Done attempting. 18:32:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:32:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:28 INFO - (blobuploader) - INFO - Done attempting. 18:32:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:32:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:32:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:29 INFO - (blobuploader) - INFO - Done attempting. 18:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:32:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:32 INFO - (blobuploader) - INFO - Done attempting. 18:32:32 INFO - (blobuploader) - INFO - Iteration through files over. 18:32:32 INFO - Return code: 0 18:32:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:32:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:32:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04bac626768acdc93dfcd45d4dc8d20dec609d6a5aa7f5a33ba2d16a0aa47598a4d0d1925e90126ac9f1a3f8f698e3c37581edf9282afa2df27d03f1975f4599", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b1576d6f628ac16c9918abbc93a70a9c9e5aac0ba63c7269d726b6d8f673222082acbb894bc0e5f3cca6448634e5c1735d1e3d3f929a7967d97fc7ae6a32159", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fa523ba85b1d8b36eb34be5dd57418d67b9fbc1bc49febd2f4cf545f87c0dac22f3d83270b3a6ea99d12a8e183d3bce1357eefe7406627508f8181be937791b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56581764fa8c13e97bf26dbb74f73b7304e843e43686b20e6f7cc0293a2210249cc9b9815aa2dc51b3be4aa622f5e37e51a236f830f6479ff58e79585b3be77e"} 18:32:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:32 INFO - Contents: 18:32:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04bac626768acdc93dfcd45d4dc8d20dec609d6a5aa7f5a33ba2d16a0aa47598a4d0d1925e90126ac9f1a3f8f698e3c37581edf9282afa2df27d03f1975f4599", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b1576d6f628ac16c9918abbc93a70a9c9e5aac0ba63c7269d726b6d8f673222082acbb894bc0e5f3cca6448634e5c1735d1e3d3f929a7967d97fc7ae6a32159", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fa523ba85b1d8b36eb34be5dd57418d67b9fbc1bc49febd2f4cf545f87c0dac22f3d83270b3a6ea99d12a8e183d3bce1357eefe7406627508f8181be937791b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56581764fa8c13e97bf26dbb74f73b7304e843e43686b20e6f7cc0293a2210249cc9b9815aa2dc51b3be4aa622f5e37e51a236f830f6479ff58e79585b3be77e"} 18:32:32 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:32 INFO - Copying logs to upload dir... 18:32:32 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.455232 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-02 18:32:32.436581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 18:32:32.440599) ========= 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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04bac626768acdc93dfcd45d4dc8d20dec609d6a5aa7f5a33ba2d16a0aa47598a4d0d1925e90126ac9f1a3f8f698e3c37581edf9282afa2df27d03f1975f4599", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b1576d6f628ac16c9918abbc93a70a9c9e5aac0ba63c7269d726b6d8f673222082acbb894bc0e5f3cca6448634e5c1735d1e3d3f929a7967d97fc7ae6a32159", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fa523ba85b1d8b36eb34be5dd57418d67b9fbc1bc49febd2f4cf545f87c0dac22f3d83270b3a6ea99d12a8e183d3bce1357eefe7406627508f8181be937791b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56581764fa8c13e97bf26dbb74f73b7304e843e43686b20e6f7cc0293a2210249cc9b9815aa2dc51b3be4aa622f5e37e51a236f830f6479ff58e79585b3be77e"} build_url:https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010880 build_url: 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04bac626768acdc93dfcd45d4dc8d20dec609d6a5aa7f5a33ba2d16a0aa47598a4d0d1925e90126ac9f1a3f8f698e3c37581edf9282afa2df27d03f1975f4599", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b1576d6f628ac16c9918abbc93a70a9c9e5aac0ba63c7269d726b6d8f673222082acbb894bc0e5f3cca6448634e5c1735d1e3d3f929a7967d97fc7ae6a32159", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fa523ba85b1d8b36eb34be5dd57418d67b9fbc1bc49febd2f4cf545f87c0dac22f3d83270b3a6ea99d12a8e183d3bce1357eefe7406627508f8181be937791b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56581764fa8c13e97bf26dbb74f73b7304e843e43686b20e6f7cc0293a2210249cc9b9815aa2dc51b3be4aa622f5e37e51a236f830f6479ff58e79585b3be77e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 18:32:32.475353) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:32:32.475772) ========= 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.Wqf5QHiR6S/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.dz4pYS7fi2/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005185 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:32:32.525203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 18:32:32.525611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 18:32:32.526066) ========= ========= Total master_lag: 0.18 =========