builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0299 starttime: 1490100352.41 results: success (0) buildid: 20170321035429 builduid: 5b0360c7f00945839b3472e9c31d7e84 revision: 87a4ac4ccadc75acc6d3a7a8a71c25ae0d2a09da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:52.405833) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:52.406245) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:52.406530) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:52.436515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:52.436852) ========= 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.d63V1fQlvj/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.IJdwh1t4cR/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-21 05:45:52-- 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% 17.7M=0.001s 2017-03-21 05:45:52 (17.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:52.639696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:52.640010) ========= 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.d63V1fQlvj/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.IJdwh1t4cR/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.025697 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:52.689118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 05:45:52.689484) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 87a4ac4ccadc75acc6d3a7a8a71c25ae0d2a09da --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 87a4ac4ccadc75acc6d3a7a8a71c25ae0d2a09da --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d63V1fQlvj/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.IJdwh1t4cR/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-21 05:45:53,151 truncating revision to first 12 chars 2017-03-21 05:45:53,151 Setting DEBUG logging. 2017-03-21 05:45:53,151 attempt 1/10 2017-03-21 05:45:53,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/87a4ac4ccadc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 05:45:53,972 unpacking tar archive at: mozilla-beta-87a4ac4ccadc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.097061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 05:45:53.811212) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:53.811539) ========= script_repo_revision: 87a4ac4ccadc75acc6d3a7a8a71c25ae0d2a09da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:53.811954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:53.812218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 05:45:53.832134) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-21 05:45:53.832574) ========= /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.d63V1fQlvj/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.IJdwh1t4cR/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:45:54 INFO - MultiFileLogger online at 20170321 05:45:54 in /builds/slave/test 05:45:54 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 05:45:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:54 INFO - {'append_to_log': False, 05:45:54 INFO - 'base_work_dir': '/builds/slave/test', 05:45:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:45:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:54 INFO - 'branch': 'Mozilla-Beta', 05:45:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:54 INFO - 'config_files': ('talos/mac_config.py',), 05:45:54 INFO - 'default_actions': ('clobber', 05:45:54 INFO - 'read-buildbot-config', 05:45:54 INFO - 'download-and-extract', 05:45:54 INFO - 'populate-webroot', 05:45:54 INFO - 'create-virtualenv', 05:45:54 INFO - 'install', 05:45:54 INFO - 'run-tests'), 05:45:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:54 INFO - 'download_minidump_stackwalk': True, 05:45:54 INFO - 'download_symbols': 'ondemand', 05:45:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:54 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:54 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:54 INFO - 'installer_path': 'installer.exe', 05:45:54 INFO - 'log_level': 'info', 05:45:54 INFO - 'log_name': 'talos', 05:45:54 INFO - 'log_to_console': True, 05:45:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:45:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:45:54 INFO - 'opt_config_files': (), 05:45:54 INFO - 'pip_index': False, 05:45:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:54 INFO - 'cmd': ('bash', 05:45:54 INFO - '-c', 05:45:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:54 INFO - 'enabled': True, 05:45:54 INFO - 'halt_on_failure': False, 05:45:54 INFO - 'name': 'check_screen_resolution'},), 05:45:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:54 INFO - 'cmd': ('bash', 05:45:54 INFO - '-c', 05:45:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:54 INFO - 'enabled': True, 05:45:54 INFO - 'halt_on_failure': False, 05:45:54 INFO - 'name': 'check_screen_resolution'},), 05:45:54 INFO - 'run_cmd_checks_enabled': True, 05:45:54 INFO - 'sps_profile': False, 05:45:54 INFO - 'sps_profile_interval': 0, 05:45:54 INFO - 'suite': 'dromaeojs', 05:45:54 INFO - 'system_bits': '32', 05:45:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:54 INFO - 'title': 't-yosemite-r7-0299', 05:45:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:54 INFO - 'use_talos_json': True, 05:45:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:54 INFO - 'work_dir': 'build'} 05:45:54 INFO - [mozharness: 2017-03-21 12:45:54.397804Z] Running clobber step. 05:45:54 INFO - Running pre-action listener: _resource_record_pre_action 05:45:54 INFO - Running main action method: clobber 05:45:54 INFO - rmtree: /builds/slave/test/build 05:45:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:56 INFO - Running post-action listener: _resource_record_post_action 05:45:56 INFO - [mozharness: 2017-03-21 12:45:56.967362Z] Finished clobber step (success) 05:45:56 INFO - [mozharness: 2017-03-21 12:45:56.967526Z] Running read-buildbot-config step. 05:45:56 INFO - Running pre-action listener: _resource_record_pre_action 05:45:56 INFO - Running main action method: read_buildbot_config 05:45:56 INFO - Using buildbot properties: 05:45:56 INFO - { 05:45:56 INFO - "project": "", 05:45:56 INFO - "product": "firefox", 05:45:56 INFO - "script_repo_revision": "production", 05:45:56 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:45:56 INFO - "repository": "", 05:45:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:45:56 INFO - "buildid": "20170321035429", 05:45:56 INFO - "pgo_build": "False", 05:45:56 INFO - "basedir": "/builds/slave/test", 05:45:56 INFO - "buildnumber": 1, 05:45:56 INFO - "slavename": "t-yosemite-r7-0299", 05:45:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:45:56 INFO - "platform": "yosemite_r7", 05:45:56 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:45:56 INFO - "branch": "mozilla-beta", 05:45:56 INFO - "repo_path": "releases/mozilla-beta", 05:45:56 INFO - "revision": "87a4ac4ccadc75acc6d3a7a8a71c25ae0d2a09da", 05:45:56 INFO - "stage_platform": "macosx64", 05:45:56 INFO - "builduid": "5b0360c7f00945839b3472e9c31d7e84", 05:45:56 INFO - "slavebuilddir": "test" 05:45:56 INFO - } 05:45:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 05:45:56 INFO - Running post-action listener: _resource_record_post_action 05:45:56 INFO - [mozharness: 2017-03-21 12:45:56.973060Z] Finished read-buildbot-config step (success) 05:45:56 INFO - [mozharness: 2017-03-21 12:45:56.973313Z] Running download-and-extract step. 05:45:56 INFO - Running pre-action listener: _resource_record_pre_action 05:45:56 INFO - Running main action method: download_and_extract 05:45:56 INFO - mkdir: /builds/slave/test/build/tests 05:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:56 INFO - trying https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 05:45:56 INFO - Downloading https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:45:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 05:45:57 INFO - Downloaded 1165 bytes. 05:45:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:45:57 INFO - Using the following test package requirements: 05:45:57 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:45:57 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:45:57 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 05:45:57 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:45:57 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 05:45:57 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:45:57 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:45:57 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 05:45:57 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:45:57 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:45:57 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 05:45:57 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:45:57 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 05:45:57 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:45:57 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 05:45:57 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:45:57 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 05:45:57 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 05:45:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:45:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:45:57 INFO - Fetch https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:45:58 INFO - Expected file size: 16108241 05:45:58 INFO - Obtained file size: 16108241 05:46:05 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:46:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:46:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:46:05 INFO - Fetch https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:46:06 INFO - Expected file size: 16108241 05:46:06 INFO - Obtained file size: 16108241 05:46:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 05:46:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 05:46:13 INFO - Fetch https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 05:46:14 INFO - Expected file size: 14403663 05:46:14 INFO - Obtained file size: 14403663 05:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:14 INFO - trying https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:46:14 INFO - Downloading https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 05:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 05:46:16 INFO - Downloaded 58736661 bytes. 05:46:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:46:16 INFO - mkdir: /builds/slave/test/properties 05:46:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:16 INFO - Contents: 05:46:16 INFO - build_url:https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:46:17 INFO - Running post-action listener: _resource_record_post_action 05:46:17 INFO - Running post-action listener: set_extra_try_arguments 05:46:17 INFO - [mozharness: 2017-03-21 12:46:17.534388Z] Finished download-and-extract step (success) 05:46:17 INFO - [mozharness: 2017-03-21 12:46:17.534508Z] Running populate-webroot step. 05:46:17 INFO - Running pre-action listener: _resource_record_pre_action 05:46:17 INFO - Running main action method: populate_webroot 05:46:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:17 INFO - '--tppagecycles', 05:46:17 INFO - '7'], 05:46:17 INFO - 'tests': ['tsvgm']}}, 05:46:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:46:17 INFO - 'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:46:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:46:17 INFO - 'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['damp', 'tps']}, 05:46:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:46:17 INFO - 'tests': ['damp', 'tps']}, 05:46:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['dromaeo_dom']}, 05:46:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['basic_compositor_video']}, 05:46:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:46:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['a11yr', 05:46:17 INFO - 'ts_paint', 05:46:17 INFO - 'tpaint', 05:46:17 INFO - 'sessionrestore', 05:46:17 INFO - 'sessionrestore_no_auto_restore', 05:46:17 INFO - 'tabpaint']}, 05:46:17 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:17 INFO - 'ts_paint', 05:46:17 INFO - 'tpaint', 05:46:17 INFO - 'sessionrestore', 05:46:17 INFO - 'sessionrestore_no_auto_restore', 05:46:17 INFO - 'tabpaint']}, 05:46:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:17 INFO - 'ts_paint', 05:46:17 INFO - 'tpaint', 05:46:17 INFO - 'sessionrestore', 05:46:17 INFO - 'sessionrestore_no_auto_restore', 05:46:17 INFO - 'tabpaint']}, 05:46:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:17 INFO - 'ts_paint', 05:46:17 INFO - 'tpaint', 05:46:17 INFO - 'sessionrestore', 05:46:17 INFO - 'sessionrestore_no_auto_restore', 05:46:17 INFO - 'tabpaint']}, 05:46:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['a11yr', 05:46:17 INFO - 'ts_paint', 05:46:17 INFO - 'tpaint', 05:46:17 INFO - 'sessionrestore', 05:46:17 INFO - 'sessionrestore_no_auto_restore', 05:46:17 INFO - 'tabpaint']}, 05:46:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['a11yr', 05:46:17 INFO - 'ts_paint', 05:46:17 INFO - 'tpaint', 05:46:17 INFO - 'sessionrestore', 05:46:17 INFO - 'sessionrestore_no_auto_restore', 05:46:17 INFO - 'tabpaint']}, 05:46:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['tsvgx', 05:46:17 INFO - 'tsvgr_opacity', 05:46:17 INFO - 'tart', 05:46:17 INFO - 'tscrollx', 05:46:17 INFO - 'cart', 05:46:17 INFO - 'tsvg_static']}, 05:46:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:17 INFO - 'tsvgr_opacity', 05:46:17 INFO - 'tart', 05:46:17 INFO - 'tscrollx', 05:46:17 INFO - 'cart', 05:46:17 INFO - 'tsvg_static']}, 05:46:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:46:17 INFO - 'talos_options': ['--disable-e10s'], 05:46:17 INFO - 'tests': ['tp5o']}, 05:46:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:46:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:46:17 INFO - 'talos_options': ['--disable-e10s', 05:46:17 INFO - '--xperf_path', 05:46:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:17 INFO - 'tests': ['tp5n']}, 05:46:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:46:17 INFO - 'talos_options': ['--xperf_path', 05:46:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:17 INFO - 'tests': ['tp5n']}}, 05:46:17 INFO - 'talos.zip': {'path': '', 05:46:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:17 INFO - Running post-action listener: _resource_record_post_action 05:46:17 INFO - [mozharness: 2017-03-21 12:46:17.552773Z] Finished populate-webroot step (success) 05:46:17 INFO - [mozharness: 2017-03-21 12:46:17.552914Z] Running create-virtualenv step. 05:46:17 INFO - Running pre-action listener: _resource_record_pre_action 05:46:17 INFO - Running main action method: create_virtualenv 05:46:17 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:17 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 05:46:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:17 INFO - Using real prefix '/tools/python27' 05:46:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:21 INFO - Installing pip.................done. 05:46:21 INFO - Return code: 0 05:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:46:21 INFO - Reading from file tmpfile_stdout 05:46:21 INFO - Output received: 05:46:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:46:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:21 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 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:21 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 05:46:21 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 05:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:21 INFO - 'HOME': '/Users/cltbld', 05:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:21 INFO - 'LOGNAME': 'cltbld', 05:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:21 INFO - 'MOZ_NO_REMOTE': '1', 05:46:21 INFO - 'NO_EM_RESTART': '1', 05:46:21 INFO - 'PAGER': '/bin/cat', 05:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:21 INFO - 'PWD': '/builds/slave/test', 05:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:21 INFO - 'SHELL': '/bin/bash', 05:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:21 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:21 INFO - 'USER': 'cltbld', 05:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:21 INFO - 'XPC_FLAGS': '0x0', 05:46:21 INFO - 'XPC_SERVICE_NAME': '0', 05:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:21 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 05:46:21 INFO - Cleaning up... 05:46:21 INFO - Return code: 0 05:46:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:21 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 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:21 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 05:46:21 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 05:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:21 INFO - 'HOME': '/Users/cltbld', 05:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:21 INFO - 'LOGNAME': 'cltbld', 05:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:21 INFO - 'MOZ_NO_REMOTE': '1', 05:46:21 INFO - 'NO_EM_RESTART': '1', 05:46:21 INFO - 'PAGER': '/bin/cat', 05:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:21 INFO - 'PWD': '/builds/slave/test', 05:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:21 INFO - 'SHELL': '/bin/bash', 05:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:21 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:21 INFO - 'USER': 'cltbld', 05:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:21 INFO - 'XPC_FLAGS': '0x0', 05:46:21 INFO - 'XPC_SERVICE_NAME': '0', 05:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:22 INFO - Downloading/unpacking psutil>=3.1.1 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:25 INFO - Installing collected packages: psutil 05:46:25 INFO - Running setup.py install for psutil 05:46:25 INFO - building 'psutil._psutil_osx' extension 05:46:25 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 05:46:26 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 05:46:26 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 05:46:26 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 05:46:26 INFO - building 'psutil._psutil_posix' extension 05:46:26 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 05:46:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:46:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:46:26 INFO - ^ 05:46:26 INFO - 1 warning generated. 05:46:26 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 05:46:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:26 INFO - Successfully installed psutil 05:46:26 INFO - Cleaning up... 05:46:26 INFO - Return code: 0 05:46:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46:26 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')]} 05:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:26 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')]} 05:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:26 INFO - 'HOME': '/Users/cltbld', 05:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:26 INFO - 'LOGNAME': 'cltbld', 05:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:26 INFO - 'MOZ_NO_REMOTE': '1', 05:46:26 INFO - 'NO_EM_RESTART': '1', 05:46:26 INFO - 'PAGER': '/bin/cat', 05:46:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:26 INFO - 'PWD': '/builds/slave/test', 05:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:26 INFO - 'SHELL': '/bin/bash', 05:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:26 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:26 INFO - 'USER': 'cltbld', 05:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:26 INFO - 'XPC_FLAGS': '0x0', 05:46:26 INFO - 'XPC_SERVICE_NAME': '0', 05:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:26 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 05:46:26 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 05:46:26 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 05:46:26 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 05:46:26 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 05:46:26 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 05:46:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:29 INFO - Installing collected packages: mozsystemmonitor 05:46:29 INFO - Running setup.py install for mozsystemmonitor 05:46:29 INFO - Successfully installed mozsystemmonitor 05:46:29 INFO - Cleaning up... 05:46:29 INFO - Return code: 0 05:46:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:29 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 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:29 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 05:46:29 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 05:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:29 INFO - 'HOME': '/Users/cltbld', 05:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:29 INFO - 'LOGNAME': 'cltbld', 05:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:29 INFO - 'MOZ_NO_REMOTE': '1', 05:46:29 INFO - 'NO_EM_RESTART': '1', 05:46:29 INFO - 'PAGER': '/bin/cat', 05:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:29 INFO - 'PWD': '/builds/slave/test', 05:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:29 INFO - 'SHELL': '/bin/bash', 05:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:29 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:29 INFO - 'USER': 'cltbld', 05:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:29 INFO - 'XPC_FLAGS': '0x0', 05:46:29 INFO - 'XPC_SERVICE_NAME': '0', 05:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:30 INFO - Downloading/unpacking jsonschema==2.5.1 05:46:30 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 05:46:30 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 05:46:30 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 05:46:30 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 05:46:30 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 05:46:30 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 05:46:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:46:32 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 05:46:32 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 05:46:32 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 05:46:32 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 05:46:32 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 05:46:32 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 05:46:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:33 INFO - warning: no files found matching '*.txt' 05:46:33 INFO - no previously-included directories found matching 'build' 05:46:33 INFO - no previously-included directories found matching 'dist' 05:46:33 INFO - no previously-included directories found matching '.git*' 05:46:33 INFO - Installing collected packages: jsonschema, functools32 05:46:33 INFO - Running setup.py install for functools32 05:46:33 INFO - warning: no files found matching '*.txt' 05:46:33 INFO - no previously-included directories found matching 'build' 05:46:33 INFO - no previously-included directories found matching 'dist' 05:46:33 INFO - no previously-included directories found matching '.git*' 05:46:33 INFO - Successfully installed jsonschema functools32 05:46:33 INFO - Cleaning up... 05:46:33 INFO - Return code: 0 05:46:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:46:33 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')]} 05:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:33 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')]} 05:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:33 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 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:33 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 05:46:33 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 05:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:33 INFO - 'HOME': '/Users/cltbld', 05:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:33 INFO - 'LOGNAME': 'cltbld', 05:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:33 INFO - 'MOZ_NO_REMOTE': '1', 05:46:33 INFO - 'NO_EM_RESTART': '1', 05:46:33 INFO - 'PAGER': '/bin/cat', 05:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:33 INFO - 'PWD': '/builds/slave/test', 05:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:33 INFO - 'SHELL': '/bin/bash', 05:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:33 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:33 INFO - 'USER': 'cltbld', 05:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:33 INFO - 'XPC_FLAGS': '0x0', 05:46:33 INFO - 'XPC_SERVICE_NAME': '0', 05:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:46:33 INFO - Cleaning up... 05:46:33 INFO - Return code: 0 05:46:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46:33 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')]} 05:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:33 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')]} 05:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:33 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 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:33 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 05:46:33 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 05:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:33 INFO - 'HOME': '/Users/cltbld', 05:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:33 INFO - 'LOGNAME': 'cltbld', 05:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:33 INFO - 'MOZ_NO_REMOTE': '1', 05:46:33 INFO - 'NO_EM_RESTART': '1', 05:46:33 INFO - 'PAGER': '/bin/cat', 05:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:33 INFO - 'PWD': '/builds/slave/test', 05:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:33 INFO - 'SHELL': '/bin/bash', 05:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:33 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:33 INFO - 'USER': 'cltbld', 05:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:33 INFO - 'XPC_FLAGS': '0x0', 05:46:33 INFO - 'XPC_SERVICE_NAME': '0', 05:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:34 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 05:46:34 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 05:46:34 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 05:46:34 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 05:46:34 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 05:46:34 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 05:46:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:36 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 05:46:36 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 05:46:36 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 05:46:36 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 05:46:36 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 05:46:36 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 05:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:38 INFO - Downloading docopt-0.6.1.tar.gz 05:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:38 INFO - Running setup.py install for blobuploader 05:46:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:38 INFO - Running setup.py install for requests 05:46:38 INFO - Running setup.py install for docopt 05:46:39 INFO - Successfully installed blobuploader requests docopt 05:46:39 INFO - Cleaning up... 05:46:39 INFO - Return code: 0 05:46:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:39 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')]} 05:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:39 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')]} 05:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:39 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 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:39 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 05:46:39 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 05:46:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:39 INFO - 'HOME': '/Users/cltbld', 05:46:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:39 INFO - 'LOGNAME': 'cltbld', 05:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:39 INFO - 'MOZ_NO_REMOTE': '1', 05:46:39 INFO - 'NO_EM_RESTART': '1', 05:46:39 INFO - 'PAGER': '/bin/cat', 05:46:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:39 INFO - 'PWD': '/builds/slave/test', 05:46:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:39 INFO - 'SHELL': '/bin/bash', 05:46:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:39 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:39 INFO - 'USER': 'cltbld', 05:46:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:39 INFO - 'XPC_FLAGS': '0x0', 05:46:39 INFO - 'XPC_SERVICE_NAME': '0', 05:46:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-KqSWMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-zcUBNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-nsIkcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-TjhmQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-7kiGY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:39 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-WRRmMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Mslesj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-chQ_Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-YXVjSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-UYELY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-MuUFf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-uH610e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-IgJSll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-AyZQ1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-0z5faI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:40 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-skxnPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:41 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-yk1BWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:41 INFO - Running setup.py install for manifestparser 05:46:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:41 INFO - Running setup.py install for mozcrash 05:46:41 INFO - Running setup.py install for mozdebug 05:46:41 INFO - Running setup.py install for mozdevice 05:46:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:41 INFO - Running setup.py install for mozfile 05:46:41 INFO - Running setup.py install for mozhttpd 05:46:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:42 INFO - Running setup.py install for mozinfo 05:46:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:42 INFO - Running setup.py install for mozInstall 05:46:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:42 INFO - Running setup.py install for mozleak 05:46:42 INFO - Running setup.py install for mozlog 05:46:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:42 INFO - Running setup.py install for moznetwork 05:46:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:42 INFO - Running setup.py install for mozprocess 05:46:43 INFO - Running setup.py install for mozprofile 05:46:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:43 INFO - Running setup.py install for mozrunner 05:46:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:43 INFO - Running setup.py install for mozscreenshot 05:46:43 INFO - Running setup.py install for moztest 05:46:43 INFO - Running setup.py install for mozversion 05:46:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:43 INFO - Cleaning up... 05:46:43 INFO - Return code: 0 05:46:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:43 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')]} 05:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:43 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')]} 05:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:43 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 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:43 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 05:46:43 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 05:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:43 INFO - 'HOME': '/Users/cltbld', 05:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:43 INFO - 'LOGNAME': 'cltbld', 05:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:43 INFO - 'MOZ_NO_REMOTE': '1', 05:46:43 INFO - 'NO_EM_RESTART': '1', 05:46:43 INFO - 'PAGER': '/bin/cat', 05:46:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:43 INFO - 'PWD': '/builds/slave/test', 05:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:43 INFO - 'SHELL': '/bin/bash', 05:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:43 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:43 INFO - 'USER': 'cltbld', 05:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:43 INFO - 'XPC_FLAGS': '0x0', 05:46:43 INFO - 'XPC_SERVICE_NAME': '0', 05:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-GZGG4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:44 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)) 05:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-g4EOTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-9qRV9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:44 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)) 05:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-1BjMOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-6BVS_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:44 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)) 05:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-oBY8aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:44 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)) 05:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-pPphwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:44 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)) 05:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-qWXpoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:44 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)) 05:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-8TVdpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:45 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)) 05:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-I2ZG_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:45 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)) 05:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-HjpcbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:45 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)) 05:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-4W3l8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Phh7kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:45 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)) 05:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-rYBKYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-uSmLZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:45 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)) 05:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-2FrqeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Fz22xM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:45 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)) 05:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:45 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)) 05:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:48 INFO - Downloading blessings-1.6.tar.gz 05:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:48 INFO - Installing collected packages: blessings 05:46:48 INFO - Running setup.py install for blessings 05:46:48 INFO - Successfully installed blessings 05:46:48 INFO - Cleaning up... 05:46:49 INFO - Return code: 0 05:46:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:49 INFO - Reading from file tmpfile_stdout 05:46:49 INFO - Current package versions: 05:46:49 INFO - blessings == 1.6 05:46:49 INFO - blobuploader == 1.2.4 05:46:49 INFO - docopt == 0.6.1 05:46:49 INFO - functools32 == 3.2.3-2 05:46:49 INFO - jsonschema == 2.5.1 05:46:49 INFO - manifestparser == 1.1 05:46:49 INFO - mozInstall == 1.12 05:46:49 INFO - mozcrash == 1.0 05:46:49 INFO - mozdebug == 0.1 05:46:49 INFO - mozdevice == 0.49 05:46:49 INFO - mozfile == 1.2 05:46:49 INFO - mozhttpd == 0.7 05:46:49 INFO - mozinfo == 0.9 05:46:49 INFO - mozleak == 0.1 05:46:49 INFO - mozlog == 3.4 05:46:49 INFO - moznetwork == 0.27 05:46:49 INFO - mozprocess == 0.24 05:46:49 INFO - mozprofile == 0.28 05:46:49 INFO - mozrunner == 6.13 05:46:49 INFO - mozscreenshot == 0.1 05:46:49 INFO - mozsystemmonitor == 0.3 05:46:49 INFO - moztest == 0.8 05:46:49 INFO - mozversion == 1.4 05:46:49 INFO - psutil == 3.1.1 05:46:49 INFO - requests == 1.2.3 05:46:49 INFO - wsgiref == 0.1.2 05:46:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:49 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')]} 05:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:49 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')]} 05:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:49 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 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:49 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 05:46:49 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 05:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:49 INFO - 'HOME': '/Users/cltbld', 05:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:49 INFO - 'LOGNAME': 'cltbld', 05:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:49 INFO - 'MOZ_NO_REMOTE': '1', 05:46:49 INFO - 'NO_EM_RESTART': '1', 05:46:49 INFO - 'PAGER': '/bin/cat', 05:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:49 INFO - 'PWD': '/builds/slave/test', 05:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:49 INFO - 'SHELL': '/bin/bash', 05:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:49 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:49 INFO - 'USER': 'cltbld', 05:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:49 INFO - 'XPC_FLAGS': '0x0', 05:46:49 INFO - 'XPC_SERVICE_NAME': '0', 05:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:50 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)) 05:46:50 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)) 05:46:50 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)) 05:46:50 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)) 05:46:50 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)) 05:46:50 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)) 05:46:50 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)) 05:46:50 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)) 05:46:50 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)) 05:46:50 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)) 05:46:50 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)) 05:46:50 INFO - Cleaning up... 05:46:50 INFO - Return code: 0 05:46:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:50 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 0x103799b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10379c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf1c78020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, '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.d63V1fQlvj/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.IJdwh1t4cR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 05:46:50 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 05:46:50 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 05:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:50 INFO - 'HOME': '/Users/cltbld', 05:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:50 INFO - 'LOGNAME': 'cltbld', 05:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:50 INFO - 'MOZ_NO_REMOTE': '1', 05:46:50 INFO - 'NO_EM_RESTART': '1', 05:46:50 INFO - 'PAGER': '/bin/cat', 05:46:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:50 INFO - 'PWD': '/builds/slave/test', 05:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:50 INFO - 'SHELL': '/bin/bash', 05:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:46:50 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:50 INFO - 'USER': 'cltbld', 05:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:50 INFO - 'XPC_FLAGS': '0x0', 05:46:50 INFO - 'XPC_SERVICE_NAME': '0', 05:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:50 INFO - Cleaning up... 05:46:50 INFO - Return code: 0 05:46:50 INFO - Running post-action listener: _resource_record_post_action 05:46:50 INFO - Running post-action listener: _start_resource_monitoring 05:46:50 INFO - Starting resource monitoring. 05:46:50 INFO - [mozharness: 2017-03-21 12:46:50.902572Z] Finished create-virtualenv step (success) 05:46:50 INFO - [mozharness: 2017-03-21 12:46:50.903541Z] Running install step. 05:46:50 INFO - Running pre-action listener: _resource_record_pre_action 05:46:50 INFO - Running main action method: install 05:46:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:51 INFO - Reading from file tmpfile_stdout 05:46:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:51 INFO - Reading from file tmpfile_stdout 05:46:51 INFO - Output received: 05:46:51 INFO - Usage: mozinstall [options] installer 05:46:51 INFO - Options: 05:46:51 INFO - -h, --help show this help message and exit 05:46:51 INFO - -d DEST, --destination=DEST 05:46:51 INFO - Directory to install application into. [default: 05:46:51 INFO - "/builds/slave/test"] 05:46:51 INFO - --app=APP Application being installed. [default: firefox] 05:46:51 INFO - mkdir: /builds/slave/test/build/application 05:46:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:47:05 INFO - Reading from file tmpfile_stdout 05:47:05 INFO - Output received: 05:47:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:47:05 INFO - Running post-action listener: _resource_record_post_action 05:47:05 INFO - [mozharness: 2017-03-21 12:47:05.924016Z] Finished install step (success) 05:47:05 INFO - [mozharness: 2017-03-21 12:47:05.924149Z] Running run-tests step. 05:47:05 INFO - Running pre-action listener: _resource_record_pre_action 05:47:05 INFO - Running main action method: run_tests 05:47:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:47:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:47:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:47:05 INFO - 2017-03-21 05:47:05.938 screenresolution[1622:7421] starting screenresolution argv=screenresolution get 05:47:05 INFO - 2017-03-21 05:47:05.941 screenresolution[1622:7421] Display 0: 1600x1200x32@60 05:47:05 INFO - 2017-03-21 05:47:05.946 screenresolution[1623:7423] starting screenresolution argv=screenresolution list 05:47:05 INFO - Available Modes on Display 0 05:47:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:47:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:47:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:47:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:47:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:47:06 INFO - Intel Iris: 05:47:06 INFO - Chipset Model: Intel Iris 05:47:06 INFO - Type: GPU 05:47:06 INFO - Bus: Built-In 05:47:06 INFO - VRAM (Dynamic, Max): 1536 MB 05:47:06 INFO - Vendor: Intel (0x8086) 05:47:06 INFO - Device ID: 0x0a2e 05:47:06 INFO - Revision ID: 0x0009 05:47:06 INFO - Displays: 05:47:06 INFO - Display: 05:47:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:47:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:47:06 INFO - Display Serial Number: 1600x1200 60 05:47:06 INFO - Main Display: Yes 05:47:06 INFO - Mirror: Off 05:47:06 INFO - Online: Yes 05:47:06 INFO - Rotation: Supported 05:47:06 INFO - Return code: 0 05:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:06 INFO - Python 2.7.3 05:47:06 INFO - Return code: 0 05:47:06 INFO - grabbing minidump binary from tooltool 05:47:06 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')]} 05:47:06 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 0x103577d30>, '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 0x10349edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10356cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:06 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 05:47:06 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 05:47:06 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 05:47:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:06 INFO - Return code: 0 05:47:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:47:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:47:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:06 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/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--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 05:47:06 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/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0299 --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 05:47:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d63V1fQlvj/Render', 05:47:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:06 INFO - 'HOME': '/Users/cltbld', 05:47:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:06 INFO - 'LOGNAME': 'cltbld', 05:47:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:06 INFO - 'MOZ_NO_REMOTE': '1', 05:47:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:06 INFO - 'NO_EM_RESTART': '1', 05:47:06 INFO - 'PAGER': '/bin/cat', 05:47:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:06 INFO - 'PWD': '/builds/slave/test', 05:47:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:06 INFO - 'SHELL': '/bin/bash', 05:47:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IJdwh1t4cR/Listeners', 05:47:06 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 05:47:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:06 INFO - 'USER': 'cltbld', 05:47:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:06 INFO - 'XPC_FLAGS': '0x0', 05:47:06 INFO - 'XPC_SERVICE_NAME': '0', 05:47:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:06 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/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--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 05:47:06 INFO - mozversion application_buildid: 20170321035429 05:47:06 INFO - mozversion application_changeset: 87a4ac4ccadc75acc6d3a7a8a71c25ae0d2a09da 05:47:06 INFO - mozversion application_display_name: Firefox 05:47:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:06 INFO - mozversion application_name: Firefox 05:47:06 INFO - mozversion application_remotingname: firefox 05:47:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:47:06 INFO - mozversion application_vendor: Mozilla 05:47:06 INFO - mozversion application_version: 53.0 05:47:06 INFO - mozversion platform_buildid: 20170321035429 05:47:06 INFO - mozversion platform_changeset: 87a4ac4ccadc75acc6d3a7a8a71c25ae0d2a09da 05:47:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:47:06 INFO - mozversion platform_version: 53.0 05:47:06 INFO - using testdate: 1490100426 05:47:06 INFO - actual date: 1490100426 05:47:06 INFO - starting webserver on 'localhost:49245' 05:47:06 INFO - SUITE-START | Running 2 tests 05:47:06 INFO - TEST-START | dromaeo_css 05:47:06 INFO - operating with platform_type : mac_ 05:47:06 INFO - Initialising browser for dromaeo_css test... 05:47:06 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpdNFpNx/profile http://localhost:49245/getInfo.html) 05:47:08 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 05:47:08 INFO - PROCESS | 1633 | colorDepth:24 05:47:08 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 05:47:08 INFO - PROCESS | 1633 | __metrics 05:47:09 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:47:09 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:47:09 INFO - TEST-INFO | 1633: exit 0 05:47:09 INFO - Browser initialized. 05:47:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:09 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpdNFpNx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:21 INFO - PROCESS | 1636 | RSS: Main: 167407616 05:47:21 INFO - PROCESS | 1636 | 05:50:24 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 05:50:26 INFO - PROCESS | 1636 | RSS: Main: 342245376 05:50:26 INFO - PROCESS | 1636 | 05:53:28 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 05:53:29 INFO - PROCESS | 1636 | RSS: Main: 312299520 05:53:29 INFO - PROCESS | 1636 | 05:56:31 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 05:56:32 INFO - PROCESS | 1636 | RSS: Main: 297410560 05:56:32 INFO - PROCESS | 1636 | 05:59:34 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 05:59:35 INFO - PROCESS | 1636 | RSS: Main: 281374720 05:59:35 INFO - PROCESS | 1636 | 06:02:38 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 06:02:38 INFO - PROCESS | 1636 | RSS: Main: 281681920 06:02:38 INFO - PROCESS | 1636 | 06:05:42 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 06:05:42 INFO - PROCESS | 1636 | RSS: Main: 348028928 06:05:42 INFO - PROCESS | 1636 | 06:05:42 INFO - PROCESS | 1636 | __start_tp_report 06:05:42 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 06:05:42 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 06:05:42 INFO - PROCESS | 1636 | |i|pagename|runs| 06:05:42 INFO - PROCESS | 1636 | |0;dojo.html;3046.7105624965625;3482.0250329907603;3485.494603282524;3499.7725147865403;3520.295940811838;5799.797007104752;5803.274590676166;5811.331696854863;5821.9999999999945;5835.44563266489;5841.912371314434;5902.88194236115;5962.373950735165;5966.134910437984;5970.194023806785;5283.762230699608;5285.418603953572;5343.599230057742;5355.6786592804365;5391.433899440561;5249.921251181236;5261.158214685651;5264.763085661135;5323;5381.973090134564;5188.974055129738;5322.8137015204475;5326.733663316838;5350.759215835296;5377.677339359651;5333.866653333697;5348.705821179834;5353.304070470834;5355.892882142374;5394.514493695547;5169.095408303532;5215.765290561896;5223.843284701427;5280.049591073605;5296.602754793406;4678.672492925497;5725.885482290331;5818.854528636775;5827.941720582825;5900.527957763368;6246.219222597176;6307.810765677037;6335.334789847046;6339.36606339367;6361.236651601791;6239.65681887496;6278.6860656966965;6301.59039662425;6308.653024083674;6331.620102793847;5770.826875193751;5888.735006924656;5907.379725128842;5943.435373639497;5949.791757288561;6408.00675895237;6415.871682566322;6417;6420.454261387741;6420.58266212704;6278.058291256348;6283.654399008007;6287.308396076428;6302.212223472066;6311.936880631227;6224.315325314303;6246.250449946036;6259.561830671901;6263.31103578606;6263.467605253604;5170.715610641376;6331.651759153291;6339.904901426482;6342.080398342307;6342.8414289642205;6329.303776584572;6335.619862808154;6340.270868850142;6350.428461438492;6354.17395738551;4953.554180123806;4988.80044798204;4993.0762808879745;4998.975210081924;5084.542391184811;4555.134524440346;4557.043020965568;4581.816727330869;4587.357769912215;4602.424696912886;5798.246227990334;5827.708614569255;5831.096180092092;5840.474357307863;5858.7070646468355;6247.687615619292;6279.748810047547;6297.842553936097;6308.621482711052;6331.398517140864;5961.165436838846;5962.433568810956;5968.104784282393;5969.283685957713;5989.371116032841;5454.863628409322;5526.171074338801;5551.417101204396;5552.08390615552;5557.944420555824;6222.81331560054;6279.183706118175;6469.676516174267;6471.7734879279;6486.091947127406;6293.874122517433;6298.748050077946;6307.274663413767;6312.43188113072;6339.2392912850755;6311.495080393649;6359.936400635935;6365.04524321337;6427.678616069272;6444.130042444398;6291.433770960635;6293.213348331458;6299.086632438362;6315.873682526232;6317.936820631735;5627.5497960162265;6289.591176573508;6322.33615470369;6329.7151628175925;6340.968295158679;5690.800821971211;6122.520135281246;6134.099846298167;6155.969220153871;6157.076438534076;6209.59637623553;6218.129461875432;6255.53083518747;6267.467265282502;6268.780592679417;5111.258867464123;6152.753889844356;6154.907676384768;6168.475679567287;6169.537284703755;6088.6042407243385;6130.245269656939;6261.655608941552;6277.2781130170615;6277.435030847063;6037.9094313584455;6083;6119.470635406854;6134.509239260938;6163.630182189083 06:05:42 INFO - PROCESS | 1636 | |1;ext.html;490.458043861533;493.9654224204305;514.3878784246746;549.870780366614;589.2428229724804;32319.030429087135;42049.78975105124;43764.781176094075;43787.90530236742;45705;45850.54149458504;45933.0813383733;46168.538314616846;46195.53804461954;46343.768281158635;9472.952635236832;9662.758431039245;9674.08096230857;9691.563879625399;9704.02959704031;9075.727728168133;9286.814263714721;9485.81028379432;11734.471948762326;12005.219660722025;11914.880851191507;11919.7616047679;11965.282083075;11971.580994665188;12071.637850864488;11870.7625847483;11950.641480755592;11968.521259149667;11986.400679965967;11987.400629968466;11778.882211177865;11840;11850.525978960832;11861.051115910706;11864.347460889647;41965;42169.57830421687;42257.36613950793;42268.1546369074;42302;4091.89770255743;4134.834606615732;4160.667146628262;4162.313218318974;4201.222773786859;30639.846800766078;31391.84304078488;31750;31938;32758.181045473815;3185.888493902702;3259;3275.2139486523065;3276.7214786743157;3463.584369875631;453570;455324;458816;459524;461302;63274.36725632685;63856;63982;63988;64049.67975160095;65246.673766631815;67932.660336698;67947.32052679508;68076.31923680799;68094.65952670205;17862.55343616394;18125.456236312933;18144.274229030954;18147;18153.818461815477;13696.383662735201;13769.793453098211;13778.173309601256;13790;13796.103253288504;15080.396784128512;15366.923165384325;15435.845641543441;15704.528864134094;15708.68582628341;5016.398032236155;6373.171487706569;6476.222853257639;6486.124373209651;6490.318516555788;881.823635272948;882.223643193998;898.7573355194061;923.4690053219425;928.1924725488868;30100.84949575238;30148.698513015028;30286.54570181449;30482.54276185859;30735.538966915516;1069.588208539718;1078.0836289154156;1113.3264375053138;1119.4514687802919;1235.407004637761;15508.069515829086;15521.922390387976;15617.60955976087;15904.681906361808;16082.195890205678;640518;644374;644976;645401;646212;48064.75967620209;59084.70457647684;59184.81630367369;61521.692391537756;62065.68967155226;1431;1437.331640787039;1477.2982833154165;1501.6771394150528;1502.8872834537453;22303.330900073022;29053.12840614785;29691.85154074216;30501.847490762404;30576;49603.25595116148;52321;52322.476775231764;52329.738351308;52418.213726793365;599374;607224;607316;607334;607501;24402.75597244076;25363.746362536138;25530.489390212464;25615.23154305374;25654.230373088092;43866.56133438625;44792;45077.32384014177;45081.32378014398;45461;36684.63315366919;36817.815910920275;36921.81539092395;37320;37421.877343679735;35942.8202858984;35991.64008359883;36540.451893222154;36938.8153059233;37171;33375.332493350485;34404.48393274153;36493.45259821052;36684.81657591695;36890.893273201844;30168.84915575408;31601.367972639957;31654.841725791222;31848.6815131855;32090.51864221992;17435.389761358292;24052.639210411508;24157.550546966537;24494.203398473266;24563.508729825662 06:05:42 INFO - PROCESS | 1636 | |2;jquery.html;382.25841866778467;399.3849471813409;402.69395259602703;412.75234859084543;432.418397255691;15171.924140379297;17651.55871103223;22129.66805497919;22665.206717764882;22823.885880570575;21660.89169554154;22460.775392246072;22537;23097;23741.64387534184;5026.894083301677;5946.940530594682;6245.032020036879;6256.124142620037;6269.968650156743;5520.337559492847;5525.198846167304;6106.419890110455;6213.7514499420195;6215.471684906788;5561;5563.972180139114;5567.248421463111;5573.526250268732;5579.69311687857;5542.528885044776;5549.417311182328;5562.97085039267;6066.939330606726;6160.6611636359985;5460.726963651801;5463.836084917459;5474.233607294982;5477.233187353773;5477.7261136943;13920.651983700387;14063.085899416505;14088.859111408858;14093.013489055771;20034.69947950782;2680.9865950670123;2690.1391554702504;2723.196656986194;2723.9319017024536;2785.8189217700783;9229.400088994262;9949.656796332474;10077.949610251975;10253.692389228261;10752.086072683831;1797.757302764123;1864.7389365488707;1888.8866667999964;1937.4575118966711;1954.5797653504565;109576;135263.32368338192;139002.6099739;140287.29856350654;142217;11743.354115523729;12054.035677145806;12085;12085.395730213455;12106.273623582612;16430.917845410695;16451.25969331383;16465.176741163134;16473.176341183134;16499.340026398808;7386.630668466555;8975.596098175598;9167.495787731605;9185.724428267162;9323.160915517501;8953.060653312521;8953.4180278283;9020.188183063425;9116.407433516933;9183.448993060438;4906.681065730716;4922.268141181678;4936.605071594264;4943.406791185081;5011.348524691767;1829.2408650409932;1963.8232559069752;2018.9899050504948;2053.9319553832224;2068.834493240567;960.6541645007792;1001.5793366785967;1007.1992765751245;1015.0712098429854;1025.9846102308472;21824.89087554552;22094.668579971312;22095;22185.556288874133;22256.43896976476;862.6284208109137;875.8248350329959;995.7012896131132;1001.0990108902047;1017.4658304390107;11046.061084807881;11260.887391126147;11376.976072153546;11377.601783937522;11437.59968401102;800225;803473.0574634961;807448;809862;823278;94091.61749972113;152631;155017;155197;158700;1038.4081073787868;1068.7862427514528;1102.5204036244259;1102.9613963511238;1105.6793529876245;21072.894635526725;21150.788492114883;21329.17777977549;21525.03137358854;21726.89136554307;58801.765902875755;60818;61316.38683613285;62538.374616253255;63663.6816815913;83750.58124709337;90356;92932.53533732289;93714;94141;8573.22840944318;8589.914100859161;8727.91272087271;8821.779455513664;8888.955555222183;10132.594696212069;13270.535531256359;13314.533991310258;13526.661833454242;13589.52436664712;11231.494582743633;11392.316461012366;11486.425678716198;11572.479238434122;11665.708357291136;9642.566084526354;11110.555577776799;11298;11325.886741132483;11830.349330786545;9706.369086009387;10749;11916.344601047025;12048.879511204776;12103.33431661267;7374.557526548424;7814.179511151247;7827.726029588937;8332.16678332162;8733.737987860375;8403.83192336162;8744.606492707717;9257.120573545502;11284.43577821122;11444.599439019594 06:05:42 INFO - PROCESS | 1636 | |3;mootools.html;1447.1534152520776;1448.0732331307966;1475.0338528263985;1476.2028504607508;1481.7629179331307;8182.918170818298;8567.271781898546;8567.485950842954;8568.443051201668;8588.312934965212;7621.161672216066;7852.411069169821;8130.9593452032805;8385.0357208921;8393.118722534138;2374.620060790274;2415.0581273303424;2418.2745176447083;2420.9636855447184;2421.6609674645474;2397.928062158138;2419.9516009679796;2425.9878700606473;2428.9271321860283;2430.720467146274;2378.8810559472045;2381.428457170275;2397.412633904687;2405.795507381875;2421.5520128776234;2365.1012615206196;2370.4073981504625;2391;2396.2811156652933;2398.7481314461907;2395.6765836612185;2416.9516609667885;2417.5648383291;2419.6249581314923;2421.5520128776056;8441.155884411572;8484.448510846774;8546.829063418696;8548.529830859301;8552.957235213846;5138.126518491828;5295.7881684732565;5297.761600727977;5311.150215965427;5319;3383.543221665093;3470.2712430389647;3589.6948759355487;3607.7113830893463;3670.06413364593;1097.1825989637691;1213.9332336721477;1263.7662032524013;1273.0441345136917;1304.5173285884189;10957.12343012565;11025.228234023622;11026.338419694845;11039.227254092217;11067.335959842354;4420.977895110504;4710.882227944328;4721.5750582447745;4810.7835147418455;4820.30105634681;7923.524588524591;9564.139227469423;9580.616775329048;9588.280878934107;9598;5317.175837745079;5327.547158491494;5329.280547126166;5332.066888294533;5332.30680011596;4222.387753775685;4242.637266890099;4898.187670561915;4908.337374454474;4923.77842997066;3046.4211799757977;3399.5920489540918;3729.645683660048;3905.72659913809;4016.779077150726;1111.4387234446715;1277.8786015328528;1287.2598256002648;1287.9935600322126;1300.3498250874563;917.0966597901062;920.3143657974852;944.6221511395497;950.0926615082718;988.6243227573476;5605.859853503695;5699.971500142473;5787.276590426197;5947.345791962881;6000.699965001732;580.1269090019493;583.0874681124027;590.4302348233974;595.7289433307922;602.6263716495713;3835.8657446989223;3843.6925045996254;3869.2261547690573;3904.511936007999;3963.7027222958395;9737.513124343754;9830.459324737065;9962;10069.848952265722;10070.345427547187;9118.81762364749;9980.650677226262;10032.64885728996;10037.297389182833;10044;7594.8860767089645;7882.605869706606;7941.364690824836;7960.761177164694;7960.920390796134;5824.271966004249;5990.041593345044;5998.790042348497;6047.848803779941;6061.272647282354;8854.690085846965;8993;9293.581788819383;9306.860397093913;9432.62269509212;9023.142801433853;9096.545172741204;9459.716208513755;9550.140487356171;9600.279979001743;6788.389044985975;6996.965015174892;7054.506184567031;7260.745873894389;7435.739749108755;8004.799880003046;8099.676012959416;8165.1018387978465;8171.83656326882;8190.877136842833;7079.716811327489;7102.786916392516;7290;7344.632768361667;7382.298681625237;7061.788146355618;7147;7154.892676609959;7294.051773269441;7340.302671246223;5522.751476183501;6454.644994525346;6575.178102737158;6581.736730530725;6596.60420374779;4346.587074227943;5008.367141218434;5092.2361645753435;5163.199704045879;5168.638195326442;4981.925271121008;5041.747912604428;5146.588272938081;5230.2677625131755;5306.310179676618 06:05:42 INFO - PROCESS | 1636 | |4;prototype.html;362.2139956294841;364.62443683006495;371.3056584187569;374.7545357790648;377.38863041872173;4841.806327746895;5285.603579731521;5340.732963351831;5386.380566234884;5389.218563308323;4930;5108.7956481740775;5271.288376069229;5284.313039304895;5334.67991920485;3693.947225040857;4127.534725172565;4152.335626299792;4185.937210941823;4187.895302617429;3605.954273260751;4052.9797351013353;4146.523149837777;4178.352355384905;4208.97895510522;3526.629703881094;3594.2272411431536;3819;3949.7037722170808;4145.979270103645;3598.4062629666337;3962.722609417342;4009.939850902239;4193.972476743203;4229.6404805591255;3057.281538838371;3395.3888300105973;3468.3871999520343;3689.114612493009;3692.7415080944343;5213;5220.765065572058;5224.63427560071;5226.346706661668;5253.238280449352;4136.544980052192;4336.588024137734;4678.391809064834;4800.663953523254;4814.975925120352;5551.583631227633;5672.262605861253;5685.276144125563;5719.283340413312;5772.3361813391575;3884.5726970033274;3930.213957208541;3944.447777311179;3952.7351247600777;4008.83964641414;5386.596005299618;5596.2165296858475;5909.704514774244;6012.632925561699;6042.788502402439;3518.82405879705;3627.8209581885994;3984.641382275609;3985.8206380712936;3997.4603428536775;3832;4056.8377264909664;4057.797110144481;4058.0463591056077;4076.898077548085;4393.319035549495;4537.455505339381;4671.649626278043;4691.296305554194;4734.384530011145;4720.834770783006;5094.592432605456;5208.322918020709;5734.77060917567;5830;1079.6707004363745;1088.363307465126;1289.8516670583003;1310.0174868848364;1318.2420108437686;716.8924661300847;749.8087987563136;861.2851333393269;887.8801361816202;890.9242714369221;4611.446626404853;4689.906201875943;5080.415752188472;5133.281340612317;5133.717645529532;4738.928916066262;4798.448178459452;4976.5023497649945;5462.562994960394;5741.45456181662;4181.853635122817;4666.603338716247;4977.278294647328;5204.011237864794;5282.920756188661;2870.4402641485126;2890.898818541383;2957.438086763508;2975.6577993530586;2983.686712895158;4876.804927802848;4899.436564795023;5318.521333080042;5449;5763.0202865512965;5318.444213116355;5707.458986073737;5802.47777700009;5849.064149736022;5862.267216597926;4771.974025584516;5153.871153221125;5830.95042892275;5877.52979761618;5986.910196347146;5754.56840736938;5770.50950669181;5839.620424672553;5847.356790753099;5852.132455097057;5490.286262785812;5766.308043034863;5774.797882074276;5784.82645520635;5806.6806325650805;5063.974680126576;5331.680099194061;5998.370171131968;6012.518998480198;6118.847028824315;3938.7242892997215;3948.4077388390824;3954.2008386184793;3968.960310396859;3972.880813575597;4898.681585697061;5617.662940223599;5748;5852.419846641468;5866.823995280149;5633.3521645009705;5678.2050512929045;5679;5683.829485115453;5722.799702010409;5057.898842023213;5567.693776842312;5653.293338332708;5661.773529058956;5714.79998200061;4891.926621100757;5105.8723531912;5133.922991155061;5203.985222881502;5262.763175657181;5011.423686275979;5423.691548155701;5459.406781778624;5647.119968815851;5662.631928924607;4608.907821843612;5257.7371131442505;5528.695921724344;5544.586130536687;5596.496315331639 06:05:42 INFO - PROCESS | 1636 | |5;yui.html;752.2289653105563;779.844031193761;803.3091541274505;803.8874557561942;887.56065747455;15112.093274403544;15207.087574745508;15594.532164035068;15724.29240684169;15771.369145234192;13972.860271397283;14346;14453;14456.349464274106;14495.057821241639;891.2736120062161;912.4753266871576;912.7991841794794;916.4684482999877;921.2814005076051;737.3106145753737;758.3326672528168;881.6032785246632;903.0878812399458;906.9002409734924;982.7837875667342;985.5417230987589;986.2405947420482;987.3927534566262;988.6984469736727;977.4330888084894;979.3585201692867;980.0689345122091;981.3768257156721;981.5632043740538;726.5894769455241;729.0813574895617;732.783828770514;732.827785470414;737.9631018449056;15188.620284492865;15597.14215718135;15608.531744047697;15742.212889355487;16067.276972536263;14763.26183690822;14795.630109247248;14983.625409364744;15234.619134521725;15522.61193470161;11743.069884273844;11829.693887725578;11990.220635658654;12210.877891221064;12593.055520835882;3808.980955095207;3875.5736868944396;3875.9418608720894;4031.4154447605224;4052.1287923096675;109152.45423772909;112205;118607;118659;122410.3879480597;10580.52387642558;10698.946505267424;10993.175511836644;11628.476718547685;11952.701182470508;23803.523929521314;23840.523189536114;23855.165069222494;23866.761332386803;23951.880240598686;7728.4590078693955;7842.686292548348;7997.600119993977;8100.554469504234;8289.461185023074;4339.132173565299;4463.598276155161;4485.461744590605;4592.609628181575;4684.250519916797;3119.703628155367;3640.7997560134445;3649.4525821127045;3721.218544105768;3938.0351813805228;759.3545486336681;759.5594555157995;763.6601712238112;777.4985134588159;778.9260020298062;694.506900100934;713.678844519968;727.8435136445689;739.7336958694866;767.7044337929938;9778.902210977942;9957.104504522424;10778.029977301923;10859.891401085888;11365;607.9300880398811;629.6064959400375;635.6376865186799;637.5696404926656;748.9588072655947;4978.825741099116;5170.250313704491;5183.118869792069;5183.118869792144;5186.196139598368;99457.50271248598;104976;105999.4700026495;106024.46987765012;107043;78482.6075869617;96581;96615.51692241494;99735;100331;76183.61908190424;77465;82984.58507707423;83990;86662.99999999873;10926.50830712604;11081.612143574936;11286.15353848481;11438.885611143782;11500;44839.775801120784;53746.46253537414;54132;54743.35769926909;56586;70528.64735676494;70738.64630676813;72709.63645181741;73940.63029684818;74835;14428.783568246694;14515.951979402957;14726.77909831332;15041.119860017498;15445.536633901002;13121.737565248832;14905.403783848524;15448.691026179189;16140.838591613934;16791.41230056942;13594.728105438033;13667.81576604125;14384.208868512333;14597.12417254968;14749.451307612546;12690;12844.743105137659;12879.098463107868;13261.734765304833;13283.203007819562;13209.735805283648;14164;14292.85707142957;14516.983811133541;14619.853801462275;11229.55081796719;11343.659690209306;11415.828762568402;11788.70528236801;12145.332006739362;10927.722772277228;11514.136439767219;12005.879941200476;12011.339376334385;12028.15802893789 06:05:42 INFO - PROCESS | 1636 | __end_tp_report 06:05:42 INFO - PROCESS | 1636 | __start_cc_report 06:05:42 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1671 06:05:42 INFO - PROCESS | 1636 | __end_cc_report 06:05:42 INFO - PROCESS | 1636 | __startTimestamp1490101542567__endTimestamp 06:05:42 INFO - PROCESS | 1636 | 06:05:42 INFO - PROCESS | 1636 | ------- Summary: start ------- 06:05:42 INFO - PROCESS | 1636 | Number of tests: 6 06:05:42 INFO - PROCESS | 1636 | 06:05:42 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5833.79 Median:6119.47 stddev:650.19 (10.6%) stddev-sans-first:614.32 06:05:42 INFO - PROCESS | 1636 | Values: 3046.7 3482.0 3485.5 3499.8 3520.3 5799.8 5803.3 5811.3 5822.0 5835.4 5841.9 5902.9 5962.4 5966.1 5970.2 5283.8 5285.4 5343.6 5355.7 5391.4 5249.9 5261.2 5264.8 5323.0 5382.0 5189.0 5322.8 5326.7 5350.8 5377.7 5333.9 5348.7 5353.3 5355.9 5394.5 5169.1 5215.8 5223.8 5280.0 5296.6 4678.7 5725.9 5818.9 5827.9 5900.5 6246.2 6307.8 6335.3 6339.4 6361.2 6239.7 6278.7 6301.6 6308.7 6331.6 5770.8 5888.7 5907.4 5943.4 5949.8 6408.0 6415.9 6417.0 6420.5 6420.6 6278.1 6283.7 6287.3 6302.2 6311.9 6224.3 6246.3 6259.6 6263.3 6263.5 5170.7 6331.7 6339.9 6342.1 6342.8 6329.3 6335.6 6340.3 6350.4 6354.2 4953.6 4988.8 4993.1 4999.0 5084.5 4555.1 4557.0 4581.8 4587.4 4602.4 5798.2 5827.7 5831.1 5840.5 5858.7 6247.7 6279.7 6297.8 6308.6 6331.4 5961.2 5962.4 5968.1 5969.3 5989.4 5454.9 5526.2 5551.4 5552.1 5557.9 6222.8 6279.2 6469.7 6471.8 6486.1 6293.9 6298.7 6307.3 6312.4 6339.2 6311.5 6359.9 6365.0 6427.7 6444.1 6291.4 6293.2 6299.1 6315.9 6317.9 5627.5 6289.6 6322.3 6329.7 6341.0 5690.8 6122.5 6134.1 6156.0 6157.1 6209.6 6218.1 6255.5 6267.5 6268.8 5111.3 6152.8 6154.9 6168.5 6169.5 6088.6 6130.2 6261.7 6277.3 6277.4 6037.9 6083.0 6119.5 6134.5 6163.6 06:05:42 INFO - PROCESS | 1636 | 06:05:42 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:70533.57 Median:36751.32 stddev:153671.65 (418.1%) stddev-sans-first:154012.76 06:05:42 INFO - PROCESS | 1636 | Values: 490.5 494.0 514.4 549.9 589.2 32319.0 42049.8 43764.8 43787.9 45705.0 45850.5 45933.1 46168.5 46195.5 46343.8 9473.0 9662.8 9674.1 9691.6 9704.0 9075.7 9286.8 9485.8 11734.5 12005.2 11914.9 11919.8 11965.3 11971.6 12071.6 11870.8 11950.6 11968.5 11986.4 11987.4 11778.9 11840.0 11850.5 11861.1 11864.3 41965.0 42169.6 42257.4 42268.2 42302.0 4091.9 4134.8 4160.7 4162.3 4201.2 30639.8 31391.8 31750.0 31938.0 32758.2 3185.9 3259.0 3275.2 3276.7 3463.6 453570.0 455324.0 458816.0 459524.0 461302.0 63274.4 63856.0 63982.0 63988.0 64049.7 65246.7 67932.7 67947.3 68076.3 68094.7 17862.6 18125.5 18144.3 18147.0 18153.8 13696.4 13769.8 13778.2 13790.0 13796.1 15080.4 15366.9 15435.8 15704.5 15708.7 5016.4 6373.2 6476.2 6486.1 6490.3 881.8 882.2 898.8 923.5 928.2 30100.8 30148.7 30286.5 30482.5 30735.5 1069.6 1078.1 1113.3 1119.5 1235.4 15508.1 15521.9 15617.6 15904.7 16082.2 640518.0 644374.0 644976.0 645401.0 646212.0 48064.8 59084.7 59184.8 61521.7 62065.7 1431.0 1437.3 1477.3 1501.7 1502.9 22303.3 29053.1 29691.9 30501.8 30576.0 49603.3 52321.0 52322.5 52329.7 52418.2 599374.0 607224.0 607316.0 607334.0 607501.0 24402.8 25363.7 25530.5 25615.2 25654.2 43866.6 44792.0 45077.3 45081.3 45461.0 36684.6 36817.8 36921.8 37320.0 37421.9 35942.8 35991.6 36540.5 36938.8 37171.0 33375.3 34404.5 36493.5 36684.8 36890.9 30168.8 31601.4 31654.8 31848.7 32090.5 17435.4 24052.6 24157.6 24494.2 24563.5 06:05:42 INFO - PROCESS | 1636 | 06:05:42 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:42323.21 Median:22960.44 stddev:134205.91 (584.5%) stddev-sans-first:134545.44 06:05:42 INFO - PROCESS | 1636 | Values: 382.3 399.4 402.7 412.8 432.4 15171.9 17651.6 22129.7 22665.2 22823.9 21660.9 22460.8 22537.0 23097.0 23741.6 5026.9 5946.9 6245.0 6256.1 6270.0 5520.3 5525.2 6106.4 6213.8 6215.5 5561.0 5564.0 5567.2 5573.5 5579.7 5542.5 5549.4 5563.0 6066.9 6160.7 5460.7 5463.8 5474.2 5477.2 5477.7 13920.7 14063.1 14088.9 14093.0 20034.7 2681.0 2690.1 2723.2 2723.9 2785.8 9229.4 9949.7 10077.9 10253.7 10752.1 1797.8 1864.7 1888.9 1937.5 1954.6 109576.0 135263.3 139002.6 140287.3 142217.0 11743.4 12054.0 12085.0 12085.4 12106.3 16430.9 16451.3 16465.2 16473.2 16499.3 7386.6 8975.6 9167.5 9185.7 9323.2 8953.1 8953.4 9020.2 9116.4 9183.4 4906.7 4922.3 4936.6 4943.4 5011.3 1829.2 1963.8 2019.0 2053.9 2068.8 960.7 1001.6 1007.2 1015.1 1026.0 21824.9 22094.7 22095.0 22185.6 22256.4 862.6 875.8 995.7 1001.1 1017.5 11046.1 11260.9 11377.0 11377.6 11437.6 800225.0 803473.1 807448.0 809862.0 823278.0 94091.6 152631.0 155017.0 155197.0 158700.0 1038.4 1068.8 1102.5 1103.0 1105.7 21072.9 21150.8 21329.2 21525.0 21726.9 58801.8 60818.0 61316.4 62538.4 63663.7 83750.6 90356.0 92932.5 93714.0 94141.0 8573.2 8589.9 8727.9 8821.8 8889.0 10132.6 13270.5 13314.5 13526.7 13589.5 11231.5 11392.3 11486.4 11572.5 11665.7 9642.6 11110.6 11298.0 11325.9 11830.3 9706.4 10749.0 11916.3 12048.9 12103.3 7374.6 7814.2 7827.7 8332.2 8733.7 8403.8 8744.6 9257.1 11284.4 11444.6 06:05:42 INFO - PROCESS | 1636 | 06:05:42 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5498.05 Median:5323.27 stddev:2974.81 (55.9%) stddev-sans-first:2967.58 06:05:42 INFO - PROCESS | 1636 | Values: 1447.2 1448.1 1475.0 1476.2 1481.8 8182.9 8567.3 8567.5 8568.4 8588.3 7621.2 7852.4 8131.0 8385.0 8393.1 2374.6 2415.1 2418.3 2421.0 2421.7 2397.9 2420.0 2426.0 2428.9 2430.7 2378.9 2381.4 2397.4 2405.8 2421.6 2365.1 2370.4 2391.0 2396.3 2398.7 2395.7 2417.0 2417.6 2419.6 2421.6 8441.2 8484.4 8546.8 8548.5 8553.0 5138.1 5295.8 5297.8 5311.2 5319.0 3383.5 3470.3 3589.7 3607.7 3670.1 1097.2 1213.9 1263.8 1273.0 1304.5 10957.1 11025.2 11026.3 11039.2 11067.3 4421.0 4710.9 4721.6 4810.8 4820.3 7923.5 9564.1 9580.6 9588.3 9598.0 5317.2 5327.5 5329.3 5332.1 5332.3 4222.4 4242.6 4898.2 4908.3 4923.8 3046.4 3399.6 3729.6 3905.7 4016.8 1111.4 1277.9 1287.3 1288.0 1300.3 917.1 920.3 944.6 950.1 988.6 5605.9 5700.0 5787.3 5947.3 6000.7 580.1 583.1 590.4 595.7 602.6 3835.9 3843.7 3869.2 3904.5 3963.7 9737.5 9830.5 9962.0 10069.8 10070.3 9118.8 9980.7 10032.6 10037.3 10044.0 7594.9 7882.6 7941.4 7960.8 7960.9 5824.3 5990.0 5998.8 6047.8 6061.3 8854.7 8993.0 9293.6 9306.9 9432.6 9023.1 9096.5 9459.7 9550.1 9600.3 6788.4 6997.0 7054.5 7260.7 7435.7 8004.8 8099.7 8165.1 8171.8 8190.9 7079.7 7102.8 7290.0 7344.6 7382.3 7061.8 7147.0 7154.9 7294.1 7340.3 5522.8 6454.6 6575.2 6581.7 6596.6 4346.6 5008.4 5092.2 5163.2 5168.6 4981.9 5041.7 5146.6 5230.3 5306.3 06:05:42 INFO - PROCESS | 1636 | 06:05:42 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4539.30 Median:5087.50 stddev:1385.15 (27.2%) stddev-sans-first:1353.08 06:05:42 INFO - PROCESS | 1636 | Values: 362.2 364.6 371.3 374.8 377.4 4841.8 5285.6 5340.7 5386.4 5389.2 4930.0 5108.8 5271.3 5284.3 5334.7 3693.9 4127.5 4152.3 4185.9 4187.9 3606.0 4053.0 4146.5 4178.4 4209.0 3526.6 3594.2 3819.0 3949.7 4146.0 3598.4 3962.7 4009.9 4194.0 4229.6 3057.3 3395.4 3468.4 3689.1 3692.7 5213.0 5220.8 5224.6 5226.3 5253.2 4136.5 4336.6 4678.4 4800.7 4815.0 5551.6 5672.3 5685.3 5719.3 5772.3 3884.6 3930.2 3944.4 3952.7 4008.8 5386.6 5596.2 5909.7 6012.6 6042.8 3518.8 3627.8 3984.6 3985.8 3997.5 3832.0 4056.8 4057.8 4058.0 4076.9 4393.3 4537.5 4671.6 4691.3 4734.4 4720.8 5094.6 5208.3 5734.8 5830.0 1079.7 1088.4 1289.9 1310.0 1318.2 716.9 749.8 861.3 887.9 890.9 4611.4 4689.9 5080.4 5133.3 5133.7 4738.9 4798.4 4976.5 5462.6 5741.5 4181.9 4666.6 4977.3 5204.0 5282.9 2870.4 2890.9 2957.4 2975.7 2983.7 4876.8 4899.4 5318.5 5449.0 5763.0 5318.4 5707.5 5802.5 5849.1 5862.3 4772.0 5153.9 5831.0 5877.5 5986.9 5754.6 5770.5 5839.6 5847.4 5852.1 5490.3 5766.3 5774.8 5784.8 5806.7 5064.0 5331.7 5998.4 6012.5 6118.8 3938.7 3948.4 3954.2 3969.0 3972.9 4898.7 5617.7 5748.0 5852.4 5866.8 5633.4 5678.2 5679.0 5683.8 5722.8 5057.9 5567.7 5653.3 5661.8 5714.8 4891.9 5105.9 5133.9 5204.0 5262.8 5011.4 5423.7 5459.4 5647.1 5662.6 4608.9 5257.7 5528.7 5544.6 5596.5 06:05:42 INFO - PROCESS | 1636 | 06:05:42 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:21634.35 Median:3685.34 stddev:31167.52 (845.7%) stddev-sans-first:31215.51 06:05:42 INFO - PROCESS | 1636 | Values: 752.2 779.8 803.3 803.9 887.6 15112.1 15207.1 15594.5 15724.3 15771.4 13972.9 14346.0 14453.0 14456.3 14495.1 891.3 912.5 912.8 916.5 921.3 737.3 758.3 881.6 903.1 906.9 982.8 985.5 986.2 987.4 988.7 977.4 979.4 980.1 981.4 981.6 726.6 729.1 732.8 732.8 738.0 15188.6 15597.1 15608.5 15742.2 16067.3 14763.3 14795.6 14983.6 15234.6 15522.6 11743.1 11829.7 11990.2 12210.9 12593.1 3809.0 3875.6 3875.9 4031.4 4052.1 109152.5 112205.0 118607.0 118659.0 122410.4 10580.5 10698.9 10993.2 11628.5 11952.7 23803.5 23840.5 23855.2 23866.8 23951.9 7728.5 7842.7 7997.6 8100.6 8289.5 4339.1 4463.6 4485.5 4592.6 4684.3 3119.7 3640.8 3649.5 3721.2 3938.0 759.4 759.6 763.7 777.5 778.9 694.5 713.7 727.8 739.7 767.7 9778.9 9957.1 10778.0 10859.9 11365.0 607.9 629.6 635.6 637.6 749.0 4978.8 5170.3 5183.1 5183.1 5186.2 99457.5 104976.0 105999.5 106024.5 107043.0 78482.6 96581.0 96615.5 99735.0 100331.0 76183.6 77465.0 82984.6 83990.0 86663.0 10926.5 11081.6 11286.2 11438.9 11500.0 44839.8 53746.5 54132.0 54743.4 56586.0 70528.6 70738.6 72709.6 73940.6 74835.0 14428.8 14516.0 14726.8 15041.1 15445.5 13121.7 14905.4 15448.7 16140.8 16791.4 13594.7 13667.8 14384.2 14597.1 14749.5 12690.0 12844.7 12879.1 13261.7 13283.2 13209.7 14164.0 14292.9 14517.0 14619.9 11229.6 11343.7 11415.8 11788.7 12145.3 10927.7 11514.1 12005.9 12011.3 12028.2 06:05:42 INFO - PROCESS | 1636 | -------- Summary: end -------- 06:05:42 INFO - PROCESS | 1636 | 06:05:43 INFO - TEST-INFO | 1636: exit 0 06:05:43 INFO - TEST-OK | dromaeo_css | took 1116641ms 06:05:43 INFO - TEST-START | kraken 06:05:43 INFO - operating with platform_type : mac_ 06:05:43 INFO - Initialising browser for kraken test... 06:05:43 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpQl3tdf/profile http://localhost:49245/getInfo.html) 06:05:45 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 06:05:45 INFO - PROCESS | 1646 | colorDepth:24 06:05:45 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 06:05:45 INFO - PROCESS | 1646 | __metrics 06:05:45 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:05:45 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:46 INFO - TEST-INFO | 1646: exit 0 06:05:46 INFO - Browser initialized. 06:05:46 INFO - Running cycle 1/1 for kraken test... 06:05:46 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpQl3tdf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:58 INFO - PROCESS | 1648 | RSS: Main: 167243776 06:05:58 INFO - PROCESS | 1648 | 06:06:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:01 INFO - PROCESS | 1648 | RSS: Main: 215019520 06:06:01 INFO - PROCESS | 1648 | 06:06:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 06:06:04 INFO - PROCESS | 1648 | RSS: Main: 228110336 06:06:04 INFO - PROCESS | 1648 | 06:06:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 06:06:08 INFO - PROCESS | 1648 | RSS: Main: 325431296 06:06:08 INFO - PROCESS | 1648 | 06:06:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 06:06:11 INFO - PROCESS | 1648 | RSS: Main: 228233216 06:06:11 INFO - PROCESS | 1648 | 06:06:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:13 INFO - PROCESS | 1648 | RSS: Main: 228577280 06:06:13 INFO - PROCESS | 1648 | 06:06:16 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:16 INFO - PROCESS | 1648 | RSS: Main: 269303808 06:06:16 INFO - PROCESS | 1648 | 06:06:19 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:20 INFO - PROCESS | 1648 | RSS: Main: 270794752 06:06:20 INFO - PROCESS | 1648 | 06:06:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 06:06:24 INFO - PROCESS | 1648 | RSS: Main: 269185024 06:06:24 INFO - PROCESS | 1648 | 06:06:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:26 INFO - PROCESS | 1648 | RSS: Main: 246456320 06:06:26 INFO - PROCESS | 1648 | 06:06:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:28 INFO - PROCESS | 1648 | RSS: Main: 248430592 06:06:28 INFO - PROCESS | 1648 | 06:06:30 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:31 INFO - PROCESS | 1648 | RSS: Main: 254746624 06:06:31 INFO - PROCESS | 1648 | 06:06:34 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:35 INFO - PROCESS | 1648 | RSS: Main: 272052224 06:06:35 INFO - PROCESS | 1648 | 06:06:38 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:38 INFO - PROCESS | 1648 | RSS: Main: 265748480 06:06:38 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 06:06:40 INFO - PROCESS | 1648 | RSS: Main: 310018048 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | __start_tp_report 06:06:40 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 06:06:40 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 06:06:40 INFO - PROCESS | 1648 | |i|pagename|runs| 06:06:40 INFO - PROCESS | 1648 | |0;ai-astar;114;113;114;115;112;114;115;114;113;114 06:06:40 INFO - PROCESS | 1648 | |1;audio-beat-detection;137;132;137;173;109;108;106;107;125;108 06:06:40 INFO - PROCESS | 1648 | |2;audio-dft;181;181;183;182;182;183;183;183;181;184 06:06:40 INFO - PROCESS | 1648 | |3;audio-fft;79;57;58;88;60;59;58;57;72;58 06:06:40 INFO - PROCESS | 1648 | |4;audio-oscillator;85;70;83;68;66;67;81;68;67;80 06:06:40 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;88;86;88;85;87;84;88;85;87;84 06:06:40 INFO - PROCESS | 1648 | |6;imaging-darkroom;97;95;96;96;109;158;104;96;97;116 06:06:40 INFO - PROCESS | 1648 | |7;imaging-desaturate;125;139;86;85;86;84;85;84;87;87 06:06:40 INFO - PROCESS | 1648 | |8;json-parse-financial;54;53;52;52;55;55;55;55;56;56 06:06:40 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;64;67;74;76;71;68;68;70;69;70 06:06:40 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;83;101;101;101;75;78;81;83;83;86 06:06:40 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;138;159;133;129;131;130;137;140;203;164 06:06:40 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;159;162;162;219;228;161;161;162;161;162 06:06:40 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;64;65;65;64;75;81;82;81;73;62 06:06:40 INFO - PROCESS | 1648 | __end_tp_report 06:06:40 INFO - PROCESS | 1648 | __start_cc_report 06:06:40 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2026 06:06:40 INFO - PROCESS | 1648 | __end_cc_report 06:06:40 INFO - PROCESS | 1648 | __startTimestamp1490101600781__endTimestamp 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | ------- Summary: start ------- 06:06:40 INFO - PROCESS | 1648 | Number of tests: 14 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 06:06:40 INFO - PROCESS | 1648 | Values: 114.0 113.0 114.0 115.0 112.0 114.0 115.0 114.0 113.0 114.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:128.50 stddev:21.48 (16.7%) stddev-sans-first:22.28 06:06:40 INFO - PROCESS | 1648 | Values: 137.0 132.0 137.0 173.0 109.0 108.0 106.0 107.0 125.0 108.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:182.30 Median:183.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 06:06:40 INFO - PROCESS | 1648 | Values: 181.0 181.0 183.0 182.0 182.0 183.0 183.0 183.0 181.0 184.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:64.60 Median:59.50 stddev:11.10 (18.7%) stddev-sans-first:10.48 06:06:40 INFO - PROCESS | 1648 | Values: 79.0 57.0 58.0 88.0 60.0 59.0 58.0 57.0 72.0 58.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:73.50 Median:75.00 stddev:7.71 (10.3%) stddev-sans-first:6.96 06:06:40 INFO - PROCESS | 1648 | Values: 85.0 70.0 83.0 68.0 66.0 67.0 81.0 68.0 67.0 80.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:1.62 (1.9%) stddev-sans-first:1.58 06:06:40 INFO - PROCESS | 1648 | Values: 88.0 86.0 88.0 85.0 87.0 84.0 88.0 85.0 87.0 84.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:106.40 Median:96.00 stddev:19.43 (20.2%) stddev-sans-first:20.31 06:06:40 INFO - PROCESS | 1648 | Values: 97.0 95.0 96.0 96.0 109.0 158.0 104.0 96.0 97.0 116.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:85.50 stddev:19.91 (23.3%) stddev-sans-first:17.87 06:06:40 INFO - PROCESS | 1648 | Values: 125.0 139.0 86.0 85.0 86.0 84.0 85.0 84.0 87.0 87.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.58 06:06:40 INFO - PROCESS | 1648 | Values: 54.0 53.0 52.0 52.0 55.0 55.0 55.0 55.0 56.0 56.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:3.43 (4.9%) stddev-sans-first:2.96 06:06:40 INFO - PROCESS | 1648 | Values: 64.0 67.0 74.0 76.0 71.0 68.0 68.0 70.0 69.0 70.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:82.00 stddev:9.99 (12.2%) stddev-sans-first:10.48 06:06:40 INFO - PROCESS | 1648 | Values: 83.0 101.0 101.0 101.0 75.0 78.0 81.0 83.0 83.0 86.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:139.00 stddev:23.24 (16.7%) stddev-sans-first:24.45 06:06:40 INFO - PROCESS | 1648 | Values: 138.0 159.0 133.0 129.0 131.0 130.0 137.0 140.0 203.0 164.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:162.00 stddev:26.35 (16.3%) stddev-sans-first:27.40 06:06:40 INFO - PROCESS | 1648 | Values: 159.0 162.0 162.0 219.0 228.0 161.0 161.0 162.0 161.0 162.0 06:06:40 INFO - PROCESS | 1648 | 06:06:40 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:74.00 stddev:8.11 (11.0%) stddev-sans-first:8.17 06:06:40 INFO - PROCESS | 1648 | Values: 64.0 65.0 65.0 64.0 75.0 81.0 82.0 81.0 73.0 62.0 06:06:40 INFO - PROCESS | 1648 | -------- Summary: end -------- 06:06:40 INFO - PROCESS | 1648 | 06:06:41 INFO - TEST-INFO | 1648: exit 0 06:06:41 INFO - TEST-OK | kraken | took 58442ms 06:06:41 INFO - SUITE-END | took 1175s 06:06:41 INFO - Completed test suite (00:19:35) 06:06:41 INFO - javascript benchmark 06:06:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3046.7105624965625, 3482.0250329907603, 3485.494603282524, 3499.7725147865403, 3520.295940811838, 5799.797007104752, 5803.274590676166, 5811.331696854863, 5821.9999999999945, 5835.44563266489, 5841.912371314434, 5902.88194236115, 5962.373950735165, 5966.134910437984, 5970.194023806785, 5283.762230699608, 5285.418603953572, 5343.599230057742, 5355.6786592804365, 5391.433899440561, 5249.921251181236, 5261.158214685651, 5264.763085661135, 5323.0, 5381.973090134564, 5188.974055129738, 5322.8137015204475, 5326.733663316838, 5350.759215835296, 5377.677339359651, 5333.866653333697, 5348.705821179834, 5353.304070470834, 5355.892882142374, 5394.514493695547, 5169.095408303532, 5215.765290561896, 5223.843284701427, 5280.049591073605, 5296.602754793406, 4678.672492925497, 5725.885482290331, 5818.854528636775, 5827.941720582825, 5900.527957763368, 6246.219222597176, 6307.810765677037, 6335.334789847046, 6339.36606339367, 6361.236651601791, 6239.65681887496, 6278.6860656966965, 6301.59039662425, 6308.653024083674, 6331.620102793847, 5770.826875193751, 5888.735006924656, 5907.379725128842, 5943.435373639497, 5949.791757288561, 6408.00675895237, 6415.871682566322, 6417.0, 6420.454261387741, 6420.58266212704, 6278.058291256348, 6283.654399008007, 6287.308396076428, 6302.212223472066, 6311.936880631227, 6224.315325314303, 6246.250449946036, 6259.561830671901, 6263.31103578606, 6263.467605253604, 5170.715610641376, 6331.651759153291, 6339.904901426482, 6342.080398342307, 6342.8414289642205, 6329.303776584572, 6335.619862808154, 6340.270868850142, 6350.428461438492, 6354.17395738551, 4953.554180123806, 4988.80044798204, 4993.0762808879745, 4998.975210081924, 5084.542391184811, 4555.134524440346, 4557.043020965568, 4581.816727330869, 4587.357769912215, 4602.424696912886, 5798.246227990334, 5827.708614569255, 5831.096180092092, 5840.474357307863, 5858.7070646468355, 6247.687615619292, 6279.748810047547, 6297.842553936097, 6308.621482711052, 6331.398517140864, 5961.165436838846, 5962.433568810956, 5968.104784282393, 5969.283685957713, 5989.371116032841, 5454.863628409322, 5526.171074338801, 5551.417101204396, 5552.08390615552, 5557.944420555824, 6222.81331560054, 6279.183706118175, 6469.676516174267, 6471.7734879279, 6486.091947127406, 6293.874122517433, 6298.748050077946, 6307.274663413767, 6312.43188113072, 6339.2392912850755, 6311.495080393649, 6359.936400635935, 6365.04524321337, 6427.678616069272, 6444.130042444398, 6291.433770960635, 6293.213348331458, 6299.086632438362, 6315.873682526232, 6317.936820631735, 5627.5497960162265, 6289.591176573508, 6322.33615470369, 6329.7151628175925, 6340.968295158679, 5690.800821971211, 6122.520135281246, 6134.099846298167, 6155.969220153871, 6157.076438534076, 6209.59637623553, 6218.129461875432, 6255.53083518747, 6267.467265282502, 6268.780592679417, 5111.258867464123, 6152.753889844356, 6154.907676384768, 6168.475679567287, 6169.537284703755, 6088.6042407243385, 6130.245269656939, 6261.655608941552, 6277.2781130170615, 6277.435030847063, 6037.9094313584455, 6083.0, 6119.470635406854, 6134.509239260938, 6163.630182189083], "value": 5793.048407216731, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.458043861533, 493.9654224204305, 514.3878784246746, 549.870780366614, 589.2428229724804, 32319.030429087135, 42049.78975105124, 43764.781176094075, 43787.90530236742, 45705.0, 45850.54149458504, 45933.0813383733, 46168.538314616846, 46195.53804461954, 46343.768281158635, 9472.952635236832, 9662.758431039245, 9674.08096230857, 9691.563879625399, 9704.02959704031, 9075.727728168133, 9286.814263714721, 9485.81028379432, 11734.471948762326, 12005.219660722025, 11914.880851191507, 11919.7616047679, 11965.282083075, 11971.580994665188, 12071.637850864488, 11870.7625847483, 11950.641480755592, 11968.521259149667, 11986.400679965967, 11987.400629968466, 11778.882211177865, 11840.0, 11850.525978960832, 11861.051115910706, 11864.347460889647, 41965.0, 42169.57830421687, 42257.36613950793, 42268.1546369074, 42302.0, 4091.89770255743, 4134.834606615732, 4160.667146628262, 4162.313218318974, 4201.222773786859, 30639.846800766078, 31391.84304078488, 31750.0, 31938.0, 32758.181045473815, 3185.888493902702, 3259.0, 3275.2139486523065, 3276.7214786743157, 3463.584369875631, 453570.0, 455324.0, 458816.0, 459524.0, 461302.0, 63274.36725632685, 63856.0, 63982.0, 63988.0, 64049.67975160095, 65246.673766631815, 67932.660336698, 67947.32052679508, 68076.31923680799, 68094.65952670205, 17862.55343616394, 18125.456236312933, 18144.274229030954, 18147.0, 18153.818461815477, 13696.383662735201, 13769.793453098211, 13778.173309601256, 13790.0, 13796.103253288504, 15080.396784128512, 15366.923165384325, 15435.845641543441, 15704.528864134094, 15708.68582628341, 5016.398032236155, 6373.171487706569, 6476.222853257639, 6486.124373209651, 6490.318516555788, 881.823635272948, 882.223643193998, 898.7573355194061, 923.4690053219425, 928.1924725488868, 30100.84949575238, 30148.698513015028, 30286.54570181449, 30482.54276185859, 30735.538966915516, 1069.588208539718, 1078.0836289154156, 1113.3264375053138, 1119.4514687802919, 1235.407004637761, 15508.069515829086, 15521.922390387976, 15617.60955976087, 15904.681906361808, 16082.195890205678, 640518.0, 644374.0, 644976.0, 645401.0, 646212.0, 48064.75967620209, 59084.70457647684, 59184.81630367369, 61521.692391537756, 62065.68967155226, 1431.0, 1437.331640787039, 1477.2982833154165, 1501.6771394150528, 1502.8872834537453, 22303.330900073022, 29053.12840614785, 29691.85154074216, 30501.847490762404, 30576.0, 49603.25595116148, 52321.0, 52322.476775231764, 52329.738351308, 52418.213726793365, 599374.0, 607224.0, 607316.0, 607334.0, 607501.0, 24402.75597244076, 25363.746362536138, 25530.489390212464, 25615.23154305374, 25654.230373088092, 43866.56133438625, 44792.0, 45077.32384014177, 45081.32378014398, 45461.0, 36684.63315366919, 36817.815910920275, 36921.81539092395, 37320.0, 37421.877343679735, 35942.8202858984, 35991.64008359883, 36540.451893222154, 36938.8153059233, 37171.0, 33375.332493350485, 34404.48393274153, 36493.45259821052, 36684.81657591695, 36890.893273201844, 30168.84915575408, 31601.367972639957, 31654.841725791222, 31848.6815131855, 32090.51864221992, 17435.389761358292, 24052.639210411508, 24157.550546966537, 24494.203398473266, 24563.508729825662], "value": 20385.576531898863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.25841866778467, 399.3849471813409, 402.69395259602703, 412.75234859084543, 432.418397255691, 15171.924140379297, 17651.55871103223, 22129.66805497919, 22665.206717764882, 22823.885880570575, 21660.89169554154, 22460.775392246072, 22537.0, 23097.0, 23741.64387534184, 5026.894083301677, 5946.940530594682, 6245.032020036879, 6256.124142620037, 6269.968650156743, 5520.337559492847, 5525.198846167304, 6106.419890110455, 6213.7514499420195, 6215.471684906788, 5561.0, 5563.972180139114, 5567.248421463111, 5573.526250268732, 5579.69311687857, 5542.528885044776, 5549.417311182328, 5562.97085039267, 6066.939330606726, 6160.6611636359985, 5460.726963651801, 5463.836084917459, 5474.233607294982, 5477.233187353773, 5477.7261136943, 13920.651983700387, 14063.085899416505, 14088.859111408858, 14093.013489055771, 20034.69947950782, 2680.9865950670123, 2690.1391554702504, 2723.196656986194, 2723.9319017024536, 2785.8189217700783, 9229.400088994262, 9949.656796332474, 10077.949610251975, 10253.692389228261, 10752.086072683831, 1797.757302764123, 1864.7389365488707, 1888.8866667999964, 1937.4575118966711, 1954.5797653504565, 109576.0, 135263.32368338192, 139002.6099739, 140287.29856350654, 142217.0, 11743.354115523729, 12054.035677145806, 12085.0, 12085.395730213455, 12106.273623582612, 16430.917845410695, 16451.25969331383, 16465.176741163134, 16473.176341183134, 16499.340026398808, 7386.630668466555, 8975.596098175598, 9167.495787731605, 9185.724428267162, 9323.160915517501, 8953.060653312521, 8953.4180278283, 9020.188183063425, 9116.407433516933, 9183.448993060438, 4906.681065730716, 4922.268141181678, 4936.605071594264, 4943.406791185081, 5011.348524691767, 1829.2408650409932, 1963.8232559069752, 2018.9899050504948, 2053.9319553832224, 2068.834493240567, 960.6541645007792, 1001.5793366785967, 1007.1992765751245, 1015.0712098429854, 1025.9846102308472, 21824.89087554552, 22094.668579971312, 22095.0, 22185.556288874133, 22256.43896976476, 862.6284208109137, 875.8248350329959, 995.7012896131132, 1001.0990108902047, 1017.4658304390107, 11046.061084807881, 11260.887391126147, 11376.976072153546, 11377.601783937522, 11437.59968401102, 800225.0, 803473.0574634961, 807448.0, 809862.0, 823278.0, 94091.61749972113, 152631.0, 155017.0, 155197.0, 158700.0, 1038.4081073787868, 1068.7862427514528, 1102.5204036244259, 1102.9613963511238, 1105.6793529876245, 21072.894635526725, 21150.788492114883, 21329.17777977549, 21525.03137358854, 21726.89136554307, 58801.765902875755, 60818.0, 61316.38683613285, 62538.374616253255, 63663.6816815913, 83750.58124709337, 90356.0, 92932.53533732289, 93714.0, 94141.0, 8573.22840944318, 8589.914100859161, 8727.91272087271, 8821.779455513664, 8888.955555222183, 10132.594696212069, 13270.535531256359, 13314.533991310258, 13526.661833454242, 13589.52436664712, 11231.494582743633, 11392.316461012366, 11486.425678716198, 11572.479238434122, 11665.708357291136, 9642.566084526354, 11110.555577776799, 11298.0, 11325.886741132483, 11830.349330786545, 9706.369086009387, 10749.0, 11916.344601047025, 12048.879511204776, 12103.33431661267, 7374.557526548424, 7814.179511151247, 7827.726029588937, 8332.16678332162, 8733.737987860375, 8403.83192336162, 8744.606492707717, 9257.120573545502, 11284.43577821122, 11444.599439019594], "value": 9950.877993153692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.1534152520776, 1448.0732331307966, 1475.0338528263985, 1476.2028504607508, 1481.7629179331307, 8182.918170818298, 8567.271781898546, 8567.485950842954, 8568.443051201668, 8588.312934965212, 7621.161672216066, 7852.411069169821, 8130.9593452032805, 8385.0357208921, 8393.118722534138, 2374.620060790274, 2415.0581273303424, 2418.2745176447083, 2420.9636855447184, 2421.6609674645474, 2397.928062158138, 2419.9516009679796, 2425.9878700606473, 2428.9271321860283, 2430.720467146274, 2378.8810559472045, 2381.428457170275, 2397.412633904687, 2405.795507381875, 2421.5520128776234, 2365.1012615206196, 2370.4073981504625, 2391.0, 2396.2811156652933, 2398.7481314461907, 2395.6765836612185, 2416.9516609667885, 2417.5648383291, 2419.6249581314923, 2421.5520128776056, 8441.155884411572, 8484.448510846774, 8546.829063418696, 8548.529830859301, 8552.957235213846, 5138.126518491828, 5295.7881684732565, 5297.761600727977, 5311.150215965427, 5319.0, 3383.543221665093, 3470.2712430389647, 3589.6948759355487, 3607.7113830893463, 3670.06413364593, 1097.1825989637691, 1213.9332336721477, 1263.7662032524013, 1273.0441345136917, 1304.5173285884189, 10957.12343012565, 11025.228234023622, 11026.338419694845, 11039.227254092217, 11067.335959842354, 4420.977895110504, 4710.882227944328, 4721.5750582447745, 4810.7835147418455, 4820.30105634681, 7923.524588524591, 9564.139227469423, 9580.616775329048, 9588.280878934107, 9598.0, 5317.175837745079, 5327.547158491494, 5329.280547126166, 5332.066888294533, 5332.30680011596, 4222.387753775685, 4242.637266890099, 4898.187670561915, 4908.337374454474, 4923.77842997066, 3046.4211799757977, 3399.5920489540918, 3729.645683660048, 3905.72659913809, 4016.779077150726, 1111.4387234446715, 1277.8786015328528, 1287.2598256002648, 1287.9935600322126, 1300.3498250874563, 917.0966597901062, 920.3143657974852, 944.6221511395497, 950.0926615082718, 988.6243227573476, 5605.859853503695, 5699.971500142473, 5787.276590426197, 5947.345791962881, 6000.699965001732, 580.1269090019493, 583.0874681124027, 590.4302348233974, 595.7289433307922, 602.6263716495713, 3835.8657446989223, 3843.6925045996254, 3869.2261547690573, 3904.511936007999, 3963.7027222958395, 9737.513124343754, 9830.459324737065, 9962.0, 10069.848952265722, 10070.345427547187, 9118.81762364749, 9980.650677226262, 10032.64885728996, 10037.297389182833, 10044.0, 7594.8860767089645, 7882.605869706606, 7941.364690824836, 7960.761177164694, 7960.920390796134, 5824.271966004249, 5990.041593345044, 5998.790042348497, 6047.848803779941, 6061.272647282354, 8854.690085846965, 8993.0, 9293.581788819383, 9306.860397093913, 9432.62269509212, 9023.142801433853, 9096.545172741204, 9459.716208513755, 9550.140487356171, 9600.279979001743, 6788.389044985975, 6996.965015174892, 7054.506184567031, 7260.745873894389, 7435.739749108755, 8004.799880003046, 8099.676012959416, 8165.1018387978465, 8171.83656326882, 8190.877136842833, 7079.716811327489, 7102.786916392516, 7290.0, 7344.632768361667, 7382.298681625237, 7061.788146355618, 7147.0, 7154.892676609959, 7294.051773269441, 7340.302671246223, 5522.751476183501, 6454.644994525346, 6575.178102737158, 6581.736730530725, 6596.60420374779, 4346.587074227943, 5008.367141218434, 5092.2361645753435, 5163.199704045879, 5168.638195326442, 4981.925271121008, 5041.747912604428, 5146.588272938081, 5230.2677625131755, 5306.310179676618], "value": 4442.4637518786485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.2139956294841, 364.62443683006495, 371.3056584187569, 374.7545357790648, 377.38863041872173, 4841.806327746895, 5285.603579731521, 5340.732963351831, 5386.380566234884, 5389.218563308323, 4930.0, 5108.7956481740775, 5271.288376069229, 5284.313039304895, 5334.67991920485, 3693.947225040857, 4127.534725172565, 4152.335626299792, 4185.937210941823, 4187.895302617429, 3605.954273260751, 4052.9797351013353, 4146.523149837777, 4178.352355384905, 4208.97895510522, 3526.629703881094, 3594.2272411431536, 3819.0, 3949.7037722170808, 4145.979270103645, 3598.4062629666337, 3962.722609417342, 4009.939850902239, 4193.972476743203, 4229.6404805591255, 3057.281538838371, 3395.3888300105973, 3468.3871999520343, 3689.114612493009, 3692.7415080944343, 5213.0, 5220.765065572058, 5224.63427560071, 5226.346706661668, 5253.238280449352, 4136.544980052192, 4336.588024137734, 4678.391809064834, 4800.663953523254, 4814.975925120352, 5551.583631227633, 5672.262605861253, 5685.276144125563, 5719.283340413312, 5772.3361813391575, 3884.5726970033274, 3930.213957208541, 3944.447777311179, 3952.7351247600777, 4008.83964641414, 5386.596005299618, 5596.2165296858475, 5909.704514774244, 6012.632925561699, 6042.788502402439, 3518.82405879705, 3627.8209581885994, 3984.641382275609, 3985.8206380712936, 3997.4603428536775, 3832.0, 4056.8377264909664, 4057.797110144481, 4058.0463591056077, 4076.898077548085, 4393.319035549495, 4537.455505339381, 4671.649626278043, 4691.296305554194, 4734.384530011145, 4720.834770783006, 5094.592432605456, 5208.322918020709, 5734.77060917567, 5830.0, 1079.6707004363745, 1088.363307465126, 1289.8516670583003, 1310.0174868848364, 1318.2420108437686, 716.8924661300847, 749.8087987563136, 861.2851333393269, 887.8801361816202, 890.9242714369221, 4611.446626404853, 4689.906201875943, 5080.415752188472, 5133.281340612317, 5133.717645529532, 4738.928916066262, 4798.448178459452, 4976.5023497649945, 5462.562994960394, 5741.45456181662, 4181.853635122817, 4666.603338716247, 4977.278294647328, 5204.011237864794, 5282.920756188661, 2870.4402641485126, 2890.898818541383, 2957.438086763508, 2975.6577993530586, 2983.686712895158, 4876.804927802848, 4899.436564795023, 5318.521333080042, 5449.0, 5763.0202865512965, 5318.444213116355, 5707.458986073737, 5802.47777700009, 5849.064149736022, 5862.267216597926, 4771.974025584516, 5153.871153221125, 5830.95042892275, 5877.52979761618, 5986.910196347146, 5754.56840736938, 5770.50950669181, 5839.620424672553, 5847.356790753099, 5852.132455097057, 5490.286262785812, 5766.308043034863, 5774.797882074276, 5784.82645520635, 5806.6806325650805, 5063.974680126576, 5331.680099194061, 5998.370171131968, 6012.518998480198, 6118.847028824315, 3938.7242892997215, 3948.4077388390824, 3954.2008386184793, 3968.960310396859, 3972.880813575597, 4898.681585697061, 5617.662940223599, 5748.0, 5852.419846641468, 5866.823995280149, 5633.3521645009705, 5678.2050512929045, 5679.0, 5683.829485115453, 5722.799702010409, 5057.898842023213, 5567.693776842312, 5653.293338332708, 5661.773529058956, 5714.79998200061, 4891.926621100757, 5105.8723531912, 5133.922991155061, 5203.985222881502, 5262.763175657181, 5011.423686275979, 5423.691548155701, 5459.406781778624, 5647.119968815851, 5662.631928924607, 4608.907821843612, 5257.7371131442505, 5528.695921724344, 5544.586130536687, 5596.496315331639], "value": 4104.055892868988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.2289653105563, 779.844031193761, 803.3091541274505, 803.8874557561942, 887.56065747455, 15112.093274403544, 15207.087574745508, 15594.532164035068, 15724.29240684169, 15771.369145234192, 13972.860271397283, 14346.0, 14453.0, 14456.349464274106, 14495.057821241639, 891.2736120062161, 912.4753266871576, 912.7991841794794, 916.4684482999877, 921.2814005076051, 737.3106145753737, 758.3326672528168, 881.6032785246632, 903.0878812399458, 906.9002409734924, 982.7837875667342, 985.5417230987589, 986.2405947420482, 987.3927534566262, 988.6984469736727, 977.4330888084894, 979.3585201692867, 980.0689345122091, 981.3768257156721, 981.5632043740538, 726.5894769455241, 729.0813574895617, 732.783828770514, 732.827785470414, 737.9631018449056, 15188.620284492865, 15597.14215718135, 15608.531744047697, 15742.212889355487, 16067.276972536263, 14763.26183690822, 14795.630109247248, 14983.625409364744, 15234.619134521725, 15522.61193470161, 11743.069884273844, 11829.693887725578, 11990.220635658654, 12210.877891221064, 12593.055520835882, 3808.980955095207, 3875.5736868944396, 3875.9418608720894, 4031.4154447605224, 4052.1287923096675, 109152.45423772909, 112205.0, 118607.0, 118659.0, 122410.3879480597, 10580.52387642558, 10698.946505267424, 10993.175511836644, 11628.476718547685, 11952.701182470508, 23803.523929521314, 23840.523189536114, 23855.165069222494, 23866.761332386803, 23951.880240598686, 7728.4590078693955, 7842.686292548348, 7997.600119993977, 8100.554469504234, 8289.461185023074, 4339.132173565299, 4463.598276155161, 4485.461744590605, 4592.609628181575, 4684.250519916797, 3119.703628155367, 3640.7997560134445, 3649.4525821127045, 3721.218544105768, 3938.0351813805228, 759.3545486336681, 759.5594555157995, 763.6601712238112, 777.4985134588159, 778.9260020298062, 694.506900100934, 713.678844519968, 727.8435136445689, 739.7336958694866, 767.7044337929938, 9778.902210977942, 9957.104504522424, 10778.029977301923, 10859.891401085888, 11365.0, 607.9300880398811, 629.6064959400375, 635.6376865186799, 637.5696404926656, 748.9588072655947, 4978.825741099116, 5170.250313704491, 5183.118869792069, 5183.118869792144, 5186.196139598368, 99457.50271248598, 104976.0, 105999.4700026495, 106024.46987765012, 107043.0, 78482.6075869617, 96581.0, 96615.51692241494, 99735.0, 100331.0, 76183.61908190424, 77465.0, 82984.58507707423, 83990.0, 86662.99999999873, 10926.50830712604, 11081.612143574936, 11286.15353848481, 11438.885611143782, 11500.0, 44839.775801120784, 53746.46253537414, 54132.0, 54743.35769926909, 56586.0, 70528.64735676494, 70738.64630676813, 72709.63645181741, 73940.63029684818, 74835.0, 14428.783568246694, 14515.951979402957, 14726.77909831332, 15041.119860017498, 15445.536633901002, 13121.737565248832, 14905.403783848524, 15448.691026179189, 16140.838591613934, 16791.41230056942, 13594.728105438033, 13667.81576604125, 14384.208868512333, 14597.12417254968, 14749.451307612546, 12690.0, 12844.743105137659, 12879.098463107868, 13261.734765304833, 13283.203007819562, 13209.735805283648, 14164.0, 14292.85707142957, 14516.983811133541, 14619.853801462275, 11229.55081796719, 11343.659690209306, 11415.828762568402, 11788.70528236801, 12145.332006739362, 10927.722772277228, 11514.136439767219, 12005.879941200476, 12011.339376334385, 12028.15802893789], "value": 7934.715121986748, "unit": "score"}], "name": "dromaeo_css", "value": 7443.057314663584, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 115.0, 112.0, 114.0, 115.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 137.0, 173.0, 109.0, 108.0, 106.0, 107.0, 125.0, 108.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 183.0, 182.0, 182.0, 183.0, 183.0, 183.0, 181.0, 184.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 88.0, 60.0, 59.0, 58.0, 57.0, 72.0, 58.0], "value": 64.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 83.0, 68.0, 66.0, 67.0, 81.0, 68.0, 67.0, 80.0], "value": 73.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 87.0, 84.0, 88.0, 85.0, 87.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 96.0, 109.0, 158.0, 104.0, 96.0, 97.0, 116.0], "value": 106.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 139.0, 86.0, 85.0, 86.0, 84.0, 85.0, 84.0, 87.0, 87.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 52.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 74.0, 76.0, 71.0, 68.0, 68.0, 70.0, 69.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 101.0, 101.0, 101.0, 75.0, 78.0, 81.0, 83.0, 83.0, 86.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 159.0, 133.0, 129.0, 131.0, 130.0, 137.0, 140.0, 203.0, 164.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 162.0, 219.0, 228.0, 161.0, 161.0, 162.0, 161.0, 162.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 75.0, 81.0, 82.0, 81.0, 73.0, 62.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1448.3000000000002, "alertThreshold": 2.0}]} 06:06:42 INFO - Return code: 0 06:06:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:42 INFO - # TBPL SUCCESS # 06:06:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:06:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:06:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:06:42 INFO - 2017-03-21 06:06:42.113 screenresolution[1652:9787] starting screenresolution argv=screenresolution get 06:06:42 INFO - 2017-03-21 06:06:42.116 screenresolution[1652:9787] Display 0: 1600x1200x32@60 06:06:42 INFO - 2017-03-21 06:06:42.121 screenresolution[1653:9790] starting screenresolution argv=screenresolution list 06:06:42 INFO - Available Modes on Display 0 06:06:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:06:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:06:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:06:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:06:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:06:42 INFO - Intel Iris: 06:06:42 INFO - Chipset Model: Intel Iris 06:06:42 INFO - Type: GPU 06:06:42 INFO - Bus: Built-In 06:06:42 INFO - VRAM (Dynamic, Max): 1536 MB 06:06:42 INFO - Vendor: Intel (0x8086) 06:06:42 INFO - Device ID: 0x0a2e 06:06:42 INFO - Revision ID: 0x0009 06:06:42 INFO - Displays: 06:06:42 INFO - Display: 06:06:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:06:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:06:42 INFO - Display Serial Number: 1600x1200 60 06:06:42 INFO - Main Display: Yes 06:06:42 INFO - Mirror: Off 06:06:42 INFO - Online: Yes 06:06:42 INFO - Rotation: Supported 06:06:42 INFO - Return code: 0 06:06:42 INFO - Running post-action listener: _resource_record_post_action 06:06:42 INFO - [mozharness: 2017-03-21 13:06:42.356449Z] Finished run-tests step (success) 06:06:42 INFO - Running post-run listener: _resource_record_post_run 06:06:42 INFO - Total resource usage - Wall time: 1190s; CPU: 53.0%; Read bytes: 37708800; Write bytes: 420994560; Read time: 241; Write time: 1400 06:06:42 INFO - TinderboxPrint: CPU usage
53.5% 06:06:42 INFO - TinderboxPrint: I/O read bytes / time
37,708,800 / 241 06:06:42 INFO - TinderboxPrint: I/O write bytes / time
420,994,560 / 1,400 06:06:42 INFO - TinderboxPrint: CPU idle
2,214.6 (46.5%) 06:06:42 INFO - TinderboxPrint: CPU system
949.6 (19.9%) 06:06:42 INFO - TinderboxPrint: CPU user
1,597.5 (33.5%) 06:06:42 INFO - TinderboxPrint: Swap in / out
160,096,256 / 0 06:06:42 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 245760; Write bytes: 124377088; Read time: 4; Write time: 286 06:06:42 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 34067456; Write bytes: 295216640; Read time: 218; Write time: 1107 06:06:42 INFO - Running post-run listener: _upload_blobber_files 06:06:42 INFO - Blob upload gear active. 06:06:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:42 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:06:42 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:06:42 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:06:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:06:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:44 INFO - (blobuploader) - INFO - Done attempting. 06:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:45 INFO - (blobuploader) - INFO - Done attempting. 06:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:06:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:46 INFO - (blobuploader) - INFO - Done attempting. 06:06:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:48 INFO - (blobuploader) - INFO - Done attempting. 06:06:48 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:48 INFO - Return code: 0 06:06:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61e87834a07d15dbb944ec3ee097c652275e5920984147b59bc5ead7cf910dadf297a765d3335c43bbe19e0e16865ab47d2ee8b3c217dd98cbffe2d77671e896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b57770c450bb2eac7bd8c88c66e2088c44dcb4ae0ce97c636c21946fe6fe34db35ef90bad14bf047f3f32f9c1777e921e008a67822a6e7d6bc3e6b82f65784e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e53c6ad19630ec5698f55e26d8a6c09e2137a515deb226239c9dc8c114271940f197aff299c406c7f3c9f10fa6e2578a0cd7fc64c8c593c3d3ae8a8631082531", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/050695b38d861ca50be622b3d320047e7ebe6af210a153708f7b99918fce4c6811bc8f1ae9f92eb589e732b2d9115383d4f217091626c8f9e0bc7cb86a6dbf0d"} 06:06:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:48 INFO - Contents: 06:06:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61e87834a07d15dbb944ec3ee097c652275e5920984147b59bc5ead7cf910dadf297a765d3335c43bbe19e0e16865ab47d2ee8b3c217dd98cbffe2d77671e896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b57770c450bb2eac7bd8c88c66e2088c44dcb4ae0ce97c636c21946fe6fe34db35ef90bad14bf047f3f32f9c1777e921e008a67822a6e7d6bc3e6b82f65784e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e53c6ad19630ec5698f55e26d8a6c09e2137a515deb226239c9dc8c114271940f197aff299c406c7f3c9f10fa6e2578a0cd7fc64c8c593c3d3ae8a8631082531", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/050695b38d861ca50be622b3d320047e7ebe6af210a153708f7b99918fce4c6811bc8f1ae9f92eb589e732b2d9115383d4f217091626c8f9e0bc7cb86a6dbf0d"} 06:06:48 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:48 INFO - Copying logs to upload dir... 06:06:48 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.146492 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-21 06:06:48.400380) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 06:06:48.403725) ========= 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.d63V1fQlvj/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.IJdwh1t4cR/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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/61e87834a07d15dbb944ec3ee097c652275e5920984147b59bc5ead7cf910dadf297a765d3335c43bbe19e0e16865ab47d2ee8b3c217dd98cbffe2d77671e896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b57770c450bb2eac7bd8c88c66e2088c44dcb4ae0ce97c636c21946fe6fe34db35ef90bad14bf047f3f32f9c1777e921e008a67822a6e7d6bc3e6b82f65784e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e53c6ad19630ec5698f55e26d8a6c09e2137a515deb226239c9dc8c114271940f197aff299c406c7f3c9f10fa6e2578a0cd7fc64c8c593c3d3ae8a8631082531", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/050695b38d861ca50be622b3d320047e7ebe6af210a153708f7b99918fce4c6811bc8f1ae9f92eb589e732b2d9115383d4f217091626c8f9e0bc7cb86a6dbf0d"} build_url:https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010947 build_url: 'https://queue.taskcluster.net/v1/task/BBBcTWqyTnmYCjrEnemMvA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61e87834a07d15dbb944ec3ee097c652275e5920984147b59bc5ead7cf910dadf297a765d3335c43bbe19e0e16865ab47d2ee8b3c217dd98cbffe2d77671e896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b57770c450bb2eac7bd8c88c66e2088c44dcb4ae0ce97c636c21946fe6fe34db35ef90bad14bf047f3f32f9c1777e921e008a67822a6e7d6bc3e6b82f65784e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e53c6ad19630ec5698f55e26d8a6c09e2137a515deb226239c9dc8c114271940f197aff299c406c7f3c9f10fa6e2578a0cd7fc64c8c593c3d3ae8a8631082531", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/050695b38d861ca50be622b3d320047e7ebe6af210a153708f7b99918fce4c6811bc8f1ae9f92eb589e732b2d9115383d4f217091626c8f9e0bc7cb86a6dbf0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 06:06:48.438468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 06:06:48.438800) ========= 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.d63V1fQlvj/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.IJdwh1t4cR/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.005042 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 06:06:48.487333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 06:06:48.487651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 06:06:48.487986) ========= ========= Total master_lag: 0.56 =========