builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0253 starttime: 1488889826.39 results: success (0) buildid: 20170307030205 builduid: 7e6dcb95794e472d8d11cd4048ff23ee revision: b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:26.394451) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:26.394888) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:26.395181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:26.457190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:26.457492) ========= 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.t1j4emCvHK/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.gCNjBmmGFw/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-07 04:30:26-- 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% 39.6M=0s 2017-03-07 04:30:26 (39.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.461239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:26.942723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:26.943052) ========= 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.t1j4emCvHK/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.gCNjBmmGFw/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.025913 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:26.991570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-07 04:30:26.991972) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t1j4emCvHK/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.gCNjBmmGFw/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-07 04:30:27,098 truncating revision to first 12 chars 2017-03-07 04:30:27,098 Setting DEBUG logging. 2017-03-07 04:30:27,098 attempt 1/10 2017-03-07 04:30:27,098 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b7e42143bbbc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-07 04:30:28,135 unpacking tar archive at: mozilla-central-b7e42143bbbc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.307257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-07 04:30:28.322766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:28.323124) ========= script_repo_revision: b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:28.323498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:28.323759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-07 04:30:28.343549) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 56 secs) (at 2017-03-07 04:30:28.344052) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t1j4emCvHK/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.gCNjBmmGFw/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:30:28 INFO - MultiFileLogger online at 20170307 04:30:28 in /builds/slave/test 04:30:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:30:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:28 INFO - {'append_to_log': False, 04:30:28 INFO - 'base_work_dir': '/builds/slave/test', 04:30:28 INFO - 'blob_upload_branch': 'Firefox', 04:30:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:28 INFO - 'branch': 'Firefox', 04:30:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:28 INFO - 'config_files': ('talos/mac_config.py',), 04:30:28 INFO - 'default_actions': ('clobber', 04:30:28 INFO - 'read-buildbot-config', 04:30:28 INFO - 'download-and-extract', 04:30:28 INFO - 'populate-webroot', 04:30:28 INFO - 'create-virtualenv', 04:30:28 INFO - 'install', 04:30:28 INFO - 'run-tests'), 04:30:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:28 INFO - 'download_minidump_stackwalk': True, 04:30:28 INFO - 'download_symbols': 'ondemand', 04:30:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:28 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:28 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:28 INFO - 'gecko_profile': False, 04:30:28 INFO - 'gecko_profile_interval': 0, 04:30:28 INFO - 'installer_path': 'installer.exe', 04:30:28 INFO - 'log_level': 'info', 04:30:28 INFO - 'log_name': 'talos', 04:30:28 INFO - 'log_to_console': True, 04:30:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:30:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:30:28 INFO - 'opt_config_files': (), 04:30:28 INFO - 'pip_index': False, 04:30:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:28 INFO - 'cmd': ('bash', 04:30:28 INFO - '-c', 04:30:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:28 INFO - 'enabled': True, 04:30:28 INFO - 'halt_on_failure': False, 04:30:28 INFO - 'name': 'check_screen_resolution'},), 04:30:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:28 INFO - 'cmd': ('bash', 04:30:28 INFO - '-c', 04:30:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:28 INFO - 'enabled': True, 04:30:28 INFO - 'halt_on_failure': False, 04:30:28 INFO - 'name': 'check_screen_resolution'},), 04:30:28 INFO - 'run_cmd_checks_enabled': True, 04:30:28 INFO - 'suite': 'dromaeojs', 04:30:28 INFO - 'system_bits': '32', 04:30:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:28 INFO - 'title': 't-yosemite-r7-0253', 04:30:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:28 INFO - 'use_talos_json': True, 04:30:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:28 INFO - 'work_dir': 'build'} 04:30:28 INFO - [mozharness: 2017-03-07 12:30:28.556987Z] Running clobber step. 04:30:28 INFO - Running pre-action listener: _resource_record_pre_action 04:30:28 INFO - Running main action method: clobber 04:30:28 INFO - rmtree: /builds/slave/test/build 04:30:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:31 INFO - Running post-action listener: _resource_record_post_action 04:30:31 INFO - [mozharness: 2017-03-07 12:30:31.001343Z] Finished clobber step (success) 04:30:31 INFO - [mozharness: 2017-03-07 12:30:31.001474Z] Running read-buildbot-config step. 04:30:31 INFO - Running pre-action listener: _resource_record_pre_action 04:30:31 INFO - Running main action method: read_buildbot_config 04:30:31 INFO - Using buildbot properties: 04:30:31 INFO - { 04:30:31 INFO - "project": "", 04:30:31 INFO - "product": "firefox", 04:30:31 INFO - "script_repo_revision": "production", 04:30:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:30:31 INFO - "repository": "", 04:30:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:30:31 INFO - "buildid": "20170307030205", 04:30:31 INFO - "stage_platform": "macosx64", 04:30:31 INFO - "basedir": "/builds/slave/test", 04:30:31 INFO - "nightly_build": "True", 04:30:31 INFO - "buildnumber": 64, 04:30:31 INFO - "slavename": "t-yosemite-r7-0253", 04:30:31 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:30:31 INFO - "platform": "yosemite_r7", 04:30:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:30:31 INFO - "branch": "mozilla-central", 04:30:31 INFO - "repo_path": "mozilla-central", 04:30:31 INFO - "revision": "b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4", 04:30:31 INFO - "pgo_build": "False", 04:30:31 INFO - "builduid": "7e6dcb95794e472d8d11cd4048ff23ee", 04:30:31 INFO - "slavebuilddir": "test" 04:30:31 INFO - } 04:30:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:30:31 INFO - Running post-action listener: _resource_record_post_action 04:30:31 INFO - [mozharness: 2017-03-07 12:30:31.004692Z] Finished read-buildbot-config step (success) 04:30:31 INFO - [mozharness: 2017-03-07 12:30:31.004777Z] Running download-and-extract step. 04:30:31 INFO - Running pre-action listener: _resource_record_pre_action 04:30:31 INFO - Running main action method: download_and_extract 04:30:31 INFO - mkdir: /builds/slave/test/build/tests 04:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:31 INFO - trying https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:30:31 INFO - Downloading https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:30:31 INFO - Downloaded 1199 bytes. 04:30:31 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:30:31 INFO - Using the following test package requirements: 04:30:31 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:30:31 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:30:31 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:30:31 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:30:31 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:30:31 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:30:31 INFO - u'jsshell-mac.zip'], 04:30:31 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:30:31 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:30:31 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:30:31 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:30:31 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:30:31 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:30:31 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:30:31 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:30:31 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:30:31 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:30:31 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:30:31 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:30:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:30:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:31 INFO - Fetch https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:30:59 INFO - Expected file size: 51781426 04:30:59 INFO - Obtained file size: 36084317 04:30:59 INFO - retry: attempt #1 caught exception: The expected file size is 51781426 while we got instead 36084317 04:30:59 INFO - retry: Failed, sleeping 60 seconds before retrying 04:31:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #2 04:31:59 INFO - Fetch https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:32:01 INFO - Expected file size: 51781426 04:32:01 INFO - Obtained file size: 51781426 04:32:17 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:32:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:32:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:32:17 INFO - Fetch https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:32:20 INFO - Expected file size: 51781426 04:32:20 INFO - Obtained file size: 51781426 04:32:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:32:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:32:35 INFO - Fetch https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:32:36 INFO - Expected file size: 14404424 04:32:36 INFO - Obtained file size: 14404424 04:32:36 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')]} 04:32:36 INFO - trying https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:32:36 INFO - Downloading https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:32:39 INFO - Downloaded 75026192 bytes. 04:32:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:32:39 INFO - mkdir: /builds/slave/test/properties 04:32:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:39 INFO - Contents: 04:32:39 INFO - build_url:https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:32:40 INFO - Running post-action listener: _resource_record_post_action 04:32:40 INFO - Running post-action listener: set_extra_try_arguments 04:32:40 INFO - [mozharness: 2017-03-07 12:32:40.119199Z] Finished download-and-extract step (success) 04:32:40 INFO - [mozharness: 2017-03-07 12:32:40.119329Z] Running populate-webroot step. 04:32:40 INFO - Running pre-action listener: _resource_record_pre_action 04:32:40 INFO - Running main action method: populate_webroot 04:32:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:40 INFO - '--tppagecycles', 04:32:40 INFO - '7'], 04:32:40 INFO - 'tests': ['tsvgm']}}, 04:32:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:32:40 INFO - 'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:32:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:32:40 INFO - 'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['damp', 'tps']}, 04:32:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:32:40 INFO - 'tests': ['damp', 'tps']}, 04:32:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['dromaeo_dom']}, 04:32:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['basic_compositor_video']}, 04:32:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:32:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['a11yr', 04:32:40 INFO - 'ts_paint', 04:32:40 INFO - 'tpaint', 04:32:40 INFO - 'sessionrestore', 04:32:40 INFO - 'sessionrestore_no_auto_restore', 04:32:40 INFO - 'tabpaint']}, 04:32:40 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:40 INFO - 'ts_paint', 04:32:40 INFO - 'tpaint', 04:32:40 INFO - 'sessionrestore', 04:32:40 INFO - 'sessionrestore_no_auto_restore', 04:32:40 INFO - 'tabpaint']}, 04:32:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:40 INFO - 'ts_paint', 04:32:40 INFO - 'tpaint', 04:32:40 INFO - 'sessionrestore', 04:32:40 INFO - 'sessionrestore_no_auto_restore', 04:32:40 INFO - 'tabpaint']}, 04:32:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:40 INFO - 'ts_paint', 04:32:40 INFO - 'tpaint', 04:32:40 INFO - 'sessionrestore', 04:32:40 INFO - 'sessionrestore_no_auto_restore', 04:32:40 INFO - 'tabpaint']}, 04:32:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['a11yr', 04:32:40 INFO - 'ts_paint', 04:32:40 INFO - 'tpaint', 04:32:40 INFO - 'sessionrestore', 04:32:40 INFO - 'sessionrestore_no_auto_restore', 04:32:40 INFO - 'tabpaint']}, 04:32:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['a11yr', 04:32:40 INFO - 'ts_paint', 04:32:40 INFO - 'tpaint', 04:32:40 INFO - 'sessionrestore', 04:32:40 INFO - 'sessionrestore_no_auto_restore', 04:32:40 INFO - 'tabpaint']}, 04:32:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['tsvgx', 04:32:40 INFO - 'tsvgr_opacity', 04:32:40 INFO - 'tart', 04:32:40 INFO - 'tscrollx', 04:32:40 INFO - 'cart', 04:32:40 INFO - 'tsvg_static']}, 04:32:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:40 INFO - 'tsvgr_opacity', 04:32:40 INFO - 'tart', 04:32:40 INFO - 'tscrollx', 04:32:40 INFO - 'cart', 04:32:40 INFO - 'tsvg_static']}, 04:32:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:32:40 INFO - 'talos_options': ['--disable-e10s'], 04:32:40 INFO - 'tests': ['tp5o']}, 04:32:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:32:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:32:40 INFO - 'talos_options': ['--disable-e10s', 04:32:40 INFO - '--xperf_path', 04:32:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:40 INFO - 'tests': ['tp5n']}, 04:32:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:32:40 INFO - 'talos_options': ['--xperf_path', 04:32:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:40 INFO - 'tests': ['tp5n']}}, 04:32:40 INFO - 'talos.zip': {'path': '', 04:32:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:40 INFO - Running post-action listener: _resource_record_post_action 04:32:40 INFO - [mozharness: 2017-03-07 12:32:40.137668Z] Finished populate-webroot step (success) 04:32:40 INFO - [mozharness: 2017-03-07 12:32:40.137769Z] Running create-virtualenv step. 04:32:40 INFO - Running pre-action listener: _resource_record_pre_action 04:32:40 INFO - Running main action method: create_virtualenv 04:32:40 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:40 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 04:32:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:40 INFO - Using real prefix '/tools/python27' 04:32:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:43 INFO - Installing pip.................done. 04:32:43 INFO - Return code: 0 04:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:32:44 INFO - Reading from file tmpfile_stdout 04:32:44 INFO - Output received: 04:32:44 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) 04:32:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:44 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')]} 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:44 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')]} 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:44 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 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:32:44 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 04:32:44 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 04:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:44 INFO - 'HOME': '/Users/cltbld', 04:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:44 INFO - 'LOGNAME': 'cltbld', 04:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:44 INFO - 'MOZ_NO_REMOTE': '1', 04:32:44 INFO - 'NO_EM_RESTART': '1', 04:32:44 INFO - 'PAGER': '/bin/cat', 04:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:44 INFO - 'PWD': '/builds/slave/test', 04:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:44 INFO - 'SHELL': '/bin/bash', 04:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:32:44 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:44 INFO - 'USER': 'cltbld', 04:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:44 INFO - 'XPC_FLAGS': '0x0', 04:32:44 INFO - 'XPC_SERVICE_NAME': '0', 04:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:44 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 04:32:44 INFO - Cleaning up... 04:32:44 INFO - Return code: 0 04:32:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32:44 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')]} 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:44 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')]} 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:44 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 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:32:44 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 04:32:44 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 04:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:44 INFO - 'HOME': '/Users/cltbld', 04:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:44 INFO - 'LOGNAME': 'cltbld', 04:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:44 INFO - 'MOZ_NO_REMOTE': '1', 04:32:44 INFO - 'NO_EM_RESTART': '1', 04:32:44 INFO - 'PAGER': '/bin/cat', 04:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:44 INFO - 'PWD': '/builds/slave/test', 04:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:44 INFO - 'SHELL': '/bin/bash', 04:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:32:44 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:44 INFO - 'USER': 'cltbld', 04:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:44 INFO - 'XPC_FLAGS': '0x0', 04:32:44 INFO - 'XPC_SERVICE_NAME': '0', 04:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:44 INFO - Downloading/unpacking psutil>=3.1.1 04:32:44 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 04:32:44 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 04:32:44 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 04:32:44 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 04:32:44 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 04:32:44 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 04:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:48 INFO - Installing collected packages: psutil 04:32:48 INFO - Running setup.py install for psutil 04:32:48 INFO - building 'psutil._psutil_osx' extension 04:32:48 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 04:32:49 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 04:32:49 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 04:32:49 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 04:32:49 INFO - building 'psutil._psutil_posix' extension 04:32:49 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 04:32:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:49 INFO - ^ 04:32:49 INFO - 1 warning generated. 04:32:49 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 04:32:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:49 INFO - Successfully installed psutil 04:32:49 INFO - Cleaning up... 04:32:49 INFO - Return code: 0 04:32:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:49 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 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:32:49 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 04:32:49 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 04:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:49 INFO - 'HOME': '/Users/cltbld', 04:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:49 INFO - 'LOGNAME': 'cltbld', 04:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:49 INFO - 'MOZ_NO_REMOTE': '1', 04:32:49 INFO - 'NO_EM_RESTART': '1', 04:32:49 INFO - 'PAGER': '/bin/cat', 04:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:49 INFO - 'PWD': '/builds/slave/test', 04:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:49 INFO - 'SHELL': '/bin/bash', 04:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:32:49 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:49 INFO - 'USER': 'cltbld', 04:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:49 INFO - 'XPC_FLAGS': '0x0', 04:32:49 INFO - 'XPC_SERVICE_NAME': '0', 04:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:50 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 04:32:50 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 04:32:50 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 04:32:50 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 04:32:50 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 04:32:50 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 04:32:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:53 INFO - Installing collected packages: mozsystemmonitor 04:32:53 INFO - Running setup.py install for mozsystemmonitor 04:32:53 INFO - Successfully installed mozsystemmonitor 04:32:53 INFO - Cleaning up... 04:32:53 INFO - Return code: 0 04:32:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:53 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 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:32:53 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 04:32:53 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 04:32:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:32:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:53 INFO - 'HOME': '/Users/cltbld', 04:32:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:53 INFO - 'LOGNAME': 'cltbld', 04:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:53 INFO - 'MOZ_NO_REMOTE': '1', 04:32:53 INFO - 'NO_EM_RESTART': '1', 04:32:53 INFO - 'PAGER': '/bin/cat', 04:32:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:53 INFO - 'PWD': '/builds/slave/test', 04:32:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:53 INFO - 'SHELL': '/bin/bash', 04:32:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:32:53 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:32:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:53 INFO - 'USER': 'cltbld', 04:32:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:53 INFO - 'XPC_FLAGS': '0x0', 04:32:53 INFO - 'XPC_SERVICE_NAME': '0', 04:32:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:53 INFO - Downloading/unpacking jsonschema==2.5.1 04:32:53 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 04:32:53 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 04:32:53 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 04:32:53 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 04:32:53 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 04:32:53 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 04:32:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:56 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:56 INFO - warning: no files found matching '*.txt' 04:32:56 INFO - no previously-included directories found matching 'build' 04:32:56 INFO - no previously-included directories found matching 'dist' 04:32:56 INFO - no previously-included directories found matching '.git*' 04:32:56 INFO - Installing collected packages: jsonschema, functools32 04:32:56 INFO - Running setup.py install for functools32 04:32:57 INFO - warning: no files found matching '*.txt' 04:32:57 INFO - no previously-included directories found matching 'build' 04:32:57 INFO - no previously-included directories found matching 'dist' 04:32:57 INFO - no previously-included directories found matching '.git*' 04:32:57 INFO - Successfully installed jsonschema functools32 04:32:57 INFO - Cleaning up... 04:32:57 INFO - Return code: 0 04:32:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:57 INFO - 'HOME': '/Users/cltbld', 04:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:57 INFO - 'LOGNAME': 'cltbld', 04:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:57 INFO - 'MOZ_NO_REMOTE': '1', 04:32:57 INFO - 'NO_EM_RESTART': '1', 04:32:57 INFO - 'PAGER': '/bin/cat', 04:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:57 INFO - 'PWD': '/builds/slave/test', 04:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:57 INFO - 'SHELL': '/bin/bash', 04:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:32:57 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:57 INFO - 'USER': 'cltbld', 04:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:57 INFO - 'XPC_FLAGS': '0x0', 04:32:57 INFO - 'XPC_SERVICE_NAME': '0', 04:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:32:57 INFO - Cleaning up... 04:32:57 INFO - Return code: 0 04:32:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:57 INFO - 'HOME': '/Users/cltbld', 04:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:57 INFO - 'LOGNAME': 'cltbld', 04:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:57 INFO - 'MOZ_NO_REMOTE': '1', 04:32:57 INFO - 'NO_EM_RESTART': '1', 04:32:57 INFO - 'PAGER': '/bin/cat', 04:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:57 INFO - 'PWD': '/builds/slave/test', 04:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:57 INFO - 'SHELL': '/bin/bash', 04:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:32:57 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:57 INFO - 'USER': 'cltbld', 04:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:57 INFO - 'XPC_FLAGS': '0x0', 04:32:57 INFO - 'XPC_SERVICE_NAME': '0', 04:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:57 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:33:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:33:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:01 INFO - Downloading docopt-0.6.1.tar.gz 04:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:33:01 INFO - Installing collected packages: blobuploader, requests, docopt 04:33:01 INFO - Running setup.py install for blobuploader 04:33:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:33:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:33:01 INFO - Running setup.py install for requests 04:33:02 INFO - Running setup.py install for docopt 04:33:02 INFO - Successfully installed blobuploader requests docopt 04:33:02 INFO - Cleaning up... 04:33:02 INFO - Return code: 0 04:33:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:02 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 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:33:02 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 04:33:02 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 04:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:02 INFO - 'HOME': '/Users/cltbld', 04:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:02 INFO - 'LOGNAME': 'cltbld', 04:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:02 INFO - 'MOZ_NO_REMOTE': '1', 04:33:02 INFO - 'NO_EM_RESTART': '1', 04:33:02 INFO - 'PAGER': '/bin/cat', 04:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:02 INFO - 'PWD': '/builds/slave/test', 04:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:02 INFO - 'SHELL': '/bin/bash', 04:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:33:02 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:02 INFO - 'USER': 'cltbld', 04:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:02 INFO - 'XPC_FLAGS': '0x0', 04:33:02 INFO - 'XPC_SERVICE_NAME': '0', 04:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-r69Y6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-RWCsnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-jYPQg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-84uR5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-L0Xmn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-KzhzxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ZalayQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-9Hlavh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-qJP6Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-kRPOXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-KACmaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-sVpQXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-YmdIgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-sAjwA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-WZaeea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-WFr6DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-g4r2hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:33:04 INFO - Running setup.py install for manifestparser 04:33:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:33:04 INFO - Running setup.py install for mozcrash 04:33:04 INFO - Running setup.py install for mozdebug 04:33:05 INFO - Running setup.py install for mozdevice 04:33:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:33:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:33:05 INFO - Running setup.py install for mozfile 04:33:05 INFO - Running setup.py install for mozhttpd 04:33:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:33:05 INFO - Running setup.py install for mozinfo 04:33:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:33:05 INFO - Running setup.py install for mozInstall 04:33:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:33:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:33:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:33:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:33:05 INFO - Running setup.py install for mozleak 04:33:05 INFO - Running setup.py install for mozlog 04:33:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:33:06 INFO - Running setup.py install for moznetwork 04:33:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:33:06 INFO - Running setup.py install for mozprocess 04:33:06 INFO - Running setup.py install for mozprofile 04:33:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:33:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:33:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:33:06 INFO - Running setup.py install for mozrunner 04:33:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:33:06 INFO - Running setup.py install for mozscreenshot 04:33:06 INFO - Running setup.py install for moztest 04:33:07 INFO - Running setup.py install for mozversion 04:33:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:33:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:33:07 INFO - Cleaning up... 04:33:07 INFO - Return code: 0 04:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:07 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 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:33:07 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 04:33:07 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 04:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:07 INFO - 'HOME': '/Users/cltbld', 04:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:07 INFO - 'LOGNAME': 'cltbld', 04:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:07 INFO - 'MOZ_NO_REMOTE': '1', 04:33:07 INFO - 'NO_EM_RESTART': '1', 04:33:07 INFO - 'PAGER': '/bin/cat', 04:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:07 INFO - 'PWD': '/builds/slave/test', 04:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:07 INFO - 'SHELL': '/bin/bash', 04:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:33:07 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:07 INFO - 'USER': 'cltbld', 04:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:07 INFO - 'XPC_FLAGS': '0x0', 04:33:07 INFO - 'XPC_SERVICE_NAME': '0', 04:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:07 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-AtkCTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:07 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)) 04:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:07 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Iat3Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:07 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)) 04:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:07 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Ua7uHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:07 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)) 04:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:07 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-u_kBhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:07 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)) 04:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:07 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-StgQBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:08 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)) 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:08 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-MiGgMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:08 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)) 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:08 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-6aLQR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:08 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)) 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:08 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-CyOBxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:08 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)) 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:08 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-4IvabL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:08 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)) 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:08 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Wu8iwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:08 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)) 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:08 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-DCyc0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:08 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)) 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:08 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-MpvSh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:08 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-uXZifs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:08 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)) 04:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:08 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ME7Kuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:09 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)) 04:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:09 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-DlQ25k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:09 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)) 04:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:09 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-rLbawp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:09 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)) 04:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:09 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-GYtREk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:09 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)) 04:33:09 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)) 04:33:09 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)) 04:33:09 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)) 04:33:09 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)) 04:33:09 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)) 04:33:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:11 INFO - Downloading blessings-1.6.tar.gz 04:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:33:12 INFO - Installing collected packages: blessings 04:33:12 INFO - Running setup.py install for blessings 04:33:12 INFO - Successfully installed blessings 04:33:12 INFO - Cleaning up... 04:33:12 INFO - Return code: 0 04:33:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:12 INFO - Reading from file tmpfile_stdout 04:33:12 INFO - Current package versions: 04:33:12 INFO - blessings == 1.6 04:33:12 INFO - blobuploader == 1.2.4 04:33:12 INFO - docopt == 0.6.1 04:33:12 INFO - functools32 == 3.2.3-2 04:33:12 INFO - jsonschema == 2.5.1 04:33:12 INFO - manifestparser == 1.1 04:33:12 INFO - mozInstall == 1.12 04:33:12 INFO - mozcrash == 1.0 04:33:12 INFO - mozdebug == 0.1 04:33:12 INFO - mozdevice == 0.49 04:33:12 INFO - mozfile == 1.2 04:33:12 INFO - mozhttpd == 0.7 04:33:12 INFO - mozinfo == 0.9 04:33:12 INFO - mozleak == 0.1 04:33:12 INFO - mozlog == 3.4 04:33:12 INFO - moznetwork == 0.27 04:33:12 INFO - mozprocess == 0.25 04:33:12 INFO - mozprofile == 0.28 04:33:12 INFO - mozrunner == 6.13 04:33:12 INFO - mozscreenshot == 0.1 04:33:12 INFO - mozsystemmonitor == 0.3 04:33:12 INFO - moztest == 0.8 04:33:12 INFO - mozversion == 1.4 04:33:12 INFO - psutil == 3.1.1 04:33:12 INFO - requests == 1.2.3 04:33:12 INFO - wsgiref == 0.1.2 04:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:12 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 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:33:12 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 04:33:12 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 04:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:12 INFO - 'HOME': '/Users/cltbld', 04:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:12 INFO - 'LOGNAME': 'cltbld', 04:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:12 INFO - 'MOZ_NO_REMOTE': '1', 04:33:12 INFO - 'NO_EM_RESTART': '1', 04:33:12 INFO - 'PAGER': '/bin/cat', 04:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:12 INFO - 'PWD': '/builds/slave/test', 04:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:12 INFO - 'SHELL': '/bin/bash', 04:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:33:12 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:12 INFO - 'USER': 'cltbld', 04:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:12 INFO - 'XPC_FLAGS': '0x0', 04:33:12 INFO - 'XPC_SERVICE_NAME': '0', 04:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:12 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)) 04:33:12 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)) 04:33:12 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)) 04:33:12 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)) 04:33:12 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)) 04:33:12 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)) 04:33:12 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)) 04:33:12 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)) 04:33:12 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)) 04:33:12 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)) 04:33:12 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)) 04:33:12 INFO - Cleaning up... 04:33:12 INFO - Return code: 0 04:33:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0684be4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, '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.t1j4emCvHK/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.gCNjBmmGFw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 04:33:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:12 INFO - 'HOME': '/Users/cltbld', 04:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:12 INFO - 'LOGNAME': 'cltbld', 04:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:12 INFO - 'MOZ_NO_REMOTE': '1', 04:33:12 INFO - 'NO_EM_RESTART': '1', 04:33:12 INFO - 'PAGER': '/bin/cat', 04:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:12 INFO - 'PWD': '/builds/slave/test', 04:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:12 INFO - 'SHELL': '/bin/bash', 04:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:33:12 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:12 INFO - 'USER': 'cltbld', 04:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:12 INFO - 'XPC_FLAGS': '0x0', 04:33:12 INFO - 'XPC_SERVICE_NAME': '0', 04:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:33:13 INFO - Cleaning up... 04:33:13 INFO - Return code: 0 04:33:13 INFO - Running post-action listener: _resource_record_post_action 04:33:13 INFO - Running post-action listener: _start_resource_monitoring 04:33:13 INFO - Starting resource monitoring. 04:33:13 INFO - [mozharness: 2017-03-07 12:33:13.240355Z] Finished create-virtualenv step (success) 04:33:13 INFO - [mozharness: 2017-03-07 12:33:13.241379Z] Running install step. 04:33:13 INFO - Running pre-action listener: _resource_record_pre_action 04:33:13 INFO - Running main action method: install 04:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:13 INFO - Reading from file tmpfile_stdout 04:33:13 INFO - Detecting whether we're running mozinstall >=1.0... 04:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:33:13 INFO - Reading from file tmpfile_stdout 04:33:13 INFO - Output received: 04:33:13 INFO - Usage: mozinstall [options] installer 04:33:13 INFO - Options: 04:33:13 INFO - -h, --help show this help message and exit 04:33:13 INFO - -d DEST, --destination=DEST 04:33:13 INFO - Directory to install application into. [default: 04:33:13 INFO - "/builds/slave/test"] 04:33:13 INFO - --app=APP Application being installed. [default: firefox] 04:33:13 INFO - mkdir: /builds/slave/test/build/application 04:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:33:33 INFO - Reading from file tmpfile_stdout 04:33:33 INFO - Output received: 04:33:33 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:33:33 INFO - Running post-action listener: _resource_record_post_action 04:33:33 INFO - [mozharness: 2017-03-07 12:33:33.912633Z] Finished install step (success) 04:33:33 INFO - [mozharness: 2017-03-07 12:33:33.912788Z] Running run-tests step. 04:33:33 INFO - Running pre-action listener: _resource_record_pre_action 04:33:33 INFO - Running main action method: run_tests 04:33:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:33 INFO - 2017-03-07 04:33:33.927 screenresolution[1633:8459] starting screenresolution argv=screenresolution get 04:33:33 INFO - 2017-03-07 04:33:33.929 screenresolution[1633:8459] Display 0: 1600x1200x32@60 04:33:33 INFO - 2017-03-07 04:33:33.935 screenresolution[1634:8462] starting screenresolution argv=screenresolution list 04:33:33 INFO - Available Modes on Display 0 04:33:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:34 INFO - Intel Iris: 04:33:34 INFO - Chipset Model: Intel Iris 04:33:34 INFO - Type: GPU 04:33:34 INFO - Bus: Built-In 04:33:34 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:34 INFO - Vendor: Intel (0x8086) 04:33:34 INFO - Device ID: 0x0a2e 04:33:34 INFO - Revision ID: 0x0009 04:33:34 INFO - Displays: 04:33:34 INFO - Display: 04:33:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:34 INFO - Display Serial Number: 1600x1200 60 04:33:34 INFO - Main Display: Yes 04:33:34 INFO - Mirror: Off 04:33:34 INFO - Online: Yes 04:33:34 INFO - Rotation: Supported 04:33:34 INFO - Return code: 0 04:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:34 INFO - Python 2.7.3 04:33:34 INFO - Return code: 0 04:33:34 INFO - grabbing minidump binary from tooltool 04:33:34 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')]} 04:33:34 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 0x10b97ad30>, '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 0x10b8a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b96fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:34 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 04:33:34 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 04:33:34 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 04:33:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:34 INFO - Return code: 0 04:33:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:34 INFO - ENV: RUST_BACKTRACE is now 1 04:33:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 04:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0253 --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 04:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t1j4emCvHK/Render', 04:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:34 INFO - 'HOME': '/Users/cltbld', 04:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:34 INFO - 'LOGNAME': 'cltbld', 04:33:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:34 INFO - 'MOZ_NO_REMOTE': '1', 04:33:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:34 INFO - 'NO_EM_RESTART': '1', 04:33:34 INFO - 'PAGER': '/bin/cat', 04:33:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:34 INFO - 'PWD': '/builds/slave/test', 04:33:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:34 INFO - 'RUST_BACKTRACE': '1', 04:33:34 INFO - 'SHELL': '/bin/bash', 04:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gCNjBmmGFw/Listeners', 04:33:34 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:34 INFO - 'USER': 'cltbld', 04:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:34 INFO - 'XPC_FLAGS': '0x0', 04:33:34 INFO - 'XPC_SERVICE_NAME': '0', 04:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 04:33:34 INFO - mozversion application_buildid: 20170307030205 04:33:34 INFO - mozversion application_changeset: b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 04:33:34 INFO - mozversion application_display_name: Nightly 04:33:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:34 INFO - mozversion application_name: Firefox 04:33:34 INFO - mozversion application_remotingname: firefox 04:33:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:33:34 INFO - mozversion application_vendor: Mozilla 04:33:34 INFO - mozversion application_version: 55.0a1 04:33:34 INFO - mozversion platform_buildid: 20170307030205 04:33:34 INFO - mozversion platform_changeset: b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 04:33:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:33:34 INFO - mozversion platform_version: 55.0a1 04:33:34 INFO - using testdate: 1488890014 04:33:34 INFO - actual date: 1488890014 04:33:34 INFO - starting webserver on 'localhost:49250' 04:33:34 INFO - SUITE-START | Running 2 tests 04:33:34 INFO - TEST-START | dromaeo_css 04:33:34 INFO - operating with platform_type : mac_ 04:33:34 INFO - Initialising browser for dromaeo_css test... 04:33:34 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmp1rm_qb/profile http://localhost:49250/getInfo.html) 04:33:37 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 04:33:37 INFO - PROCESS | 1644 | colorDepth:24 04:33:37 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 04:33:37 INFO - PROCESS | 1644 | __metrics 04:33:37 INFO - PROCESS | 1644 | 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" 04:33:37 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:38 INFO - TEST-INFO | 1644: exit 0 04:33:38 INFO - Browser initialized. 04:33:38 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:38 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmp1rm_qb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:50 INFO - PROCESS | 1648 | RSS: Main: 232386560 04:33:50 INFO - PROCESS | 1648 | 04:36:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 04:36:57 INFO - PROCESS | 1648 | RSS: Main: 583598080 04:36:57 INFO - PROCESS | 1648 | 04:38:39 INFO - PROCESS | 1648 | ************************* 04:38:39 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 04:38:39 INFO - PROCESS | 1648 | 04:38:39 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:38:39 INFO - PROCESS | 1648 | Full stack: 04:38:39 INFO - PROCESS | 1648 | ************************* 04:40:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 04:40:01 INFO - PROCESS | 1648 | RSS: Main: 365826048 04:40:01 INFO - PROCESS | 1648 | 04:43:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 04:43:04 INFO - PROCESS | 1648 | RSS: Main: 346939392 04:43:04 INFO - PROCESS | 1648 | 04:46:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 04:46:07 INFO - PROCESS | 1648 | RSS: Main: 335921152 04:46:07 INFO - PROCESS | 1648 | 04:49:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 04:49:12 INFO - PROCESS | 1648 | RSS: Main: 336519168 04:49:12 INFO - PROCESS | 1648 | 04:52:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 04:52:15 INFO - PROCESS | 1648 | RSS: Main: 368885760 04:52:15 INFO - PROCESS | 1648 | 04:52:15 INFO - PROCESS | 1648 | __start_tp_report 04:52:15 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 04:52:15 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 04:52:15 INFO - PROCESS | 1648 | |i|pagename|runs| 04:52:15 INFO - PROCESS | 1648 | |0;dojo.html;3376.206591451009;3384.187794929216;3388.847501862416;3420.7092397146243;3432.8455219515117;5090.592752579794;5297.622618119288;5810.593258471903;5906.26171728534;5976.282846058479;5737.540996720263;5791.971040144794;5855.853603659911;5870.501007414364;5886.117082437626;5122.154844450662;5198.168293073109;5222.608304377178;5247.2653828464045;5249.475052494739;5306.124489459235;5337.386200586924;5343.893122137555;5368.892622147555;5401.540869026137;5130.3074084998425;5190.480951904817;5207.531322180984;5222.32109825724;5310.230016647603;5252.553532949704;5256.448072952323;5259.0796610593;5294.629375943686;5336.626436149471;5193.714765503204;5233.764480598382;5245.737713114368;5280.10238259493;5291.312129423189;5581.748821303051;5631.8592035199035;5794.68129252891;5794.884102317972;5830.096335068071;6180.289266734293;6187.381261873777;6190.5976111553055;6192.040233763774;6195.31851496335;6123.343628574293;6274.901892168898;6279.277883043463;6283.465905398047;6310.842228944267;5716;5790.7973220937065;5792.797252096157;5799.536037117021;5800.53595712342;6271.592346497463;6322.336154703782;6332.33510481402;6344.936550634435;6359.872802543923;6012.669303188279;6034.607750496291;6060.454559089615;6295.559310848196;6308.495320374359;6205.875882482325;6206.06908963659;6224.906626400608;6225.533085018551;6281.528885333527;6331.715072821734;6341.8097457076365;6346.30190679025;6347;6367.044943258548;6119.258838874149;6156.538259630456;6163.7842675506145;6355.682215889187;6366.076918846741;4985.55130038291;4995.325631039836;5033.572146367526;5040.47075057121;5070.087384270867;4487.259602165672;4488.5287044859815;4491.775411229425;4493.213687604722;4511.5262897395305;4941.876453088629;5662.320521537442;5899.262592175978;5917.763289468459;5953.047512397996;6221;6254.437100660963;6256.311805701369;6264.2796078451565;6271.498280137578;5703.657780533182;5705.2012718219485;5735.799247026417;5747.597668163188;5756.971215143982;5430.5927055471;5433.565314774887;5435.864103397446;5435.891282174413;5442.91835622466;6241.781537646251;6256.562040657202;6257.843553911189;6259.593126446766;6265.091561723524;6248.312685604671;6277.686115694289;6312.873742525216;6314.179156709598;6327.683615819098;6461.289258181502;6465.418112369909;6470.48236141117;6479.449246814073;6483.870322593616;6346.3019067903415;6347.492200624031;6353.4599559038;6358.237011558643;6365.777197798055;5636.746346414503;5886.352501224947;6114.327782088646;6259.749610015549;6306.653134077486;5989.2812862456785;6198.969005154945;6246.312905580474;6265.342139075331;6276.592021518587;6063.969680151571;6074.757009719562;6074.936886045013;6078.996965500643;6085.1785009023215;4957.529034741694;5917.201177841109;5937.732802023833;5952.8809423812145;5953.940460595339;5958.910616340845;6082.7262773174425;6091.573589848846;6096.725647345791;6105.877882442415;5816.302043754777;5897.026990546512;5901.232839730807;5904.114382842608;5922.141289512911 04:52:15 INFO - PROCESS | 1648 | |1;ext.html;758.1508710244525;778.0507780507778;835.6573804740058;849.770561948274;920.1810388754014;34960.97948735896;35104.99999999997;35516.46725299123;36514.8174259129;36576;35327.2934541309;35459.1135221619;35466.64533354672;35524.822375888085;35528;6480.416762491386;7694.230576942317;7718.151003389623;7725.884111738328;7747.496412733182;7540.019797426355;7640.044994375703;7650.770476885702;7654.732084377048;7678.731244406447;7589.089309282894;7590.1650818409935;7599.088109426849;7608.657610407545;7613.619319034054;7562.886556701654;7584.089909210875;7585.469017168801;7587.355074818647;7595.164531901486;6565.704543295563;6598.340165983412;6609.768658096944;6611.371919667672;6623.337666233387;32913.84801531935;33086.33827323464;33154.17114572131;33159;33220.335593288;3436.6735160159747;3469.496922946184;3473.3053389322235;3505.894823155284;3619.49327094207;24305;24710.752892471024;25029;25093.87077581495;25421.745782542308;2274.465500607356;2715.416185520123;2783.4850552647827;2788.5817127431046;2870.1963450233966;328870;330967;332307;332730;335306;16520.4217852377;16634.916825415796;34949.65050349515;35537.46693799595;36826;48414.22200891878;49559;49605.25592116049;49617.25574116391;51902;13275.601731948056;13355.131916425402;13464.192148471124;13475.517693053756;13498.055136140572;10060.597576096874;11497.022753066083;11558.190926635223;11583.536658533565;11589.01493373056;10521.210909181842;10538.841917371246;10543.683689489328;10553.31403458788;10563.366198028143;5271.20931860224;5422.40353561108;5476.67139971603;5495.203195536625;5525.4474552544425;938.901415351392;972.9173020293355;1120.2102517724984;1128.3568366031448;1167.3462860797981;23594.764052359256;25614;25643.615345769827;25645.74354256471;25654.48691026169;1003.9046290602381;1056.8309070548676;1194.814803705427;1246.6634008817568;1255.8806913343217;11073.280236784583;11685.649430517098;12787.680307992188;12822.294773787531;13541.458341666223;407148;409503;409727;409778;409813;44796;44804.327935081;44866;44954.55045449569;45063.54936450593;1339.7320535892666;1366.296357375952;1370.0888908875884;1378.5450801235568;1384.4531410092957;18931.71602425937;24033.317667763087;25605.103821366163;25609.487810243318;25637.23088307354;40803.775886723444;41684.87363447814;43224.13551729011;43241.567584323755;43246.78376608097;412968;414838;414843;415161;415255;27558.86220568884;27584.172474825788;27698;27729.722702772713;27752.583711243944;34967.70536553277;35116;35580.11049723778;36065.81967090148;36189.457158143174;29726;29989.70010299869;30496.797836227764;30770;30923.536146957365;26553;26808.06171783978;27319.453610927274;29724.47696353039;30222.54666180053;30165.245868853453;30420.239494012825;30506.542401864433;30550.236244094074;30628.08115756531;21135.471613209793;24799.380015499755;26903.327416814736;27678.584821227294;27956.720432796224;17963.820361796214;20132.597348052663;21896.233631822808;22049.448763781034;22049.684783097542 04:52:15 INFO - PROCESS | 1648 | |2;jquery.html;358.60374286413514;375.3768743885151;397.2591117565741;399.88003598920324;420.627744446165;12878.562208320916;14938.402463901444;20513.282035128774;21725.565488690216;22047.889760551214;21924.23265185715;22453.101875924986;22919.770802291972;22977.77022229777;23333.533329333404;6347.333529979355;6553.672316384173;6653.401193892549;6701.664916754167;6708.429783468411;6525.608463492182;6581.3747693969;6637.767678131267;6640.435562977153;6656.833579160511;6364.968175159118;6558.967205163967;6639.070530125786;6649.700763465656;6651.567648102882;6513.283538810727;6574.408303252706;6637.3030831762935;6646.501512386542;6663.63350015749;6346.365363463663;6425.389587989133;6431.74273029083;6442.774502892376;6473.28793832678;26439.867800661064;26742.5988610171;26760.464790704078;26869.73130268692;26950.595741063702;2905.6513218413716;2918.9854050729823;2934.8092373995837;2934.9413011739643;3061.8315992620396;15675.921620391826;15763.97534160276;16536.66926661472;16601.169941502998;16605.931546770997;1987.2349145578912;2022.9739301865975;2046.5190680190144;2049.2008116834445;2094.6229678657837;96586;117775;121840;122354.16468752976;124397.9999999991;14566.927165364317;19736.309229177197;20377.89811050935;20656.483587910123;20843.478913027295;28588.42823143567;28619.14142575726;30261.848690756404;31672.891448799182;33017;9768.51157442125;10269;10324.587016519255;10413.739656508647;10496.370217786956;8340.499570025819;8344.874826877602;8353.872227249365;8550.700725474579;8575.656973720981;8404.621792019374;9978.750531236778;10010.799784004279;10199.898001020043;10205.795884082278;3738.6448287412654;3905.4922860028582;4050.6354428101613;4169.666426685919;4172.93139189288;750.2684882239772;805.5408417202256;836.66951554137;908.1554154636119;1079.3631757263095;20406.897965510077;21049.15803367879;21164;21172.15311387558;21206.46983825417;896.1441823058963;898.8427025270682;901.2069378946485;921.433318509112;924.1451657217048;8674.612062070039;8765.91234087651;9778.16885564735;9969.35199212049;11025.44872756359;683068;700247;702316;713590;749448;156633;157424;159071;159537;160008;1222.798238290672;1264.3488603369271;1294.2752058847075;1298.1107941060404;1298.79868620364;17651.82348176502;18108.818911810715;18274.269029238683;18529.058495766454;18580.907095464438;43293.78353108215;59805.40194597998;63145.84270786534;64272.357276426636;65855;86189.1381086181;86931.69602455842;88284.5585772067;88374;89847;7585.317321441097;10199.490025498844;10944.781104378028;11651.017682355412;11706.88293117092;13008.869911300766;13099.869001309866;13476.258805765778;13492.59522214335;13519.324033798073;11353.37556434404;11395.031422329195;11517;11706.063514918957;11715.824262635897;11049.17131215146;11108.111351092055;11232;11446.94276528612;11708.121890858049;11200.551977920792;11228.168004301897;11518.36648984314;11621.825672614748;11673.007794337576;11181.944090279496;11388.715282118013;11529.365884876412;11591.420428978687;11667.708307292385;10874.347539147677;11147.331160130418;11329.943350283196;11366.374849383363;11418.486168122621 04:52:15 INFO - PROCESS | 1648 | |3;mootools.html;1463.8316593591737;1510.6374470127173;1528.5261568913638;1556.8520990505897;1558.018448377522;10207.948960255198;10755.677329680102;10777;10778.784424311509;10787.352758834475;10251.743706407344;10631.893681063188;10688.091512221452;10698.5185666645;10703.46482675865;2318.976810231897;2361.657559653858;2364.9763502365013;2373.5727569037567;2388.653645221442;2292.747797742247;2329.662198981155;2329.7087864017;2330.743618202005;2337;2303.1823702585593;2327.4763178284834;2330.941726456835;2332.6734257204007;2333.9183128590503;2272.4318920269934;2291.6677081823127;2300.9884950575306;2303.1133013789645;2303.6199027160496;2253.6732173834703;2324.7094113235844;2325.1280769711357;2326.627739561662;2361.657559653858;10689.679309620724;10757.408342541157;10758.677239682822;10766.676999690022;10799.460026998619;5563.582731295129;5764.365919748824;5774.191613174159;5778.797742079007;5782.710864456761;3092.58250136231;3265.053134590966;3374.0552645259368;3376.6960973512255;3376.96623033769;1124.1231839165464;1142.5030111901349;1164.225789849749;1184.9466773995105;1192.8568571771443;13135.146215495963;13564.118332308468;13841.30793460333;14592.781108283385;14643.267836608127;3910.276598829226;4100.0569868929715;4185.183889141588;4298.3552467130185;4301.2257793597455;10441.582336706599;11283.984441400313;11373.943130284295;11418;11422.543098275975;5427.810026649048;5485.807996720096;5490.670559766427;5500;5504.724763761876;4851.927221091686;5065.822696205689;5192.532672059533;5202.1416466282635;5228.816991405282;3620.2759448110482;3744.794036328028;3792.3363411402893;3827.8086095695103;3868.497095377583;1016.1667432705111;1024.416082832793;1030.5053574284386;1030.6135199300263;1033.5710680067687;874.3748220022715;930.6417029443578;931.4411353188168;952.1525842000625;973.732223638505;6371;6421.74313027483;6529.347065293433;6603.70283337251;6642.83392915181;972.3242346569067;988.6984469736799;1008.3193844155165;1009.9242556808268;1018.8981101889751;3720.981395093007;3741.663250307431;3791.639794219545;3816.5992570779667;3869.28418242626;12546.498140074478;12964.611061668165;12984.026198035184;13043.673908152372;13055.216686998621;12850.29323387204;12997.870021299856;13018.28399438021;13020.609381718563;13131.409086591126;9431.76420589477;9651.90348096524;9712.417254964725;9851.901480985098;9889.950550247202;6247.187865577446;6342.334054924167;6368.745250189941;6415.037744338387;6488.740450381932;11706.297622142698;11844.940775296069;12046.04871806378;12083;12086.879131208576;10748.946255268673;10762.3542587445;11137.721556961142;12030.63908082759;12195.939020305197;7664.233576642291;7816.218378162365;7918.406119541172;7924.4056695749205;7925.524468531907;9487.762805929908;9534.666286679932;9681.564329605044;9694.854577181206;9747.220222382335;8503.829923401621;8558.657653693783;8562.614682339434;8688.087750786077;8689.522076285612;8331.50010999342;8365.916340836757;8379;8402.453840500348;8600.13998600135;7484.139323977594;7605.923940760522;7619.276168763959;7622.771316860281;7630.084389873251;4991.800327986985;5520.585956053232;5615.634983726045;5709.25779648643;5824.737886795189;4521.525239849769;5666.744996475086;5745.052066408995;5829.504492118048;5968.6717230551 04:52:15 INFO - PROCESS | 1648 | |4;prototype.html;315.7700755557104;363.6854121185175;364.67361711268416;370.1449651305486;374.3430279858848;4518.876128219736;4849.733264670442;4870.586000189984;4902.578252306836;4919.360483137196;4581.663351690637;4719.433667959841;4779.876728968698;4784.5693887550115;4786.760661966897;3491.912702182453;4023.637872591466;4069.572694867041;4074.1647962167685;4083.5712250213746;3500.597431295408;4075.755454672714;4076.2255171517318;4078.5309689385654;4101.118259574191;3682.2083252100792;3756.0422092366407;4049.7570145791346;4116.835326586933;4146.859613606252;3330.833458327074;3486.581610206766;4031.5766844481495;4050.5544390117066;4151.97924010381;3361.6974472297366;3453.326601312745;3486.9128271793156;3705.814709264553;3752.1182522107283;3913.902152446183;4052.872242072906;4655.952410707598;4711.293306004092;4749.311349854286;3812.2375524895133;4630.699004564693;4741.407324084489;4742.146413645542;4758.619310455155;4829.806807727687;5098.431098231216;5134.4095429025765;5137.409197942247;5171.534561889411;4191.706580539363;4199.91600167998;4213.726107802983;4241.49102107746;4277.957220427787;4190.533313340306;4473.329000649896;4600.010997635524;5359.356877174686;5590.748416321276;3621.366260904384;3714.1271801126713;4087.3868919661695;4225.492940847118;4276.465441819772;3622.112582417272;3919.5296564411883;4178.435911152016;4363.38912552243;4437.2932511168165;4483.856616562755;4673.3690951721765;4678.2982552616695;4741.193997020515;4798.49615790337;4795.784189711471;5183.2743415921805;5242.423333433319;5265.893123057414;5278.868028299246;1281.3726567259528;1496;1496.9925150374397;1499.8750936797403;1501.06183635228;1054.852320675106;1106.9335839849634;1114.9609763658395;1127.9453710780447;1130.773111174385;4174.937375939363;4188.685848561309;4316.525182229952;4752.239641657318;4903.978737435269;4708.105459962596;4988.501149884983;5430.588047107702;5454.836354909359;5456.590755693339;4284.400183974246;4304.720193187432;4461.152381047656;4548.384678809698;4668.743219122981;2470.542949554302;2766.543520319165;2773.1974216758863;2808.382155925693;2827.172827172827;4796.273341597022;4959.380077490314;5605.299337582802;5635.070213414822;5674.4892959633835;4580.335851301543;5336.306280183629;5524.364698059774;5578.41426650204;5579.536370903261;4931.827386041471;5119.950410165907;5465.9726701366235;5470.617056805985;5503.559715222773;4530.546945305443;4634.884127896829;5152.5620322271525;5295.74311798249;5296.298887567292;4327.913441731211;4834.709917404967;5418.8645283866645;5448.83653490396;5448.866901531715;4426.667999899956;5426.887488065016;5606.943930560806;5682.801101961577;5683.476244728295;3730.403135498307;3874.2638898609175;4074.4703188585295;4258.041940563472;4294.1411717655965;5221.295125158055;5301.443348448512;5354.7590358434745;5427.042261967316;5466.945330546644;4648.883777905579;4692;5250.737463126905;5303.231031500488;5311.123664595299;4174.497181014772;4761.595329377911;5283.418823929288;5313.814016509404;5328.6802791832615;4598.4478614369345;4922.93236840535;5182.274481572507;5194;5222.686638801684;4883.877903052452;5257.684538927677;5312.389075256395;5317.282166907573;5319.973400133129;4551.613112885309;4606.894345357023;4755.97870904871;4935.975320123376;5208.583313335 04:52:15 INFO - PROCESS | 1648 | |5;yui.html;722.2741145149124;755.4787196834184;778.9182135875733;801.7795106345754;818.8159347323502;15473.690526189483;16257.593560160973;16286.918565407157;16291;16301.592460188502;13240.543540210594;13923.512677056306;14305.499307524238;14857.331420086095;15207.46773862915;923.9676611318605;930.186087173723;933.4725879877848;939.5302348825587;942.5852624845046;924.2421214604027;927.378656300277;927.7263207353847;928.336239588694;928.4522131942186;960.9909594925335;984.8768903887014;985.5909797434092;1002.2282842211492;1004.743790333464;980.2745967983712;982.5234761140877;983.061176576375;983.1593987141034;983.572146116438;721.0986267166043;721.5382155420535;721.9494635375526;722.5736815278958;722.8951801988735;15707.528774136794;16082.381464170585;16103.758443623356;16120.75818862718;16235.83764162367;13703.794443083361;14139.858601413956;14160.15039097647;14204.573862784133;14207.857921420757;11706.297622142698;11726.687879779089;11752.177347585672;11811.822822657667;11993;3167.4298626247264;3653.209927135711;3663.6336366363416;3681.9815900920594;3777.6788972937334;111454;112942;113884;115155.42422287836;117953;10639.787204255872;10653.387206591995;10734.516946737416;11140.721481962853;11219.270747401393;22156.667649985262;22533.43666408353;22538.436539086655;22555.661665075037;22588.66117008246;7276.391688095102;7397.704091836266;7411.436527223923;7495.437842161859;7513.248675132443;4178.101708132766;4182.749035057906;4235.70821339617;4268.615824575803;4419.138268037702;3345.7323414126813;3403.7787543809573;3411.1131105912145;3425.72594192464;3450.258194488197;600.5615900392738;604.625132417895;609.0863704443335;616.3435940723116;617.4227097663698;641.666333506574;645.20639613275;673.8079647300495;684.8253695307765;713.2475238623199;8396.412251142483;8503.362247831437;10008.599656013677;10171.338862973884;10274;510.19898758948835;546.2025442853399;569.8831739493394;577.8150991682621;579.5769088565371;4725.330188443519;4870.732109733928;4917.224725534659;4925.704457732476;4932.901341973212;94750.0524994755;96291;97584;99176;102967;48507.757461212466;57724.71137644285;66513.66743166253;77084.61457692788;91307.54346228359;75637;75731.07747996363;76338.53709175033;76897;77821;9096.856350970009;10340.793184136426;10901;11043.39261340634;11055.336679799238;32608;49093.754531228544;50321.245181323044;50738.49261507337;51309.23036154536;62755.05867412084;62923;67453.66273168799;68250.31749682638;68324;12337.136400451882;12705.0589941828;12825.294608796607;12840.357982101044;12851.678708032;14519.34662940149;14617.122972621677;14776.63058423548;14843.03520271179;14976.251187440803;13574.932125339705;13920.791188132389;13958.720825583634;14149.885367765914;14400;12510.749785004431;12805.487780488676;12969.610911672666;13267.203967761965;13331;13422.664433389244;13506.39221235027;13698.38357273905;13865;14444.494442694455;10923.22932144626;10968.067714244378;11178.944105279421;11298.830517542408;11542.884571154516;8820.867686984571;9172.081157571554;9489.525523723649;11003.33979961205;11435.256708313933 04:52:15 INFO - PROCESS | 1648 | __end_tp_report 04:52:15 INFO - PROCESS | 1648 | __start_cc_report 04:52:15 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,4489 04:52:15 INFO - PROCESS | 1648 | __end_cc_report 04:52:15 INFO - PROCESS | 1648 | __startTimestamp1488891135961__endTimestamp 04:52:15 INFO - PROCESS | 1648 | 04:52:15 INFO - PROCESS | 1648 | ------- Summary: start ------- 04:52:15 INFO - PROCESS | 1648 | Number of tests: 6 04:52:15 INFO - PROCESS | 1648 | 04:52:15 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5768.94 Median:5937.73 stddev:640.91 (10.8%) stddev-sans-first:614.77 04:52:15 INFO - PROCESS | 1648 | Values: 3376.2 3384.2 3388.8 3420.7 3432.8 5090.6 5297.6 5810.6 5906.3 5976.3 5737.5 5792.0 5855.9 5870.5 5886.1 5122.2 5198.2 5222.6 5247.3 5249.5 5306.1 5337.4 5343.9 5368.9 5401.5 5130.3 5190.5 5207.5 5222.3 5310.2 5252.6 5256.4 5259.1 5294.6 5336.6 5193.7 5233.8 5245.7 5280.1 5291.3 5581.7 5631.9 5794.7 5794.9 5830.1 6180.3 6187.4 6190.6 6192.0 6195.3 6123.3 6274.9 6279.3 6283.5 6310.8 5716.0 5790.8 5792.8 5799.5 5800.5 6271.6 6322.3 6332.3 6344.9 6359.9 6012.7 6034.6 6060.5 6295.6 6308.5 6205.9 6206.1 6224.9 6225.5 6281.5 6331.7 6341.8 6346.3 6347.0 6367.0 6119.3 6156.5 6163.8 6355.7 6366.1 4985.6 4995.3 5033.6 5040.5 5070.1 4487.3 4488.5 4491.8 4493.2 4511.5 4941.9 5662.3 5899.3 5917.8 5953.0 6221.0 6254.4 6256.3 6264.3 6271.5 5703.7 5705.2 5735.8 5747.6 5757.0 5430.6 5433.6 5435.9 5435.9 5442.9 6241.8 6256.6 6257.8 6259.6 6265.1 6248.3 6277.7 6312.9 6314.2 6327.7 6461.3 6465.4 6470.5 6479.4 6483.9 6346.3 6347.5 6353.5 6358.2 6365.8 5636.7 5886.4 6114.3 6259.7 6306.7 5989.3 6199.0 6246.3 6265.3 6276.6 6064.0 6074.8 6074.9 6079.0 6085.2 4957.5 5917.2 5937.7 5952.9 5953.9 5958.9 6082.7 6091.6 6096.7 6105.9 5816.3 5897.0 5901.2 5904.1 5922.1 04:52:15 INFO - PROCESS | 1648 | 04:52:15 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:49965.32 Median:33189.67 stddev:102897.93 (310.0%) stddev-sans-first:103120.26 04:52:15 INFO - PROCESS | 1648 | Values: 758.2 778.1 835.7 849.8 920.2 34961.0 35105.0 35516.5 36514.8 36576.0 35327.3 35459.1 35466.6 35524.8 35528.0 6480.4 7694.2 7718.2 7725.9 7747.5 7540.0 7640.0 7650.8 7654.7 7678.7 7589.1 7590.2 7599.1 7608.7 7613.6 7562.9 7584.1 7585.5 7587.4 7595.2 6565.7 6598.3 6609.8 6611.4 6623.3 32913.8 33086.3 33154.2 33159.0 33220.3 3436.7 3469.5 3473.3 3505.9 3619.5 24305.0 24710.8 25029.0 25093.9 25421.7 2274.5 2715.4 2783.5 2788.6 2870.2 328870.0 330967.0 332307.0 332730.0 335306.0 16520.4 16634.9 34949.7 35537.5 36826.0 48414.2 49559.0 49605.3 49617.3 51902.0 13275.6 13355.1 13464.2 13475.5 13498.1 10060.6 11497.0 11558.2 11583.5 11589.0 10521.2 10538.8 10543.7 10553.3 10563.4 5271.2 5422.4 5476.7 5495.2 5525.4 938.9 972.9 1120.2 1128.4 1167.3 23594.8 25614.0 25643.6 25645.7 25654.5 1003.9 1056.8 1194.8 1246.7 1255.9 11073.3 11685.6 12787.7 12822.3 13541.5 407148.0 409503.0 409727.0 409778.0 409813.0 44796.0 44804.3 44866.0 44954.6 45063.5 1339.7 1366.3 1370.1 1378.5 1384.5 18931.7 24033.3 25605.1 25609.5 25637.2 40803.8 41684.9 43224.1 43241.6 43246.8 412968.0 414838.0 414843.0 415161.0 415255.0 27558.9 27584.2 27698.0 27729.7 27752.6 34967.7 35116.0 35580.1 36065.8 36189.5 29726.0 29989.7 30496.8 30770.0 30923.5 26553.0 26808.1 27319.5 29724.5 30222.5 30165.2 30420.2 30506.5 30550.2 30628.1 21135.5 24799.4 26903.3 27678.6 27956.7 17963.8 20132.6 21896.2 22049.4 22049.7 04:52:15 INFO - PROCESS | 1648 | 04:52:15 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:40810.07 Median:23155.65 stddev:118165.82 (510.3%) stddev-sans-first:118458.27 04:52:15 INFO - PROCESS | 1648 | Values: 358.6 375.4 397.3 399.9 420.6 12878.6 14938.4 20513.3 21725.6 22047.9 21924.2 22453.1 22919.8 22977.8 23333.5 6347.3 6553.7 6653.4 6701.7 6708.4 6525.6 6581.4 6637.8 6640.4 6656.8 6365.0 6559.0 6639.1 6649.7 6651.6 6513.3 6574.4 6637.3 6646.5 6663.6 6346.4 6425.4 6431.7 6442.8 6473.3 26439.9 26742.6 26760.5 26869.7 26950.6 2905.7 2919.0 2934.8 2934.9 3061.8 15675.9 15764.0 16536.7 16601.2 16605.9 1987.2 2023.0 2046.5 2049.2 2094.6 96586.0 117775.0 121840.0 122354.2 124398.0 14566.9 19736.3 20377.9 20656.5 20843.5 28588.4 28619.1 30261.8 31672.9 33017.0 9768.5 10269.0 10324.6 10413.7 10496.4 8340.5 8344.9 8353.9 8550.7 8575.7 8404.6 9978.8 10010.8 10199.9 10205.8 3738.6 3905.5 4050.6 4169.7 4172.9 750.3 805.5 836.7 908.2 1079.4 20406.9 21049.2 21164.0 21172.2 21206.5 896.1 898.8 901.2 921.4 924.1 8674.6 8765.9 9778.2 9969.4 11025.4 683068.0 700247.0 702316.0 713590.0 749448.0 156633.0 157424.0 159071.0 159537.0 160008.0 1222.8 1264.3 1294.3 1298.1 1298.8 17651.8 18108.8 18274.3 18529.1 18580.9 43293.8 59805.4 63145.8 64272.4 65855.0 86189.1 86931.7 88284.6 88374.0 89847.0 7585.3 10199.5 10944.8 11651.0 11706.9 13008.9 13099.9 13476.3 13492.6 13519.3 11353.4 11395.0 11517.0 11706.1 11715.8 11049.2 11108.1 11232.0 11446.9 11708.1 11200.6 11228.2 11518.4 11621.8 11673.0 11181.9 11388.7 11529.4 11591.4 11667.7 10874.3 11147.3 11329.9 11366.4 11418.5 04:52:15 INFO - PROCESS | 1648 | 04:52:15 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:6410.31 Median:3375.38 stddev:3978.89 (117.9%) stddev-sans-first:3972.69 04:52:15 INFO - PROCESS | 1648 | Values: 1463.8 1510.6 1528.5 1556.9 1558.0 10207.9 10755.7 10777.0 10778.8 10787.4 10251.7 10631.9 10688.1 10698.5 10703.5 2319.0 2361.7 2365.0 2373.6 2388.7 2292.7 2329.7 2329.7 2330.7 2337.0 2303.2 2327.5 2330.9 2332.7 2333.9 2272.4 2291.7 2301.0 2303.1 2303.6 2253.7 2324.7 2325.1 2326.6 2361.7 10689.7 10757.4 10758.7 10766.7 10799.5 5563.6 5764.4 5774.2 5778.8 5782.7 3092.6 3265.1 3374.1 3376.7 3377.0 1124.1 1142.5 1164.2 1184.9 1192.9 13135.1 13564.1 13841.3 14592.8 14643.3 3910.3 4100.1 4185.2 4298.4 4301.2 10441.6 11284.0 11373.9 11418.0 11422.5 5427.8 5485.8 5490.7 5500.0 5504.7 4851.9 5065.8 5192.5 5202.1 5228.8 3620.3 3744.8 3792.3 3827.8 3868.5 1016.2 1024.4 1030.5 1030.6 1033.6 874.4 930.6 931.4 952.2 973.7 6371.0 6421.7 6529.3 6603.7 6642.8 972.3 988.7 1008.3 1009.9 1018.9 3721.0 3741.7 3791.6 3816.6 3869.3 12546.5 12964.6 12984.0 13043.7 13055.2 12850.3 12997.9 13018.3 13020.6 13131.4 9431.8 9651.9 9712.4 9851.9 9890.0 6247.2 6342.3 6368.7 6415.0 6488.7 11706.3 11844.9 12046.0 12083.0 12086.9 10748.9 10762.4 11137.7 12030.6 12195.9 7664.2 7816.2 7918.4 7924.4 7925.5 9487.8 9534.7 9681.6 9694.9 9747.2 8503.8 8558.7 8562.6 8688.1 8689.5 8331.5 8365.9 8379.0 8402.5 8600.1 7484.1 7605.9 7619.3 7622.8 7630.1 4991.8 5520.6 5615.6 5709.3 5824.7 4521.5 5666.7 5745.1 5829.5 5968.7 04:52:15 INFO - PROCESS | 1648 | 04:52:15 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4317.35 Median:4641.88 stddev:1211.87 (26.1%) stddev-sans-first:1177.46 04:52:15 INFO - PROCESS | 1648 | Values: 315.8 363.7 364.7 370.1 374.3 4518.9 4849.7 4870.6 4902.6 4919.4 4581.7 4719.4 4779.9 4784.6 4786.8 3491.9 4023.6 4069.6 4074.2 4083.6 3500.6 4075.8 4076.2 4078.5 4101.1 3682.2 3756.0 4049.8 4116.8 4146.9 3330.8 3486.6 4031.6 4050.6 4152.0 3361.7 3453.3 3486.9 3705.8 3752.1 3913.9 4052.9 4656.0 4711.3 4749.3 3812.2 4630.7 4741.4 4742.1 4758.6 4829.8 5098.4 5134.4 5137.4 5171.5 4191.7 4199.9 4213.7 4241.5 4278.0 4190.5 4473.3 4600.0 5359.4 5590.7 3621.4 3714.1 4087.4 4225.5 4276.5 3622.1 3919.5 4178.4 4363.4 4437.3 4483.9 4673.4 4678.3 4741.2 4798.5 4795.8 5183.3 5242.4 5265.9 5278.9 1281.4 1496.0 1497.0 1499.9 1501.1 1054.9 1106.9 1115.0 1127.9 1130.8 4174.9 4188.7 4316.5 4752.2 4904.0 4708.1 4988.5 5430.6 5454.8 5456.6 4284.4 4304.7 4461.2 4548.4 4668.7 2470.5 2766.5 2773.2 2808.4 2827.2 4796.3 4959.4 5605.3 5635.1 5674.5 4580.3 5336.3 5524.4 5578.4 5579.5 4931.8 5120.0 5466.0 5470.6 5503.6 4530.5 4634.9 5152.6 5295.7 5296.3 4327.9 4834.7 5418.9 5448.8 5448.9 4426.7 5426.9 5606.9 5682.8 5683.5 3730.4 3874.3 4074.5 4258.0 4294.1 5221.3 5301.4 5354.8 5427.0 5466.9 4648.9 4692.0 5250.7 5303.2 5311.1 4174.5 4761.6 5283.4 5313.8 5328.7 4598.4 4922.9 5182.3 5194.0 5222.7 4883.9 5257.7 5312.4 5317.3 5320.0 4551.6 4606.9 4756.0 4936.0 5208.6 04:52:15 INFO - PROCESS | 1648 | 04:52:15 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:19879.81 Median:3672.81 stddev:28449.92 (774.6%) stddev-sans-first:28493.37 04:52:15 INFO - PROCESS | 1648 | Values: 722.3 755.5 778.9 801.8 818.8 15473.7 16257.6 16286.9 16291.0 16301.6 13240.5 13923.5 14305.5 14857.3 15207.5 924.0 930.2 933.5 939.5 942.6 924.2 927.4 927.7 928.3 928.5 961.0 984.9 985.6 1002.2 1004.7 980.3 982.5 983.1 983.2 983.6 721.1 721.5 721.9 722.6 722.9 15707.5 16082.4 16103.8 16120.8 16235.8 13703.8 14139.9 14160.2 14204.6 14207.9 11706.3 11726.7 11752.2 11811.8 11993.0 3167.4 3653.2 3663.6 3682.0 3777.7 111454.0 112942.0 113884.0 115155.4 117953.0 10639.8 10653.4 10734.5 11140.7 11219.3 22156.7 22533.4 22538.4 22555.7 22588.7 7276.4 7397.7 7411.4 7495.4 7513.2 4178.1 4182.7 4235.7 4268.6 4419.1 3345.7 3403.8 3411.1 3425.7 3450.3 600.6 604.6 609.1 616.3 617.4 641.7 645.2 673.8 684.8 713.2 8396.4 8503.4 10008.6 10171.3 10274.0 510.2 546.2 569.9 577.8 579.6 4725.3 4870.7 4917.2 4925.7 4932.9 94750.1 96291.0 97584.0 99176.0 102967.0 48507.8 57724.7 66513.7 77084.6 91307.5 75637.0 75731.1 76338.5 76897.0 77821.0 9096.9 10340.8 10901.0 11043.4 11055.3 32608.0 49093.8 50321.2 50738.5 51309.2 62755.1 62923.0 67453.7 68250.3 68324.0 12337.1 12705.1 12825.3 12840.4 12851.7 14519.3 14617.1 14776.6 14843.0 14976.3 13574.9 13920.8 13958.7 14149.9 14400.0 12510.7 12805.5 12969.6 13267.2 13331.0 13422.7 13506.4 13698.4 13865.0 14444.5 10923.2 10968.1 11178.9 11298.8 11542.9 8820.9 9172.1 9489.5 11003.3 11435.3 04:52:15 INFO - PROCESS | 1648 | -------- Summary: end -------- 04:52:15 INFO - PROCESS | 1648 | 04:52:16 INFO - TEST-INFO | 1648: exit 0 04:52:16 INFO - TEST-OK | dromaeo_css | took 1122097ms 04:52:16 INFO - TEST-START | kraken 04:52:16 INFO - operating with platform_type : mac_ 04:52:16 INFO - Initialising browser for kraken test... 04:52:16 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmp3l1hci/profile http://localhost:49250/getInfo.html) 04:52:19 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 04:52:19 INFO - PROCESS | 1654 | colorDepth:24 04:52:19 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 04:52:19 INFO - PROCESS | 1654 | __metrics 04:52:19 INFO - PROCESS | 1654 | 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" 04:52:19 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:20 INFO - TEST-INFO | 1654: exit 0 04:52:20 INFO - Browser initialized. 04:52:20 INFO - Running cycle 1/1 for kraken test... 04:52:20 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmp3l1hci/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:32 INFO - PROCESS | 1656 | RSS: Main: 233160704 04:52:32 INFO - PROCESS | 1656 | 04:52:35 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:36 INFO - PROCESS | 1656 | RSS: Main: 284073984 04:52:36 INFO - PROCESS | 1656 | 04:52:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 04:52:39 INFO - PROCESS | 1656 | RSS: Main: 284770304 04:52:39 INFO - PROCESS | 1656 | 04:52:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 04:52:43 INFO - PROCESS | 1656 | RSS: Main: 375857152 04:52:43 INFO - PROCESS | 1656 | 04:52:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 04:52:46 INFO - PROCESS | 1656 | RSS: Main: 277745664 04:52:46 INFO - PROCESS | 1656 | 04:52:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:49 INFO - PROCESS | 1656 | RSS: Main: 280657920 04:52:49 INFO - PROCESS | 1656 | 04:52:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:52 INFO - PROCESS | 1656 | RSS: Main: 323854336 04:52:52 INFO - PROCESS | 1656 | 04:52:56 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:56 INFO - PROCESS | 1656 | RSS: Main: 326017024 04:52:56 INFO - PROCESS | 1656 | 04:52:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 04:53:00 INFO - PROCESS | 1656 | RSS: Main: 324988928 04:53:00 INFO - PROCESS | 1656 | 04:53:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:02 INFO - PROCESS | 1656 | RSS: Main: 300806144 04:53:02 INFO - PROCESS | 1656 | 04:53:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:05 INFO - PROCESS | 1656 | RSS: Main: 304263168 04:53:05 INFO - PROCESS | 1656 | 04:53:07 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:08 INFO - PROCESS | 1656 | RSS: Main: 313114624 04:53:08 INFO - PROCESS | 1656 | 04:53:11 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:53:12 INFO - PROCESS | 1656 | RSS: Main: 324784128 04:53:12 INFO - PROCESS | 1656 | 04:53:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:53:15 INFO - PROCESS | 1656 | RSS: Main: 318873600 04:53:15 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 04:53:17 INFO - PROCESS | 1656 | RSS: Main: 363556864 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | __start_tp_report 04:53:17 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 04:53:17 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 04:53:17 INFO - PROCESS | 1656 | |i|pagename|runs| 04:53:17 INFO - PROCESS | 1656 | |0;ai-astar;115;117;115;115;116;119;119;159;115;115 04:53:17 INFO - PROCESS | 1656 | |1;audio-beat-detection;137;135;106;143;111;110;108;106;129;108 04:53:17 INFO - PROCESS | 1656 | |2;audio-dft;187;186;185;182;182;184;184;183;186;185 04:53:17 INFO - PROCESS | 1656 | |3;audio-fft;83;63;61;90;62;61;63;61;76;66 04:53:17 INFO - PROCESS | 1656 | |4;audio-oscillator;90;70;89;95;99;57;92;59;65;77 04:53:17 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;89;89;87;86;89;88;88;88;89;87 04:53:17 INFO - PROCESS | 1656 | |6;imaging-darkroom;107;128;147;95;96;95;96;96;96;106 04:53:17 INFO - PROCESS | 1656 | |7;imaging-desaturate;86;87;127;83;84;83;83;87;84;82 04:53:17 INFO - PROCESS | 1656 | |8;json-parse-financial;63;61;60;61;65;64;61;61;64;63 04:53:17 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;64;54;61;64;62;57;57;58;58;58 04:53:17 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;89;88;89;85;88;90;86;91;87;91 04:53:17 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;142;142;141;148;138;134;156;144;200;142 04:53:17 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;172;172;176;174;172;173;171;173;172;171 04:53:17 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;68;67;66;66;66;66;67;65;66 04:53:17 INFO - PROCESS | 1656 | __end_tp_report 04:53:17 INFO - PROCESS | 1656 | __start_cc_report 04:53:17 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2286 04:53:17 INFO - PROCESS | 1656 | __end_cc_report 04:53:17 INFO - PROCESS | 1656 | __startTimestamp1488891197633__endTimestamp 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | ------- Summary: start ------- 04:53:17 INFO - PROCESS | 1656 | Number of tests: 14 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:120.50 Median:116.50 stddev:13.62 (11.7%) stddev-sans-first:14.30 04:53:17 INFO - PROCESS | 1656 | Values: 115.0 117.0 115.0 115.0 116.0 119.0 119.0 159.0 115.0 115.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:119.30 Median:120.00 stddev:14.83 (12.4%) stddev-sans-first:14.28 04:53:17 INFO - PROCESS | 1656 | Values: 137.0 135.0 106.0 143.0 111.0 110.0 108.0 106.0 129.0 108.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.71 (0.9%) stddev-sans-first:1.54 04:53:17 INFO - PROCESS | 1656 | Values: 187.0 186.0 185.0 182.0 182.0 184.0 184.0 183.0 186.0 185.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:68.60 Median:64.50 stddev:10.57 (16.4%) stddev-sans-first:9.85 04:53:17 INFO - PROCESS | 1656 | Values: 83.0 63.0 61.0 90.0 62.0 61.0 63.0 61.0 76.0 66.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:89.50 stddev:15.67 (17.5%) stddev-sans-first:16.14 04:53:17 INFO - PROCESS | 1656 | Values: 90.0 70.0 89.0 95.0 99.0 57.0 92.0 59.0 65.0 77.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.50 stddev:1.05 (1.2%) stddev-sans-first:1.05 04:53:17 INFO - PROCESS | 1656 | Values: 89.0 89.0 87.0 86.0 89.0 88.0 88.0 88.0 89.0 87.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:106.20 Median:95.50 stddev:17.66 (18.5%) stddev-sans-first:18.73 04:53:17 INFO - PROCESS | 1656 | Values: 107.0 128.0 147.0 95.0 96.0 95.0 96.0 96.0 96.0 106.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:88.60 Median:84.00 stddev:13.61 (16.2%) stddev-sans-first:14.40 04:53:17 INFO - PROCESS | 1656 | Values: 86.0 87.0 127.0 83.0 84.0 83.0 83.0 87.0 84.0 82.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.79 04:53:17 INFO - PROCESS | 1656 | Values: 63.0 61.0 60.0 61.0 65.0 64.0 61.0 61.0 64.0 63.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:3.30 (5.5%) stddev-sans-first:3.03 04:53:17 INFO - PROCESS | 1656 | Values: 64.0 54.0 61.0 64.0 62.0 57.0 57.0 58.0 58.0 58.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:89.00 stddev:2.01 (2.3%) stddev-sans-first:2.12 04:53:17 INFO - PROCESS | 1656 | Values: 89.0 88.0 89.0 85.0 88.0 90.0 86.0 91.0 87.0 91.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:143.00 stddev:18.95 (13.3%) stddev-sans-first:19.94 04:53:17 INFO - PROCESS | 1656 | Values: 142.0 142.0 141.0 148.0 138.0 134.0 156.0 144.0 200.0 142.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:172.50 stddev:1.51 (0.9%) stddev-sans-first:1.58 04:53:17 INFO - PROCESS | 1656 | Values: 172.0 172.0 176.0 174.0 172.0 173.0 171.0 173.0 172.0 171.0 04:53:17 INFO - PROCESS | 1656 | 04:53:17 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 04:53:17 INFO - PROCESS | 1656 | Values: 67.0 68.0 67.0 66.0 66.0 66.0 66.0 67.0 65.0 66.0 04:53:17 INFO - PROCESS | 1656 | -------- Summary: end -------- 04:53:17 INFO - PROCESS | 1656 | 04:53:18 INFO - TEST-INFO | 1656: exit 0 04:53:18 INFO - TEST-OK | kraken | took 61984ms 04:53:18 INFO - SUITE-END | took 1184s 04:53:18 INFO - Completed test suite (00:19:44) 04:53:18 INFO - javascript benchmark 04:53:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7314.304244491143, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.206591451009, 3384.187794929216, 3388.847501862416, 3420.7092397146243, 3432.8455219515117, 5090.592752579794, 5297.622618119288, 5810.593258471903, 5906.26171728534, 5976.282846058479, 5737.540996720263, 5791.971040144794, 5855.853603659911, 5870.501007414364, 5886.117082437626, 5122.154844450662, 5198.168293073109, 5222.608304377178, 5247.2653828464045, 5249.475052494739, 5306.124489459235, 5337.386200586924, 5343.893122137555, 5368.892622147555, 5401.540869026137, 5130.3074084998425, 5190.480951904817, 5207.531322180984, 5222.32109825724, 5310.230016647603, 5252.553532949704, 5256.448072952323, 5259.0796610593, 5294.629375943686, 5336.626436149471, 5193.714765503204, 5233.764480598382, 5245.737713114368, 5280.10238259493, 5291.312129423189, 5581.748821303051, 5631.8592035199035, 5794.68129252891, 5794.884102317972, 5830.096335068071, 6180.289266734293, 6187.381261873777, 6190.5976111553055, 6192.040233763774, 6195.31851496335, 6123.343628574293, 6274.901892168898, 6279.277883043463, 6283.465905398047, 6310.842228944267, 5716.0, 5790.7973220937065, 5792.797252096157, 5799.536037117021, 5800.53595712342, 6271.592346497463, 6322.336154703782, 6332.33510481402, 6344.936550634435, 6359.872802543923, 6012.669303188279, 6034.607750496291, 6060.454559089615, 6295.559310848196, 6308.495320374359, 6205.875882482325, 6206.06908963659, 6224.906626400608, 6225.533085018551, 6281.528885333527, 6331.715072821734, 6341.8097457076365, 6346.30190679025, 6347.0, 6367.044943258548, 6119.258838874149, 6156.538259630456, 6163.7842675506145, 6355.682215889187, 6366.076918846741, 4985.55130038291, 4995.325631039836, 5033.572146367526, 5040.47075057121, 5070.087384270867, 4487.259602165672, 4488.5287044859815, 4491.775411229425, 4493.213687604722, 4511.5262897395305, 4941.876453088629, 5662.320521537442, 5899.262592175978, 5917.763289468459, 5953.047512397996, 6221.0, 6254.437100660963, 6256.311805701369, 6264.2796078451565, 6271.498280137578, 5703.657780533182, 5705.2012718219485, 5735.799247026417, 5747.597668163188, 5756.971215143982, 5430.5927055471, 5433.565314774887, 5435.864103397446, 5435.891282174413, 5442.91835622466, 6241.781537646251, 6256.562040657202, 6257.843553911189, 6259.593126446766, 6265.091561723524, 6248.312685604671, 6277.686115694289, 6312.873742525216, 6314.179156709598, 6327.683615819098, 6461.289258181502, 6465.418112369909, 6470.48236141117, 6479.449246814073, 6483.870322593616, 6346.3019067903415, 6347.492200624031, 6353.4599559038, 6358.237011558643, 6365.777197798055, 5636.746346414503, 5886.352501224947, 6114.327782088646, 6259.749610015549, 6306.653134077486, 5989.2812862456785, 6198.969005154945, 6246.312905580474, 6265.342139075331, 6276.592021518587, 6063.969680151571, 6074.757009719562, 6074.936886045013, 6078.996965500643, 6085.1785009023215, 4957.529034741694, 5917.201177841109, 5937.732802023833, 5952.8809423812145, 5953.940460595339, 5958.910616340845, 6082.7262773174425, 6091.573589848846, 6096.725647345791, 6105.877882442415, 5816.302043754777, 5897.026990546512, 5901.232839730807, 5904.114382842608, 5922.141289512911], "value": 5728.6978128100545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.1508710244525, 778.0507780507778, 835.6573804740058, 849.770561948274, 920.1810388754014, 34960.97948735896, 35104.99999999997, 35516.46725299123, 36514.8174259129, 36576.0, 35327.2934541309, 35459.1135221619, 35466.64533354672, 35524.822375888085, 35528.0, 6480.416762491386, 7694.230576942317, 7718.151003389623, 7725.884111738328, 7747.496412733182, 7540.019797426355, 7640.044994375703, 7650.770476885702, 7654.732084377048, 7678.731244406447, 7589.089309282894, 7590.1650818409935, 7599.088109426849, 7608.657610407545, 7613.619319034054, 7562.886556701654, 7584.089909210875, 7585.469017168801, 7587.355074818647, 7595.164531901486, 6565.704543295563, 6598.340165983412, 6609.768658096944, 6611.371919667672, 6623.337666233387, 32913.84801531935, 33086.33827323464, 33154.17114572131, 33159.0, 33220.335593288, 3436.6735160159747, 3469.496922946184, 3473.3053389322235, 3505.894823155284, 3619.49327094207, 24305.0, 24710.752892471024, 25029.0, 25093.87077581495, 25421.745782542308, 2274.465500607356, 2715.416185520123, 2783.4850552647827, 2788.5817127431046, 2870.1963450233966, 328870.0, 330967.0, 332307.0, 332730.0, 335306.0, 16520.4217852377, 16634.916825415796, 34949.65050349515, 35537.46693799595, 36826.0, 48414.22200891878, 49559.0, 49605.25592116049, 49617.25574116391, 51902.0, 13275.601731948056, 13355.131916425402, 13464.192148471124, 13475.517693053756, 13498.055136140572, 10060.597576096874, 11497.022753066083, 11558.190926635223, 11583.536658533565, 11589.01493373056, 10521.210909181842, 10538.841917371246, 10543.683689489328, 10553.31403458788, 10563.366198028143, 5271.20931860224, 5422.40353561108, 5476.67139971603, 5495.203195536625, 5525.4474552544425, 938.901415351392, 972.9173020293355, 1120.2102517724984, 1128.3568366031448, 1167.3462860797981, 23594.764052359256, 25614.0, 25643.615345769827, 25645.74354256471, 25654.48691026169, 1003.9046290602381, 1056.8309070548676, 1194.814803705427, 1246.6634008817568, 1255.8806913343217, 11073.280236784583, 11685.649430517098, 12787.680307992188, 12822.294773787531, 13541.458341666223, 407148.0, 409503.0, 409727.0, 409778.0, 409813.0, 44796.0, 44804.327935081, 44866.0, 44954.55045449569, 45063.54936450593, 1339.7320535892666, 1366.296357375952, 1370.0888908875884, 1378.5450801235568, 1384.4531410092957, 18931.71602425937, 24033.317667763087, 25605.103821366163, 25609.487810243318, 25637.23088307354, 40803.775886723444, 41684.87363447814, 43224.13551729011, 43241.567584323755, 43246.78376608097, 412968.0, 414838.0, 414843.0, 415161.0, 415255.0, 27558.86220568884, 27584.172474825788, 27698.0, 27729.722702772713, 27752.583711243944, 34967.70536553277, 35116.0, 35580.11049723778, 36065.81967090148, 36189.457158143174, 29726.0, 29989.70010299869, 30496.797836227764, 30770.0, 30923.536146957365, 26553.0, 26808.06171783978, 27319.453610927274, 29724.47696353039, 30222.54666180053, 30165.245868853453, 30420.239494012825, 30506.542401864433, 30550.236244094074, 30628.08115756531, 21135.471613209793, 24799.380015499755, 26903.327416814736, 27678.584821227294, 27956.720432796224, 17963.820361796214, 20132.597348052663, 21896.233631822808, 22049.448763781034, 22049.684783097542], "value": 16258.818329184263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.60374286413514, 375.3768743885151, 397.2591117565741, 399.88003598920324, 420.627744446165, 12878.562208320916, 14938.402463901444, 20513.282035128774, 21725.565488690216, 22047.889760551214, 21924.23265185715, 22453.101875924986, 22919.770802291972, 22977.77022229777, 23333.533329333404, 6347.333529979355, 6553.672316384173, 6653.401193892549, 6701.664916754167, 6708.429783468411, 6525.608463492182, 6581.3747693969, 6637.767678131267, 6640.435562977153, 6656.833579160511, 6364.968175159118, 6558.967205163967, 6639.070530125786, 6649.700763465656, 6651.567648102882, 6513.283538810727, 6574.408303252706, 6637.3030831762935, 6646.501512386542, 6663.63350015749, 6346.365363463663, 6425.389587989133, 6431.74273029083, 6442.774502892376, 6473.28793832678, 26439.867800661064, 26742.5988610171, 26760.464790704078, 26869.73130268692, 26950.595741063702, 2905.6513218413716, 2918.9854050729823, 2934.8092373995837, 2934.9413011739643, 3061.8315992620396, 15675.921620391826, 15763.97534160276, 16536.66926661472, 16601.169941502998, 16605.931546770997, 1987.2349145578912, 2022.9739301865975, 2046.5190680190144, 2049.2008116834445, 2094.6229678657837, 96586.0, 117775.0, 121840.0, 122354.16468752976, 124397.9999999991, 14566.927165364317, 19736.309229177197, 20377.89811050935, 20656.483587910123, 20843.478913027295, 28588.42823143567, 28619.14142575726, 30261.848690756404, 31672.891448799182, 33017.0, 9768.51157442125, 10269.0, 10324.587016519255, 10413.739656508647, 10496.370217786956, 8340.499570025819, 8344.874826877602, 8353.872227249365, 8550.700725474579, 8575.656973720981, 8404.621792019374, 9978.750531236778, 10010.799784004279, 10199.898001020043, 10205.795884082278, 3738.6448287412654, 3905.4922860028582, 4050.6354428101613, 4169.666426685919, 4172.93139189288, 750.2684882239772, 805.5408417202256, 836.66951554137, 908.1554154636119, 1079.3631757263095, 20406.897965510077, 21049.15803367879, 21164.0, 21172.15311387558, 21206.46983825417, 896.1441823058963, 898.8427025270682, 901.2069378946485, 921.433318509112, 924.1451657217048, 8674.612062070039, 8765.91234087651, 9778.16885564735, 9969.35199212049, 11025.44872756359, 683068.0, 700247.0, 702316.0, 713590.0, 749448.0, 156633.0, 157424.0, 159071.0, 159537.0, 160008.0, 1222.798238290672, 1264.3488603369271, 1294.2752058847075, 1298.1107941060404, 1298.79868620364, 17651.82348176502, 18108.818911810715, 18274.269029238683, 18529.058495766454, 18580.907095464438, 43293.78353108215, 59805.40194597998, 63145.84270786534, 64272.357276426636, 65855.0, 86189.1381086181, 86931.69602455842, 88284.5585772067, 88374.0, 89847.0, 7585.317321441097, 10199.490025498844, 10944.781104378028, 11651.017682355412, 11706.88293117092, 13008.869911300766, 13099.869001309866, 13476.258805765778, 13492.59522214335, 13519.324033798073, 11353.37556434404, 11395.031422329195, 11517.0, 11706.063514918957, 11715.824262635897, 11049.17131215146, 11108.111351092055, 11232.0, 11446.94276528612, 11708.121890858049, 11200.551977920792, 11228.168004301897, 11518.36648984314, 11621.825672614748, 11673.007794337576, 11181.944090279496, 11388.715282118013, 11529.365884876412, 11591.420428978687, 11667.708307292385, 10874.347539147677, 11147.331160130418, 11329.943350283196, 11366.374849383363, 11418.486168122621], "value": 11255.808098631796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.8316593591737, 1510.6374470127173, 1528.5261568913638, 1556.8520990505897, 1558.018448377522, 10207.948960255198, 10755.677329680102, 10777.0, 10778.784424311509, 10787.352758834475, 10251.743706407344, 10631.893681063188, 10688.091512221452, 10698.5185666645, 10703.46482675865, 2318.976810231897, 2361.657559653858, 2364.9763502365013, 2373.5727569037567, 2388.653645221442, 2292.747797742247, 2329.662198981155, 2329.7087864017, 2330.743618202005, 2337.0, 2303.1823702585593, 2327.4763178284834, 2330.941726456835, 2332.6734257204007, 2333.9183128590503, 2272.4318920269934, 2291.6677081823127, 2300.9884950575306, 2303.1133013789645, 2303.6199027160496, 2253.6732173834703, 2324.7094113235844, 2325.1280769711357, 2326.627739561662, 2361.657559653858, 10689.679309620724, 10757.408342541157, 10758.677239682822, 10766.676999690022, 10799.460026998619, 5563.582731295129, 5764.365919748824, 5774.191613174159, 5778.797742079007, 5782.710864456761, 3092.58250136231, 3265.053134590966, 3374.0552645259368, 3376.6960973512255, 3376.96623033769, 1124.1231839165464, 1142.5030111901349, 1164.225789849749, 1184.9466773995105, 1192.8568571771443, 13135.146215495963, 13564.118332308468, 13841.30793460333, 14592.781108283385, 14643.267836608127, 3910.276598829226, 4100.0569868929715, 4185.183889141588, 4298.3552467130185, 4301.2257793597455, 10441.582336706599, 11283.984441400313, 11373.943130284295, 11418.0, 11422.543098275975, 5427.810026649048, 5485.807996720096, 5490.670559766427, 5500.0, 5504.724763761876, 4851.927221091686, 5065.822696205689, 5192.532672059533, 5202.1416466282635, 5228.816991405282, 3620.2759448110482, 3744.794036328028, 3792.3363411402893, 3827.8086095695103, 3868.497095377583, 1016.1667432705111, 1024.416082832793, 1030.5053574284386, 1030.6135199300263, 1033.5710680067687, 874.3748220022715, 930.6417029443578, 931.4411353188168, 952.1525842000625, 973.732223638505, 6371.0, 6421.74313027483, 6529.347065293433, 6603.70283337251, 6642.83392915181, 972.3242346569067, 988.6984469736799, 1008.3193844155165, 1009.9242556808268, 1018.8981101889751, 3720.981395093007, 3741.663250307431, 3791.639794219545, 3816.5992570779667, 3869.28418242626, 12546.498140074478, 12964.611061668165, 12984.026198035184, 13043.673908152372, 13055.216686998621, 12850.29323387204, 12997.870021299856, 13018.28399438021, 13020.609381718563, 13131.409086591126, 9431.76420589477, 9651.90348096524, 9712.417254964725, 9851.901480985098, 9889.950550247202, 6247.187865577446, 6342.334054924167, 6368.745250189941, 6415.037744338387, 6488.740450381932, 11706.297622142698, 11844.940775296069, 12046.04871806378, 12083.0, 12086.879131208576, 10748.946255268673, 10762.3542587445, 11137.721556961142, 12030.63908082759, 12195.939020305197, 7664.233576642291, 7816.218378162365, 7918.406119541172, 7924.4056695749205, 7925.524468531907, 9487.762805929908, 9534.666286679932, 9681.564329605044, 9694.854577181206, 9747.220222382335, 8503.829923401621, 8558.657653693783, 8562.614682339434, 8688.087750786077, 8689.522076285612, 8331.50010999342, 8365.916340836757, 8379.0, 8402.453840500348, 8600.13998600135, 7484.139323977594, 7605.923940760522, 7619.276168763959, 7622.771316860281, 7630.084389873251, 4991.800327986985, 5520.585956053232, 5615.634983726045, 5709.25779648643, 5824.737886795189, 4521.525239849769, 5666.744996475086, 5745.052066408995, 5829.504492118048, 5968.6717230551], "value": 4918.8449317827735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.7700755557104, 363.6854121185175, 364.67361711268416, 370.1449651305486, 374.3430279858848, 4518.876128219736, 4849.733264670442, 4870.586000189984, 4902.578252306836, 4919.360483137196, 4581.663351690637, 4719.433667959841, 4779.876728968698, 4784.5693887550115, 4786.760661966897, 3491.912702182453, 4023.637872591466, 4069.572694867041, 4074.1647962167685, 4083.5712250213746, 3500.597431295408, 4075.755454672714, 4076.2255171517318, 4078.5309689385654, 4101.118259574191, 3682.2083252100792, 3756.0422092366407, 4049.7570145791346, 4116.835326586933, 4146.859613606252, 3330.833458327074, 3486.581610206766, 4031.5766844481495, 4050.5544390117066, 4151.97924010381, 3361.6974472297366, 3453.326601312745, 3486.9128271793156, 3705.814709264553, 3752.1182522107283, 3913.902152446183, 4052.872242072906, 4655.952410707598, 4711.293306004092, 4749.311349854286, 3812.2375524895133, 4630.699004564693, 4741.407324084489, 4742.146413645542, 4758.619310455155, 4829.806807727687, 5098.431098231216, 5134.4095429025765, 5137.409197942247, 5171.534561889411, 4191.706580539363, 4199.91600167998, 4213.726107802983, 4241.49102107746, 4277.957220427787, 4190.533313340306, 4473.329000649896, 4600.010997635524, 5359.356877174686, 5590.748416321276, 3621.366260904384, 3714.1271801126713, 4087.3868919661695, 4225.492940847118, 4276.465441819772, 3622.112582417272, 3919.5296564411883, 4178.435911152016, 4363.38912552243, 4437.2932511168165, 4483.856616562755, 4673.3690951721765, 4678.2982552616695, 4741.193997020515, 4798.49615790337, 4795.784189711471, 5183.2743415921805, 5242.423333433319, 5265.893123057414, 5278.868028299246, 1281.3726567259528, 1496.0, 1496.9925150374397, 1499.8750936797403, 1501.06183635228, 1054.852320675106, 1106.9335839849634, 1114.9609763658395, 1127.9453710780447, 1130.773111174385, 4174.937375939363, 4188.685848561309, 4316.525182229952, 4752.239641657318, 4903.978737435269, 4708.105459962596, 4988.501149884983, 5430.588047107702, 5454.836354909359, 5456.590755693339, 4284.400183974246, 4304.720193187432, 4461.152381047656, 4548.384678809698, 4668.743219122981, 2470.542949554302, 2766.543520319165, 2773.1974216758863, 2808.382155925693, 2827.172827172827, 4796.273341597022, 4959.380077490314, 5605.299337582802, 5635.070213414822, 5674.4892959633835, 4580.335851301543, 5336.306280183629, 5524.364698059774, 5578.41426650204, 5579.536370903261, 4931.827386041471, 5119.950410165907, 5465.9726701366235, 5470.617056805985, 5503.559715222773, 4530.546945305443, 4634.884127896829, 5152.5620322271525, 5295.74311798249, 5296.298887567292, 4327.913441731211, 4834.709917404967, 5418.8645283866645, 5448.83653490396, 5448.866901531715, 4426.667999899956, 5426.887488065016, 5606.943930560806, 5682.801101961577, 5683.476244728295, 3730.403135498307, 3874.2638898609175, 4074.4703188585295, 4258.041940563472, 4294.1411717655965, 5221.295125158055, 5301.443348448512, 5354.7590358434745, 5427.042261967316, 5466.945330546644, 4648.883777905579, 4692.0, 5250.737463126905, 5303.231031500488, 5311.123664595299, 4174.497181014772, 4761.595329377911, 5283.418823929288, 5313.814016509404, 5328.6802791832615, 4598.4478614369345, 4922.93236840535, 5182.274481572507, 5194.0, 5222.686638801684, 4883.877903052452, 5257.684538927677, 5312.389075256395, 5317.282166907573, 5319.973400133129, 4551.613112885309, 4606.894345357023, 4755.97870904871, 4935.975320123376, 5208.583313335], "value": 3969.391229699967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.2741145149124, 755.4787196834184, 778.9182135875733, 801.7795106345754, 818.8159347323502, 15473.690526189483, 16257.593560160973, 16286.918565407157, 16291.0, 16301.592460188502, 13240.543540210594, 13923.512677056306, 14305.499307524238, 14857.331420086095, 15207.46773862915, 923.9676611318605, 930.186087173723, 933.4725879877848, 939.5302348825587, 942.5852624845046, 924.2421214604027, 927.378656300277, 927.7263207353847, 928.336239588694, 928.4522131942186, 960.9909594925335, 984.8768903887014, 985.5909797434092, 1002.2282842211492, 1004.743790333464, 980.2745967983712, 982.5234761140877, 983.061176576375, 983.1593987141034, 983.572146116438, 721.0986267166043, 721.5382155420535, 721.9494635375526, 722.5736815278958, 722.8951801988735, 15707.528774136794, 16082.381464170585, 16103.758443623356, 16120.75818862718, 16235.83764162367, 13703.794443083361, 14139.858601413956, 14160.15039097647, 14204.573862784133, 14207.857921420757, 11706.297622142698, 11726.687879779089, 11752.177347585672, 11811.822822657667, 11993.0, 3167.4298626247264, 3653.209927135711, 3663.6336366363416, 3681.9815900920594, 3777.6788972937334, 111454.0, 112942.0, 113884.0, 115155.42422287836, 117953.0, 10639.787204255872, 10653.387206591995, 10734.516946737416, 11140.721481962853, 11219.270747401393, 22156.667649985262, 22533.43666408353, 22538.436539086655, 22555.661665075037, 22588.66117008246, 7276.391688095102, 7397.704091836266, 7411.436527223923, 7495.437842161859, 7513.248675132443, 4178.101708132766, 4182.749035057906, 4235.70821339617, 4268.615824575803, 4419.138268037702, 3345.7323414126813, 3403.7787543809573, 3411.1131105912145, 3425.72594192464, 3450.258194488197, 600.5615900392738, 604.625132417895, 609.0863704443335, 616.3435940723116, 617.4227097663698, 641.666333506574, 645.20639613275, 673.8079647300495, 684.8253695307765, 713.2475238623199, 8396.412251142483, 8503.362247831437, 10008.599656013677, 10171.338862973884, 10274.0, 510.19898758948835, 546.2025442853399, 569.8831739493394, 577.8150991682621, 579.5769088565371, 4725.330188443519, 4870.732109733928, 4917.224725534659, 4925.704457732476, 4932.901341973212, 94750.0524994755, 96291.0, 97584.0, 99176.0, 102967.0, 48507.757461212466, 57724.71137644285, 66513.66743166253, 77084.61457692788, 91307.54346228359, 75637.0, 75731.07747996363, 76338.53709175033, 76897.0, 77821.0, 9096.856350970009, 10340.793184136426, 10901.0, 11043.39261340634, 11055.336679799238, 32608.0, 49093.754531228544, 50321.245181323044, 50738.49261507337, 51309.23036154536, 62755.05867412084, 62923.0, 67453.66273168799, 68250.31749682638, 68324.0, 12337.136400451882, 12705.0589941828, 12825.294608796607, 12840.357982101044, 12851.678708032, 14519.34662940149, 14617.122972621677, 14776.63058423548, 14843.03520271179, 14976.251187440803, 13574.932125339705, 13920.791188132389, 13958.720825583634, 14149.885367765914, 14400.0, 12510.749785004431, 12805.487780488676, 12969.610911672666, 13267.203967761965, 13331.0, 13422.664433389244, 13506.39221235027, 13698.38357273905, 13865.0, 14444.494442694455, 10923.22932144626, 10968.067714244378, 11178.944105279421, 11298.830517542408, 11542.884571154516, 8820.867686984571, 9172.081157571554, 9489.525523723649, 11003.33979961205, 11435.256708313933], "value": 7479.781548749331, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 115.0, 115.0, 116.0, 119.0, 119.0, 159.0, 115.0, 115.0], "value": 120.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 106.0, 143.0, 111.0, 110.0, 108.0, 106.0, 129.0, 108.0], "value": 119.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 185.0, 182.0, 182.0, 184.0, 184.0, 183.0, 186.0, 185.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 63.0, 61.0, 90.0, 62.0, 61.0, 63.0, 61.0, 76.0, 66.0], "value": 68.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 89.0, 95.0, 99.0, 57.0, 92.0, 59.0, 65.0, 77.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 87.0, 86.0, 89.0, 88.0, 88.0, 88.0, 89.0, 87.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 128.0, 147.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 106.0], "value": 106.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 127.0, 83.0, 84.0, 83.0, 83.0, 87.0, 84.0, 82.0], "value": 88.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 60.0, 61.0, 65.0, 64.0, 61.0, 61.0, 64.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 54.0, 61.0, 64.0, 62.0, 57.0, 57.0, 58.0, 58.0, 58.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 85.0, 88.0, 90.0, 86.0, 91.0, 87.0, 91.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 141.0, 148.0, 138.0, 134.0, 156.0, 144.0, 200.0, 142.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 176.0, 174.0, 172.0, 173.0, 171.0, 173.0, 172.0, 171.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0], "value": 66.4, "unit": "score"}]}]} 04:53:18 INFO - Return code: 0 04:53:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:53:18 ERROR - # TBPL SUCCESS # 04:53:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:18 INFO - 2017-03-07 04:53:18.976 screenresolution[1660:11165] starting screenresolution argv=screenresolution get 04:53:18 INFO - 2017-03-07 04:53:18.978 screenresolution[1660:11165] Display 0: 1600x1200x32@60 04:53:18 INFO - 2017-03-07 04:53:18.985 screenresolution[1661:11169] starting screenresolution argv=screenresolution list 04:53:18 INFO - Available Modes on Display 0 04:53:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:19 INFO - Intel Iris: 04:53:19 INFO - Chipset Model: Intel Iris 04:53:19 INFO - Type: GPU 04:53:19 INFO - Bus: Built-In 04:53:19 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:19 INFO - Vendor: Intel (0x8086) 04:53:19 INFO - Device ID: 0x0a2e 04:53:19 INFO - Revision ID: 0x0009 04:53:19 INFO - Displays: 04:53:19 INFO - Display: 04:53:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:19 INFO - Display Serial Number: 1600x1200 60 04:53:19 INFO - Main Display: Yes 04:53:19 INFO - Mirror: Off 04:53:19 INFO - Online: Yes 04:53:19 INFO - Rotation: Supported 04:53:19 INFO - Return code: 0 04:53:19 INFO - Running post-action listener: _resource_record_post_action 04:53:19 INFO - [mozharness: 2017-03-07 12:53:19.220035Z] Finished run-tests step (success) 04:53:19 INFO - Running post-run listener: _resource_record_post_run 04:53:19 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 32656384; Write bytes: 513840640; Read time: 195; Write time: 1626 04:53:19 INFO - TinderboxPrint: CPU usage
54.0% 04:53:19 INFO - TinderboxPrint: I/O read bytes / time
32,656,384 / 195 04:53:19 INFO - TinderboxPrint: I/O write bytes / time
513,840,640 / 1,626 04:53:19 INFO - TinderboxPrint: CPU idle
2,217.4 (46.0%) 04:53:19 INFO - TinderboxPrint: CPU system
964.5 (20.0%) 04:53:19 INFO - TinderboxPrint: CPU user
1,639.8 (34.0%) 04:53:19 INFO - TinderboxPrint: Swap in / out
238,862,336 / 0 04:53:19 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203483648; Write bytes: 201048064; Read time: 15620; Write time: 432 04:53:19 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 30862336; Write bytes: 301991424; Read time: 180; Write time: 1157 04:53:19 INFO - Running post-run listener: _upload_blobber_files 04:53:19 INFO - Blob upload gear active. 04:53:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:53:19 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 04:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:53:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:53:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:53:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:53:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:21 INFO - (blobuploader) - INFO - Done attempting. 04:53:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:53:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:53:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:22 INFO - (blobuploader) - INFO - Done attempting. 04:53:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:53:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:53:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:23 INFO - (blobuploader) - INFO - Done attempting. 04:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:25 INFO - (blobuploader) - INFO - Done attempting. 04:53:25 INFO - (blobuploader) - INFO - Iteration through files over. 04:53:25 INFO - Return code: 0 04:53:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:53:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:53:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/027158dbe71dedf9e0df175d23f4721545ec2ad882381760cb7cbddc799599a93e9c156fcd349a84a546b275386e203dfe48b7f5f87366a9f05d3e8f2ef06386", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1ade937058521b0202464569dfd7b2a236b831654fed677cbc5a3defcc95aad1e82197a874117c1504bb37d44008afbd0aba6159043a392bb03f92cf7d1b94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e32b21a4551cfaac247f67d0952f2c27d986a48f2967611be5ce5cf0e763c535aafa2df31138c7effae480902a21716b5c9533c0f6f062fd5ce780cb0d92c885", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19162273fb5bd896325a754ff2460e99b6b8a8619a1b0235a024262584e454f63726d2bc12f743ebe97e21d2654b3f67c1af3086d7463e4afd2e0b55df47dfb0"} 04:53:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:53:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:53:25 INFO - Contents: 04:53:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/027158dbe71dedf9e0df175d23f4721545ec2ad882381760cb7cbddc799599a93e9c156fcd349a84a546b275386e203dfe48b7f5f87366a9f05d3e8f2ef06386", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1ade937058521b0202464569dfd7b2a236b831654fed677cbc5a3defcc95aad1e82197a874117c1504bb37d44008afbd0aba6159043a392bb03f92cf7d1b94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e32b21a4551cfaac247f67d0952f2c27d986a48f2967611be5ce5cf0e763c535aafa2df31138c7effae480902a21716b5c9533c0f6f062fd5ce780cb0d92c885", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19162273fb5bd896325a754ff2460e99b6b8a8619a1b0235a024262584e454f63726d2bc12f743ebe97e21d2654b3f67c1af3086d7463e4afd2e0b55df47dfb0"} 04:53:25 INFO - Running post-run listener: copy_logs_to_upload_dir 04:53:25 INFO - Copying logs to upload dir... 04:53:25 INFO - mkdir: /builds/slave/test/build/upload/logs 04:53:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1376.871936 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 56 secs) (at 2017-03-07 04:53:25.258641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-07 04:53:25.262535) ========= 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.t1j4emCvHK/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.gCNjBmmGFw/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/027158dbe71dedf9e0df175d23f4721545ec2ad882381760cb7cbddc799599a93e9c156fcd349a84a546b275386e203dfe48b7f5f87366a9f05d3e8f2ef06386", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1ade937058521b0202464569dfd7b2a236b831654fed677cbc5a3defcc95aad1e82197a874117c1504bb37d44008afbd0aba6159043a392bb03f92cf7d1b94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e32b21a4551cfaac247f67d0952f2c27d986a48f2967611be5ce5cf0e763c535aafa2df31138c7effae480902a21716b5c9533c0f6f062fd5ce780cb0d92c885", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19162273fb5bd896325a754ff2460e99b6b8a8619a1b0235a024262584e454f63726d2bc12f743ebe97e21d2654b3f67c1af3086d7463e4afd2e0b55df47dfb0"} build_url:https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/C5ve5g19S3mzxt9Rha8v6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/027158dbe71dedf9e0df175d23f4721545ec2ad882381760cb7cbddc799599a93e9c156fcd349a84a546b275386e203dfe48b7f5f87366a9f05d3e8f2ef06386", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1ade937058521b0202464569dfd7b2a236b831654fed677cbc5a3defcc95aad1e82197a874117c1504bb37d44008afbd0aba6159043a392bb03f92cf7d1b94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e32b21a4551cfaac247f67d0952f2c27d986a48f2967611be5ce5cf0e763c535aafa2df31138c7effae480902a21716b5c9533c0f6f062fd5ce780cb0d92c885", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19162273fb5bd896325a754ff2460e99b6b8a8619a1b0235a024262584e454f63726d2bc12f743ebe97e21d2654b3f67c1af3086d7463e4afd2e0b55df47dfb0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-07 04:53:25.298271) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 04:53:25.298693) ========= 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.t1j4emCvHK/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.gCNjBmmGFw/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.005168 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 04:53:25.347895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-07 04:53:25.348208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-07 04:53:25.348577) ========= ========= Total master_lag: 0.18 =========