builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0225 starttime: 1484403386.98 results: success (0) buildid: 20170114031023 builduid: 6326925ecc4c44f1ac37b78bdaf455d0 revision: 64b8f9218c9894223a9ae02c43de6643bd97c98d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:26.979320) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:26.979727) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2017-01-14 06:16:26.979998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2017-01-14 06:16:29.537352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:29.540722) ========= 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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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-01-14 06:16:29-- 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% 164M=0s 2017-01-14 06:16:29 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126799 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:29.699163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:29.699499) ========= 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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.024657 ========= master_lag: 0.92 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:30.648360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-14 06:16:30.652864) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 64b8f9218c9894223a9ae02c43de6643bd97c98d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 64b8f9218c9894223a9ae02c43de6643bd97c98d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kp6LnoVzNN/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.9CL8sbeaHF/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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-01-14 06:16:30,752 truncating revision to first 12 chars 2017-01-14 06:16:30,752 Setting DEBUG logging. 2017-01-14 06:16:30,752 attempt 1/10 2017-01-14 06:16:30,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/64b8f9218c98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-14 06:16:32,584 unpacking tar archive at: mozilla-beta-64b8f9218c98/testing/mozharness/ program finished with exit code 0 elapsedTime=2.121708 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-14 06:16:32.799089) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:32.799411) ========= script_repo_revision: 64b8f9218c9894223a9ae02c43de6643bd97c98d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:32.799796) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:32.800068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 06:16:32.820987) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-14 06:16:32.821384) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kp6LnoVzNN/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.9CL8sbeaHF/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:16:33 INFO - MultiFileLogger online at 20170114 06:16:33 in /builds/slave/test 06:16:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:16:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:16:33 INFO - {'append_to_log': False, 06:16:33 INFO - 'base_work_dir': '/builds/slave/test', 06:16:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:16:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:16:33 INFO - 'branch': 'Mozilla-Beta', 06:16:33 INFO - 'buildbot_json_path': 'buildprops.json', 06:16:33 INFO - 'config_files': ('talos/mac_config.py',), 06:16:33 INFO - 'default_actions': ('clobber', 06:16:33 INFO - 'read-buildbot-config', 06:16:33 INFO - 'download-and-extract', 06:16:33 INFO - 'populate-webroot', 06:16:33 INFO - 'create-virtualenv', 06:16:33 INFO - 'install', 06:16:33 INFO - 'run-tests'), 06:16:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:16:33 INFO - 'download_minidump_stackwalk': True, 06:16:33 INFO - 'download_symbols': 'ondemand', 06:16:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:16:33 INFO - 'tooltool.py': '/tools/tooltool.py', 06:16:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:16:33 INFO - '/tools/misc-python/virtualenv.py')}, 06:16:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:16:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:16:33 INFO - 'installer_path': 'installer.exe', 06:16:33 INFO - 'log_level': 'info', 06:16:33 INFO - 'log_name': 'talos', 06:16:33 INFO - 'log_to_console': True, 06:16:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:16:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:16:33 INFO - 'opt_config_files': (), 06:16:33 INFO - 'pip_index': False, 06:16:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:16:33 INFO - 'cmd': ('bash', 06:16:33 INFO - '-c', 06:16:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:16:33 INFO - 'enabled': True, 06:16:33 INFO - 'halt_on_failure': False, 06:16:33 INFO - 'name': 'check_screen_resolution'},), 06:16:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:16:33 INFO - 'cmd': ('bash', 06:16:33 INFO - '-c', 06:16:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:16:33 INFO - 'enabled': True, 06:16:33 INFO - 'halt_on_failure': False, 06:16:33 INFO - 'name': 'check_screen_resolution'},), 06:16:33 INFO - 'run_cmd_checks_enabled': True, 06:16:33 INFO - 'sps_profile': False, 06:16:33 INFO - 'sps_profile_interval': 0, 06:16:33 INFO - 'suite': 'dromaeojs', 06:16:33 INFO - 'system_bits': '32', 06:16:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:16:33 INFO - 'title': 't-yosemite-r7-0225', 06:16:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:16:33 INFO - 'use_talos_json': True, 06:16:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:16:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:16:33 INFO - 'work_dir': 'build'} 06:16:33 INFO - [mozharness: 2017-01-14 14:16:33.038604Z] Running clobber step. 06:16:33 INFO - Running pre-action listener: _resource_record_pre_action 06:16:33 INFO - Running main action method: clobber 06:16:33 INFO - rmtree: /builds/slave/test/build 06:16:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:16:35 INFO - Running post-action listener: _resource_record_post_action 06:16:35 INFO - [mozharness: 2017-01-14 14:16:35.461151Z] Finished clobber step (success) 06:16:35 INFO - [mozharness: 2017-01-14 14:16:35.461281Z] Running read-buildbot-config step. 06:16:35 INFO - Running pre-action listener: _resource_record_pre_action 06:16:35 INFO - Running main action method: read_buildbot_config 06:16:35 INFO - Using buildbot properties: 06:16:35 INFO - { 06:16:35 INFO - "project": "", 06:16:35 INFO - "product": "firefox", 06:16:35 INFO - "script_repo_revision": "production", 06:16:35 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:16:35 INFO - "repository": "", 06:16:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:16:35 INFO - "buildid": "20170114031023", 06:16:35 INFO - "pgo_build": "False", 06:16:35 INFO - "basedir": "/builds/slave/test", 06:16:35 INFO - "buildnumber": 29, 06:16:35 INFO - "slavename": "t-yosemite-r7-0225", 06:16:35 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:16:35 INFO - "platform": "yosemite_r7", 06:16:35 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:16:35 INFO - "branch": "mozilla-beta", 06:16:35 INFO - "repo_path": "releases/mozilla-beta", 06:16:35 INFO - "revision": "64b8f9218c9894223a9ae02c43de6643bd97c98d", 06:16:35 INFO - "stage_platform": "macosx64", 06:16:35 INFO - "builduid": "6326925ecc4c44f1ac37b78bdaf455d0", 06:16:35 INFO - "slavebuilddir": "test" 06:16:35 INFO - } 06:16:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 06:16:35 INFO - Running post-action listener: _resource_record_post_action 06:16:35 INFO - [mozharness: 2017-01-14 14:16:35.464747Z] Finished read-buildbot-config step (success) 06:16:35 INFO - [mozharness: 2017-01-14 14:16:35.464889Z] Running download-and-extract step. 06:16:35 INFO - Running pre-action listener: _resource_record_pre_action 06:16:35 INFO - Running main action method: download_and_extract 06:16:35 INFO - mkdir: /builds/slave/test/build/tests 06:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:35 INFO - trying https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 06:16:35 INFO - Downloading https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 06:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 06:16:36 INFO - Downloaded 1165 bytes. 06:16:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 06:16:36 INFO - Using the following test package requirements: 06:16:36 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 06:16:36 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:16:36 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 06:16:36 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:16:36 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 06:16:36 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:16:36 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:16:36 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 06:16:36 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 06:16:36 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:16:36 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 06:16:36 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:16:36 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 06:16:36 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:16:36 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 06:16:36 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:16:36 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 06:16:36 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 06:16:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 06:16:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 06:16:36 INFO - Fetch https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 06:16:37 INFO - Expected file size: 16236152 06:16:44 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:16:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 06:16:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 06:16:44 INFO - Fetch https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 06:16:44 INFO - Expected file size: 16236152 06:16:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 06:16:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 06:16:51 INFO - Fetch https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 06:16:52 INFO - Expected file size: 14414089 06:16:53 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')]} 06:16:53 INFO - trying https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 06:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 06:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 06:16:55 INFO - Downloaded 86171390 bytes. 06:16:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 06:16:55 INFO - mkdir: /builds/slave/test/properties 06:16:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:16:55 INFO - Writing to file /builds/slave/test/properties/build_url 06:16:55 INFO - Contents: 06:16:55 INFO - build_url:https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 06:16:56 INFO - Running post-action listener: _resource_record_post_action 06:16:56 INFO - Running post-action listener: set_extra_try_arguments 06:16:56 INFO - [mozharness: 2017-01-14 14:16:56.008153Z] Finished download-and-extract step (success) 06:16:56 INFO - [mozharness: 2017-01-14 14:16:56.008291Z] Running populate-webroot step. 06:16:56 INFO - Running pre-action listener: _resource_record_pre_action 06:16:56 INFO - Running main action method: populate_webroot 06:16:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:16:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:16:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:16:56 INFO - '--tppagecycles', 06:16:56 INFO - '7'], 06:16:56 INFO - 'tests': ['tsvgm']}}, 06:16:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:16:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:16:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:16:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:16:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:56 INFO - 'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:16:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:16:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:56 INFO - 'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['damp', 'tps']}, 06:16:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:56 INFO - 'tests': ['damp', 'tps']}, 06:16:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['dromaeo_dom']}, 06:16:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:16:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['basic_compositor_video']}, 06:16:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:16:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['a11yr', 06:16:56 INFO - 'ts_paint', 06:16:56 INFO - 'tpaint', 06:16:56 INFO - 'sessionrestore', 06:16:56 INFO - 'sessionrestore_no_auto_restore', 06:16:56 INFO - 'tabpaint']}, 06:16:56 INFO - 'other-e10s': {'tests': ['a11yr', 06:16:56 INFO - 'ts_paint', 06:16:56 INFO - 'tpaint', 06:16:56 INFO - 'sessionrestore', 06:16:56 INFO - 'sessionrestore_no_auto_restore', 06:16:56 INFO - 'tabpaint']}, 06:16:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:16:56 INFO - 'ts_paint', 06:16:56 INFO - 'tpaint', 06:16:56 INFO - 'sessionrestore', 06:16:56 INFO - 'sessionrestore_no_auto_restore', 06:16:56 INFO - 'tabpaint']}, 06:16:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:16:56 INFO - 'ts_paint', 06:16:56 INFO - 'tpaint', 06:16:56 INFO - 'sessionrestore', 06:16:56 INFO - 'sessionrestore_no_auto_restore', 06:16:56 INFO - 'tabpaint']}, 06:16:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['a11yr', 06:16:56 INFO - 'ts_paint', 06:16:56 INFO - 'tpaint', 06:16:56 INFO - 'sessionrestore', 06:16:56 INFO - 'sessionrestore_no_auto_restore', 06:16:56 INFO - 'tabpaint']}, 06:16:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['a11yr', 06:16:56 INFO - 'ts_paint', 06:16:56 INFO - 'tpaint', 06:16:56 INFO - 'sessionrestore', 06:16:56 INFO - 'sessionrestore_no_auto_restore', 06:16:56 INFO - 'tabpaint']}, 06:16:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['tsvgx', 06:16:56 INFO - 'tsvgr_opacity', 06:16:56 INFO - 'tart', 06:16:56 INFO - 'tscrollx', 06:16:56 INFO - 'cart']}, 06:16:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:16:56 INFO - 'tsvgr_opacity', 06:16:56 INFO - 'tart', 06:16:56 INFO - 'tscrollx', 06:16:56 INFO - 'cart']}, 06:16:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:56 INFO - 'talos_options': ['--disable-e10s'], 06:16:56 INFO - 'tests': ['tp5o']}, 06:16:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:56 INFO - 'tests': ['tp5o']}, 06:16:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:56 INFO - 'talos_options': ['--disable-e10s', 06:16:56 INFO - '--xperf_path', 06:16:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:16:56 INFO - 'tests': ['tp5n']}, 06:16:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:56 INFO - 'talos_options': ['--xperf_path', 06:16:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:16:56 INFO - 'tests': ['tp5n']}}, 06:16:56 INFO - 'talos.zip': {'path': '', 06:16:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:16:56 INFO - Running post-action listener: _resource_record_post_action 06:16:56 INFO - [mozharness: 2017-01-14 14:16:56.027347Z] Finished populate-webroot step (success) 06:16:56 INFO - [mozharness: 2017-01-14 14:16:56.027486Z] Running create-virtualenv step. 06:16:56 INFO - Running pre-action listener: _resource_record_pre_action 06:16:56 INFO - Running main action method: create_virtualenv 06:16:56 INFO - Creating virtualenv /builds/slave/test/build/venv 06:16:56 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 06:16:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:16:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:16:56 INFO - Using real prefix '/tools/python27' 06:16:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:16:56 INFO - Installing distribute.............................................................................................................................................................................................done. 06:16:59 INFO - Installing pip.................done. 06:16:59 INFO - Return code: 0 06:16:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:16:59 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')]} 06:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:59 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')]} 06:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:59 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 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:16:59 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 06:16:59 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 06:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:16:59 INFO - 'HOME': '/Users/cltbld', 06:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:16:59 INFO - 'LOGNAME': 'cltbld', 06:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:59 INFO - 'MOZ_NO_REMOTE': '1', 06:16:59 INFO - 'NO_EM_RESTART': '1', 06:16:59 INFO - 'PAGER': '/bin/cat', 06:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:59 INFO - 'PWD': '/builds/slave/test', 06:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:16:59 INFO - 'SHELL': '/bin/bash', 06:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:16:59 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:16:59 INFO - 'USER': 'cltbld', 06:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:59 INFO - 'XPC_FLAGS': '0x0', 06:16:59 INFO - 'XPC_SERVICE_NAME': '0', 06:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:59 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 06:16:59 INFO - Cleaning up... 06:16:59 INFO - Return code: 0 06:16:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:16:59 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')]} 06:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:00 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')]} 06:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:00 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 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:17:00 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 06:17:00 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 06:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:00 INFO - 'HOME': '/Users/cltbld', 06:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:00 INFO - 'LOGNAME': 'cltbld', 06:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:00 INFO - 'MOZ_NO_REMOTE': '1', 06:17:00 INFO - 'NO_EM_RESTART': '1', 06:17:00 INFO - 'PAGER': '/bin/cat', 06:17:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:00 INFO - 'PWD': '/builds/slave/test', 06:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:00 INFO - 'SHELL': '/bin/bash', 06:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:00 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:00 INFO - 'USER': 'cltbld', 06:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:00 INFO - 'XPC_FLAGS': '0x0', 06:17:00 INFO - 'XPC_SERVICE_NAME': '0', 06:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:00 INFO - Downloading/unpacking psutil>=3.1.1 06:17:00 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 06:17:00 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 06:17:00 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 06:17:00 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 06:17:00 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 06:17:00 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 06:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:03 INFO - Installing collected packages: psutil 06:17:03 INFO - Running setup.py install for psutil 06:17:03 INFO - building 'psutil._psutil_osx' extension 06:17:03 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 06:17:04 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 06:17:04 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 06:17:04 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 06:17:04 INFO - building 'psutil._psutil_posix' extension 06:17:04 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 06:17:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:17:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:17:04 INFO - ^ 06:17:04 INFO - 1 warning generated. 06:17:04 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 06:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:04 INFO - Successfully installed psutil 06:17:04 INFO - Cleaning up... 06:17:04 INFO - Return code: 0 06:17:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:04 INFO - 'HOME': '/Users/cltbld', 06:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:04 INFO - 'LOGNAME': 'cltbld', 06:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:04 INFO - 'MOZ_NO_REMOTE': '1', 06:17:04 INFO - 'NO_EM_RESTART': '1', 06:17:04 INFO - 'PAGER': '/bin/cat', 06:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:04 INFO - 'PWD': '/builds/slave/test', 06:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:04 INFO - 'SHELL': '/bin/bash', 06:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:04 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:04 INFO - 'USER': 'cltbld', 06:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:04 INFO - 'XPC_FLAGS': '0x0', 06:17:04 INFO - 'XPC_SERVICE_NAME': '0', 06:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:17:07 INFO - Installing collected packages: mozsystemmonitor 06:17:07 INFO - Running setup.py install for mozsystemmonitor 06:17:08 INFO - Successfully installed mozsystemmonitor 06:17:08 INFO - Cleaning up... 06:17:08 INFO - Return code: 0 06:17:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:08 INFO - 'HOME': '/Users/cltbld', 06:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:08 INFO - 'LOGNAME': 'cltbld', 06:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:08 INFO - 'MOZ_NO_REMOTE': '1', 06:17:08 INFO - 'NO_EM_RESTART': '1', 06:17:08 INFO - 'PAGER': '/bin/cat', 06:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:08 INFO - 'PWD': '/builds/slave/test', 06:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:08 INFO - 'SHELL': '/bin/bash', 06:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:08 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:08 INFO - 'USER': 'cltbld', 06:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:08 INFO - 'XPC_FLAGS': '0x0', 06:17:08 INFO - 'XPC_SERVICE_NAME': '0', 06:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:08 INFO - Downloading/unpacking jsonschema==2.5.1 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:17:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:11 INFO - Downloading functools32-3.2.3-2.tar.gz 06:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:17:11 INFO - warning: no files found matching '*.txt' 06:17:11 INFO - no previously-included directories found matching 'build' 06:17:11 INFO - no previously-included directories found matching 'dist' 06:17:11 INFO - no previously-included directories found matching '.git*' 06:17:11 INFO - Installing collected packages: jsonschema, functools32 06:17:11 INFO - Running setup.py install for functools32 06:17:11 INFO - warning: no files found matching '*.txt' 06:17:11 INFO - no previously-included directories found matching 'build' 06:17:11 INFO - no previously-included directories found matching 'dist' 06:17:11 INFO - no previously-included directories found matching '.git*' 06:17:11 INFO - Successfully installed jsonschema functools32 06:17:11 INFO - Cleaning up... 06:17:11 INFO - Return code: 0 06:17:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:17:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:17:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:11 INFO - 'HOME': '/Users/cltbld', 06:17:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:11 INFO - 'LOGNAME': 'cltbld', 06:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:11 INFO - 'MOZ_NO_REMOTE': '1', 06:17:11 INFO - 'NO_EM_RESTART': '1', 06:17:11 INFO - 'PAGER': '/bin/cat', 06:17:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:11 INFO - 'PWD': '/builds/slave/test', 06:17:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:11 INFO - 'SHELL': '/bin/bash', 06:17:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:11 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:11 INFO - 'USER': 'cltbld', 06:17:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:11 INFO - 'XPC_FLAGS': '0x0', 06:17:11 INFO - 'XPC_SERVICE_NAME': '0', 06:17:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:17:12 INFO - Cleaning up... 06:17:12 INFO - Return code: 0 06:17:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:12 INFO - 'HOME': '/Users/cltbld', 06:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:12 INFO - 'LOGNAME': 'cltbld', 06:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:12 INFO - 'MOZ_NO_REMOTE': '1', 06:17:12 INFO - 'NO_EM_RESTART': '1', 06:17:12 INFO - 'PAGER': '/bin/cat', 06:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:12 INFO - 'PWD': '/builds/slave/test', 06:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:12 INFO - 'SHELL': '/bin/bash', 06:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:12 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:12 INFO - 'USER': 'cltbld', 06:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:12 INFO - 'XPC_FLAGS': '0x0', 06:17:12 INFO - 'XPC_SERVICE_NAME': '0', 06:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:12 INFO - Downloading/unpacking blobuploader==1.2.4 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17:14 INFO - Downloading blobuploader-1.2.4.tar.gz 06:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:17:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:17:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:16 INFO - Downloading docopt-0.6.1.tar.gz 06:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:17:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:17:16 INFO - Running setup.py install for blobuploader 06:17:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:17:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:17:16 INFO - Running setup.py install for requests 06:17:16 INFO - Running setup.py install for docopt 06:17:17 INFO - Successfully installed blobuploader requests docopt 06:17:17 INFO - Cleaning up... 06:17:17 INFO - Return code: 0 06:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:17 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 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:17:17 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 06:17:17 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 06:17:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:17 INFO - 'HOME': '/Users/cltbld', 06:17:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:17 INFO - 'LOGNAME': 'cltbld', 06:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:17 INFO - 'MOZ_NO_REMOTE': '1', 06:17:17 INFO - 'NO_EM_RESTART': '1', 06:17:17 INFO - 'PAGER': '/bin/cat', 06:17:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:17 INFO - 'PWD': '/builds/slave/test', 06:17:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:17 INFO - 'SHELL': '/bin/bash', 06:17:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:17 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:17 INFO - 'USER': 'cltbld', 06:17:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:17 INFO - 'XPC_FLAGS': '0x0', 06:17:17 INFO - 'XPC_SERVICE_NAME': '0', 06:17:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-CAtlGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-a5PXeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-noZb5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-8gjhU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-8erFqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-yjTCVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:17 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-f87WnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-e_G8nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-A6RuKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-xglbyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-gdI6NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-_moVzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-3S9c0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-BQkk_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-jpDjrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-x50RM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-xHVH0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:17:19 INFO - Running setup.py install for manifestparser 06:17:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:17:19 INFO - Running setup.py install for mozcrash 06:17:19 INFO - Running setup.py install for mozdebug 06:17:19 INFO - Running setup.py install for mozdevice 06:17:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:17:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:17:19 INFO - Running setup.py install for mozfile 06:17:19 INFO - Running setup.py install for mozhttpd 06:17:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:17:20 INFO - Running setup.py install for mozinfo 06:17:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:17:20 INFO - Running setup.py install for mozInstall 06:17:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:17:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:17:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:17:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:17:20 INFO - Running setup.py install for mozleak 06:17:20 INFO - Running setup.py install for mozlog 06:17:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:17:20 INFO - Running setup.py install for moznetwork 06:17:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:17:20 INFO - Running setup.py install for mozprocess 06:17:20 INFO - Running setup.py install for mozprofile 06:17:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:17:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:17:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:17:21 INFO - Running setup.py install for mozrunner 06:17:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:17:21 INFO - Running setup.py install for mozscreenshot 06:17:21 INFO - Running setup.py install for moztest 06:17:21 INFO - Running setup.py install for mozversion 06:17:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:17:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:17:21 INFO - Cleaning up... 06:17:21 INFO - Return code: 0 06:17:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:22 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')]} 06:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:22 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 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:17:22 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 06:17:22 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 06:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:22 INFO - 'HOME': '/Users/cltbld', 06:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:22 INFO - 'LOGNAME': 'cltbld', 06:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:22 INFO - 'MOZ_NO_REMOTE': '1', 06:17:22 INFO - 'NO_EM_RESTART': '1', 06:17:22 INFO - 'PAGER': '/bin/cat', 06:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:22 INFO - 'PWD': '/builds/slave/test', 06:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:22 INFO - 'SHELL': '/bin/bash', 06:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:22 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:22 INFO - 'USER': 'cltbld', 06:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:22 INFO - 'XPC_FLAGS': '0x0', 06:17:22 INFO - 'XPC_SERVICE_NAME': '0', 06:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-yR_qRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:22 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)) 06:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-k0m9SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-IulOTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:22 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)) 06:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-q2aMPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-qSDSHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:22 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)) 06:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-grOUfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:23 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)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-ytEVLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:23 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)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-iQIyED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:23 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)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-c7iiQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:23 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)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-dZqMkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:23 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)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-x8hwuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:23 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)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-yLmLtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-6GLT6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:23 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)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-bEtj_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-2qhPFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:23 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)) 06:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:24 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-GfBSYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 06:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:24 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-dCoRMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:24 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)) 06:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:17:24 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)) 06:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:17:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:17:24 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 06:17:24 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 06:17:24 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 06:17:24 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 06:17:24 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 06:17:24 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 06:17:27 INFO - Downloading blessings-1.6.tar.gz 06:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:17:27 INFO - Installing collected packages: blessings 06:17:27 INFO - Running setup.py install for blessings 06:17:27 INFO - Successfully installed blessings 06:17:27 INFO - Cleaning up... 06:17:27 INFO - Return code: 0 06:17:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:27 INFO - Reading from file tmpfile_stdout 06:17:27 INFO - Current package versions: 06:17:27 INFO - blessings == 1.6 06:17:27 INFO - blobuploader == 1.2.4 06:17:27 INFO - docopt == 0.6.1 06:17:27 INFO - functools32 == 3.2.3-2 06:17:27 INFO - jsonschema == 2.5.1 06:17:27 INFO - manifestparser == 1.1 06:17:27 INFO - mozInstall == 1.12 06:17:27 INFO - mozcrash == 0.17 06:17:27 INFO - mozdebug == 0.1 06:17:27 INFO - mozdevice == 0.48 06:17:27 INFO - mozfile == 1.2 06:17:27 INFO - mozhttpd == 0.7 06:17:27 INFO - mozinfo == 0.9 06:17:27 INFO - mozleak == 0.1 06:17:27 INFO - mozlog == 3.4 06:17:27 INFO - moznetwork == 0.27 06:17:27 INFO - mozprocess == 0.23 06:17:27 INFO - mozprofile == 0.28 06:17:27 INFO - mozrunner == 6.12 06:17:27 INFO - mozscreenshot == 0.1 06:17:27 INFO - mozsystemmonitor == 0.3 06:17:27 INFO - moztest == 0.7 06:17:27 INFO - mozversion == 1.4 06:17:27 INFO - psutil == 3.1.1 06:17:27 INFO - requests == 1.2.3 06:17:27 INFO - wsgiref == 0.1.2 06:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:27 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')]} 06:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:27 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')]} 06:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:27 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 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:17:27 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 06:17:27 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 06:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:27 INFO - 'HOME': '/Users/cltbld', 06:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:27 INFO - 'LOGNAME': 'cltbld', 06:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:27 INFO - 'MOZ_NO_REMOTE': '1', 06:17:27 INFO - 'NO_EM_RESTART': '1', 06:17:27 INFO - 'PAGER': '/bin/cat', 06:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:27 INFO - 'PWD': '/builds/slave/test', 06:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:27 INFO - 'SHELL': '/bin/bash', 06:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:27 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:27 INFO - 'USER': 'cltbld', 06:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:27 INFO - 'XPC_FLAGS': '0x0', 06:17:27 INFO - 'XPC_SERVICE_NAME': '0', 06:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:28 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)) 06:17:28 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)) 06:17:28 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)) 06:17:28 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)) 06:17:28 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)) 06:17:28 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)) 06:17:28 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)) 06:17:28 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)) 06:17:28 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)) 06:17:28 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)) 06:17:28 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)) 06:17:28 INFO - Cleaning up... 06:17:28 INFO - Return code: 0 06:17:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:17:28 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')]} 06:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:28 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')]} 06:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:28 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 0x10759c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107512570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb85bd98270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, '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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 06:17:28 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 06:17:28 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 06:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:28 INFO - 'HOME': '/Users/cltbld', 06:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:28 INFO - 'LOGNAME': 'cltbld', 06:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:28 INFO - 'MOZ_NO_REMOTE': '1', 06:17:28 INFO - 'NO_EM_RESTART': '1', 06:17:28 INFO - 'PAGER': '/bin/cat', 06:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:28 INFO - 'PWD': '/builds/slave/test', 06:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:28 INFO - 'SHELL': '/bin/bash', 06:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:28 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:28 INFO - 'USER': 'cltbld', 06:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:28 INFO - 'XPC_FLAGS': '0x0', 06:17:28 INFO - 'XPC_SERVICE_NAME': '0', 06:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:17:28 INFO - Cleaning up... 06:17:28 INFO - Return code: 0 06:17:28 INFO - Running post-action listener: _resource_record_post_action 06:17:28 INFO - Running post-action listener: _start_resource_monitoring 06:17:28 INFO - Starting resource monitoring. 06:17:28 INFO - [mozharness: 2017-01-14 14:17:28.407014Z] Finished create-virtualenv step (success) 06:17:28 INFO - [mozharness: 2017-01-14 14:17:28.407958Z] Running install step. 06:17:28 INFO - Running pre-action listener: _resource_record_pre_action 06:17:28 INFO - Running main action method: install 06:17:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:28 INFO - Reading from file tmpfile_stdout 06:17:28 INFO - Detecting whether we're running mozinstall >=1.0... 06:17:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:17:28 INFO - Reading from file tmpfile_stdout 06:17:28 INFO - Output received: 06:17:28 INFO - Usage: mozinstall [options] installer 06:17:28 INFO - Options: 06:17:28 INFO - -h, --help show this help message and exit 06:17:28 INFO - -d DEST, --destination=DEST 06:17:28 INFO - Directory to install application into. [default: 06:17:28 INFO - "/builds/slave/test"] 06:17:28 INFO - --app=APP Application being installed. [default: firefox] 06:17:28 INFO - mkdir: /builds/slave/test/build/application 06:17:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:17:50 INFO - Reading from file tmpfile_stdout 06:17:50 INFO - Output received: 06:17:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:17:50 INFO - Running post-action listener: _resource_record_post_action 06:17:50 INFO - [mozharness: 2017-01-14 14:17:50.325123Z] Finished install step (success) 06:17:50 INFO - [mozharness: 2017-01-14 14:17:50.325252Z] Running run-tests step. 06:17:50 INFO - Running pre-action listener: _resource_record_pre_action 06:17:50 INFO - Running main action method: run_tests 06:17:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:17:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:17:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:17:50 INFO - 2017-01-14 06:17:50.339 screenresolution[1627:7341] starting screenresolution argv=screenresolution get 06:17:50 INFO - 2017-01-14 06:17:50.342 screenresolution[1627:7341] Display 0: 1600x1200x32@60 06:17:50 INFO - 2017-01-14 06:17:50.348 screenresolution[1628:7343] starting screenresolution argv=screenresolution list 06:17:50 INFO - Available Modes on Display 0 06:17:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:17:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:17:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:17:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:17:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:17:50 INFO - Intel Iris: 06:17:50 INFO - Chipset Model: Intel Iris 06:17:50 INFO - Type: GPU 06:17:50 INFO - Bus: Built-In 06:17:50 INFO - VRAM (Dynamic, Max): 1536 MB 06:17:50 INFO - Vendor: Intel (0x8086) 06:17:50 INFO - Device ID: 0x0a2e 06:17:50 INFO - Revision ID: 0x0009 06:17:50 INFO - Displays: 06:17:50 INFO - Display: 06:17:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:17:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:17:50 INFO - Display Serial Number: 1600x1200 60 06:17:50 INFO - Main Display: Yes 06:17:50 INFO - Mirror: Off 06:17:50 INFO - Online: Yes 06:17:50 INFO - Rotation: Supported 06:17:50 INFO - Return code: 0 06:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:17:50 INFO - Python 2.7.3 06:17:50 INFO - Return code: 0 06:17:50 INFO - grabbing minidump binary from tooltool 06:17: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')]} 06:17:50 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 0x1073b0d30>, '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 0x107216db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:17:50 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 06:17:50 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 06:17:50 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 06:17:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:17:50 INFO - Return code: 0 06:17:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:17:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:17:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:17:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:17:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--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 06:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0225 --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 06:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kp6LnoVzNN/Render', 06:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:17:50 INFO - 'HOME': '/Users/cltbld', 06:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:17:50 INFO - 'LOGNAME': 'cltbld', 06:17:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:17:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:50 INFO - 'MOZ_NO_REMOTE': '1', 06:17:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:17:50 INFO - 'NO_EM_RESTART': '1', 06:17:50 INFO - 'PAGER': '/bin/cat', 06:17:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:50 INFO - 'PWD': '/builds/slave/test', 06:17:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:17:50 INFO - 'SHELL': '/bin/bash', 06:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9CL8sbeaHF/Listeners', 06:17:50 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 06:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:17:50 INFO - 'USER': 'cltbld', 06:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:50 INFO - 'XPC_FLAGS': '0x0', 06:17:50 INFO - 'XPC_SERVICE_NAME': '0', 06:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:17:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--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 06:17:50 INFO - mozversion application_buildid: 20170114031023 06:17:50 INFO - mozversion application_changeset: 64b8f9218c9894223a9ae02c43de6643bd97c98d 06:17:50 INFO - mozversion application_display_name: Firefox 06:17:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:17:50 INFO - mozversion application_name: Firefox 06:17:50 INFO - mozversion application_remotingname: firefox 06:17:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:17:50 INFO - mozversion application_vendor: Mozilla 06:17:50 INFO - mozversion application_version: 51.0 06:17:50 INFO - mozversion platform_buildid: 20170114031023 06:17:50 INFO - mozversion platform_changeset: 64b8f9218c9894223a9ae02c43de6643bd97c98d 06:17:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:17:50 INFO - mozversion platform_version: 51.0 06:17:50 INFO - using testdate: 1484403470 06:17:50 INFO - actual date: 1484403470 06:17:50 INFO - starting webserver on 'localhost:49242' 06:17:50 INFO - SUITE-START | Running 2 tests 06:17:50 INFO - TEST-START | dromaeo_css 06:17:50 INFO - operating with platform_type : mac_ 06:17:50 INFO - Initialising browser for dromaeo_css test... 06:17:50 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpoZTycY/profile http://localhost:49242/getInfo.html) 06:17:53 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 06:17:53 INFO - PROCESS | 1638 | colorDepth:24 06:17:53 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 06:17:53 INFO - PROCESS | 1638 | __metrics 06:17:53 INFO - PROCESS | 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:17:53 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:17:53 INFO - TEST-INFO | 1638: exit 0 06:17:53 INFO - Browser initialized. 06:17:53 INFO - Running cycle 1/1 for dromaeo_css test... 06:17:53 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpoZTycY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:05 INFO - PROCESS | 1641 | RSS: Main: 168755200 06:18:05 INFO - PROCESS | 1641 | 06:19:01 INFO - PROCESS | 1641 | 1484403541956 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:21:07 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 06:21:09 INFO - PROCESS | 1641 | RSS: Main: 249020416 06:21:09 INFO - PROCESS | 1641 | 06:24:12 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 06:24:13 INFO - PROCESS | 1641 | RSS: Main: 301723648 06:24:13 INFO - PROCESS | 1641 | 06:27:15 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 06:27:15 INFO - PROCESS | 1641 | RSS: Main: 273092608 06:27:15 INFO - PROCESS | 1641 | 06:30:18 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 06:30:18 INFO - PROCESS | 1641 | RSS: Main: 281219072 06:30:18 INFO - PROCESS | 1641 | 06:33:21 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 06:33:22 INFO - PROCESS | 1641 | RSS: Main: 258428928 06:33:22 INFO - PROCESS | 1641 | 06:36:25 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 06:36:25 INFO - PROCESS | 1641 | RSS: Main: 303476736 06:36:25 INFO - PROCESS | 1641 | 06:36:25 INFO - PROCESS | 1641 | __start_tp_report 06:36:25 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 06:36:25 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 06:36:25 INFO - PROCESS | 1641 | |i|pagename|runs| 06:36:25 INFO - PROCESS | 1641 | |0;dojo.html;3426.211971246614;3443.7933723976557;3475.1833319170005;3488.8953331400066;3511.806850623216;5680.744366503507;5684.118961560959;5691.373948865621;5704.77180912764;5716.771329146829;4322.481302243735;5879.735411906464;5885.323187833401;5889.6171748836405;5903.173555702205;5315.867103322419;5325.813596524103;5330.440303768107;5382.569394448455;5394.622376433651;5349.331333583302;5352.330958630171;5428.45715428458;5438;5455.9633669602845;5377.7580008899695;5392.325959255093;5400.513953744162;5413.783448662069;5415.10650742627;4490.685652004345;5311.867203319909;5345.812896548602;5360.195970604402;5395.973020134894;5230.8169214077325;5284.788608455658;5303.7348132593215;5334.973325133388;5391.433899440542;5967.075103358986;6007.369226231226;6016.939830601682;6022.728977196037;6032.095185722133;6148.631082135086;6202.689865506707;6340.809775706736;6341.714622841937;6353.110564520971;6197.81406557804;6228.937710622927;6247.96876015617;6287.9056814147825;6317.652529110897;5954.255718035246;5956.821295361146;5957.046872500422;5966.806638672239;6000.549958753111;6182.752689892444;6224.06639004153;6297.055441683784;6337.556371053982;6348.587341822767;6144.9246381882995;6166.475849552839;6227.906581401283;6278.277998030285;6303.810885673345;6255.093011513396;6256.968715156486;6262.780802671885;6274.435300822948;6274.874502509924;6129.8784197560135;6230.190075290183;6274.278457977391;6318.62088274705;6350.523710721714;6209.348018458088;6243.032329988859;6283.277423096402;6303.905441418382;6315.431611154926;5024.49755024502;5031.74841257943;5032.974835125874;5036.370453693288;5053.54518093366;4529.796159172845;4536.432945881765;4538.364628951949;4541.568550987651;4568.337591049346;5757.366689664133;5880.558958078162;5891.499222566044;5922.644641321534;5965.13505541694;6246.6876656167915;6249.437550620375;6286.968565157236;6300.9684951574945;6309.022101574264;6034.125051867454;6060.727267272895;6064.06007068905;6076.483498902554;6095.299040610298;5354.277172581729;5448.210009548593;5542.39033706292;5547.889042219133;5598.468145526169;6265.874682506415;6318.810435686937;6325.810225693236;6328.778492752732;6389.744410223539;6257.998720204745;6259.1550140730415;6264.404881536247;6272.153259309935;6276;6323.430891219812;6337.714802833976;6385.393387628168;6394.200724909387;6409.038644203407;6182.721777519932;6188.040853667689;6219.191505104308;6254.124422580751;6308.432241098323;6145.907811382922;6252.218472690914;6266.467350275278;6268.7492500301305;6291.559590828781;6237.625742455467;6262.718177681924;6270.216222972129;6318.526110541636;6339.112524246517;6098.420650038239;6144.279601711528;6148.923938310867;6285.96857015712;6317.494600432046;6042.274927008787;6126.754929802758;6149.41580549847;6151;6159.84600384994;6106.542009349228;6146.139540464249;6287.182666253358;6311.810645680637;6312.242530896138;6002.33974262822;6045.909311360245;6114.571104522845;6118.174046503843;6156.365288323759 06:36:25 INFO - PROCESS | 1641 | |1;ext.html;460.43366659009416;490.3894651159305;495.0569165739268;516.9815463536836;536.2438961064898;40348.596514034885;43501;43516.912077198045;43611.78194109033;43656.12687746243;44516;44670;44885.55114448855;44918;45163.32255016169;9210.539473026356;9483.857742133874;10001.89998100017;10219.233557483181;12438.315892625902;12360.938195309056;12630.052746044037;12632.2420654761;12636.178648387826;12660.366981650881;12571;12618.621441356729;12631.621051368473;12638.810417843739;12640.115191936567;12509.749805003894;12592.307423091726;12593.874061259361;12601.684957876034;12622.495100196027;12486.438110285058;12544.74910501794;12559.058070644738;12566.74866502674;12571.057170712233;42532.78733606343;42818;42830.78584607057;42911.57088429138;42971.35542966858;2891.508443564578;3190.6968837960358;3510.947335789965;3537.3809583322814;3915.8042097895277;28510.091450658492;28775.42449151026;31102.688973110206;32034.359312813613;32567.348653026806;3082.4605694003685;3352.614449338333;3361.697447229761;3394.6435624259343;3563.82180890957;538150;539641;539843;541901;541920;65104;65510;65557.34442655512;65624;65633;68421;68559.65720171467;68585;68619.65690171518;68626;17629.823701763074;17852.19665115073;17869.37457189018;17917.37289194872;17946.730799038025;12765.234085954873;13125.474981000843;13143.802842957364;13559.66100847467;13676.589702308947;17355.566110847078;17361.82638173602;17363.652726945642;17366.044867532153;17490.03804790749;6267.9373206268265;7008.544444611084;7145.464090193256;7278.636068196569;7310;744.281768093792;785.5012067337282;848.4781859156574;902.6299217320867;1058.751193469534;28806.135815925554;30327.786888524213;31920;32042.878499252412;32634.836825816194;989.4113002763344;1067.8665166854144;1114.7268919114706;1122.6744244169263;1184.8622944323429;16422.83577164237;16439.83560164383;16535.586610334598;16623.0099755953;16804.747928780835;693703;698109;699397;701397.4930125317;703666;61570.0764488533;61596.69201653963;61746;61812.381876181564;61841.690791545756;1277.6805798550363;1313.1333320008748;1374.896882733779;1428.728541577097;1451.1800832529798;29979.850100749358;33438.331233375684;33439.16402089967;33584.32831343408;34063.829680851435;53195.73402132965;53661.731691341294;53661.731691341294;53829.46170538401;54005.45994540161;593544;596211;597459;599485.0257487021;600599;36785.63214367929;39254;44144;44221.33667995047;45337;48557.7860553489;50145;50355;50360;50599.241011384125;35816.46275305925;40242.1951560973;41565.1686966253;41703.58296416997;42990.92522686958;40912;41398.379024314054;41687.248147666854;42682.35976460294;42977.355339670554;36021.81989090038;40263;40808.79595602003;40891;41535.58464415317;33668.49497257494;36225.45661815022;36432.453513197856;36651;36765.63234367622;23001.07995680154;26469.33826654349;26779.79490922952;26804.329891752863;26984.865075674497 06:36:25 INFO - PROCESS | 1641 | |2;jquery.html;384.38114635436943;384.78644352384424;387.94582684684593;392.8860630417178;415.8523724077952;14691.853081469182;20230.29193978211;21409.57180856382;21593.13627454902;21603.45991350215;21108.155673773068;21355.679664805;21435.67846482304;22040.44898877529;22131.668024979597;5615.185798059279;6078.6048906820915;6433.517486188532;6435.292117867031;6445.903311450332;6094.969525152368;6266.843328916791;6310.779122730705;6362.077498762676;6410.423061924426;6316.399942005525;6320.5891617044745;6322.051692246154;6325.956217224152;6331.430171284584;6017.849553761169;6264.342244064376;6322.968385158091;6326.620402775825;6414;5939.821805345847;6127.387261273881;6216.658083805389;6231.158793562857;6235.127082208494;13364.06451548392;13399.732005359838;13621.863781362159;13629.727405451835;13860.4455821767;2248.8875556222124;2258.051618320293;2435.415500279938;2548.3374322676054;2736.315921019745;10045.09594136524;10143.289969702124;10335;10461;10674.62638807638;1768.8319609637065;1974.891380974046;1981.791911849264;2022.898855057256;2026.6656001759693;114711.99999999917;121644.39177804143;128517;130784;131940.02089968658;8485.95757021211;9985.550650220612;10226.59093636261;10302.124319432782;10527.210459215436;12675.492980280686;12738.235705857493;12757.362131893367;13450.529231476852;13969.58091257264;8380.916190838136;8679.349048821237;8777.122287771172;8821.029686734453;8915.465072095694;7838;8736.737897862948;8759.868601970975;8825.02924678285;8915;3766.246750649881;4455.799489023002;4556.635469162459;4639.956009897746;4640.187967105743;1879.2483006797117;1929.2861641192567;1929.488685498344;1930.1217945834612;1930.4305229957197;832.7501749475255;933.1648174883442;959.429139661914;987.9753006174903;1010.8736407949007;20492.59014819725;22074.337769866608;22103.336899892707;22107.7840718762;22326.106955721913;936.6300311376968;941.2093841173447;945.2579724915907;984.8128855517429;1016.761061150629;11175.714792798932;11473.426328683532;11486.712832179262;11501.942490287494;11518.136139789549;624328;637420.8128959326;652611;673197;677148;130978.34510827385;138278.3086084563;138631.37527436088;146278;149008.25495872452;952.518977916148;963.3738070254251;967.1778987860263;973.78576713123;1000.2148313573955;18200.544986374916;18816.7177492335;19510.463639726746;19539.804601953798;19590.216391344187;50840;52617.42147735574;55356.44643553513;55960.72019639876;57465.42534574768;66868.33131668816;81680;84212;85262.72105918292;85843;7030;8189.672413103409;8239.835203296021;8478.152184781473;8621.741347759576;10278.486075696335;13193.010524210531;13312.800307995194;13394.598162055154;13513.324333783468;11124.888751112385;11175.552977880794;11288.040516556184;11488.597899073826;11693.473793679475;11093;11163.49764260594;11232.606858759904;11640.417979101181;11792.23350482216;10430.634927777492;10865.18511111654;11570.363630000431;11736.647900562997;12027.518899244282;8033.839323213386;8184.468009579358;8454.746357609281;8531.312636519477;8550.401471896908;10473.842892356774;11399.544018239178;11463.082953363544;11607.477663504993;11879.643610691694 06:36:25 INFO - PROCESS | 1641 | |3;mootools.html;1386.8266466691664;1545.7604071368937;1553.1535313254278;1559.532140357893;1951.590166065127;7985.680572777089;8479.576021198938;8773.649054037838;8999.910000899989;9004.234640055587;8866.202041816252;8966.730998070052;8990.145936136072;8999.190072893438;9016.72949811505;2396.3649632847264;2413.746556611557;2418.105301038618;2418.600930846408;2420.104561312317;2021.5148364392587;2398.040783686522;2406.133791834938;2412.023130632088;2413.79482743967;2368.39605900496;2393.066703985447;2398.8200884933613;2411.3248290478605;2412.553677569655;2351.988240058806;2379.6668466414717;2381.7022872140983;2387.785099341059;2393.4614711689906;2030.35028790787;2330.5105927755194;2339.6022676145094;2367.573836709392;2371.8221133415063;8949.865752013726;9073.45559266446;9074.95638001625;9083.318751093695;9083.68207112748;5373.838784836461;5544.91682624761;5559.19391688207;5575.107982722786;5576.247206627094;3576.660217279354;3607.2965771674535;3658.432942893856;3676.852925882988;3704.666580007812;1076.6716151573767;1089.1232557790975;1092.3609688332335;1119.9440027998567;1122.2929554380687;11773.175877688565;11792.469338879771;11837.171398002143;11877.762444751143;11910.166288359906;4151.27352713274;4501.41481607389;4612.7462989535225;4637.65217608674;4732.692374995614;9310.674126405544;9325.114114159143;9327.253819694408;9332.953335233417;9341.813163736822;5369.167778994262;5371.060064488777;5375.892482150413;5377.0321342158;5378.435264297271;4290.4636920384955;4548.6133678637025;4661.930071048937;4718.764061796896;5042.949570504321;3849.576546579874;3898.766074035567;3952.2490726761825;3986.700997425147;4000.4199391088127;1182.9585964491373;1183.5798291606527;1194.778965891313;1196.545312781155;1204.0668481926577;920.8894932607996;923.2567782934668;930.6412637549254;932.077243528915;971.1065819446127;5787.710614469344;5869.295684517885;5921.319048309413;6167.537434692416;6286.748530058747;429.5382463851372;433.9479262488522;434.8434563557117;448.14628133405915;448.66126074813957;3999.3601023836627;4044.130511939947;4044.352903535479;4111.483298971164;4154.584541545822;10609.257351985287;11104.5558177672;11108.16688748347;11115.055220306203;11115.666530004113;11022.338659680445;11035.558577656804;11050.944745276222;11059.22585419013;11081.833772493419;8369;8394.370422218359;8418.747437576883;8427.32581393487;8434.536100514408;5886.293644762656;5901.852453688693;5941.9405805943115;6096.513995926998;6168;9789.9021009789;10237.539310730886;10244.924282950184;10337.896621033995;10349.120324772479;9510.429374237292;10292;10409.895901040893;10428.478576071015;10465.47672616351;7136.286371362822;7381.741639042608;7481.326680598555;7652.540847549165;7748.34139098183;8521.275691566037;8521.53131577769;8558.058613552628;8579.571021448777;8639.91360086391;7727.9953606033105;7733.226677332222;7754.7673569793;7788.182240864628;7798;6917.584944903322;7119.323664251888;7585.962070189614;7618.885716714364;7721.343685786771;7089.645517724196;7146.142462904485;7163.212046674966;7186.6047367395295;7242.13094428672;5186.714730689849;5220.973895130652;5243.580513558983;5247.134222853187;5249.763760630857;5084.313617661716;5094.312267843794;5144.382674078985;5327.360716714019;5395.514403703685 06:36:25 INFO - PROCESS | 1641 | |4;prototype.html;300.52517023103496;303.64776858843743;311.4036619872943;317.55066580788184;318.7497814215841;5500.614956953015;5505.917411238835;5511.0906700394435;5533.778648854041;5568;4593.494715581283;5107.7701503432345;5277.282199667175;5291.259223708675;5299.311089558361;3485.982570087159;4150.916981660373;4161.188568229181;4162;4178.12259425521;3778.7152368194807;4019.698522610816;4154.626083652471;4171.374293855931;4198.265303571878;3829.444730514074;4018.0124655804943;4155.39746736723;4189.413482112506;4190.811413486401;3332.516785066152;4131.256373852705;4173.937390939138;4187.183499217654;4255.510616279121;3264.9020529384156;3400.4697885951173;3607.3687104756564;3607.556977209111;3616.5660120785674;4884.92531643038;5262.789488420497;5297.364316282033;5314.601404894648;5454.7818087276855;4310.784460776948;4640.169496607067;4750.123701138031;4757.286407038937;4908.9754551227015;4728.186728896301;5619.325680918316;5730.707716913226;5738.856528586777;5794.88410231793;3863.5220783358996;4011.7392369495888;4044.8382064717375;4047.1096358801015;4052.5482083339743;5323.520883120499;5720.741436883879;5801.7389217485315;5963.493103086286;6039.667818269993;3466.7053300469743;4084.65280451159;4114.794260286973;4115.218108559364;4166.749995000249;3612.7109831213966;4035.878923632296;4216.9036050627055;4246.426732391149;4262.168877068942;3977.5425826030378;4742.478327383985;4802.398201348989;4892.630063582132;4904.068227036852;4923.778429970588;5482.396936337;5683.8863222736145;5752.223449834302;5754.827355179351;1224.7734169178552;1330.9866901331056;1399.4122468563228;1416.3343228682502;1436.3177490691837;755.5844285642984;842.3850589070013;863.317978796756;873.6156091319799;920.7191806499083;4151.854685086068;4433.401490798701;4439.179936226132;4456.5766252205985;4465.017696106851;4428.446444194476;4468.865934021985;4829.502854115235;4880.951190488121;4919.7540122993705;3529.1177205698577;4060.2285565742413;4202.495700515958;4331.787099612114;4464.486584042812;2384.701912260967;2400.159944019579;2540.593505039185;2548.13363456422;2591.611258311231;4572.51988541205;4778.928316075262;4981.118503866232;5050.267711181858;5117.897642047138;4123.525794533667;4163.02168990287;4831.830885918976;4889.3888263967;4919.278252611557;4818.759062046884;4986.426560945465;4987.850364489072;5048.62135339851;5054.59563234933;4045.615666511677;4782.2980016290685;4790.616750660009;4838.661293709407;4936.432310284364;4011.7764081954115;4222.176675548239;4714.646401519831;4805.495422980537;5818.476337129509;6268.686565671789;6278.246610406781;6287.497000240061;6298.338674439301;6299.685015749286;3410.7612467128056;3638.853076684769;3960.2277555876326;4008.2985477541897;4017.397390391348;4882.9989852079525;5070.467600901852;5940.257467816523;6022.728977196124;6059.818205453844;5764.682942438206;5825.300963884361;5828.242328497268;5870.882582348415;5875.265591801025;5460.399356070909;5727.770889164553;5775.191473193672;5834.970825145847;5838;4511.593956543927;5084.288469417272;5538.501534861882;5722.628029178257;5749.885002300014;5560.19377190297;5729.312482502127;5828.184054232326;5872.970635146968;5889.261493405587;4843.975780121077;5655.7172141393585;5701.201831743642;5706.914396283976;5780.653160810365 06:36:25 INFO - PROCESS | 1641 | |5;yui.html;709.9751508697196;755.4749449132852;789.1989630525018;845.0873057098335;846.8687353460214;15630.9839860409;16789;16789.832101678978;16842;16884.577885552866;12624.684382890433;14960.326785294661;15100.169490678036;15103.320350584223;15120.47078352255;729.3253740290211;747.3796748698594;749.8837680159584;818.3575892924056;873.2184694698241;863.1584205399716;916.0335845682802;928.6146249306563;929.159111004542;930.1907340613676;976.1166144639113;981.3474039763585;981.5582987655548;983.0562659846556;986.634945070325;972.2270794718181;973.1582181413097;974.4056125763278;975.8243516167087;975.8243516167158;730.375528922774;730.441212472459;731.7073170731696;731.9194888562254;732.1104857598044;15811.051336919822;16061.518154455385;16209.946353487103;16227.594310142224;16243.593910152222;13626.182429054288;13648.658783530393;13720.862791372158;13981.161130332111;15174.013689110283;12905.2902090385;13044.804327935088;13128.60614181576;13521.932390338085;13755.10591811529;4671.04243630055;4792.281157826319;4866.245731911559;4932.827351042696;4967.7019378837385;112145;113375;115090.42454787756;116459;117779.41110294565;10578.52396642153;10950.178736594788;11004.724881878017;11089.22375433712;11249.550017999189;20550.486237844172;20730.585388292453;20791;20794.1682332705;20798.064087115814;7788.14330423653;7823.049360073127;7886.250806173404;8170.75487735357;8176.305014073871;4484.148011877733;4593.931091033637;4603.677742558056;4680.180968330528;4746.97939942907;3674.6876515496483;3781.7920014398924;3829.0235989822418;3831.5593706724085;3843.5195600549932;700.9614471204133;703.7853454696367;705.8059033765755;707.4305184326666;724.3842733676438;554.9611527193058;623.6133597169784;669.6417416682149;705.1326867952447;711.5303899426353;9633.710988670211;9965;10000.499975001221;10068.69793906184;10079;624.4754406298731;674.9932500675029;691.6161530350704;691.8996745471878;706.8162277807807;4818.229083346648;4857.489963553776;4873.707577545359;4957.182064959314;4961.05739909416;118423;147505;150242;152148.47851521565;158984.20507897617;137182.31408842892;138503;138863.30568347094;145223.273883632;147304;90039.09960900438;91339;95923.08153836885;109846.90153098367;121480;9851.45816980073;10489.685309440729;10721.678349649523;10802.297850639683;10846.891531084588;54155.72922135364;59908.50228744316;60193.54516885285;63040.36959630345;66992.6650366745;64784.999602953874;78374.608126959;88441.78895527405;93304.06695932953;99756;12803;13870.098443601133;13893.652658683613;14476.276186190858;15040.548783536511;12893.613191604267;15850.52448426549;16194.867005156953;16226;16931.746023809406;12313.815292770436;12761.361931903553;12787.872121278668;13079.542216022393;13182.274974876475;12116.697082573006;14342.569722908329;14539.127652340894;15245.542633721006;15591.142487163315;14188.787168192692;14470.855291447371;14827.703445931236;15177.544673659808;15486.380544778083;11509.194356394972;11653.47559359814;11763.764724705628;12281.201721888407;12430.12989090755;11302.547898084313;11832;12169.69575760613;12173.20874143178;12181 06:36:25 INFO - PROCESS | 1641 | __end_tp_report 06:36:25 INFO - PROCESS | 1641 | __start_cc_report 06:36:25 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1677 06:36:25 INFO - PROCESS | 1641 | __end_cc_report 06:36:25 INFO - PROCESS | 1641 | __startTimestamp1484404585857__endTimestamp 06:36:25 INFO - PROCESS | 1641 | 06:36:25 INFO - PROCESS | 1641 | ------- Summary: start ------- 06:36:25 INFO - PROCESS | 1641 | Number of tests: 6 06:36:25 INFO - PROCESS | 1641 | 06:36:25 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5844.46 Median:6126.75 stddev:635.85 (10.4%) stddev-sans-first:608.84 06:36:25 INFO - PROCESS | 1641 | Values: 3426.2 3443.8 3475.2 3488.9 3511.8 5680.7 5684.1 5691.4 5704.8 5716.8 4322.5 5879.7 5885.3 5889.6 5903.2 5315.9 5325.8 5330.4 5382.6 5394.6 5349.3 5352.3 5428.5 5438.0 5456.0 5377.8 5392.3 5400.5 5413.8 5415.1 4490.7 5311.9 5345.8 5360.2 5396.0 5230.8 5284.8 5303.7 5335.0 5391.4 5967.1 6007.4 6016.9 6022.7 6032.1 6148.6 6202.7 6340.8 6341.7 6353.1 6197.8 6228.9 6248.0 6287.9 6317.7 5954.3 5956.8 5957.0 5966.8 6000.5 6182.8 6224.1 6297.1 6337.6 6348.6 6144.9 6166.5 6227.9 6278.3 6303.8 6255.1 6257.0 6262.8 6274.4 6274.9 6129.9 6230.2 6274.3 6318.6 6350.5 6209.3 6243.0 6283.3 6303.9 6315.4 5024.5 5031.7 5033.0 5036.4 5053.5 4529.8 4536.4 4538.4 4541.6 4568.3 5757.4 5880.6 5891.5 5922.6 5965.1 6246.7 6249.4 6287.0 6301.0 6309.0 6034.1 6060.7 6064.1 6076.5 6095.3 5354.3 5448.2 5542.4 5547.9 5598.5 6265.9 6318.8 6325.8 6328.8 6389.7 6258.0 6259.2 6264.4 6272.2 6276.0 6323.4 6337.7 6385.4 6394.2 6409.0 6182.7 6188.0 6219.2 6254.1 6308.4 6145.9 6252.2 6266.5 6268.7 6291.6 6237.6 6262.7 6270.2 6318.5 6339.1 6098.4 6144.3 6148.9 6286.0 6317.5 6042.3 6126.8 6149.4 6151.0 6159.8 6106.5 6146.1 6287.2 6311.8 6312.2 6002.3 6045.9 6114.6 6118.2 6156.4 06:36:25 INFO - PROCESS | 1641 | 06:36:25 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:75864.17 Median:21584.90 stddev:164448.17 (761.9%) stddev-sans-first:164812.03 06:36:25 INFO - PROCESS | 1641 | Values: 460.4 490.4 495.1 517.0 536.2 40348.6 43501.0 43516.9 43611.8 43656.1 44516.0 44670.0 44885.6 44918.0 45163.3 9210.5 9483.9 10001.9 10219.2 12438.3 12360.9 12630.1 12632.2 12636.2 12660.4 12571.0 12618.6 12631.6 12638.8 12640.1 12509.7 12592.3 12593.9 12601.7 12622.5 12486.4 12544.7 12559.1 12566.7 12571.1 42532.8 42818.0 42830.8 42911.6 42971.4 2891.5 3190.7 3510.9 3537.4 3915.8 28510.1 28775.4 31102.7 32034.4 32567.3 3082.5 3352.6 3361.7 3394.6 3563.8 538150.0 539641.0 539843.0 541901.0 541920.0 65104.0 65510.0 65557.3 65624.0 65633.0 68421.0 68559.7 68585.0 68619.7 68626.0 17629.8 17852.2 17869.4 17917.4 17946.7 12765.2 13125.5 13143.8 13559.7 13676.6 17355.6 17361.8 17363.7 17366.0 17490.0 6267.9 7008.5 7145.5 7278.6 7310.0 744.3 785.5 848.5 902.6 1058.8 28806.1 30327.8 31920.0 32042.9 32634.8 989.4 1067.9 1114.7 1122.7 1184.9 16422.8 16439.8 16535.6 16623.0 16804.7 693703.0 698109.0 699397.0 701397.5 703666.0 61570.1 61596.7 61746.0 61812.4 61841.7 1277.7 1313.1 1374.9 1428.7 1451.2 29979.9 33438.3 33439.2 33584.3 34063.8 53195.7 53661.7 53661.7 53829.5 54005.5 593544.0 596211.0 597459.0 599485.0 600599.0 36785.6 39254.0 44144.0 44221.3 45337.0 48557.8 50145.0 50355.0 50360.0 50599.2 35816.5 40242.2 41565.2 41703.6 42990.9 40912.0 41398.4 41687.2 42682.4 42977.4 36021.8 40263.0 40808.8 40891.0 41535.6 33668.5 36225.5 36432.5 36651.0 36765.6 23001.1 26469.3 26779.8 26804.3 26984.9 06:36:25 INFO - PROCESS | 1641 | 06:36:25 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:37009.73 Median:12287.50 stddev:109110.00 (888.0%) stddev-sans-first:109381.42 06:36:25 INFO - PROCESS | 1641 | Values: 384.4 384.8 387.9 392.9 415.9 14691.9 20230.3 21409.6 21593.1 21603.5 21108.2 21355.7 21435.7 22040.4 22131.7 5615.2 6078.6 6433.5 6435.3 6445.9 6095.0 6266.8 6310.8 6362.1 6410.4 6316.4 6320.6 6322.1 6326.0 6331.4 6017.8 6264.3 6323.0 6326.6 6414.0 5939.8 6127.4 6216.7 6231.2 6235.1 13364.1 13399.7 13621.9 13629.7 13860.4 2248.9 2258.1 2435.4 2548.3 2736.3 10045.1 10143.3 10335.0 10461.0 10674.6 1768.8 1974.9 1981.8 2022.9 2026.7 114712.0 121644.4 128517.0 130784.0 131940.0 8486.0 9985.6 10226.6 10302.1 10527.2 12675.5 12738.2 12757.4 13450.5 13969.6 8380.9 8679.3 8777.1 8821.0 8915.5 7838.0 8736.7 8759.9 8825.0 8915.0 3766.2 4455.8 4556.6 4640.0 4640.2 1879.2 1929.3 1929.5 1930.1 1930.4 832.8 933.2 959.4 988.0 1010.9 20492.6 22074.3 22103.3 22107.8 22326.1 936.6 941.2 945.3 984.8 1016.8 11175.7 11473.4 11486.7 11501.9 11518.1 624328.0 637420.8 652611.0 673197.0 677148.0 130978.3 138278.3 138631.4 146278.0 149008.3 952.5 963.4 967.2 973.8 1000.2 18200.5 18816.7 19510.5 19539.8 19590.2 50840.0 52617.4 55356.4 55960.7 57465.4 66868.3 81680.0 84212.0 85262.7 85843.0 7030.0 8189.7 8239.8 8478.2 8621.7 10278.5 13193.0 13312.8 13394.6 13513.3 11124.9 11175.6 11288.0 11488.6 11693.5 11093.0 11163.5 11232.6 11640.4 11792.2 10430.6 10865.2 11570.4 11736.6 12027.5 8033.8 8184.5 8454.7 8531.3 8550.4 10473.8 11399.5 11463.1 11607.5 11879.6 06:36:25 INFO - PROCESS | 1641 | 06:36:25 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5786.98 Median:4725.73 stddev:3279.42 (69.4%) stddev-sans-first:3271.95 06:36:25 INFO - PROCESS | 1641 | Values: 1386.8 1545.8 1553.2 1559.5 1951.6 7985.7 8479.6 8773.6 8999.9 9004.2 8866.2 8966.7 8990.1 8999.2 9016.7 2396.4 2413.7 2418.1 2418.6 2420.1 2021.5 2398.0 2406.1 2412.0 2413.8 2368.4 2393.1 2398.8 2411.3 2412.6 2352.0 2379.7 2381.7 2387.8 2393.5 2030.4 2330.5 2339.6 2367.6 2371.8 8949.9 9073.5 9075.0 9083.3 9083.7 5373.8 5544.9 5559.2 5575.1 5576.2 3576.7 3607.3 3658.4 3676.9 3704.7 1076.7 1089.1 1092.4 1119.9 1122.3 11773.2 11792.5 11837.2 11877.8 11910.2 4151.3 4501.4 4612.7 4637.7 4732.7 9310.7 9325.1 9327.3 9333.0 9341.8 5369.2 5371.1 5375.9 5377.0 5378.4 4290.5 4548.6 4661.9 4718.8 5042.9 3849.6 3898.8 3952.2 3986.7 4000.4 1183.0 1183.6 1194.8 1196.5 1204.1 920.9 923.3 930.6 932.1 971.1 5787.7 5869.3 5921.3 6167.5 6286.7 429.5 433.9 434.8 448.1 448.7 3999.4 4044.1 4044.4 4111.5 4154.6 10609.3 11104.6 11108.2 11115.1 11115.7 11022.3 11035.6 11050.9 11059.2 11081.8 8369.0 8394.4 8418.7 8427.3 8434.5 5886.3 5901.9 5941.9 6096.5 6168.0 9789.9 10237.5 10244.9 10337.9 10349.1 9510.4 10292.0 10409.9 10428.5 10465.5 7136.3 7381.7 7481.3 7652.5 7748.3 8521.3 8521.5 8558.1 8579.6 8639.9 7728.0 7733.2 7754.8 7788.2 7798.0 6917.6 7119.3 7586.0 7618.9 7721.3 7089.6 7146.1 7163.2 7186.6 7242.1 5186.7 5221.0 5243.6 5247.1 5249.8 5084.3 5094.3 5144.4 5327.4 5395.5 06:36:25 INFO - PROCESS | 1641 | 06:36:25 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4437.58 Median:4796.51 stddev:1374.08 (28.6%) stddev-sans-first:1342.39 06:36:25 INFO - PROCESS | 1641 | Values: 300.5 303.6 311.4 317.6 318.7 5500.6 5505.9 5511.1 5533.8 5568.0 4593.5 5107.8 5277.3 5291.3 5299.3 3486.0 4150.9 4161.2 4162.0 4178.1 3778.7 4019.7 4154.6 4171.4 4198.3 3829.4 4018.0 4155.4 4189.4 4190.8 3332.5 4131.3 4173.9 4187.2 4255.5 3264.9 3400.5 3607.4 3607.6 3616.6 4884.9 5262.8 5297.4 5314.6 5454.8 4310.8 4640.2 4750.1 4757.3 4909.0 4728.2 5619.3 5730.7 5738.9 5794.9 3863.5 4011.7 4044.8 4047.1 4052.5 5323.5 5720.7 5801.7 5963.5 6039.7 3466.7 4084.7 4114.8 4115.2 4166.7 3612.7 4035.9 4216.9 4246.4 4262.2 3977.5 4742.5 4802.4 4892.6 4904.1 4923.8 5482.4 5683.9 5752.2 5754.8 1224.8 1331.0 1399.4 1416.3 1436.3 755.6 842.4 863.3 873.6 920.7 4151.9 4433.4 4439.2 4456.6 4465.0 4428.4 4468.9 4829.5 4881.0 4919.8 3529.1 4060.2 4202.5 4331.8 4464.5 2384.7 2400.2 2540.6 2548.1 2591.6 4572.5 4778.9 4981.1 5050.3 5117.9 4123.5 4163.0 4831.8 4889.4 4919.3 4818.8 4986.4 4987.9 5048.6 5054.6 4045.6 4782.3 4790.6 4838.7 4936.4 4011.8 4222.2 4714.6 4805.5 5818.5 6268.7 6278.2 6287.5 6298.3 6299.7 3410.8 3638.9 3960.2 4008.3 4017.4 4883.0 5070.5 5940.3 6022.7 6059.8 5764.7 5825.3 5828.2 5870.9 5875.3 5460.4 5727.8 5775.2 5835.0 5838.0 4511.6 5084.3 5538.5 5722.6 5749.9 5560.2 5729.3 5828.2 5873.0 5889.3 4844.0 5655.7 5701.2 5706.9 5780.7 06:36:25 INFO - PROCESS | 1641 | 06:36:25 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:25138.74 Median:20760.79 stddev:39824.38 (191.8%) stddev-sans-first:39893.86 06:36:25 INFO - PROCESS | 1641 | Values: 710.0 755.5 789.2 845.1 846.9 15631.0 16789.0 16789.8 16842.0 16884.6 12624.7 14960.3 15100.2 15103.3 15120.5 729.3 747.4 749.9 818.4 873.2 863.2 916.0 928.6 929.2 930.2 976.1 981.3 981.6 983.1 986.6 972.2 973.2 974.4 975.8 975.8 730.4 730.4 731.7 731.9 732.1 15811.1 16061.5 16209.9 16227.6 16243.6 13626.2 13648.7 13720.9 13981.2 15174.0 12905.3 13044.8 13128.6 13521.9 13755.1 4671.0 4792.3 4866.2 4932.8 4967.7 112145.0 113375.0 115090.4 116459.0 117779.4 10578.5 10950.2 11004.7 11089.2 11249.6 20550.5 20730.6 20791.0 20794.2 20798.1 7788.1 7823.0 7886.3 8170.8 8176.3 4484.1 4593.9 4603.7 4680.2 4747.0 3674.7 3781.8 3829.0 3831.6 3843.5 701.0 703.8 705.8 707.4 724.4 555.0 623.6 669.6 705.1 711.5 9633.7 9965.0 10000.5 10068.7 10079.0 624.5 675.0 691.6 691.9 706.8 4818.2 4857.5 4873.7 4957.2 4961.1 118423.0 147505.0 150242.0 152148.5 158984.2 137182.3 138503.0 138863.3 145223.3 147304.0 90039.1 91339.0 95923.1 109846.9 121480.0 9851.5 10489.7 10721.7 10802.3 10846.9 54155.7 59908.5 60193.5 63040.4 66992.7 64785.0 78374.6 88441.8 93304.1 99756.0 12803.0 13870.1 13893.7 14476.3 15040.5 12893.6 15850.5 16194.9 16226.0 16931.7 12313.8 12761.4 12787.9 13079.5 13182.3 12116.7 14342.6 14539.1 15245.5 15591.1 14188.8 14470.9 14827.7 15177.5 15486.4 11509.2 11653.5 11763.8 12281.2 12430.1 11302.5 11832.0 12169.7 12173.2 12181.0 06:36:25 INFO - PROCESS | 1641 | -------- Summary: end -------- 06:36:25 INFO - PROCESS | 1641 | 06:36:26 INFO - TEST-INFO | 1641: exit 0 06:36:26 INFO - TEST-OK | dromaeo_css | took 1115527ms 06:36:26 INFO - TEST-START | kraken 06:36:26 INFO - operating with platform_type : mac_ 06:36:26 INFO - Initialising browser for kraken test... 06:36:26 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpUaw8gg/profile http://localhost:49242/getInfo.html) 06:36:28 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 06:36:28 INFO - PROCESS | 1652 | colorDepth:24 06:36:28 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 06:36:28 INFO - PROCESS | 1652 | __metrics 06:36:28 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:36:28 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:36:29 INFO - TEST-INFO | 1652: exit 0 06:36:29 INFO - Browser initialized. 06:36:29 INFO - Running cycle 1/1 for kraken test... 06:36:29 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpUaw8gg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:41 INFO - PROCESS | 1654 | RSS: Main: 164777984 06:36:41 INFO - PROCESS | 1654 | 06:36:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 06:36:44 INFO - PROCESS | 1654 | RSS: Main: 216494080 06:36:44 INFO - PROCESS | 1654 | 06:36:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 06:36:47 INFO - PROCESS | 1654 | RSS: Main: 227979264 06:36:47 INFO - PROCESS | 1654 | 06:36:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 06:36:51 INFO - PROCESS | 1654 | RSS: Main: 324374528 06:36:51 INFO - PROCESS | 1654 | 06:36:53 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 06:36:54 INFO - PROCESS | 1654 | RSS: Main: 227196928 06:36:54 INFO - PROCESS | 1654 | 06:36:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:36:56 INFO - PROCESS | 1654 | RSS: Main: 227725312 06:36:56 INFO - PROCESS | 1654 | 06:36:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 06:37:00 INFO - PROCESS | 1654 | RSS: Main: 266432512 06:37:00 INFO - PROCESS | 1654 | 06:37:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 06:37:03 INFO - PROCESS | 1654 | RSS: Main: 265785344 06:37:03 INFO - PROCESS | 1654 | 06:37:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 06:37:06 INFO - PROCESS | 1654 | RSS: Main: 263553024 06:37:06 INFO - PROCESS | 1654 | 06:37:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:37:08 INFO - PROCESS | 1654 | RSS: Main: 240775168 06:37:08 INFO - PROCESS | 1654 | 06:37:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:37:11 INFO - PROCESS | 1654 | RSS: Main: 245444608 06:37:11 INFO - PROCESS | 1654 | 06:37:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:37:14 INFO - PROCESS | 1654 | RSS: Main: 252493824 06:37:14 INFO - PROCESS | 1654 | 06:37:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:37:17 INFO - PROCESS | 1654 | RSS: Main: 264974336 06:37:17 INFO - PROCESS | 1654 | 06:37:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:37:21 INFO - PROCESS | 1654 | RSS: Main: 258928640 06:37:21 INFO - PROCESS | 1654 | 06:37:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 06:37:23 INFO - PROCESS | 1654 | RSS: Main: 302768128 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | __start_tp_report 06:37:23 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 06:37:23 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 06:37:23 INFO - PROCESS | 1654 | |i|pagename|runs| 06:37:23 INFO - PROCESS | 1654 | |0;ai-astar;105;113;112;113;112;113;111;114;112;113 06:37:23 INFO - PROCESS | 1654 | |1;audio-beat-detection;147;129;139;144;108;107;108;107;136;106 06:37:23 INFO - PROCESS | 1654 | |2;audio-dft;184;183;181;183;182;184;184;183;182;185 06:37:23 INFO - PROCESS | 1654 | |3;audio-fft;83;59;58;89;65;58;58;59;97;80 06:37:23 INFO - PROCESS | 1654 | |4;audio-oscillator;85;71;120;100;96;68;92;67;69;88 06:37:23 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;89;85;87;86;91;85;88;84;87;88 06:37:23 INFO - PROCESS | 1654 | |6;imaging-darkroom;92;92;93;93;92;92;93;94;92;91 06:37:23 INFO - PROCESS | 1654 | |7;imaging-desaturate;87;85;85;86;85;85;84;84;86;84 06:37:23 INFO - PROCESS | 1654 | |8;json-parse-financial;55;52;52;52;55;56;57;56;59;58 06:37:23 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;63;64;76;76;72;66;68;70;69;68 06:37:23 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;86;80;84;83;83;80;82;81;91;98 06:37:23 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;136;120;141;143;141;141;137;139;164;149 06:37:23 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;157;159;159;210;221;159;158;159;155;209 06:37:23 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;68;77;82;81;82;69;67;62;66;64 06:37:23 INFO - PROCESS | 1654 | __end_tp_report 06:37:23 INFO - PROCESS | 1654 | __start_cc_report 06:37:23 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1866 06:37:23 INFO - PROCESS | 1654 | __end_cc_report 06:37:23 INFO - PROCESS | 1654 | __startTimestamp1484404643187__endTimestamp 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | ------- Summary: start ------- 06:37:23 INFO - PROCESS | 1654 | Number of tests: 14 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.53 (2.2%) stddev-sans-first:0.88 06:37:23 INFO - PROCESS | 1654 | Values: 105.0 113.0 112.0 113.0 112.0 113.0 111.0 114.0 112.0 113.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:132.50 stddev:17.41 (13.1%) stddev-sans-first:16.18 06:37:23 INFO - PROCESS | 1654 | Values: 147.0 129.0 139.0 144.0 108.0 107.0 108.0 107.0 136.0 106.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:1.20 (0.7%) stddev-sans-first:1.22 06:37:23 INFO - PROCESS | 1654 | Values: 184.0 183.0 181.0 183.0 182.0 184.0 184.0 183.0 182.0 185.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:70.60 Median:72.50 stddev:15.11 (20.8%) stddev-sans-first:15.34 06:37:23 INFO - PROCESS | 1654 | Values: 83.0 59.0 58.0 89.0 65.0 58.0 58.0 59.0 97.0 80.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:78.00 stddev:17.29 (22.2%) stddev-sans-first:18.34 06:37:23 INFO - PROCESS | 1654 | Values: 85.0 71.0 120.0 100.0 96.0 68.0 92.0 67.0 69.0 88.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.50 stddev:2.11 (2.4%) stddev-sans-first:2.11 06:37:23 INFO - PROCESS | 1654 | Values: 89.0 85.0 87.0 86.0 91.0 85.0 88.0 84.0 87.0 88.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:92.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 06:37:23 INFO - PROCESS | 1654 | Values: 92.0 92.0 93.0 93.0 92.0 92.0 93.0 94.0 92.0 91.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.99 (1.2%) stddev-sans-first:0.78 06:37:23 INFO - PROCESS | 1654 | Values: 87.0 85.0 85.0 86.0 85.0 85.0 84.0 84.0 86.0 84.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:2.53 (4.5%) stddev-sans-first:2.68 06:37:23 INFO - PROCESS | 1654 | Values: 55.0 52.0 52.0 52.0 55.0 56.0 57.0 56.0 59.0 58.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:4.47 (6.4%) stddev-sans-first:4.14 06:37:23 INFO - PROCESS | 1654 | Values: 63.0 64.0 76.0 76.0 72.0 66.0 68.0 70.0 69.0 68.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.50 stddev:5.67 (6.8%) stddev-sans-first:6.00 06:37:23 INFO - PROCESS | 1654 | Values: 86.0 80.0 84.0 83.0 83.0 80.0 82.0 81.0 91.0 98.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:141.00 stddev:10.97 (7.8%) stddev-sans-first:11.48 06:37:23 INFO - PROCESS | 1654 | Values: 136.0 120.0 141.0 143.0 141.0 141.0 137.0 139.0 164.0 149.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:159.00 stddev:26.94 (16.9%) stddev-sans-first:27.81 06:37:23 INFO - PROCESS | 1654 | Values: 157.0 159.0 159.0 210.0 221.0 159.0 158.0 159.0 155.0 209.0 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:73.00 stddev:7.86 (10.8%) stddev-sans-first:8.21 06:37:23 INFO - PROCESS | 1654 | Values: 68.0 77.0 82.0 81.0 82.0 69.0 67.0 62.0 66.0 64.0 06:37:23 INFO - PROCESS | 1654 | -------- Summary: end -------- 06:37:23 INFO - PROCESS | 1654 | 06:37:23 INFO - TEST-INFO | 1654: exit 0 06:37:23 INFO - TEST-OK | kraken | took 57501ms 06:37:23 INFO - SUITE-END | took 1173s 06:37:24 INFO - Completed test suite (00:19:33) 06:37:24 INFO - javascript benchmark 06:37:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3426.211971246614, 3443.7933723976557, 3475.1833319170005, 3488.8953331400066, 3511.806850623216, 5680.744366503507, 5684.118961560959, 5691.373948865621, 5704.77180912764, 5716.771329146829, 4322.481302243735, 5879.735411906464, 5885.323187833401, 5889.6171748836405, 5903.173555702205, 5315.867103322419, 5325.813596524103, 5330.440303768107, 5382.569394448455, 5394.622376433651, 5349.331333583302, 5352.330958630171, 5428.45715428458, 5438.0, 5455.9633669602845, 5377.7580008899695, 5392.325959255093, 5400.513953744162, 5413.783448662069, 5415.10650742627, 4490.685652004345, 5311.867203319909, 5345.812896548602, 5360.195970604402, 5395.973020134894, 5230.8169214077325, 5284.788608455658, 5303.7348132593215, 5334.973325133388, 5391.433899440542, 5967.075103358986, 6007.369226231226, 6016.939830601682, 6022.728977196037, 6032.095185722133, 6148.631082135086, 6202.689865506707, 6340.809775706736, 6341.714622841937, 6353.110564520971, 6197.81406557804, 6228.937710622927, 6247.96876015617, 6287.9056814147825, 6317.652529110897, 5954.255718035246, 5956.821295361146, 5957.046872500422, 5966.806638672239, 6000.549958753111, 6182.752689892444, 6224.06639004153, 6297.055441683784, 6337.556371053982, 6348.587341822767, 6144.9246381882995, 6166.475849552839, 6227.906581401283, 6278.277998030285, 6303.810885673345, 6255.093011513396, 6256.968715156486, 6262.780802671885, 6274.435300822948, 6274.874502509924, 6129.8784197560135, 6230.190075290183, 6274.278457977391, 6318.62088274705, 6350.523710721714, 6209.348018458088, 6243.032329988859, 6283.277423096402, 6303.905441418382, 6315.431611154926, 5024.49755024502, 5031.74841257943, 5032.974835125874, 5036.370453693288, 5053.54518093366, 4529.796159172845, 4536.432945881765, 4538.364628951949, 4541.568550987651, 4568.337591049346, 5757.366689664133, 5880.558958078162, 5891.499222566044, 5922.644641321534, 5965.13505541694, 6246.6876656167915, 6249.437550620375, 6286.968565157236, 6300.9684951574945, 6309.022101574264, 6034.125051867454, 6060.727267272895, 6064.06007068905, 6076.483498902554, 6095.299040610298, 5354.277172581729, 5448.210009548593, 5542.39033706292, 5547.889042219133, 5598.468145526169, 6265.874682506415, 6318.810435686937, 6325.810225693236, 6328.778492752732, 6389.744410223539, 6257.998720204745, 6259.1550140730415, 6264.404881536247, 6272.153259309935, 6276.0, 6323.430891219812, 6337.714802833976, 6385.393387628168, 6394.200724909387, 6409.038644203407, 6182.721777519932, 6188.040853667689, 6219.191505104308, 6254.124422580751, 6308.432241098323, 6145.907811382922, 6252.218472690914, 6266.467350275278, 6268.7492500301305, 6291.559590828781, 6237.625742455467, 6262.718177681924, 6270.216222972129, 6318.526110541636, 6339.112524246517, 6098.420650038239, 6144.279601711528, 6148.923938310867, 6285.96857015712, 6317.494600432046, 6042.274927008787, 6126.754929802758, 6149.41580549847, 6151.0, 6159.84600384994, 6106.542009349228, 6146.139540464249, 6287.182666253358, 6311.810645680637, 6312.242530896138, 6002.33974262822, 6045.909311360245, 6114.571104522845, 6118.174046503843, 6156.365288323759], "value": 5805.124158848383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.43366659009416, 490.3894651159305, 495.0569165739268, 516.9815463536836, 536.2438961064898, 40348.596514034885, 43501.0, 43516.912077198045, 43611.78194109033, 43656.12687746243, 44516.0, 44670.0, 44885.55114448855, 44918.0, 45163.32255016169, 9210.539473026356, 9483.857742133874, 10001.89998100017, 10219.233557483181, 12438.315892625902, 12360.938195309056, 12630.052746044037, 12632.2420654761, 12636.178648387826, 12660.366981650881, 12571.0, 12618.621441356729, 12631.621051368473, 12638.810417843739, 12640.115191936567, 12509.749805003894, 12592.307423091726, 12593.874061259361, 12601.684957876034, 12622.495100196027, 12486.438110285058, 12544.74910501794, 12559.058070644738, 12566.74866502674, 12571.057170712233, 42532.78733606343, 42818.0, 42830.78584607057, 42911.57088429138, 42971.35542966858, 2891.508443564578, 3190.6968837960358, 3510.947335789965, 3537.3809583322814, 3915.8042097895277, 28510.091450658492, 28775.42449151026, 31102.688973110206, 32034.359312813613, 32567.348653026806, 3082.4605694003685, 3352.614449338333, 3361.697447229761, 3394.6435624259343, 3563.82180890957, 538150.0, 539641.0, 539843.0, 541901.0, 541920.0, 65104.0, 65510.0, 65557.34442655512, 65624.0, 65633.0, 68421.0, 68559.65720171467, 68585.0, 68619.65690171518, 68626.0, 17629.823701763074, 17852.19665115073, 17869.37457189018, 17917.37289194872, 17946.730799038025, 12765.234085954873, 13125.474981000843, 13143.802842957364, 13559.66100847467, 13676.589702308947, 17355.566110847078, 17361.82638173602, 17363.652726945642, 17366.044867532153, 17490.03804790749, 6267.9373206268265, 7008.544444611084, 7145.464090193256, 7278.636068196569, 7310.0, 744.281768093792, 785.5012067337282, 848.4781859156574, 902.6299217320867, 1058.751193469534, 28806.135815925554, 30327.786888524213, 31920.0, 32042.878499252412, 32634.836825816194, 989.4113002763344, 1067.8665166854144, 1114.7268919114706, 1122.6744244169263, 1184.8622944323429, 16422.83577164237, 16439.83560164383, 16535.586610334598, 16623.0099755953, 16804.747928780835, 693703.0, 698109.0, 699397.0, 701397.4930125317, 703666.0, 61570.0764488533, 61596.69201653963, 61746.0, 61812.381876181564, 61841.690791545756, 1277.6805798550363, 1313.1333320008748, 1374.896882733779, 1428.728541577097, 1451.1800832529798, 29979.850100749358, 33438.331233375684, 33439.16402089967, 33584.32831343408, 34063.829680851435, 53195.73402132965, 53661.731691341294, 53661.731691341294, 53829.46170538401, 54005.45994540161, 593544.0, 596211.0, 597459.0, 599485.0257487021, 600599.0, 36785.63214367929, 39254.0, 44144.0, 44221.33667995047, 45337.0, 48557.7860553489, 50145.0, 50355.0, 50360.0, 50599.241011384125, 35816.46275305925, 40242.1951560973, 41565.1686966253, 41703.58296416997, 42990.92522686958, 40912.0, 41398.379024314054, 41687.248147666854, 42682.35976460294, 42977.355339670554, 36021.81989090038, 40263.0, 40808.79595602003, 40891.0, 41535.58464415317, 33668.49497257494, 36225.45661815022, 36432.453513197856, 36651.0, 36765.63234367622, 23001.07995680154, 26469.33826654349, 26779.79490922952, 26804.329891752863, 26984.865075674497], "value": 21577.45982979083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.38114635436943, 384.78644352384424, 387.94582684684593, 392.8860630417178, 415.8523724077952, 14691.853081469182, 20230.29193978211, 21409.57180856382, 21593.13627454902, 21603.45991350215, 21108.155673773068, 21355.679664805, 21435.67846482304, 22040.44898877529, 22131.668024979597, 5615.185798059279, 6078.6048906820915, 6433.517486188532, 6435.292117867031, 6445.903311450332, 6094.969525152368, 6266.843328916791, 6310.779122730705, 6362.077498762676, 6410.423061924426, 6316.399942005525, 6320.5891617044745, 6322.051692246154, 6325.956217224152, 6331.430171284584, 6017.849553761169, 6264.342244064376, 6322.968385158091, 6326.620402775825, 6414.0, 5939.821805345847, 6127.387261273881, 6216.658083805389, 6231.158793562857, 6235.127082208494, 13364.06451548392, 13399.732005359838, 13621.863781362159, 13629.727405451835, 13860.4455821767, 2248.8875556222124, 2258.051618320293, 2435.415500279938, 2548.3374322676054, 2736.315921019745, 10045.09594136524, 10143.289969702124, 10335.0, 10461.0, 10674.62638807638, 1768.8319609637065, 1974.891380974046, 1981.791911849264, 2022.898855057256, 2026.6656001759693, 114711.99999999917, 121644.39177804143, 128517.0, 130784.0, 131940.02089968658, 8485.95757021211, 9985.550650220612, 10226.59093636261, 10302.124319432782, 10527.210459215436, 12675.492980280686, 12738.235705857493, 12757.362131893367, 13450.529231476852, 13969.58091257264, 8380.916190838136, 8679.349048821237, 8777.122287771172, 8821.029686734453, 8915.465072095694, 7838.0, 8736.737897862948, 8759.868601970975, 8825.02924678285, 8915.0, 3766.246750649881, 4455.799489023002, 4556.635469162459, 4639.956009897746, 4640.187967105743, 1879.2483006797117, 1929.2861641192567, 1929.488685498344, 1930.1217945834612, 1930.4305229957197, 832.7501749475255, 933.1648174883442, 959.429139661914, 987.9753006174903, 1010.8736407949007, 20492.59014819725, 22074.337769866608, 22103.336899892707, 22107.7840718762, 22326.106955721913, 936.6300311376968, 941.2093841173447, 945.2579724915907, 984.8128855517429, 1016.761061150629, 11175.714792798932, 11473.426328683532, 11486.712832179262, 11501.942490287494, 11518.136139789549, 624328.0, 637420.8128959326, 652611.0, 673197.0, 677148.0, 130978.34510827385, 138278.3086084563, 138631.37527436088, 146278.0, 149008.25495872452, 952.518977916148, 963.3738070254251, 967.1778987860263, 973.78576713123, 1000.2148313573955, 18200.544986374916, 18816.7177492335, 19510.463639726746, 19539.804601953798, 19590.216391344187, 50840.0, 52617.42147735574, 55356.44643553513, 55960.72019639876, 57465.42534574768, 66868.33131668816, 81680.0, 84212.0, 85262.72105918292, 85843.0, 7030.0, 8189.672413103409, 8239.835203296021, 8478.152184781473, 8621.741347759576, 10278.486075696335, 13193.010524210531, 13312.800307995194, 13394.598162055154, 13513.324333783468, 11124.888751112385, 11175.552977880794, 11288.040516556184, 11488.597899073826, 11693.473793679475, 11093.0, 11163.49764260594, 11232.606858759904, 11640.417979101181, 11792.23350482216, 10430.634927777492, 10865.18511111654, 11570.363630000431, 11736.647900562997, 12027.518899244282, 8033.839323213386, 8184.468009579358, 8454.746357609281, 8531.312636519477, 8550.401471896908, 10473.842892356774, 11399.544018239178, 11463.082953363544, 11607.477663504993, 11879.643610691694], "value": 9648.481604759352, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.8266466691664, 1545.7604071368937, 1553.1535313254278, 1559.532140357893, 1951.590166065127, 7985.680572777089, 8479.576021198938, 8773.649054037838, 8999.910000899989, 9004.234640055587, 8866.202041816252, 8966.730998070052, 8990.145936136072, 8999.190072893438, 9016.72949811505, 2396.3649632847264, 2413.746556611557, 2418.105301038618, 2418.600930846408, 2420.104561312317, 2021.5148364392587, 2398.040783686522, 2406.133791834938, 2412.023130632088, 2413.79482743967, 2368.39605900496, 2393.066703985447, 2398.8200884933613, 2411.3248290478605, 2412.553677569655, 2351.988240058806, 2379.6668466414717, 2381.7022872140983, 2387.785099341059, 2393.4614711689906, 2030.35028790787, 2330.5105927755194, 2339.6022676145094, 2367.573836709392, 2371.8221133415063, 8949.865752013726, 9073.45559266446, 9074.95638001625, 9083.318751093695, 9083.68207112748, 5373.838784836461, 5544.91682624761, 5559.19391688207, 5575.107982722786, 5576.247206627094, 3576.660217279354, 3607.2965771674535, 3658.432942893856, 3676.852925882988, 3704.666580007812, 1076.6716151573767, 1089.1232557790975, 1092.3609688332335, 1119.9440027998567, 1122.2929554380687, 11773.175877688565, 11792.469338879771, 11837.171398002143, 11877.762444751143, 11910.166288359906, 4151.27352713274, 4501.41481607389, 4612.7462989535225, 4637.65217608674, 4732.692374995614, 9310.674126405544, 9325.114114159143, 9327.253819694408, 9332.953335233417, 9341.813163736822, 5369.167778994262, 5371.060064488777, 5375.892482150413, 5377.0321342158, 5378.435264297271, 4290.4636920384955, 4548.6133678637025, 4661.930071048937, 4718.764061796896, 5042.949570504321, 3849.576546579874, 3898.766074035567, 3952.2490726761825, 3986.700997425147, 4000.4199391088127, 1182.9585964491373, 1183.5798291606527, 1194.778965891313, 1196.545312781155, 1204.0668481926577, 920.8894932607996, 923.2567782934668, 930.6412637549254, 932.077243528915, 971.1065819446127, 5787.710614469344, 5869.295684517885, 5921.319048309413, 6167.537434692416, 6286.748530058747, 429.5382463851372, 433.9479262488522, 434.8434563557117, 448.14628133405915, 448.66126074813957, 3999.3601023836627, 4044.130511939947, 4044.352903535479, 4111.483298971164, 4154.584541545822, 10609.257351985287, 11104.5558177672, 11108.16688748347, 11115.055220306203, 11115.666530004113, 11022.338659680445, 11035.558577656804, 11050.944745276222, 11059.22585419013, 11081.833772493419, 8369.0, 8394.370422218359, 8418.747437576883, 8427.32581393487, 8434.536100514408, 5886.293644762656, 5901.852453688693, 5941.9405805943115, 6096.513995926998, 6168.0, 9789.9021009789, 10237.539310730886, 10244.924282950184, 10337.896621033995, 10349.120324772479, 9510.429374237292, 10292.0, 10409.895901040893, 10428.478576071015, 10465.47672616351, 7136.286371362822, 7381.741639042608, 7481.326680598555, 7652.540847549165, 7748.34139098183, 8521.275691566037, 8521.53131577769, 8558.058613552628, 8579.571021448777, 8639.91360086391, 7727.9953606033105, 7733.226677332222, 7754.7673569793, 7788.182240864628, 7798.0, 6917.584944903322, 7119.323664251888, 7585.962070189614, 7618.885716714364, 7721.343685786771, 7089.645517724196, 7146.142462904485, 7163.212046674966, 7186.6047367395295, 7242.13094428672, 5186.714730689849, 5220.973895130652, 5243.580513558983, 5247.134222853187, 5249.763760630857, 5084.313617661716, 5094.312267843794, 5144.382674078985, 5327.360716714019, 5395.514403703685], "value": 4551.912187049028, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.52517023103496, 303.64776858843743, 311.4036619872943, 317.55066580788184, 318.7497814215841, 5500.614956953015, 5505.917411238835, 5511.0906700394435, 5533.778648854041, 5568.0, 4593.494715581283, 5107.7701503432345, 5277.282199667175, 5291.259223708675, 5299.311089558361, 3485.982570087159, 4150.916981660373, 4161.188568229181, 4162.0, 4178.12259425521, 3778.7152368194807, 4019.698522610816, 4154.626083652471, 4171.374293855931, 4198.265303571878, 3829.444730514074, 4018.0124655804943, 4155.39746736723, 4189.413482112506, 4190.811413486401, 3332.516785066152, 4131.256373852705, 4173.937390939138, 4187.183499217654, 4255.510616279121, 3264.9020529384156, 3400.4697885951173, 3607.3687104756564, 3607.556977209111, 3616.5660120785674, 4884.92531643038, 5262.789488420497, 5297.364316282033, 5314.601404894648, 5454.7818087276855, 4310.784460776948, 4640.169496607067, 4750.123701138031, 4757.286407038937, 4908.9754551227015, 4728.186728896301, 5619.325680918316, 5730.707716913226, 5738.856528586777, 5794.88410231793, 3863.5220783358996, 4011.7392369495888, 4044.8382064717375, 4047.1096358801015, 4052.5482083339743, 5323.520883120499, 5720.741436883879, 5801.7389217485315, 5963.493103086286, 6039.667818269993, 3466.7053300469743, 4084.65280451159, 4114.794260286973, 4115.218108559364, 4166.749995000249, 3612.7109831213966, 4035.878923632296, 4216.9036050627055, 4246.426732391149, 4262.168877068942, 3977.5425826030378, 4742.478327383985, 4802.398201348989, 4892.630063582132, 4904.068227036852, 4923.778429970588, 5482.396936337, 5683.8863222736145, 5752.223449834302, 5754.827355179351, 1224.7734169178552, 1330.9866901331056, 1399.4122468563228, 1416.3343228682502, 1436.3177490691837, 755.5844285642984, 842.3850589070013, 863.317978796756, 873.6156091319799, 920.7191806499083, 4151.854685086068, 4433.401490798701, 4439.179936226132, 4456.5766252205985, 4465.017696106851, 4428.446444194476, 4468.865934021985, 4829.502854115235, 4880.951190488121, 4919.7540122993705, 3529.1177205698577, 4060.2285565742413, 4202.495700515958, 4331.787099612114, 4464.486584042812, 2384.701912260967, 2400.159944019579, 2540.593505039185, 2548.13363456422, 2591.611258311231, 4572.51988541205, 4778.928316075262, 4981.118503866232, 5050.267711181858, 5117.897642047138, 4123.525794533667, 4163.02168990287, 4831.830885918976, 4889.3888263967, 4919.278252611557, 4818.759062046884, 4986.426560945465, 4987.850364489072, 5048.62135339851, 5054.59563234933, 4045.615666511677, 4782.2980016290685, 4790.616750660009, 4838.661293709407, 4936.432310284364, 4011.7764081954115, 4222.176675548239, 4714.646401519831, 4805.495422980537, 5818.476337129509, 6268.686565671789, 6278.246610406781, 6287.497000240061, 6298.338674439301, 6299.685015749286, 3410.7612467128056, 3638.853076684769, 3960.2277555876326, 4008.2985477541897, 4017.397390391348, 4882.9989852079525, 5070.467600901852, 5940.257467816523, 6022.728977196124, 6059.818205453844, 5764.682942438206, 5825.300963884361, 5828.242328497268, 5870.882582348415, 5875.265591801025, 5460.399356070909, 5727.770889164553, 5775.191473193672, 5834.970825145847, 5838.0, 4511.593956543927, 5084.288469417272, 5538.501534861882, 5722.628029178257, 5749.885002300014, 5560.19377190297, 5729.312482502127, 5828.184054232326, 5872.970635146968, 5889.261493405587, 4843.975780121077, 5655.7172141393585, 5701.201831743642, 5706.914396283976, 5780.653160810365], "value": 4005.971440574298, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.9751508697196, 755.4749449132852, 789.1989630525018, 845.0873057098335, 846.8687353460214, 15630.9839860409, 16789.0, 16789.832101678978, 16842.0, 16884.577885552866, 12624.684382890433, 14960.326785294661, 15100.169490678036, 15103.320350584223, 15120.47078352255, 729.3253740290211, 747.3796748698594, 749.8837680159584, 818.3575892924056, 873.2184694698241, 863.1584205399716, 916.0335845682802, 928.6146249306563, 929.159111004542, 930.1907340613676, 976.1166144639113, 981.3474039763585, 981.5582987655548, 983.0562659846556, 986.634945070325, 972.2270794718181, 973.1582181413097, 974.4056125763278, 975.8243516167087, 975.8243516167158, 730.375528922774, 730.441212472459, 731.7073170731696, 731.9194888562254, 732.1104857598044, 15811.051336919822, 16061.518154455385, 16209.946353487103, 16227.594310142224, 16243.593910152222, 13626.182429054288, 13648.658783530393, 13720.862791372158, 13981.161130332111, 15174.013689110283, 12905.2902090385, 13044.804327935088, 13128.60614181576, 13521.932390338085, 13755.10591811529, 4671.04243630055, 4792.281157826319, 4866.245731911559, 4932.827351042696, 4967.7019378837385, 112145.0, 113375.0, 115090.42454787756, 116459.0, 117779.41110294565, 10578.52396642153, 10950.178736594788, 11004.724881878017, 11089.22375433712, 11249.550017999189, 20550.486237844172, 20730.585388292453, 20791.0, 20794.1682332705, 20798.064087115814, 7788.14330423653, 7823.049360073127, 7886.250806173404, 8170.75487735357, 8176.305014073871, 4484.148011877733, 4593.931091033637, 4603.677742558056, 4680.180968330528, 4746.97939942907, 3674.6876515496483, 3781.7920014398924, 3829.0235989822418, 3831.5593706724085, 3843.5195600549932, 700.9614471204133, 703.7853454696367, 705.8059033765755, 707.4305184326666, 724.3842733676438, 554.9611527193058, 623.6133597169784, 669.6417416682149, 705.1326867952447, 711.5303899426353, 9633.710988670211, 9965.0, 10000.499975001221, 10068.69793906184, 10079.0, 624.4754406298731, 674.9932500675029, 691.6161530350704, 691.8996745471878, 706.8162277807807, 4818.229083346648, 4857.489963553776, 4873.707577545359, 4957.182064959314, 4961.05739909416, 118423.0, 147505.0, 150242.0, 152148.47851521565, 158984.20507897617, 137182.31408842892, 138503.0, 138863.30568347094, 145223.273883632, 147304.0, 90039.09960900438, 91339.0, 95923.08153836885, 109846.90153098367, 121480.0, 9851.45816980073, 10489.685309440729, 10721.678349649523, 10802.297850639683, 10846.891531084588, 54155.72922135364, 59908.50228744316, 60193.54516885285, 63040.36959630345, 66992.6650366745, 64784.999602953874, 78374.608126959, 88441.78895527405, 93304.06695932953, 99756.0, 12803.0, 13870.098443601133, 13893.652658683613, 14476.276186190858, 15040.548783536511, 12893.613191604267, 15850.52448426549, 16194.867005156953, 16226.0, 16931.746023809406, 12313.815292770436, 12761.361931903553, 12787.872121278668, 13079.542216022393, 13182.274974876475, 12116.697082573006, 14342.569722908329, 14539.127652340894, 15245.542633721006, 15591.142487163315, 14188.787168192692, 14470.855291447371, 14827.703445931236, 15177.544673659808, 15486.380544778083, 11509.194356394972, 11653.47559359814, 11763.764724705628, 12281.201721888407, 12430.12989090755, 11302.547898084313, 11832.0, 12169.69575760613, 12173.20874143178, 12181.0], "value": 8191.265683862182, "unit": "score"}], "name": "dromaeo_css", "value": 7517.883960486036, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 112.0, 113.0, 112.0, 113.0, 111.0, 114.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 129.0, 139.0, 144.0, 108.0, 107.0, 108.0, 107.0, 136.0, 106.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 181.0, 183.0, 182.0, 184.0, 184.0, 183.0, 182.0, 185.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 89.0, 65.0, 58.0, 58.0, 59.0, 97.0, 80.0], "value": 70.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 120.0, 100.0, 96.0, 68.0, 92.0, 67.0, 69.0, 88.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 87.0, 86.0, 91.0, 85.0, 88.0, 84.0, 87.0, 88.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 93.0, 92.0, 92.0, 93.0, 94.0, 92.0, 91.0], "value": 92.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 86.0, 85.0, 85.0, 84.0, 84.0, 86.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 52.0, 55.0, 56.0, 57.0, 56.0, 59.0, 58.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 76.0, 76.0, 72.0, 66.0, 68.0, 70.0, 69.0, 68.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 84.0, 83.0, 83.0, 80.0, 82.0, 81.0, 91.0, 98.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 120.0, 141.0, 143.0, 141.0, 141.0, 137.0, 139.0, 164.0, 149.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 159.0, 210.0, 221.0, 159.0, 158.0, 159.0, 155.0, 209.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 82.0, 81.0, 82.0, 69.0, 67.0, 62.0, 66.0, 64.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1435.3999999999999, "alertThreshold": 2.0}]} 06:37:24 INFO - Return code: 0 06:37:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:37:24 INFO - # TBPL SUCCESS # 06:37:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:37:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:37:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:37:24 INFO - 2017-01-14 06:37:24.517 screenresolution[1658:9821] starting screenresolution argv=screenresolution get 06:37:24 INFO - 2017-01-14 06:37:24.520 screenresolution[1658:9821] Display 0: 1600x1200x32@60 06:37:24 INFO - 2017-01-14 06:37:24.526 screenresolution[1659:9824] starting screenresolution argv=screenresolution list 06:37:24 INFO - Available Modes on Display 0 06:37:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:37:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:37:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:37:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:37:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:37:24 INFO - Intel Iris: 06:37:24 INFO - Chipset Model: Intel Iris 06:37:24 INFO - Type: GPU 06:37:24 INFO - Bus: Built-In 06:37:24 INFO - VRAM (Dynamic, Max): 1536 MB 06:37:24 INFO - Vendor: Intel (0x8086) 06:37:24 INFO - Device ID: 0x0a2e 06:37:24 INFO - Revision ID: 0x0009 06:37:24 INFO - Displays: 06:37:24 INFO - Display: 06:37:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:37:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:37:24 INFO - Display Serial Number: 1600x1200 60 06:37:24 INFO - Main Display: Yes 06:37:24 INFO - Mirror: Off 06:37:24 INFO - Online: Yes 06:37:24 INFO - Rotation: Supported 06:37:24 INFO - Return code: 0 06:37:24 INFO - Running post-action listener: _resource_record_post_action 06:37:24 INFO - [mozharness: 2017-01-14 14:37:24.762323Z] Finished run-tests step (success) 06:37:24 INFO - Running post-run listener: _resource_record_post_run 06:37:24 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 37458944; Write bytes: 495117824; Read time: 242; Write time: 1536 06:37:24 INFO - TinderboxPrint: CPU usage
53.6% 06:37:24 INFO - TinderboxPrint: I/O read bytes / time
37,458,944 / 242 06:37:24 INFO - TinderboxPrint: I/O write bytes / time
495,117,824 / 1,536 06:37:24 INFO - TinderboxPrint: CPU idle
2,219.1 (46.4%) 06:37:24 INFO - TinderboxPrint: CPU system
959.8 (20.1%) 06:37:24 INFO - TinderboxPrint: CPU user
1,602.7 (33.5%) 06:37:24 INFO - TinderboxPrint: Swap in / out
233,607,168 / 0 06:37:24 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183943680; Write bytes: 176242688; Read time: 16640; Write time: 367 06:37:24 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 36504576; Write bytes: 298808832; Read time: 227; Write time: 1111 06:37:25 INFO - Running post-run listener: _upload_blobber_files 06:37:25 INFO - Blob upload gear active. 06:37:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:37:25 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 06:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:37:25 INFO - (blobuploader) - INFO - Open directory for files ... 06:37:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:37:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:26 INFO - (blobuploader) - INFO - Done attempting. 06:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:27 INFO - (blobuploader) - INFO - Done attempting. 06:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:37:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:30 INFO - (blobuploader) - INFO - Done attempting. 06:37:30 INFO - (blobuploader) - INFO - Iteration through files over. 06:37:30 INFO - Return code: 0 06:37:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:37:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:37:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e56e2e02f699218abd947c3d4a2cd8979e437fb93d2ed3bac37abdc075c1f29dfb2d226bf2af5a70668a10df58cdc653cf70c01a9a1a7f9253e1c06ead2317dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a180ed2c2b4296f38d8090019272f03d50c839c7cb0dfcd859c1daa5548409b1ba847fe233d1c6800e26f5613bca6fa2693185230ae8d7f425429de21c6ab7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90f52bd120b6612932c77e97c0a29bd68dc2ac5014f513d09dc8ed89f249fcc9ff9bbbf1745716949115f0b60b6263bd64752c080a168fdac8a30a9fe97bfb17"} 06:37:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:37:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:37:30 INFO - Contents: 06:37:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e56e2e02f699218abd947c3d4a2cd8979e437fb93d2ed3bac37abdc075c1f29dfb2d226bf2af5a70668a10df58cdc653cf70c01a9a1a7f9253e1c06ead2317dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a180ed2c2b4296f38d8090019272f03d50c839c7cb0dfcd859c1daa5548409b1ba847fe233d1c6800e26f5613bca6fa2693185230ae8d7f425429de21c6ab7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90f52bd120b6612932c77e97c0a29bd68dc2ac5014f513d09dc8ed89f249fcc9ff9bbbf1745716949115f0b60b6263bd64752c080a168fdac8a30a9fe97bfb17"} 06:37:30 INFO - Running post-run listener: copy_logs_to_upload_dir 06:37:30 INFO - Copying logs to upload dir... 06:37:30 INFO - mkdir: /builds/slave/test/build/upload/logs 06:37:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.466499 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-14 06:37:30.374622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2017-01-14 06:37:30.382025) ========= 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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e56e2e02f699218abd947c3d4a2cd8979e437fb93d2ed3bac37abdc075c1f29dfb2d226bf2af5a70668a10df58cdc653cf70c01a9a1a7f9253e1c06ead2317dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a180ed2c2b4296f38d8090019272f03d50c839c7cb0dfcd859c1daa5548409b1ba847fe233d1c6800e26f5613bca6fa2693185230ae8d7f425429de21c6ab7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90f52bd120b6612932c77e97c0a29bd68dc2ac5014f513d09dc8ed89f249fcc9ff9bbbf1745716949115f0b60b6263bd64752c080a168fdac8a30a9fe97bfb17"} build_url:https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010922 build_url: 'https://queue.taskcluster.net/v1/task/PBrGmq0hR0SIlaiOI_JErg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e56e2e02f699218abd947c3d4a2cd8979e437fb93d2ed3bac37abdc075c1f29dfb2d226bf2af5a70668a10df58cdc653cf70c01a9a1a7f9253e1c06ead2317dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a180ed2c2b4296f38d8090019272f03d50c839c7cb0dfcd859c1daa5548409b1ba847fe233d1c6800e26f5613bca6fa2693185230ae8d7f425429de21c6ab7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90f52bd120b6612932c77e97c0a29bd68dc2ac5014f513d09dc8ed89f249fcc9ff9bbbf1745716949115f0b60b6263bd64752c080a168fdac8a30a9fe97bfb17"}' ========= master_lag: 3.26 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2017-01-14 06:37:33.648430) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 06:37:33.648767) ========= 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.kp6LnoVzNN/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.9CL8sbeaHF/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.005092 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 06:37:33.745963) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 06:37:33.746278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 06:37:33.747254) ========= ========= Total master_lag: 4.41 =========