builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0389 starttime: 1486673621.15 results: success (0) buildid: 20170209101219 builduid: 49f7e09a6a7946d1b1cd61d9a69ad6e4 revision: 25c61e4eb82ddd366b9c472c0961e1d38299d588 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:41.148987) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:41.149919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:41.150406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:41.178681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:41.179377) ========= 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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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-02-09 12:53:41-- 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% 67.9M=0s 2017-02-09 12:53:41 (67.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109335 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:41.314732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:41.315056) ========= 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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.026430 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:41.365730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-09 12:53:41.366055) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 25c61e4eb82ddd366b9c472c0961e1d38299d588 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 25c61e4eb82ddd366b9c472c0961e1d38299d588 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0CIxVyUYq2/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.ZWN08JNljQ/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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-02-09 12:53:41,475 truncating revision to first 12 chars 2017-02-09 12:53:41,475 Setting DEBUG logging. 2017-02-09 12:53:41,475 attempt 1/10 2017-02-09 12:53:41,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/25c61e4eb82d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 12:53:43,544 unpacking tar archive at: mozilla-beta-25c61e4eb82d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.346832 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-09 12:53:43.739246) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:43.739640) ========= script_repo_revision: 25c61e4eb82ddd366b9c472c0961e1d38299d588 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:43.740167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:43.740482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 12:53:43.763808) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-09 12:53:43.764845) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0CIxVyUYq2/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.ZWN08JNljQ/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:53:43 INFO - MultiFileLogger online at 20170209 12:53:43 in /builds/slave/test 12:53:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:53:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:53:43 INFO - {'append_to_log': False, 12:53:43 INFO - 'base_work_dir': '/builds/slave/test', 12:53:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:53:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:53:43 INFO - 'branch': 'Mozilla-Beta', 12:53:43 INFO - 'buildbot_json_path': 'buildprops.json', 12:53:43 INFO - 'config_files': ('talos/mac_config.py',), 12:53:43 INFO - 'default_actions': ('clobber', 12:53:43 INFO - 'read-buildbot-config', 12:53:43 INFO - 'download-and-extract', 12:53:43 INFO - 'populate-webroot', 12:53:43 INFO - 'create-virtualenv', 12:53:43 INFO - 'install', 12:53:43 INFO - 'run-tests'), 12:53:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:53:43 INFO - 'download_minidump_stackwalk': True, 12:53:43 INFO - 'download_symbols': 'ondemand', 12:53:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:53:43 INFO - 'tooltool.py': '/tools/tooltool.py', 12:53:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:53:43 INFO - '/tools/misc-python/virtualenv.py')}, 12:53:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:53:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:53:43 INFO - 'installer_path': 'installer.exe', 12:53:43 INFO - 'log_level': 'info', 12:53:43 INFO - 'log_name': 'talos', 12:53:43 INFO - 'log_to_console': True, 12:53:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:53:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:53:43 INFO - 'opt_config_files': (), 12:53:43 INFO - 'pip_index': False, 12:53:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:53:43 INFO - 'cmd': ('bash', 12:53:43 INFO - '-c', 12:53:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:53:43 INFO - 'enabled': True, 12:53:43 INFO - 'halt_on_failure': False, 12:53:43 INFO - 'name': 'check_screen_resolution'},), 12:53:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:53:43 INFO - 'cmd': ('bash', 12:53:43 INFO - '-c', 12:53:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:53:43 INFO - 'enabled': True, 12:53:43 INFO - 'halt_on_failure': False, 12:53:43 INFO - 'name': 'check_screen_resolution'},), 12:53:43 INFO - 'run_cmd_checks_enabled': True, 12:53:43 INFO - 'sps_profile': False, 12:53:43 INFO - 'sps_profile_interval': 0, 12:53:43 INFO - 'suite': 'dromaeojs', 12:53:43 INFO - 'system_bits': '32', 12:53:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:53:43 INFO - 'title': 't-yosemite-r7-0389', 12:53:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:53:43 INFO - 'use_talos_json': True, 12:53:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:53:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:53:43 INFO - 'work_dir': 'build'} 12:53:43 INFO - [mozharness: 2017-02-09 20:53:43.984693Z] Running clobber step. 12:53:43 INFO - Running pre-action listener: _resource_record_pre_action 12:53:43 INFO - Running main action method: clobber 12:53:43 INFO - rmtree: /builds/slave/test/build 12:53:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:53:46 INFO - Running post-action listener: _resource_record_post_action 12:53:46 INFO - [mozharness: 2017-02-09 20:53:46.461209Z] Finished clobber step (success) 12:53:46 INFO - [mozharness: 2017-02-09 20:53:46.461358Z] Running read-buildbot-config step. 12:53:46 INFO - Running pre-action listener: _resource_record_pre_action 12:53:46 INFO - Running main action method: read_buildbot_config 12:53:46 INFO - Using buildbot properties: 12:53:46 INFO - { 12:53:46 INFO - "project": "", 12:53:46 INFO - "product": "firefox", 12:53:46 INFO - "script_repo_revision": "production", 12:53:46 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:53:46 INFO - "repository": "", 12:53:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:53:46 INFO - "buildid": "20170209101219", 12:53:46 INFO - "pgo_build": "False", 12:53:46 INFO - "basedir": "/builds/slave/test", 12:53:46 INFO - "buildnumber": 15, 12:53:46 INFO - "slavename": "t-yosemite-r7-0389", 12:53:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:53:46 INFO - "platform": "yosemite_r7", 12:53:46 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:53:46 INFO - "branch": "mozilla-beta", 12:53:46 INFO - "repo_path": "releases/mozilla-beta", 12:53:46 INFO - "revision": "25c61e4eb82ddd366b9c472c0961e1d38299d588", 12:53:46 INFO - "stage_platform": "macosx64", 12:53:46 INFO - "builduid": "49f7e09a6a7946d1b1cd61d9a69ad6e4", 12:53:46 INFO - "slavebuilddir": "test" 12:53:46 INFO - } 12:53:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 12:53:46 INFO - Running post-action listener: _resource_record_post_action 12:53:46 INFO - [mozharness: 2017-02-09 20:53:46.464499Z] Finished read-buildbot-config step (success) 12:53:46 INFO - [mozharness: 2017-02-09 20:53:46.464630Z] Running download-and-extract step. 12:53:46 INFO - Running pre-action listener: _resource_record_pre_action 12:53:46 INFO - Running main action method: download_and_extract 12:53:46 INFO - mkdir: /builds/slave/test/build/tests 12:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:46 INFO - trying https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 12:53:46 INFO - Downloading https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 12:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 12:53:47 INFO - Downloaded 1165 bytes. 12:53:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 12:53:47 INFO - Using the following test package requirements: 12:53:47 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 12:53:47 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:53:47 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 12:53:47 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:53:47 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 12:53:47 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:53:47 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:53:47 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 12:53:47 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 12:53:47 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:53:47 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 12:53:47 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:53:47 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 12:53:47 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:53:47 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 12:53:47 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:53:47 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 12:53:47 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 12:53:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 12:53:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 12:53:47 INFO - Fetch https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 12:53:48 INFO - Http code: 200 12:53:48 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 12:53:48 INFO - x-amz-cf-id: 41k3NYugqjveBB9I2oBaj0WW0zDfD0CRl69QpmAeS81NaoxD_3CLiw== 12:53:48 INFO - x-amz-version-id: aeTbXNpL.pZRvCUg2p2ek_g2QsCZOpL_ 12:53:48 INFO - Expected file size: 16093688 12:53:48 INFO - Obtained file size: 16093688 12:53:55 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:53:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 12:53:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 12:53:55 INFO - Fetch https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 12:53:55 INFO - Http code: 200 12:53:55 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 12:53:55 INFO - x-amz-cf-id: InNEGn0PUN7V6qeP8w-RLVjwL4ydx5ncMyFg8LgfeJp7_z4r5Xw8fQ== 12:53:55 INFO - x-amz-version-id: aeTbXNpL.pZRvCUg2p2ek_g2QsCZOpL_ 12:53:56 INFO - Expected file size: 16093688 12:53:56 INFO - Obtained file size: 16093688 12:54:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 12:54:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 12:54:02 INFO - Fetch https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 12:54:03 INFO - Http code: 200 12:54:03 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 12:54:03 INFO - x-amz-cf-id: DKikLGKGELLyTIr1jSz-G1mVttvMNc5iqRY2xy0UoXj2KM1nvOc1Kg== 12:54:03 INFO - x-amz-version-id: 1.ztmyANVc5epqvtTskntqJsEdAKYfU7 12:54:03 INFO - Expected file size: 14403005 12:54:03 INFO - Obtained file size: 14403005 12:54:03 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')]} 12:54:03 INFO - trying https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 12:54:03 INFO - Downloading https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 12:54:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 12:54:05 INFO - Downloaded 82151831 bytes. 12:54:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 12:54:06 INFO - mkdir: /builds/slave/test/properties 12:54:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:06 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:06 INFO - Contents: 12:54:06 INFO - build_url:https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 12:54:06 INFO - Running post-action listener: _resource_record_post_action 12:54:06 INFO - Running post-action listener: set_extra_try_arguments 12:54:06 INFO - [mozharness: 2017-02-09 20:54:06.700297Z] Finished download-and-extract step (success) 12:54:06 INFO - [mozharness: 2017-02-09 20:54:06.700419Z] Running populate-webroot step. 12:54:06 INFO - Running pre-action listener: _resource_record_pre_action 12:54:06 INFO - Running main action method: populate_webroot 12:54:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:06 INFO - '--tppagecycles', 12:54:06 INFO - '7'], 12:54:06 INFO - 'tests': ['tsvgm']}}, 12:54:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:06 INFO - 'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:06 INFO - 'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['damp', 'tps']}, 12:54:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:06 INFO - 'tests': ['damp', 'tps']}, 12:54:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['dromaeo_dom']}, 12:54:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['basic_compositor_video']}, 12:54:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:54:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['a11yr', 12:54:06 INFO - 'ts_paint', 12:54:06 INFO - 'tpaint', 12:54:06 INFO - 'sessionrestore', 12:54:06 INFO - 'sessionrestore_no_auto_restore', 12:54:06 INFO - 'tabpaint']}, 12:54:06 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:06 INFO - 'ts_paint', 12:54:06 INFO - 'tpaint', 12:54:06 INFO - 'sessionrestore', 12:54:06 INFO - 'sessionrestore_no_auto_restore', 12:54:06 INFO - 'tabpaint']}, 12:54:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:06 INFO - 'ts_paint', 12:54:06 INFO - 'tpaint', 12:54:06 INFO - 'sessionrestore', 12:54:06 INFO - 'sessionrestore_no_auto_restore', 12:54:06 INFO - 'tabpaint']}, 12:54:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:06 INFO - 'ts_paint', 12:54:06 INFO - 'tpaint', 12:54:06 INFO - 'sessionrestore', 12:54:06 INFO - 'sessionrestore_no_auto_restore', 12:54:06 INFO - 'tabpaint']}, 12:54:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['a11yr', 12:54:06 INFO - 'ts_paint', 12:54:06 INFO - 'tpaint', 12:54:06 INFO - 'sessionrestore', 12:54:06 INFO - 'sessionrestore_no_auto_restore', 12:54:06 INFO - 'tabpaint']}, 12:54:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['a11yr', 12:54:06 INFO - 'ts_paint', 12:54:06 INFO - 'tpaint', 12:54:06 INFO - 'sessionrestore', 12:54:06 INFO - 'sessionrestore_no_auto_restore', 12:54:06 INFO - 'tabpaint']}, 12:54:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['tsvgx', 12:54:06 INFO - 'tsvgr_opacity', 12:54:06 INFO - 'tart', 12:54:06 INFO - 'tscrollx', 12:54:06 INFO - 'cart']}, 12:54:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:06 INFO - 'tsvgr_opacity', 12:54:06 INFO - 'tart', 12:54:06 INFO - 'tscrollx', 12:54:06 INFO - 'cart']}, 12:54:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:06 INFO - 'talos_options': ['--disable-e10s'], 12:54:06 INFO - 'tests': ['tp5o']}, 12:54:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:06 INFO - 'tests': ['tp5o']}, 12:54:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:06 INFO - 'talos_options': ['--disable-e10s', 12:54:06 INFO - '--xperf_path', 12:54:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:06 INFO - 'tests': ['tp5n']}, 12:54:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:06 INFO - 'talos_options': ['--xperf_path', 12:54:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:06 INFO - 'tests': ['tp5n']}}, 12:54:06 INFO - 'talos.zip': {'path': '', 12:54:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:06 INFO - Running post-action listener: _resource_record_post_action 12:54:06 INFO - [mozharness: 2017-02-09 20:54:06.719138Z] Finished populate-webroot step (success) 12:54:06 INFO - [mozharness: 2017-02-09 20:54:06.719264Z] Running create-virtualenv step. 12:54:06 INFO - Running pre-action listener: _resource_record_pre_action 12:54:06 INFO - Running main action method: create_virtualenv 12:54:06 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:06 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 12:54:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:06 INFO - Using real prefix '/tools/python27' 12:54:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:10 INFO - Installing pip.................done. 12:54:10 INFO - Return code: 0 12:54:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:54:10 INFO - Reading from file tmpfile_stdout 12:54:10 INFO - Output received: 12:54:10 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) 12:54:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54:10 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')]} 12:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:10 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')]} 12:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:10 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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:10 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 12:54:10 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 12:54:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:10 INFO - 'HOME': '/Users/cltbld', 12:54:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:10 INFO - 'LOGNAME': 'cltbld', 12:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:10 INFO - 'MOZ_NO_REMOTE': '1', 12:54:10 INFO - 'NO_EM_RESTART': '1', 12:54:10 INFO - 'PAGER': '/bin/cat', 12:54:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:10 INFO - 'PWD': '/builds/slave/test', 12:54:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:10 INFO - 'SHELL': '/bin/bash', 12:54:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:10 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:10 INFO - 'USER': 'cltbld', 12:54:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:10 INFO - 'XPC_FLAGS': '0x0', 12:54:10 INFO - 'XPC_SERVICE_NAME': '0', 12:54:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:10 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 12:54:10 INFO - Cleaning up... 12:54:10 INFO - Return code: 0 12:54:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:54:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:11 INFO - 'HOME': '/Users/cltbld', 12:54:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:11 INFO - 'LOGNAME': 'cltbld', 12:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:11 INFO - 'MOZ_NO_REMOTE': '1', 12:54:11 INFO - 'NO_EM_RESTART': '1', 12:54:11 INFO - 'PAGER': '/bin/cat', 12:54:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:11 INFO - 'PWD': '/builds/slave/test', 12:54:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:11 INFO - 'SHELL': '/bin/bash', 12:54:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:11 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:11 INFO - 'USER': 'cltbld', 12:54:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:11 INFO - 'XPC_FLAGS': '0x0', 12:54:11 INFO - 'XPC_SERVICE_NAME': '0', 12:54:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:11 INFO - Downloading/unpacking psutil>=3.1.1 12:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:14 INFO - Installing collected packages: psutil 12:54:14 INFO - Running setup.py install for psutil 12:54:14 INFO - building 'psutil._psutil_osx' extension 12:54:14 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 12:54:15 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 12:54:15 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 12:54:15 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 12:54:15 INFO - building 'psutil._psutil_posix' extension 12:54:15 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 12:54:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:54:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:54:15 INFO - ^ 12:54:15 INFO - 1 warning generated. 12:54:15 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 12:54:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:15 INFO - Successfully installed psutil 12:54:15 INFO - Cleaning up... 12:54:16 INFO - Return code: 0 12:54:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54:16 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')]} 12:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:16 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')]} 12:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:16 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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:16 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 12:54:16 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 12:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:16 INFO - 'HOME': '/Users/cltbld', 12:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:16 INFO - 'LOGNAME': 'cltbld', 12:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:16 INFO - 'MOZ_NO_REMOTE': '1', 12:54:16 INFO - 'NO_EM_RESTART': '1', 12:54:16 INFO - 'PAGER': '/bin/cat', 12:54:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:16 INFO - 'PWD': '/builds/slave/test', 12:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:16 INFO - 'SHELL': '/bin/bash', 12:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:16 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:16 INFO - 'USER': 'cltbld', 12:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:16 INFO - 'XPC_FLAGS': '0x0', 12:54:16 INFO - 'XPC_SERVICE_NAME': '0', 12:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54:16 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 12:54:16 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 12:54:16 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 12:54:16 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 12:54:16 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 12:54:16 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 12:54:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:18 INFO - Installing collected packages: mozsystemmonitor 12:54:18 INFO - Running setup.py install for mozsystemmonitor 12:54:19 INFO - Successfully installed mozsystemmonitor 12:54:19 INFO - Cleaning up... 12:54:19 INFO - Return code: 0 12:54:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:19 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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:19 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 12:54:19 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 12:54:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:19 INFO - 'HOME': '/Users/cltbld', 12:54:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:19 INFO - 'LOGNAME': 'cltbld', 12:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:19 INFO - 'MOZ_NO_REMOTE': '1', 12:54:19 INFO - 'NO_EM_RESTART': '1', 12:54:19 INFO - 'PAGER': '/bin/cat', 12:54:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:19 INFO - 'PWD': '/builds/slave/test', 12:54:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:19 INFO - 'SHELL': '/bin/bash', 12:54:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:19 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:19 INFO - 'USER': 'cltbld', 12:54:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:19 INFO - 'XPC_FLAGS': '0x0', 12:54:19 INFO - 'XPC_SERVICE_NAME': '0', 12:54:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:19 INFO - Downloading/unpacking jsonschema==2.5.1 12:54:19 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 12:54:19 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 12:54:19 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 12:54:19 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 12:54:19 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 12:54:19 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 12:54:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:22 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:22 INFO - warning: no files found matching '*.txt' 12:54:22 INFO - no previously-included directories found matching 'build' 12:54:22 INFO - no previously-included directories found matching 'dist' 12:54:22 INFO - no previously-included directories found matching '.git*' 12:54:22 INFO - Installing collected packages: jsonschema, functools32 12:54:22 INFO - Running setup.py install for functools32 12:54:22 INFO - warning: no files found matching '*.txt' 12:54:22 INFO - no previously-included directories found matching 'build' 12:54:22 INFO - no previously-included directories found matching 'dist' 12:54:22 INFO - no previously-included directories found matching '.git*' 12:54:22 INFO - Successfully installed jsonschema functools32 12:54:22 INFO - Cleaning up... 12:54:22 INFO - Return code: 0 12:54:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:22 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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:22 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 12:54:22 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 12:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:22 INFO - 'HOME': '/Users/cltbld', 12:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:22 INFO - 'LOGNAME': 'cltbld', 12:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:22 INFO - 'MOZ_NO_REMOTE': '1', 12:54:22 INFO - 'NO_EM_RESTART': '1', 12:54:22 INFO - 'PAGER': '/bin/cat', 12:54:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:22 INFO - 'PWD': '/builds/slave/test', 12:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:22 INFO - 'SHELL': '/bin/bash', 12:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:22 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:22 INFO - 'USER': 'cltbld', 12:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:22 INFO - 'XPC_FLAGS': '0x0', 12:54:22 INFO - 'XPC_SERVICE_NAME': '0', 12:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:54:23 INFO - Cleaning up... 12:54:23 INFO - Return code: 0 12:54:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:23 INFO - 'HOME': '/Users/cltbld', 12:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:23 INFO - 'LOGNAME': 'cltbld', 12:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:23 INFO - 'MOZ_NO_REMOTE': '1', 12:54:23 INFO - 'NO_EM_RESTART': '1', 12:54:23 INFO - 'PAGER': '/bin/cat', 12:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:23 INFO - 'PWD': '/builds/slave/test', 12:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:23 INFO - 'SHELL': '/bin/bash', 12:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:23 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:23 INFO - 'USER': 'cltbld', 12:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:23 INFO - 'XPC_FLAGS': '0x0', 12:54:23 INFO - 'XPC_SERVICE_NAME': '0', 12:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:23 INFO - Downloading/unpacking blobuploader==1.2.4 12:54:23 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 12:54:23 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 12:54:23 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 12:54:23 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 12:54:23 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 12:54:23 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 12:54:25 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:27 INFO - Downloading docopt-0.6.1.tar.gz 12:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:27 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:27 INFO - Running setup.py install for blobuploader 12:54:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:27 INFO - Running setup.py install for requests 12:54:27 INFO - Running setup.py install for docopt 12:54:28 INFO - Successfully installed blobuploader requests docopt 12:54:28 INFO - Cleaning up... 12:54:28 INFO - Return code: 0 12:54:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:28 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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:28 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 12:54:28 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 12:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:28 INFO - 'HOME': '/Users/cltbld', 12:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:28 INFO - 'LOGNAME': 'cltbld', 12:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:28 INFO - 'MOZ_NO_REMOTE': '1', 12:54:28 INFO - 'NO_EM_RESTART': '1', 12:54:28 INFO - 'PAGER': '/bin/cat', 12:54:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:28 INFO - 'PWD': '/builds/slave/test', 12:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:28 INFO - 'SHELL': '/bin/bash', 12:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:28 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:28 INFO - 'USER': 'cltbld', 12:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:28 INFO - 'XPC_FLAGS': '0x0', 12:54:28 INFO - 'XPC_SERVICE_NAME': '0', 12:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:28 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-KIMUe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:28 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-XM4vXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:28 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-cz9yWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:28 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-tlpIAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:28 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-AW4aly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:28 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-atTi91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:29 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-hyulyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:29 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-7mMMLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:29 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Ef2PLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:29 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-J61nLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:29 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-IO0329-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:29 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-FCGuRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:29 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-XmVHs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:29 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-gtL4u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:29 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-CEJFHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-7UHwNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ZRqgiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:30 INFO - Running setup.py install for manifestparser 12:54:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Running setup.py install for mozcrash 12:54:30 INFO - Running setup.py install for mozdebug 12:54:30 INFO - Running setup.py install for mozdevice 12:54:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Running setup.py install for mozfile 12:54:30 INFO - Running setup.py install for mozhttpd 12:54:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Running setup.py install for mozinfo 12:54:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Running setup.py install for mozInstall 12:54:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Running setup.py install for mozleak 12:54:31 INFO - Running setup.py install for mozlog 12:54:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Running setup.py install for moznetwork 12:54:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Running setup.py install for mozprocess 12:54:31 INFO - Running setup.py install for mozprofile 12:54:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:32 INFO - Running setup.py install for mozrunner 12:54:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:32 INFO - Running setup.py install for mozscreenshot 12:54:32 INFO - Running setup.py install for moztest 12:54:32 INFO - Running setup.py install for mozversion 12:54:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:32 INFO - Cleaning up... 12:54:32 INFO - Return code: 0 12:54:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:32 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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:32 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 12:54:32 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 12:54:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:32 INFO - 'HOME': '/Users/cltbld', 12:54:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:32 INFO - 'LOGNAME': 'cltbld', 12:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:32 INFO - 'MOZ_NO_REMOTE': '1', 12:54:32 INFO - 'NO_EM_RESTART': '1', 12:54:32 INFO - 'PAGER': '/bin/cat', 12:54:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:32 INFO - 'PWD': '/builds/slave/test', 12:54:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:32 INFO - 'SHELL': '/bin/bash', 12:54:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:32 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:32 INFO - 'USER': 'cltbld', 12:54:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:32 INFO - 'XPC_FLAGS': '0x0', 12:54:32 INFO - 'XPC_SERVICE_NAME': '0', 12:54:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:33 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-6tdRVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:33 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-YaeSAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:33 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-oDtE0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:33 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-AZnvQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:33 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-x6Uokq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:33 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-cnKdhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:33 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-EtsP75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:33 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-tG1QZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:33 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-nHtKhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:34 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-LLxUE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:34 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)) 12:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:34 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-e3dtu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:34 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)) 12:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:34 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-OvnKfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:34 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-KnjpzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:34 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)) 12:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:34 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-7vVFM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:34 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)) 12:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:34 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-5EVxD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:34 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)) 12:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:34 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-kc3yWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:34 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)) 12:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:34 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-faOHRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:34 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)) 12:54:34 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)) 12:54:34 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)) 12:54:34 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)) 12:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:54:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:37 INFO - Downloading blessings-1.6.tar.gz 12:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:37 INFO - Installing collected packages: blessings 12:54:37 INFO - Running setup.py install for blessings 12:54:37 INFO - Successfully installed blessings 12:54:37 INFO - Cleaning up... 12:54:37 INFO - Return code: 0 12:54:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:38 INFO - Reading from file tmpfile_stdout 12:54:38 INFO - Current package versions: 12:54:38 INFO - blessings == 1.6 12:54:38 INFO - blobuploader == 1.2.4 12:54:38 INFO - docopt == 0.6.1 12:54:38 INFO - functools32 == 3.2.3-2 12:54:38 INFO - jsonschema == 2.5.1 12:54:38 INFO - manifestparser == 1.1 12:54:38 INFO - mozInstall == 1.12 12:54:38 INFO - mozcrash == 1.0 12:54:38 INFO - mozdebug == 0.1 12:54:38 INFO - mozdevice == 0.48 12:54:38 INFO - mozfile == 1.2 12:54:38 INFO - mozhttpd == 0.7 12:54:38 INFO - mozinfo == 0.9 12:54:38 INFO - mozleak == 0.1 12:54:38 INFO - mozlog == 3.4 12:54:38 INFO - moznetwork == 0.27 12:54:38 INFO - mozprocess == 0.23 12:54:38 INFO - mozprofile == 0.28 12:54:38 INFO - mozrunner == 6.13 12:54:38 INFO - mozscreenshot == 0.1 12:54:38 INFO - mozsystemmonitor == 0.3 12:54:38 INFO - moztest == 0.8 12:54:38 INFO - mozversion == 1.4 12:54:38 INFO - psutil == 3.1.1 12:54:38 INFO - requests == 1.2.3 12:54:38 INFO - wsgiref == 0.1.2 12:54:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:38 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')]} 12:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:38 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')]} 12:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:38 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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:38 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 12:54:38 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 12:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:38 INFO - 'HOME': '/Users/cltbld', 12:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:38 INFO - 'LOGNAME': 'cltbld', 12:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:38 INFO - 'MOZ_NO_REMOTE': '1', 12:54:38 INFO - 'NO_EM_RESTART': '1', 12:54:38 INFO - 'PAGER': '/bin/cat', 12:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:38 INFO - 'PWD': '/builds/slave/test', 12:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:38 INFO - 'SHELL': '/bin/bash', 12:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:38 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:38 INFO - 'USER': 'cltbld', 12:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:38 INFO - 'XPC_FLAGS': '0x0', 12:54:38 INFO - 'XPC_SERVICE_NAME': '0', 12:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 INFO - Cleaning up... 12:54:39 INFO - Return code: 0 12:54:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:39 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 0x10d582490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea934c1d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, '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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 12:54:39 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 12:54:39 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 12:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:39 INFO - 'HOME': '/Users/cltbld', 12:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:39 INFO - 'LOGNAME': 'cltbld', 12:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:39 INFO - 'MOZ_NO_REMOTE': '1', 12:54:39 INFO - 'NO_EM_RESTART': '1', 12:54:39 INFO - 'PAGER': '/bin/cat', 12:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:39 INFO - 'PWD': '/builds/slave/test', 12:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:39 INFO - 'SHELL': '/bin/bash', 12:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:54:39 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:39 INFO - 'USER': 'cltbld', 12:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:39 INFO - 'XPC_FLAGS': '0x0', 12:54:39 INFO - 'XPC_SERVICE_NAME': '0', 12:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:54:39 INFO - Cleaning up... 12:54:39 INFO - Return code: 0 12:54:39 INFO - Running post-action listener: _resource_record_post_action 12:54:39 INFO - Running post-action listener: _start_resource_monitoring 12:54:39 INFO - Starting resource monitoring. 12:54:39 INFO - [mozharness: 2017-02-09 20:54:39.929024Z] Finished create-virtualenv step (success) 12:54:39 INFO - [mozharness: 2017-02-09 20:54:39.929997Z] Running install step. 12:54:39 INFO - Running pre-action listener: _resource_record_pre_action 12:54:39 INFO - Running main action method: install 12:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:40 INFO - Reading from file tmpfile_stdout 12:54:40 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:40 INFO - Reading from file tmpfile_stdout 12:54:40 INFO - Output received: 12:54:40 INFO - Usage: mozinstall [options] installer 12:54:40 INFO - Options: 12:54:40 INFO - -h, --help show this help message and exit 12:54:40 INFO - -d DEST, --destination=DEST 12:54:40 INFO - Directory to install application into. [default: 12:54:40 INFO - "/builds/slave/test"] 12:54:40 INFO - --app=APP Application being installed. [default: firefox] 12:54:40 INFO - mkdir: /builds/slave/test/build/application 12:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:55:01 INFO - Reading from file tmpfile_stdout 12:55:01 INFO - Output received: 12:55:01 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:55:01 INFO - Running post-action listener: _resource_record_post_action 12:55:01 INFO - [mozharness: 2017-02-09 20:55:01.647597Z] Finished install step (success) 12:55:01 INFO - [mozharness: 2017-02-09 20:55:01.647726Z] Running run-tests step. 12:55:01 INFO - Running pre-action listener: _resource_record_pre_action 12:55:01 INFO - Running main action method: run_tests 12:55:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:55:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:55:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:55:01 INFO - 2017-02-09 12:55:01.662 screenresolution[1630:7649] starting screenresolution argv=screenresolution get 12:55:01 INFO - 2017-02-09 12:55:01.664 screenresolution[1630:7649] Display 0: 1600x1200x32@60 12:55:01 INFO - 2017-02-09 12:55:01.670 screenresolution[1631:7652] starting screenresolution argv=screenresolution list 12:55:01 INFO - Available Modes on Display 0 12:55:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:55:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:55:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:55:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:55:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:55:01 INFO - Intel Iris: 12:55:01 INFO - Chipset Model: Intel Iris 12:55:01 INFO - Type: GPU 12:55:01 INFO - Bus: Built-In 12:55:01 INFO - VRAM (Dynamic, Max): 1536 MB 12:55:01 INFO - Vendor: Intel (0x8086) 12:55:01 INFO - Device ID: 0x0a2e 12:55:01 INFO - Revision ID: 0x0009 12:55:01 INFO - Displays: 12:55:01 INFO - Display: 12:55:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:55:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:55:01 INFO - Display Serial Number: 1600x1200 60 12:55:01 INFO - Main Display: Yes 12:55:01 INFO - Mirror: Off 12:55:01 INFO - Online: Yes 12:55:01 INFO - Rotation: Supported 12:55:01 INFO - Return code: 0 12:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:01 INFO - Python 2.7.3 12:55:01 INFO - Return code: 0 12:55:01 INFO - grabbing minidump binary from tooltool 12:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:01 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 0x10d396d30>, '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 0x10d1fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d38eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:01 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 12:55:01 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 12:55:01 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 12:55:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:02 INFO - Return code: 0 12:55:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:55:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:55:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--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 12:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0389 --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 12:55:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CIxVyUYq2/Render', 12:55:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:02 INFO - 'HOME': '/Users/cltbld', 12:55:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:02 INFO - 'LOGNAME': 'cltbld', 12:55:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:02 INFO - 'MOZ_NO_REMOTE': '1', 12:55:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:02 INFO - 'NO_EM_RESTART': '1', 12:55:02 INFO - 'PAGER': '/bin/cat', 12:55:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:02 INFO - 'PWD': '/builds/slave/test', 12:55:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:02 INFO - 'SHELL': '/bin/bash', 12:55:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWN08JNljQ/Listeners', 12:55:02 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 12:55:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:02 INFO - 'USER': 'cltbld', 12:55:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:02 INFO - 'XPC_FLAGS': '0x0', 12:55:02 INFO - 'XPC_SERVICE_NAME': '0', 12:55:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--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 12:55:02 INFO - mozversion application_buildid: 20170209101219 12:55:02 INFO - mozversion application_changeset: 25c61e4eb82ddd366b9c472c0961e1d38299d588 12:55:02 INFO - mozversion application_display_name: Firefox 12:55:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:02 INFO - mozversion application_name: Firefox 12:55:02 INFO - mozversion application_remotingname: firefox 12:55:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:55:02 INFO - mozversion application_vendor: Mozilla 12:55:02 INFO - mozversion application_version: 52.0 12:55:02 INFO - mozversion platform_buildid: 20170209101219 12:55:02 INFO - mozversion platform_changeset: 25c61e4eb82ddd366b9c472c0961e1d38299d588 12:55:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:55:02 INFO - mozversion platform_version: 52.0 12:55:02 INFO - using testdate: 1486673702 12:55:02 INFO - actual date: 1486673702 12:55:02 INFO - starting webserver on 'localhost:49243' 12:55:02 INFO - SUITE-START | Running 2 tests 12:55:02 INFO - TEST-START | dromaeo_css 12:55:02 INFO - operating with platform_type : mac_ 12:55:02 INFO - Initialising browser for dromaeo_css test... 12:55:02 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpH75hKx/profile http://localhost:49243/getInfo.html) 12:55:04 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 12:55:04 INFO - PROCESS | 1641 | colorDepth:24 12:55:04 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 12:55:04 INFO - PROCESS | 1641 | __metrics 12:55:05 INFO - PROCESS | 1641 | 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" 12:55:05 INFO - PROCESS | 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:55:05 INFO - TEST-INFO | 1641: exit 0 12:55:05 INFO - Browser initialized. 12:55:05 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:05 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpH75hKx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:18 INFO - PROCESS | 1644 | RSS: Main: 172150784 12:55:18 INFO - PROCESS | 1644 | 12:58:20 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 12:58:22 INFO - PROCESS | 1644 | RSS: Main: 316403712 12:58:22 INFO - PROCESS | 1644 | 13:01:25 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 13:01:25 INFO - PROCESS | 1644 | RSS: Main: 297914368 13:01:25 INFO - PROCESS | 1644 | 13:04:28 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 13:04:28 INFO - PROCESS | 1644 | RSS: Main: 271372288 13:04:28 INFO - PROCESS | 1644 | 13:07:31 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 13:07:31 INFO - PROCESS | 1644 | RSS: Main: 264048640 13:07:31 INFO - PROCESS | 1644 | 13:10:34 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 13:10:35 INFO - PROCESS | 1644 | RSS: Main: 259657728 13:10:35 INFO - PROCESS | 1644 | 13:13:38 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 13:13:38 INFO - PROCESS | 1644 | RSS: Main: 467480576 13:13:38 INFO - PROCESS | 1644 | 13:13:38 INFO - PROCESS | 1644 | __start_tp_report 13:13:38 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 13:13:38 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 13:13:38 INFO - PROCESS | 1644 | |i|pagename|runs| 13:13:38 INFO - PROCESS | 1644 | |0;dojo.html;2705.7158998305176;3359.2945481448896;3405.7956522608647;3411.249525104476;3475.0617333320006;4936.593070974773;5266.552343050846;5553.111502159655;5601.579881508887;5620.943790562093;5579.442055794419;5631.099024156136;5655.886882262353;5670.206171136034;5675.943240567593;5079.517445842639;5085.974570127144;5098.107831129556;5158.3552055993005;5226.660267082647;3989.700772442064;4578.786621545277;5052.823151189709;5081.974590127063;5123.564497017758;5075.796968121271;5152.098382783017;5155.664881782691;5168.095583272931;5192.091384007803;5130.358705161855;5139.717315547643;5140.3060586820675;5143.537081662668;5179.223116532513;4976.02967421353;4982.651214414992;5082.440931497532;5088.771005304733;5104.719240441774;5517.227588137624;5554.50009499143;5557.360903496069;5614.1859430382365;5621.18492818539;6098.298695650013;6120.693965301717;6156.5998210116195;6170.7531698732;6172.9074063889075;6213.03697926822;6249.87500249997;6250.1874756281395;6261.592996455216;6262.2172228471445;5556.9444305556835;5622.297212848435;5629.24005259293;5668.234788303526;5673.943260567424;6280.340564240781;6285.994240921431;6323.588966717149;6330.335314791972;6346.17499725042;5944.791932282349;6027.547933904974;6030.7889223876955;6049.909251361233;6071.787487437919;6060.333363330118;6125.816225513242;6133.172021777093;6145.0782382642965;6151.954167791486;6041.214642096587;6079.939200608026;6101.755929762849;6143.600665956698;6151.108089327112;6106.572539922163;6155.984262596711;6157.6613286269685;6175.44421002112;6182.165407669997;4835.903281934342;4882.145624515695;4926.3349447824085;4936.925946110811;4968.677035992721;4312.827486900552;4420.557944205554;4449.154660614473;4474.082813023322;4479;5591.384947655754;5661.122526008476;5669.40471250521;5672.914906276409;5691.772329106872;6050.48570871472;6161.599496032743;6208.192934918432;6223.751049958041;6223.782167624111;5552.139418390156;5611.915821262684;5636.239107720406;5660.773569057192;5668.943310566841;5294.523492885659;5316.016536940679;5357.4106848246665;5368.731563421813;5413.269208656781;6261.217347831521;6303.117563541108;6314.84212894663;6318.684065796691;6326.9876819708625;4723.385959825201;6063.2956205653145;6214.564980451325;6250.968745156245;6258.874822503615;6169.56813023084;6208.0998255253635;6223.564350495421;6232.25212974446;6269.4984401246875;6095.329513753395;6136.161982713028;6154.415330543591;6170.290416602148;6177.135201071944;6227.128202051807;6241.531885108726;6253.78111766086;6256.749730010749;6268.529860260407;5710.200571919851;5747.3103227612955;5894.764209431574;5970.641761494324;6081.179040829608;5205.843824685266;5948.672822994777;5959.374265702038;5978.910316345171;6019.939800601938;5814.982378083903;5862.882742345215;5873.911891321719;5878.3239927408895;5879.970600146972;5808.419158084327;5988.580799344004;6057.42454466825;6063.757449701962;6074.088886667036;5778.422157784188;5823.970880145572;5827.358990510956;5872.354041055566;5895.94104058954 13:13:38 INFO - PROCESS | 1644 | |1;ext.html;471.6509782760757;518.1657531374487;525.5585308340993;553.6207697727057;571.6598623818832;30559.541606875915;32571.67428325719;32577.348453030983;32593.022209333758;32633.51049734253;32582.83708581454;33238.169045773866;33264.83367583165;39631;41847.58152418475;9523.904760952406;9729.464879431629;9729.854052189223;9730.854037189412;9742;9598.712038638852;9668.854967175497;9674.758131046745;9688.46713430761;9692.127708506234;8887.77780555488;9062.818743625123;9657.32398732089;9725.708228753114;11430.314181149117;11346.943265283704;11678;11681.065514758799;11690.947814696676;11691.94154029233;11583.76832463346;11664.125190610737;11671.949524542748;11675.182737208399;11678.591249306319;40308;40537.79731101326;40602;40686.79656601698;40846.59153408487;3307.751918606114;3338.833058347073;3347.6484969078383;3538.327717733622;3660.835262413171;29730.305990390443;30880;30907.845460772776;31130.377392452025;31264;3254.3816674831705;3284.540164376989;3336.3660904428325;3339;3352.8658853645825;486194;486330;488822;489446;489928;59818.10272845911;60211;60398;60436;60466.39533604607;35099.122521936646;35717.46423803645;35881.8205908974;36471.08822279464;36493.635063649555;17261.91369043147;17428.912855435894;17442.95342279467;17475.650486990442;17491.300347985936;13071.803922941164;13135.080544361803;13155.276459794803;13159.47362105505;13169.868301317056;19259.22963081489;19262.71105933412;19268.614627707648;19286.614267714565;19307.744996575177;6378.968105159444;7188.281171882874;7617.162112167657;7830.608469576612;7874.370050395954;759.3242014607005;997.9501024948723;1000.2748007694508;1006.8288390973552;1027.912627426662;27600.585991210148;29655;29692;30191.698083019328;30393;923.3490389275545;1060.8833028367028;1073.1146803886825;1079.6599071292517;1092.4537731134433;14896.851031489763;15677.29452174655;15819.52541423759;15972.380452334597;16071.678566428605;626133;626657;628491.2877178015;629786;631521;58448;59060.409395906354;59095.70452147712;59268.11097833536;59309.25525957913;1263.747250549912;1294.5598496511232;1377.4903285784324;1389.1526169036879;1425.0879437160227;29071.41857162887;31285.021658784146;31912.88304909317;32381.676183237865;32560;55800;56432.435675642715;56540.43459565352;56586.71706641605;56778;572305;580989;581332;581673;586930;24180.032798687855;24608.876955615106;27259;27699.89200432041;27713.030043948365;46123.53876461193;46947.53052469432;47330.52669473399;48908;49704;34505.82747086349;35639.465408019416;37774.86675399743;37936.81031594824;39781;34756.9572912813;36339.636603633626;38918.027049323995;39070.80464597659;39206.80396597999;30439.847800760854;36727.449088263165;37052.62947370492;37339;37801.243975120895;31878.68121318757;34610.82694586511;34941.301173976884;35425;35723.92828215157;25513.48973020492;25629;25793.226203213933;26133.216003519923;26589.867050664623 13:13:38 INFO - PROCESS | 1644 | |2;jquery.html;370.83497843459656;380.1408816075668;389.1089405261951;401.1835913915183;410.25129139320745;19218.807811921877;19675.901620491913;21236.362909112733;21465.67801482979;21519.354419367424;10071.798564028715;11621.47703353349;12184.81722774159;12188.268703877773;18108.275668973227;5215.087359712054;5494.313210848644;5495.395506494302;5505.421930697279;5512.862178445531;3289.259916518788;4110.034141976633;4198.244316023115;4227.556106608808;5334.386545547253;6644.169478815148;6705.564138331018;6715.731370745164;6720.697568609425;6727.4618030557685;6440.77457288995;6659.167604049518;6691.866162676743;6704.597724136567;6716.798496045127;5695.629784064023;5921.970390148022;5941.22764040672;5941.970290148565;5944.227250457456;11389.658310250707;13636.113652612648;22622.77377226223;24928;25489;2188.113813905371;2279.133929106929;2346.2961111666605;2376.2871138658334;2406.554787364326;9993.950030249802;14872.182029988346;15327.693446131127;15583.220838958006;15667.764983525141;1819.426880532628;1865.766779152606;1903.666858299792;1936.4190742777112;1952.8925909074994;108425.45787271092;115935;119138;123751;129442.99999999905;11161.888381116247;11375.544978200945;11414.600488983011;11643.708907277385;11814.173007889365;14958.850411495963;14968.176750278839;14978.325975331136;15002.774958375632;15031;8593.957030214933;8837.955810220908;8875.866861997076;8960.551972401354;9012.54937253148;8779.648814047494;8798.692045778367;8817.691380801642;8966;8968.865467018;4117.8675864137;4185.916281674349;4593.150267200579;4679;4697.248440249612;1761.8812054345326;1826.8721189516607;1874.8563376340421;1904.9897573156713;2024.0588126521238;867.1805144138855;880.3837313880309;905.6965916417942;921.8202450522218;967.6806653804227;20614.793852061586;21913.780862191175;21925.671114933288;21951;21955.560888782136;843.3632607381388;850.8213275212152;953.2231231546267;954.4178051388648;1000.4097582426404;10600.893991060146;11488.712782180346;11488.827667584992;11558.30650160993;11564.768704626029;550613;554430;555784;557829;573219;76266;93377;121065.39467302606;132547;134660.65339346678;953.1040821627648;966.1980556138528;995.1342332171057;996.4753926492479;998.7852611688377;19053;19749.506262343555;19942.800571994674;19957.101930412875;20052.89973550123;35886;54082.729586351816;54757.80968761205;56135.719321404766;56847.71576142093;77280;78049.2195078042;79171.20828791638;79498;79691;5518.613697041169;7964.442489025712;8044.758657240292;8076.4750291230885;8400.747977560683;10650.360978341325;12462.501499940263;12818.55135070268;13399;13516.662083447993;11134.33194008362;11154.776904462027;11155;11483.25358851672;11517.884821151682;11142.83285750698;11365.886341136484;11428.371439570903;11807.704807379885;11811;11363.090952723596;11366.090712742794;11613.767724645291;11731.178817483036;11801.704957376134;8303.418760686694;8409.62156702962;8423.957880210559;8541.103184165822;8569.071958809218;7909;9477.289203309918;10792.892071079503;10904.50929708181;10973.670789876316 13:13:38 INFO - PROCESS | 1644 | |3;mootools.html;1376.2568213164889;1497.9963424505577;1681.3946979087527;1866;1888.9433317000487;7921.524708517486;8323.417360784731;8326.95913010873;8331.91668083319;8336.499810011404;7025.156981162268;7485.850282994337;7759.767206983785;8118.391120665959;8291.170882911705;2213.7492316841012;2351.576716191081;2387.3912152401113;2388.176079252655;2392.0790495659207;2140.3364956863343;2162.4701948022757;2190.277208521184;2227.8329125315668;2260.9095636174616;2018.2028098900926;2308.9307320780404;2361.244401791427;2374.6794182785275;2388.856668599881;2337.9532409351887;2343.4024323797494;2362.385779697274;2364.8817559121976;2369.988150059256;2376.3821406434276;2387.438951846315;2390.426297688542;2391.1152873436768;2393.628987506939;8235.423520353577;8426.831463370698;8443.944506936632;8445.324374050062;8446.197611226924;5078.4413714491375;5257.737113144328;5259.421463638997;5263.578913686896;5268.236105764643;2962.5111856543645;3279.2785587170783;3330.6502817204087;3588.7129029677562;3591.497190393347;1064.3720205078964;1064.5688496159069;1080.3355936099322;1099.4173088263233;1120.6077872744556;10860.45697715119;10985.61550345742;11024.338539687644;11035.889641103566;11079.667609971713;4488.955110448919;4595.954040459619;4692.6245900327895;4708.387909571734;4734.4081989751285;9449.858252126223;9454.48000359973;9461.574229159567;9465.479398633004;9494.240460763122;5187.144121220032;5207.5313221809465;5208.192730126836;5210.557102646242;5211.374635043819;4324.870253892388;4456.487503937089;4553.908921821545;4772.976135119302;4784.258439941815;3798.582155962842;3831.6934645228316;3884.941725874114;3930.9803450982563;3937.9803100984313;1267.207995003123;1269.320913311374;1276.9553065642658;1287.7038281195378;1287.8003909394058;755.527795128045;839.4837175137246;886.2998231397124;903.909609039104;912.9087091290818;5475.534579560703;5497.092979658311;5544.944550554443;5698.544116470673;5884.117382392676;958.726762872578;965.8937516873139;993.0615568288043;1013.5185786751234;1032.339302846179;3585.6414358563934;3630.8184590770356;3663.725220608465;3767.171222331083;3784.110733977513;9814.214862810957;10159;10175.694729158136;10205.744856378502;10247.487625618689;9589.712308630613;9970.551325190383;9971.551280192263;10115.39307641544;10131.442770647538;7672.309492145734;7886.763397098096;7888.881666775118;7894.131645518988;7902.367810575255;4666.696664716783;5428.185772134211;5454.536364409069;5592.881423715355;5637.351704554028;9054.411463254868;9071.138241867013;9262.536873156181;9294.395864268801;9389.38968967015;9323.02108278621;9396.436213827192;9559.713208603753;9565.04349565038;9662.951685241529;6573.276939536551;6662.933370666426;6849.8972515411315;7198.71205151788;7373.483856130019;7860.528368297921;8125.634346454542;8126.146754590919;8133.389995750224;8137.674493020213;7109.466789990668;7197;7212.74755383559;7231.3853322466075;7348.448866334939;6982.581045137308;7059.399951004222;7082.822929426806;7188.28117188277;7206.171290301682;6519.706613202512;6539.607623542603;6607.438367738604;6612.801615951529;6613.074169616161;4665.160271151225;4681.765911704333;4750.12122757291;4755.239161734106;4755.643326750438;4608.446986361658;4682.906341873211;4690.9914368410955;4889.193283108248;4924.532169443897 13:13:38 INFO - PROCESS | 1644 | |4;prototype.html;259.83760149906306;314.7419116324613;318.0300084741538;322.9483282674772;328.5712145649929;4741.786619602118;5268.8155914542995;5308.575313974882;5339.759710813013;5356.598255130871;4472.546422412713;4709.9058018839605;5162.5095615916525;5205.089109405858;5286.4449232830575;3905.258000979819;3975.1118218846104;4007.779572123532;4009.5789942056103;4013.177298653769;3869.806509674519;4022.4971878515184;4076.5719599442077;4084.2035803018425;4111.814968326417;3610.368185567515;3851.691864650821;3960.4257382679493;4000.819758171332;4032.1935612877396;3494.7903125812277;3522.4011917974008;3847.7110168093723;4044.9685330240745;4086.8569600064;3159.6571457130626;3275.9516954574547;3591.7306202034692;3617.8914632561064;3624.6012938576737;4270.615644592001;4901.362822833009;5217.295665085203;5225.190095535198;5247.47525247476;4429.490608580022;4616.676832621718;4682.695624784412;4696.600788932945;4727.29817265784;5267.999080174754;5557.5553955683445;5561.749721262553;5609.242752228479;5622.437756224385;3940.6650434713083;3949.269385163754;3957.476371596927;4006.2187873364705;4010.859619913289;4617.722936623813;5379.946200537984;5696.2594862668;5765;5837.241158649391;3520.8239588020497;3832.7508711933633;3992.341263691458;4003.599640035973;4005.5193376794386;3390.271091715293;3489.7382696297877;3939.1924655445564;3994.121293315466;4081.918361632751;4415.933760993587;4670.602998745077;4675.7895894684825;4692.565525578364;4720.669553131316;5608.775648974077;5622.662640241599;5632.211490391349;5632.802851900164;5651.660900345993;1267.8415198100238;1303.7913933770742;1327.462377737018;1338.2305174524492;1359.8101661046585;788.2905385153408;836.6987884361625;868.6926176104922;908.8136931928939;920.4995856753449;4578.931316030262;4841.160359063533;4852.587530059985;4877.487863774323;4936.8765780855765;4639.025804581008;4865.537773911473;5274.630775845654;5340.91988620171;5383.461653834664;4792.400949881265;4889.997550502138;4898.4121905371585;5328.547073498796;5332.9733351333;2618.7430033583605;2752.8073034887766;2864.756495697889;2904.8257104573795;2906.3579077820964;4115.9176816463505;5474.808381706621;5637.323521177403;5684.715764211773;5744.770209191585;5227.529522342931;5545.889082218414;5610.961972035187;5663.292088488939;5681.403452637496;5103.770330335218;5580.972095139498;5648.265725455664;5760.8190320984095;5768.423157684198;5230.712310822942;5479.53423958968;5487.780488780564;5492.4507549246355;5525.336959564878;4601.469191944484;4746.5490778376;4747.982107604185;5455.9454405455435;5466.699331536644;5125.846224613268;5693.202951586864;5730.541556675373;5746.310442746897;5784.652920824764;3135.5453459247824;3296.208909861664;3309.768316217842;3503.915170473564;3602.6397360263763;4480.61914737251;5014.34813474246;5419.617997410635;5454.127339625641;5457.990271799571;4832.371791667061;5244.76398562058;5284.445133260952;5315.548178404879;5362.356517217959;3983.402489626463;4442.911486685783;4628.9537104628525;4699.459562150259;4715.41057367829;4615.538446155492;5159.380874295109;5184.740762961912;5221.556167725634;5359.222912677717;4706.599939005086;4785.114753770564;4802.543758342952;5381.300430943952;5474.987127381447;4710.387649605529;5403.378611459732;5427.430119837518;5439.891202176013;5460.781568737206 13:13:38 INFO - PROCESS | 1644 | |5;yui.html;717.4834119434006;759.9658015389307;769;828.7430896422109;831.6216121664643;14139.08095973761;15329.156896370696;15356.308966096525;15384.846151538495;15387.615309617251;13766.105203161787;13953.720925581481;13961.790573141385;13967.720645587082;14015.43938242469;688.2738710660251;709.0286307758378;836.4521238588734;852.8123812761214;870.4385671242045;802.2619190344897;838.5471845203613;849.1381248033251;853.8804567360575;855.2345650642671;910.81328327693;917.0233701108299;919.0671468459519;920.2453987730031;921.0743203080895;908.0510866144862;908.8364094462994;909.495230147268;914.931380146485;915.2677857713869;678.6233640329615;680.7141000779684;684.2815044203616;686.6772616870063;687.1582311668217;14114.153150810984;14134.434622615083;14166.362513686805;14167.574972750834;14816.62958426048;13885.514007009808;14218.289085545784;14229.928850355682;14254.216018119;14331;11418.257813242113;11425;11667.941660291644;11670.474828632732;11679.416029198506;3666.5050218220467;3713.628637136265;3768.698504119664;3873.341531939577;3951.7826519541413;90111;92806.07193928042;93399;93576;95543;10332.328398654214;10475.84286235707;10591.470426478645;10746.462676866126;10761.83857242142;19528.804711952984;19772.90113549423;19799.802001979795;20075.799242007393;20076.799232007786;6679.599224046573;7643.388528917673;7687;7734.5359278443475;7793.844123117506;4274.422952901381;4277.144571085795;4462.821487140543;4534.433195850519;4535.9546404536195;3453.913652158666;3570.696490798259;3572.231970126383;3573.5175751273246;3573.8034408107283;656.2617055812211;657.2572992518519;657.3426573426574;680.6902859199053;686.2862622872257;625.6996641611961;641.9903701444482;671.9361660642231;683.5932620091038;692.7021380806201;9112.316576256808;9163.404378715362;9274.629014839331;9365.812683746422;9419.905800941902;586.642148289543;631.5011141198494;657.57914934442;692.705600119947;696.1194089476816;4419.425474688334;4586.564276393738;4604.263317869192;4618.1918164321105;4624.745638989888;110857;111267.44366278117;112436.4378178104;112732;113319.43340283411;64759;70819.64590177016;72763;96540.06919861563;96661.51669241609;66259.66870165618;88034.55982720046;89458.55270723604;90229.09770902207;91219.5439022814;8791.164839340252;8873.866891996755;8929.464232146092;9004.36969412135;9009.729708108767;55967;56186.1572076411;56433;57547.71226143843;57849.843003140544;61279.08081378694;69273;81006;81486;82317.11890083818;11098.445077746243;11466.2546934449;11519.94240028828;11667.708307292385;11968.581099661471;12509.812352814533;12663.438497410076;13008.284544350152;13202.735945281232;13623.591292261248;12144.453499592717;12178.939105304416;12191.146619736888;12506.937465312616;12588.181768185039;11817.645470635895;11939.582114626293;11996.280223186637;12027.699307517381;12162.087843411957;10149.644762433574;12124.575639852563;12141.392930353624;12195;12463.189892656948;10612.681619551426;10839.349639021684;11471;11607.477663504993;11769;10092.444915529717;11458.19792614509;11460.718908692423;11648.534058637899;11676.474558644712 13:13:38 INFO - PROCESS | 1644 | __end_tp_report 13:13:38 INFO - PROCESS | 1644 | __start_cc_report 13:13:38 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1639 13:13:38 INFO - PROCESS | 1644 | __end_cc_report 13:13:38 INFO - PROCESS | 1644 | __startTimestamp1486674818659__endTimestamp 13:13:38 INFO - PROCESS | 1644 | 13:13:38 INFO - PROCESS | 1644 | ------- Summary: start ------- 13:13:38 INFO - PROCESS | 1644 | Number of tests: 6 13:13:38 INFO - PROCESS | 1644 | 13:13:38 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5643.44 Median:5823.97 stddev:664.64 (11.4%) stddev-sans-first:625.45 13:13:38 INFO - PROCESS | 1644 | Values: 2705.7 3359.3 3405.8 3411.2 3475.1 4936.6 5266.6 5553.1 5601.6 5620.9 5579.4 5631.1 5655.9 5670.2 5675.9 5079.5 5086.0 5098.1 5158.4 5226.7 3989.7 4578.8 5052.8 5082.0 5123.6 5075.8 5152.1 5155.7 5168.1 5192.1 5130.4 5139.7 5140.3 5143.5 5179.2 4976.0 4982.7 5082.4 5088.8 5104.7 5517.2 5554.5 5557.4 5614.2 5621.2 6098.3 6120.7 6156.6 6170.8 6172.9 6213.0 6249.9 6250.2 6261.6 6262.2 5556.9 5622.3 5629.2 5668.2 5673.9 6280.3 6286.0 6323.6 6330.3 6346.2 5944.8 6027.5 6030.8 6049.9 6071.8 6060.3 6125.8 6133.2 6145.1 6152.0 6041.2 6079.9 6101.8 6143.6 6151.1 6106.6 6156.0 6157.7 6175.4 6182.2 4835.9 4882.1 4926.3 4936.9 4968.7 4312.8 4420.6 4449.2 4474.1 4479.0 5591.4 5661.1 5669.4 5672.9 5691.8 6050.5 6161.6 6208.2 6223.8 6223.8 5552.1 5611.9 5636.2 5660.8 5668.9 5294.5 5316.0 5357.4 5368.7 5413.3 6261.2 6303.1 6314.8 6318.7 6327.0 4723.4 6063.3 6214.6 6251.0 6258.9 6169.6 6208.1 6223.6 6232.3 6269.5 6095.3 6136.2 6154.4 6170.3 6177.1 6227.1 6241.5 6253.8 6256.7 6268.5 5710.2 5747.3 5894.8 5970.6 6081.2 5205.8 5948.7 5959.4 5978.9 6019.9 5815.0 5862.9 5873.9 5878.3 5880.0 5808.4 5988.6 6057.4 6063.8 6074.1 5778.4 5824.0 5827.4 5872.4 5895.9 13:13:38 INFO - PROCESS | 1644 | 13:13:38 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:69186.51 Median:19318.73 stddev:152011.97 (786.9%) stddev-sans-first:152350.85 13:13:38 INFO - PROCESS | 1644 | Values: 471.7 518.2 525.6 553.6 571.7 30559.5 32571.7 32577.3 32593.0 32633.5 32582.8 33238.2 33264.8 39631.0 41847.6 9523.9 9729.5 9729.9 9730.9 9742.0 9598.7 9668.9 9674.8 9688.5 9692.1 8887.8 9062.8 9657.3 9725.7 11430.3 11346.9 11678.0 11681.1 11690.9 11691.9 11583.8 11664.1 11671.9 11675.2 11678.6 40308.0 40537.8 40602.0 40686.8 40846.6 3307.8 3338.8 3347.6 3538.3 3660.8 29730.3 30880.0 30907.8 31130.4 31264.0 3254.4 3284.5 3336.4 3339.0 3352.9 486194.0 486330.0 488822.0 489446.0 489928.0 59818.1 60211.0 60398.0 60436.0 60466.4 35099.1 35717.5 35881.8 36471.1 36493.6 17261.9 17428.9 17443.0 17475.7 17491.3 13071.8 13135.1 13155.3 13159.5 13169.9 19259.2 19262.7 19268.6 19286.6 19307.7 6379.0 7188.3 7617.2 7830.6 7874.4 759.3 998.0 1000.3 1006.8 1027.9 27600.6 29655.0 29692.0 30191.7 30393.0 923.3 1060.9 1073.1 1079.7 1092.5 14896.9 15677.3 15819.5 15972.4 16071.7 626133.0 626657.0 628491.3 629786.0 631521.0 58448.0 59060.4 59095.7 59268.1 59309.3 1263.7 1294.6 1377.5 1389.2 1425.1 29071.4 31285.0 31912.9 32381.7 32560.0 55800.0 56432.4 56540.4 56586.7 56778.0 572305.0 580989.0 581332.0 581673.0 586930.0 24180.0 24608.9 27259.0 27699.9 27713.0 46123.5 46947.5 47330.5 48908.0 49704.0 34505.8 35639.5 37774.9 37936.8 39781.0 34757.0 36339.6 38918.0 39070.8 39206.8 30439.8 36727.4 37052.6 37339.0 37801.2 31878.7 34610.8 34941.3 35425.0 35723.9 25513.5 25629.0 25793.2 26133.2 26589.9 13:13:38 INFO - PROCESS | 1644 | 13:13:38 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:33321.09 Median:14389.13 stddev:93322.40 (648.6%) stddev-sans-first:93551.40 13:13:38 INFO - PROCESS | 1644 | Values: 370.8 380.1 389.1 401.2 410.3 19218.8 19675.9 21236.4 21465.7 21519.4 10071.8 11621.5 12184.8 12188.3 18108.3 5215.1 5494.3 5495.4 5505.4 5512.9 3289.3 4110.0 4198.2 4227.6 5334.4 6644.2 6705.6 6715.7 6720.7 6727.5 6440.8 6659.2 6691.9 6704.6 6716.8 5695.6 5922.0 5941.2 5942.0 5944.2 11389.7 13636.1 22622.8 24928.0 25489.0 2188.1 2279.1 2346.3 2376.3 2406.6 9994.0 14872.2 15327.7 15583.2 15667.8 1819.4 1865.8 1903.7 1936.4 1952.9 108425.5 115935.0 119138.0 123751.0 129443.0 11161.9 11375.5 11414.6 11643.7 11814.2 14958.9 14968.2 14978.3 15002.8 15031.0 8594.0 8838.0 8875.9 8960.6 9012.5 8779.6 8798.7 8817.7 8966.0 8968.9 4117.9 4185.9 4593.2 4679.0 4697.2 1761.9 1826.9 1874.9 1905.0 2024.1 867.2 880.4 905.7 921.8 967.7 20614.8 21913.8 21925.7 21951.0 21955.6 843.4 850.8 953.2 954.4 1000.4 10600.9 11488.7 11488.8 11558.3 11564.8 550613.0 554430.0 555784.0 557829.0 573219.0 76266.0 93377.0 121065.4 132547.0 134660.7 953.1 966.2 995.1 996.5 998.8 19053.0 19749.5 19942.8 19957.1 20052.9 35886.0 54082.7 54757.8 56135.7 56847.7 77280.0 78049.2 79171.2 79498.0 79691.0 5518.6 7964.4 8044.8 8076.5 8400.7 10650.4 12462.5 12818.6 13399.0 13516.7 11134.3 11154.8 11155.0 11483.3 11517.9 11142.8 11365.9 11428.4 11807.7 11811.0 11363.1 11366.1 11613.8 11731.2 11801.7 8303.4 8409.6 8424.0 8541.1 8569.1 7909.0 9477.3 10792.9 10904.5 10973.7 13:13:38 INFO - PROCESS | 1644 | 13:13:38 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5440.99 Median:5197.34 stddev:2978.50 (57.3%) stddev-sans-first:2971.19 13:13:38 INFO - PROCESS | 1644 | Values: 1376.3 1498.0 1681.4 1866.0 1888.9 7921.5 8323.4 8327.0 8331.9 8336.5 7025.2 7485.9 7759.8 8118.4 8291.2 2213.7 2351.6 2387.4 2388.2 2392.1 2140.3 2162.5 2190.3 2227.8 2260.9 2018.2 2308.9 2361.2 2374.7 2388.9 2338.0 2343.4 2362.4 2364.9 2370.0 2376.4 2387.4 2390.4 2391.1 2393.6 8235.4 8426.8 8443.9 8445.3 8446.2 5078.4 5257.7 5259.4 5263.6 5268.2 2962.5 3279.3 3330.7 3588.7 3591.5 1064.4 1064.6 1080.3 1099.4 1120.6 10860.5 10985.6 11024.3 11035.9 11079.7 4489.0 4596.0 4692.6 4708.4 4734.4 9449.9 9454.5 9461.6 9465.5 9494.2 5187.1 5207.5 5208.2 5210.6 5211.4 4324.9 4456.5 4553.9 4773.0 4784.3 3798.6 3831.7 3884.9 3931.0 3938.0 1267.2 1269.3 1277.0 1287.7 1287.8 755.5 839.5 886.3 903.9 912.9 5475.5 5497.1 5544.9 5698.5 5884.1 958.7 965.9 993.1 1013.5 1032.3 3585.6 3630.8 3663.7 3767.2 3784.1 9814.2 10159.0 10175.7 10205.7 10247.5 9589.7 9970.6 9971.6 10115.4 10131.4 7672.3 7886.8 7888.9 7894.1 7902.4 4666.7 5428.2 5454.5 5592.9 5637.4 9054.4 9071.1 9262.5 9294.4 9389.4 9323.0 9396.4 9559.7 9565.0 9663.0 6573.3 6662.9 6849.9 7198.7 7373.5 7860.5 8125.6 8126.1 8133.4 8137.7 7109.5 7197.0 7212.7 7231.4 7348.4 6982.6 7059.4 7082.8 7188.3 7206.2 6519.7 6539.6 6607.4 6612.8 6613.1 4665.2 4681.8 4750.1 4755.2 4755.6 4608.4 4682.9 4691.0 4889.2 4924.5 13:13:38 INFO - PROCESS | 1644 | 13:13:38 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4395.80 Median:4788.76 stddev:1326.32 (27.7%) stddev-sans-first:1293.20 13:13:38 INFO - PROCESS | 1644 | Values: 259.8 314.7 318.0 322.9 328.6 4741.8 5268.8 5308.6 5339.8 5356.6 4472.5 4709.9 5162.5 5205.1 5286.4 3905.3 3975.1 4007.8 4009.6 4013.2 3869.8 4022.5 4076.6 4084.2 4111.8 3610.4 3851.7 3960.4 4000.8 4032.2 3494.8 3522.4 3847.7 4045.0 4086.9 3159.7 3276.0 3591.7 3617.9 3624.6 4270.6 4901.4 5217.3 5225.2 5247.5 4429.5 4616.7 4682.7 4696.6 4727.3 5268.0 5557.6 5561.7 5609.2 5622.4 3940.7 3949.3 3957.5 4006.2 4010.9 4617.7 5379.9 5696.3 5765.0 5837.2 3520.8 3832.8 3992.3 4003.6 4005.5 3390.3 3489.7 3939.2 3994.1 4081.9 4415.9 4670.6 4675.8 4692.6 4720.7 5608.8 5622.7 5632.2 5632.8 5651.7 1267.8 1303.8 1327.5 1338.2 1359.8 788.3 836.7 868.7 908.8 920.5 4578.9 4841.2 4852.6 4877.5 4936.9 4639.0 4865.5 5274.6 5340.9 5383.5 4792.4 4890.0 4898.4 5328.5 5333.0 2618.7 2752.8 2864.8 2904.8 2906.4 4115.9 5474.8 5637.3 5684.7 5744.8 5227.5 5545.9 5611.0 5663.3 5681.4 5103.8 5581.0 5648.3 5760.8 5768.4 5230.7 5479.5 5487.8 5492.5 5525.3 4601.5 4746.5 4748.0 5455.9 5466.7 5125.8 5693.2 5730.5 5746.3 5784.7 3135.5 3296.2 3309.8 3503.9 3602.6 4480.6 5014.3 5419.6 5454.1 5458.0 4832.4 5244.8 5284.4 5315.5 5362.4 3983.4 4442.9 4629.0 4699.5 4715.4 4615.5 5159.4 5184.7 5221.6 5359.2 4706.6 4785.1 4802.5 5381.3 5475.0 4710.4 5403.4 5427.4 5439.9 5460.8 13:13:38 INFO - PROCESS | 1644 | 13:13:38 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20391.19 Median:4561.26 stddev:29857.61 (654.6%) stddev-sans-first:29904.83 13:13:38 INFO - PROCESS | 1644 | Values: 717.5 760.0 769.0 828.7 831.6 14139.1 15329.2 15356.3 15384.8 15387.6 13766.1 13953.7 13961.8 13967.7 14015.4 688.3 709.0 836.5 852.8 870.4 802.3 838.5 849.1 853.9 855.2 910.8 917.0 919.1 920.2 921.1 908.1 908.8 909.5 914.9 915.3 678.6 680.7 684.3 686.7 687.2 14114.2 14134.4 14166.4 14167.6 14816.6 13885.5 14218.3 14229.9 14254.2 14331.0 11418.3 11425.0 11667.9 11670.5 11679.4 3666.5 3713.6 3768.7 3873.3 3951.8 90111.0 92806.1 93399.0 93576.0 95543.0 10332.3 10475.8 10591.5 10746.5 10761.8 19528.8 19772.9 19799.8 20075.8 20076.8 6679.6 7643.4 7687.0 7734.5 7793.8 4274.4 4277.1 4462.8 4534.4 4536.0 3453.9 3570.7 3572.2 3573.5 3573.8 656.3 657.3 657.3 680.7 686.3 625.7 642.0 671.9 683.6 692.7 9112.3 9163.4 9274.6 9365.8 9419.9 586.6 631.5 657.6 692.7 696.1 4419.4 4586.6 4604.3 4618.2 4624.7 110857.0 111267.4 112436.4 112732.0 113319.4 64759.0 70819.6 72763.0 96540.1 96661.5 66259.7 88034.6 89458.6 90229.1 91219.5 8791.2 8873.9 8929.5 9004.4 9009.7 55967.0 56186.2 56433.0 57547.7 57849.8 61279.1 69273.0 81006.0 81486.0 82317.1 11098.4 11466.3 11519.9 11667.7 11968.6 12509.8 12663.4 13008.3 13202.7 13623.6 12144.5 12178.9 12191.1 12506.9 12588.2 11817.6 11939.6 11996.3 12027.7 12162.1 10149.6 12124.6 12141.4 12195.0 12463.2 10612.7 10839.3 11471.0 11607.5 11769.0 10092.4 11458.2 11460.7 11648.5 11676.5 13:13:38 INFO - PROCESS | 1644 | -------- Summary: end -------- 13:13:38 INFO - PROCESS | 1644 | 13:13:39 INFO - TEST-INFO | 1644: exit 0 13:13:39 INFO - TEST-OK | dromaeo_css | took 1117026ms 13:13:39 INFO - TEST-START | kraken 13:13:39 INFO - operating with platform_type : mac_ 13:13:39 INFO - Initialising browser for kraken test... 13:13:39 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpzAnJkY/profile http://localhost:49243/getInfo.html) 13:13:41 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 13:13:41 INFO - PROCESS | 1654 | colorDepth:24 13:13:41 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 13:13:41 INFO - PROCESS | 1654 | __metrics 13:13:41 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" 13:13:41 INFO - PROCESS | 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:13:42 INFO - TEST-INFO | 1654: exit 0 13:13:42 INFO - Browser initialized. 13:13:42 INFO - Running cycle 1/1 for kraken test... 13:13:42 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpzAnJkY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:54 INFO - PROCESS | 1656 | RSS: Main: 167755776 13:13:54 INFO - PROCESS | 1656 | 13:13:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:58 INFO - PROCESS | 1656 | RSS: Main: 217964544 13:13:58 INFO - PROCESS | 1656 | 13:14:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 13:14:01 INFO - PROCESS | 1656 | RSS: Main: 232407040 13:14:01 INFO - PROCESS | 1656 | 13:14:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 13:14:05 INFO - PROCESS | 1656 | RSS: Main: 327933952 13:14:05 INFO - PROCESS | 1656 | 13:14:07 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 13:14:07 INFO - PROCESS | 1656 | RSS: Main: 231329792 13:14:07 INFO - PROCESS | 1656 | 13:14:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:10 INFO - PROCESS | 1656 | RSS: Main: 233766912 13:14:10 INFO - PROCESS | 1656 | 13:14:13 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:13 INFO - PROCESS | 1656 | RSS: Main: 273850368 13:14:13 INFO - PROCESS | 1656 | 13:14:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:17 INFO - PROCESS | 1656 | RSS: Main: 273453056 13:14:17 INFO - PROCESS | 1656 | 13:14:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 13:14:20 INFO - PROCESS | 1656 | RSS: Main: 271622144 13:14:20 INFO - PROCESS | 1656 | 13:14:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:22 INFO - PROCESS | 1656 | RSS: Main: 248360960 13:14:22 INFO - PROCESS | 1656 | 13:14:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:25 INFO - PROCESS | 1656 | RSS: Main: 248365056 13:14:25 INFO - PROCESS | 1656 | 13:14:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:28 INFO - PROCESS | 1656 | RSS: Main: 249876480 13:14:28 INFO - PROCESS | 1656 | 13:14:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:31 INFO - PROCESS | 1656 | RSS: Main: 267870208 13:14:31 INFO - PROCESS | 1656 | 13:14:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:35 INFO - PROCESS | 1656 | RSS: Main: 260579328 13:14:35 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 13:14:37 INFO - PROCESS | 1656 | RSS: Main: 304779264 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | __start_tp_report 13:14:37 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 13:14:37 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 13:14:37 INFO - PROCESS | 1656 | |i|pagename|runs| 13:14:37 INFO - PROCESS | 1656 | |0;ai-astar;105;115;114;114;114;117;113;114;109;92 13:14:37 INFO - PROCESS | 1656 | |1;audio-beat-detection;140;109;108;138;109;104;110;107;136;109 13:14:37 INFO - PROCESS | 1656 | |2;audio-dft;181;180;180;184;183;180;183;179;179;181 13:14:37 INFO - PROCESS | 1656 | |3;audio-fft;82;74;81;111;70;58;59;58;81;57 13:14:37 INFO - PROCESS | 1656 | |4;audio-oscillator;90;71;92;69;67;69;87;68;69;89 13:14:37 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;93;130;87;89;134;84;89;85;90;130 13:14:37 INFO - PROCESS | 1656 | |6;imaging-darkroom;95;95;96;96;96;95;97;96;96;96 13:14:37 INFO - PROCESS | 1656 | |7;imaging-desaturate;81;84;80;79;83;82;84;98;126;84 13:14:37 INFO - PROCESS | 1656 | |8;json-parse-financial;55;53;53;53;58;59;57;56;56;56 13:14:37 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;64;70;89;118;109;67;66;66;68;68 13:14:37 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;81;82;82;91;101;102;75;81;81;80 13:14:37 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;137;133;132;135;140;134;176;149;178;138 13:14:37 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;160;162;160;160;160;162;162;160;159;159 13:14:37 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;68;82;85;58;79;84;71;64;65 13:14:37 INFO - PROCESS | 1656 | __end_tp_report 13:14:37 INFO - PROCESS | 1656 | __start_cc_report 13:14:37 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1987 13:14:37 INFO - PROCESS | 1656 | __end_cc_report 13:14:37 INFO - PROCESS | 1656 | __startTimestamp1486674877254__endTimestamp 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | ------- Summary: start ------- 13:14:37 INFO - PROCESS | 1656 | Number of tests: 14 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:110.70 Median:114.00 stddev:7.39 (6.5%) stddev-sans-first:7.55 13:14:37 INFO - PROCESS | 1656 | Values: 105.0 115.0 114.0 114.0 114.0 117.0 113.0 114.0 109.0 92.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:109.50 stddev:14.61 (13.3%) stddev-sans-first:12.91 13:14:37 INFO - PROCESS | 1656 | Values: 140.0 109.0 108.0 138.0 109.0 104.0 110.0 107.0 136.0 109.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:181.00 Median:181.00 stddev:1.76 (1.0%) stddev-sans-first:1.87 13:14:37 INFO - PROCESS | 1656 | Values: 181.0 180.0 180.0 184.0 183.0 180.0 183.0 179.0 179.0 181.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:73.10 Median:72.00 stddev:16.88 (23.4%) stddev-sans-first:17.60 13:14:37 INFO - PROCESS | 1656 | Values: 82.0 74.0 81.0 111.0 70.0 58.0 59.0 58.0 81.0 57.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:79.00 stddev:10.79 (13.7%) stddev-sans-first:10.38 13:14:37 INFO - PROCESS | 1656 | Values: 90.0 71.0 92.0 69.0 67.0 69.0 87.0 68.0 69.0 89.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:101.10 Median:88.00 stddev:21.04 (23.9%) stddev-sans-first:22.11 13:14:37 INFO - PROCESS | 1656 | Values: 93.0 130.0 87.0 89.0 134.0 84.0 89.0 85.0 90.0 130.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 13:14:37 INFO - PROCESS | 1656 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 97.0 96.0 96.0 96.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:88.10 Median:83.50 stddev:14.33 (17.2%) stddev-sans-first:14.96 13:14:37 INFO - PROCESS | 1656 | Values: 81.0 84.0 80.0 79.0 83.0 82.0 84.0 98.0 126.0 84.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:2.12 (3.8%) stddev-sans-first:2.24 13:14:37 INFO - PROCESS | 1656 | Values: 55.0 53.0 53.0 53.0 58.0 59.0 57.0 56.0 56.0 56.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:67.50 stddev:19.86 (29.4%) stddev-sans-first:20.36 13:14:37 INFO - PROCESS | 1656 | Values: 64.0 70.0 89.0 118.0 109.0 67.0 66.0 66.0 68.0 68.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:81.00 stddev:9.24 (11.4%) stddev-sans-first:9.65 13:14:37 INFO - PROCESS | 1656 | Values: 81.0 82.0 82.0 91.0 101.0 102.0 75.0 81.0 81.0 80.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:139.00 stddev:17.44 (12.5%) stddev-sans-first:18.24 13:14:37 INFO - PROCESS | 1656 | Values: 137.0 133.0 132.0 135.0 140.0 134.0 176.0 149.0 178.0 138.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 13:14:37 INFO - PROCESS | 1656 | Values: 160.0 162.0 160.0 160.0 160.0 162.0 162.0 160.0 159.0 159.0 13:14:37 INFO - PROCESS | 1656 | 13:14:37 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:75.00 stddev:9.50 (12.7%) stddev-sans-first:9.88 13:14:37 INFO - PROCESS | 1656 | Values: 67.0 68.0 82.0 85.0 58.0 79.0 84.0 71.0 64.0 65.0 13:14:37 INFO - PROCESS | 1656 | -------- Summary: end -------- 13:14:37 INFO - PROCESS | 1656 | 13:14:38 INFO - TEST-INFO | 1656: exit 0 13:14:38 INFO - TEST-OK | kraken | took 59044ms 13:14:38 INFO - SUITE-END | took 1176s 13:14:38 INFO - Completed test suite (00:19:36) 13:14:38 INFO - javascript benchmark 13:14:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2705.7158998305176, 3359.2945481448896, 3405.7956522608647, 3411.249525104476, 3475.0617333320006, 4936.593070974773, 5266.552343050846, 5553.111502159655, 5601.579881508887, 5620.943790562093, 5579.442055794419, 5631.099024156136, 5655.886882262353, 5670.206171136034, 5675.943240567593, 5079.517445842639, 5085.974570127144, 5098.107831129556, 5158.3552055993005, 5226.660267082647, 3989.700772442064, 4578.786621545277, 5052.823151189709, 5081.974590127063, 5123.564497017758, 5075.796968121271, 5152.098382783017, 5155.664881782691, 5168.095583272931, 5192.091384007803, 5130.358705161855, 5139.717315547643, 5140.3060586820675, 5143.537081662668, 5179.223116532513, 4976.02967421353, 4982.651214414992, 5082.440931497532, 5088.771005304733, 5104.719240441774, 5517.227588137624, 5554.50009499143, 5557.360903496069, 5614.1859430382365, 5621.18492818539, 6098.298695650013, 6120.693965301717, 6156.5998210116195, 6170.7531698732, 6172.9074063889075, 6213.03697926822, 6249.87500249997, 6250.1874756281395, 6261.592996455216, 6262.2172228471445, 5556.9444305556835, 5622.297212848435, 5629.24005259293, 5668.234788303526, 5673.943260567424, 6280.340564240781, 6285.994240921431, 6323.588966717149, 6330.335314791972, 6346.17499725042, 5944.791932282349, 6027.547933904974, 6030.7889223876955, 6049.909251361233, 6071.787487437919, 6060.333363330118, 6125.816225513242, 6133.172021777093, 6145.0782382642965, 6151.954167791486, 6041.214642096587, 6079.939200608026, 6101.755929762849, 6143.600665956698, 6151.108089327112, 6106.572539922163, 6155.984262596711, 6157.6613286269685, 6175.44421002112, 6182.165407669997, 4835.903281934342, 4882.145624515695, 4926.3349447824085, 4936.925946110811, 4968.677035992721, 4312.827486900552, 4420.557944205554, 4449.154660614473, 4474.082813023322, 4479.0, 5591.384947655754, 5661.122526008476, 5669.40471250521, 5672.914906276409, 5691.772329106872, 6050.48570871472, 6161.599496032743, 6208.192934918432, 6223.751049958041, 6223.782167624111, 5552.139418390156, 5611.915821262684, 5636.239107720406, 5660.773569057192, 5668.943310566841, 5294.523492885659, 5316.016536940679, 5357.4106848246665, 5368.731563421813, 5413.269208656781, 6261.217347831521, 6303.117563541108, 6314.84212894663, 6318.684065796691, 6326.9876819708625, 4723.385959825201, 6063.2956205653145, 6214.564980451325, 6250.968745156245, 6258.874822503615, 6169.56813023084, 6208.0998255253635, 6223.564350495421, 6232.25212974446, 6269.4984401246875, 6095.329513753395, 6136.161982713028, 6154.415330543591, 6170.290416602148, 6177.135201071944, 6227.128202051807, 6241.531885108726, 6253.78111766086, 6256.749730010749, 6268.529860260407, 5710.200571919851, 5747.3103227612955, 5894.764209431574, 5970.641761494324, 6081.179040829608, 5205.843824685266, 5948.672822994777, 5959.374265702038, 5978.910316345171, 6019.939800601938, 5814.982378083903, 5862.882742345215, 5873.911891321719, 5878.3239927408895, 5879.970600146972, 5808.419158084327, 5988.580799344004, 6057.42454466825, 6063.757449701962, 6074.088886667036, 5778.422157784188, 5823.970880145572, 5827.358990510956, 5872.354041055566, 5895.94104058954], "value": 5600.095544098483, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.6509782760757, 518.1657531374487, 525.5585308340993, 553.6207697727057, 571.6598623818832, 30559.541606875915, 32571.67428325719, 32577.348453030983, 32593.022209333758, 32633.51049734253, 32582.83708581454, 33238.169045773866, 33264.83367583165, 39631.0, 41847.58152418475, 9523.904760952406, 9729.464879431629, 9729.854052189223, 9730.854037189412, 9742.0, 9598.712038638852, 9668.854967175497, 9674.758131046745, 9688.46713430761, 9692.127708506234, 8887.77780555488, 9062.818743625123, 9657.32398732089, 9725.708228753114, 11430.314181149117, 11346.943265283704, 11678.0, 11681.065514758799, 11690.947814696676, 11691.94154029233, 11583.76832463346, 11664.125190610737, 11671.949524542748, 11675.182737208399, 11678.591249306319, 40308.0, 40537.79731101326, 40602.0, 40686.79656601698, 40846.59153408487, 3307.751918606114, 3338.833058347073, 3347.6484969078383, 3538.327717733622, 3660.835262413171, 29730.305990390443, 30880.0, 30907.845460772776, 31130.377392452025, 31264.0, 3254.3816674831705, 3284.540164376989, 3336.3660904428325, 3339.0, 3352.8658853645825, 486194.0, 486330.0, 488822.0, 489446.0, 489928.0, 59818.10272845911, 60211.0, 60398.0, 60436.0, 60466.39533604607, 35099.122521936646, 35717.46423803645, 35881.8205908974, 36471.08822279464, 36493.635063649555, 17261.91369043147, 17428.912855435894, 17442.95342279467, 17475.650486990442, 17491.300347985936, 13071.803922941164, 13135.080544361803, 13155.276459794803, 13159.47362105505, 13169.868301317056, 19259.22963081489, 19262.71105933412, 19268.614627707648, 19286.614267714565, 19307.744996575177, 6378.968105159444, 7188.281171882874, 7617.162112167657, 7830.608469576612, 7874.370050395954, 759.3242014607005, 997.9501024948723, 1000.2748007694508, 1006.8288390973552, 1027.912627426662, 27600.585991210148, 29655.0, 29692.0, 30191.698083019328, 30393.0, 923.3490389275545, 1060.8833028367028, 1073.1146803886825, 1079.6599071292517, 1092.4537731134433, 14896.851031489763, 15677.29452174655, 15819.52541423759, 15972.380452334597, 16071.678566428605, 626133.0, 626657.0, 628491.2877178015, 629786.0, 631521.0, 58448.0, 59060.409395906354, 59095.70452147712, 59268.11097833536, 59309.25525957913, 1263.747250549912, 1294.5598496511232, 1377.4903285784324, 1389.1526169036879, 1425.0879437160227, 29071.41857162887, 31285.021658784146, 31912.88304909317, 32381.676183237865, 32560.0, 55800.0, 56432.435675642715, 56540.43459565352, 56586.71706641605, 56778.0, 572305.0, 580989.0, 581332.0, 581673.0, 586930.0, 24180.032798687855, 24608.876955615106, 27259.0, 27699.89200432041, 27713.030043948365, 46123.53876461193, 46947.53052469432, 47330.52669473399, 48908.0, 49704.0, 34505.82747086349, 35639.465408019416, 37774.86675399743, 37936.81031594824, 39781.0, 34756.9572912813, 36339.636603633626, 38918.027049323995, 39070.80464597659, 39206.80396597999, 30439.847800760854, 36727.449088263165, 37052.62947370492, 37339.0, 37801.243975120895, 31878.68121318757, 34610.82694586511, 34941.301173976884, 35425.0, 35723.92828215157, 25513.48973020492, 25629.0, 25793.226203213933, 26133.216003519923, 26589.867050664623], "value": 19829.542787149185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.83497843459656, 380.1408816075668, 389.1089405261951, 401.1835913915183, 410.25129139320745, 19218.807811921877, 19675.901620491913, 21236.362909112733, 21465.67801482979, 21519.354419367424, 10071.798564028715, 11621.47703353349, 12184.81722774159, 12188.268703877773, 18108.275668973227, 5215.087359712054, 5494.313210848644, 5495.395506494302, 5505.421930697279, 5512.862178445531, 3289.259916518788, 4110.034141976633, 4198.244316023115, 4227.556106608808, 5334.386545547253, 6644.169478815148, 6705.564138331018, 6715.731370745164, 6720.697568609425, 6727.4618030557685, 6440.77457288995, 6659.167604049518, 6691.866162676743, 6704.597724136567, 6716.798496045127, 5695.629784064023, 5921.970390148022, 5941.22764040672, 5941.970290148565, 5944.227250457456, 11389.658310250707, 13636.113652612648, 22622.77377226223, 24928.0, 25489.0, 2188.113813905371, 2279.133929106929, 2346.2961111666605, 2376.2871138658334, 2406.554787364326, 9993.950030249802, 14872.182029988346, 15327.693446131127, 15583.220838958006, 15667.764983525141, 1819.426880532628, 1865.766779152606, 1903.666858299792, 1936.4190742777112, 1952.8925909074994, 108425.45787271092, 115935.0, 119138.0, 123751.0, 129442.99999999905, 11161.888381116247, 11375.544978200945, 11414.600488983011, 11643.708907277385, 11814.173007889365, 14958.850411495963, 14968.176750278839, 14978.325975331136, 15002.774958375632, 15031.0, 8593.957030214933, 8837.955810220908, 8875.866861997076, 8960.551972401354, 9012.54937253148, 8779.648814047494, 8798.692045778367, 8817.691380801642, 8966.0, 8968.865467018, 4117.8675864137, 4185.916281674349, 4593.150267200579, 4679.0, 4697.248440249612, 1761.8812054345326, 1826.8721189516607, 1874.8563376340421, 1904.9897573156713, 2024.0588126521238, 867.1805144138855, 880.3837313880309, 905.6965916417942, 921.8202450522218, 967.6806653804227, 20614.793852061586, 21913.780862191175, 21925.671114933288, 21951.0, 21955.560888782136, 843.3632607381388, 850.8213275212152, 953.2231231546267, 954.4178051388648, 1000.4097582426404, 10600.893991060146, 11488.712782180346, 11488.827667584992, 11558.30650160993, 11564.768704626029, 550613.0, 554430.0, 555784.0, 557829.0, 573219.0, 76266.0, 93377.0, 121065.39467302606, 132547.0, 134660.65339346678, 953.1040821627648, 966.1980556138528, 995.1342332171057, 996.4753926492479, 998.7852611688377, 19053.0, 19749.506262343555, 19942.800571994674, 19957.101930412875, 20052.89973550123, 35886.0, 54082.729586351816, 54757.80968761205, 56135.719321404766, 56847.71576142093, 77280.0, 78049.2195078042, 79171.20828791638, 79498.0, 79691.0, 5518.613697041169, 7964.442489025712, 8044.758657240292, 8076.4750291230885, 8400.747977560683, 10650.360978341325, 12462.501499940263, 12818.55135070268, 13399.0, 13516.662083447993, 11134.33194008362, 11154.776904462027, 11155.0, 11483.25358851672, 11517.884821151682, 11142.83285750698, 11365.886341136484, 11428.371439570903, 11807.704807379885, 11811.0, 11363.090952723596, 11366.090712742794, 11613.767724645291, 11731.178817483036, 11801.704957376134, 8303.418760686694, 8409.62156702962, 8423.957880210559, 8541.103184165822, 8569.071958809218, 7909.0, 9477.289203309918, 10792.892071079503, 10904.50929708181, 10973.670789876316], "value": 9444.826104834778, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.2568213164889, 1497.9963424505577, 1681.3946979087527, 1866.0, 1888.9433317000487, 7921.524708517486, 8323.417360784731, 8326.95913010873, 8331.91668083319, 8336.499810011404, 7025.156981162268, 7485.850282994337, 7759.767206983785, 8118.391120665959, 8291.170882911705, 2213.7492316841012, 2351.576716191081, 2387.3912152401113, 2388.176079252655, 2392.0790495659207, 2140.3364956863343, 2162.4701948022757, 2190.277208521184, 2227.8329125315668, 2260.9095636174616, 2018.2028098900926, 2308.9307320780404, 2361.244401791427, 2374.6794182785275, 2388.856668599881, 2337.9532409351887, 2343.4024323797494, 2362.385779697274, 2364.8817559121976, 2369.988150059256, 2376.3821406434276, 2387.438951846315, 2390.426297688542, 2391.1152873436768, 2393.628987506939, 8235.423520353577, 8426.831463370698, 8443.944506936632, 8445.324374050062, 8446.197611226924, 5078.4413714491375, 5257.737113144328, 5259.421463638997, 5263.578913686896, 5268.236105764643, 2962.5111856543645, 3279.2785587170783, 3330.6502817204087, 3588.7129029677562, 3591.497190393347, 1064.3720205078964, 1064.5688496159069, 1080.3355936099322, 1099.4173088263233, 1120.6077872744556, 10860.45697715119, 10985.61550345742, 11024.338539687644, 11035.889641103566, 11079.667609971713, 4488.955110448919, 4595.954040459619, 4692.6245900327895, 4708.387909571734, 4734.4081989751285, 9449.858252126223, 9454.48000359973, 9461.574229159567, 9465.479398633004, 9494.240460763122, 5187.144121220032, 5207.5313221809465, 5208.192730126836, 5210.557102646242, 5211.374635043819, 4324.870253892388, 4456.487503937089, 4553.908921821545, 4772.976135119302, 4784.258439941815, 3798.582155962842, 3831.6934645228316, 3884.941725874114, 3930.9803450982563, 3937.9803100984313, 1267.207995003123, 1269.320913311374, 1276.9553065642658, 1287.7038281195378, 1287.8003909394058, 755.527795128045, 839.4837175137246, 886.2998231397124, 903.909609039104, 912.9087091290818, 5475.534579560703, 5497.092979658311, 5544.944550554443, 5698.544116470673, 5884.117382392676, 958.726762872578, 965.8937516873139, 993.0615568288043, 1013.5185786751234, 1032.339302846179, 3585.6414358563934, 3630.8184590770356, 3663.725220608465, 3767.171222331083, 3784.110733977513, 9814.214862810957, 10159.0, 10175.694729158136, 10205.744856378502, 10247.487625618689, 9589.712308630613, 9970.551325190383, 9971.551280192263, 10115.39307641544, 10131.442770647538, 7672.309492145734, 7886.763397098096, 7888.881666775118, 7894.131645518988, 7902.367810575255, 4666.696664716783, 5428.185772134211, 5454.536364409069, 5592.881423715355, 5637.351704554028, 9054.411463254868, 9071.138241867013, 9262.536873156181, 9294.395864268801, 9389.38968967015, 9323.02108278621, 9396.436213827192, 9559.713208603753, 9565.04349565038, 9662.951685241529, 6573.276939536551, 6662.933370666426, 6849.8972515411315, 7198.71205151788, 7373.483856130019, 7860.528368297921, 8125.634346454542, 8126.146754590919, 8133.389995750224, 8137.674493020213, 7109.466789990668, 7197.0, 7212.74755383559, 7231.3853322466075, 7348.448866334939, 6982.581045137308, 7059.399951004222, 7082.822929426806, 7188.28117188277, 7206.171290301682, 6519.706613202512, 6539.607623542603, 6607.438367738604, 6612.801615951529, 6613.074169616161, 4665.160271151225, 4681.765911704333, 4750.12122757291, 4755.239161734106, 4755.643326750438, 4608.446986361658, 4682.906341873211, 4690.9914368410955, 4889.193283108248, 4924.532169443897], "value": 4425.041333167836, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.83760149906306, 314.7419116324613, 318.0300084741538, 322.9483282674772, 328.5712145649929, 4741.786619602118, 5268.8155914542995, 5308.575313974882, 5339.759710813013, 5356.598255130871, 4472.546422412713, 4709.9058018839605, 5162.5095615916525, 5205.089109405858, 5286.4449232830575, 3905.258000979819, 3975.1118218846104, 4007.779572123532, 4009.5789942056103, 4013.177298653769, 3869.806509674519, 4022.4971878515184, 4076.5719599442077, 4084.2035803018425, 4111.814968326417, 3610.368185567515, 3851.691864650821, 3960.4257382679493, 4000.819758171332, 4032.1935612877396, 3494.7903125812277, 3522.4011917974008, 3847.7110168093723, 4044.9685330240745, 4086.8569600064, 3159.6571457130626, 3275.9516954574547, 3591.7306202034692, 3617.8914632561064, 3624.6012938576737, 4270.615644592001, 4901.362822833009, 5217.295665085203, 5225.190095535198, 5247.47525247476, 4429.490608580022, 4616.676832621718, 4682.695624784412, 4696.600788932945, 4727.29817265784, 5267.999080174754, 5557.5553955683445, 5561.749721262553, 5609.242752228479, 5622.437756224385, 3940.6650434713083, 3949.269385163754, 3957.476371596927, 4006.2187873364705, 4010.859619913289, 4617.722936623813, 5379.946200537984, 5696.2594862668, 5765.0, 5837.241158649391, 3520.8239588020497, 3832.7508711933633, 3992.341263691458, 4003.599640035973, 4005.5193376794386, 3390.271091715293, 3489.7382696297877, 3939.1924655445564, 3994.121293315466, 4081.918361632751, 4415.933760993587, 4670.602998745077, 4675.7895894684825, 4692.565525578364, 4720.669553131316, 5608.775648974077, 5622.662640241599, 5632.211490391349, 5632.802851900164, 5651.660900345993, 1267.8415198100238, 1303.7913933770742, 1327.462377737018, 1338.2305174524492, 1359.8101661046585, 788.2905385153408, 836.6987884361625, 868.6926176104922, 908.8136931928939, 920.4995856753449, 4578.931316030262, 4841.160359063533, 4852.587530059985, 4877.487863774323, 4936.8765780855765, 4639.025804581008, 4865.537773911473, 5274.630775845654, 5340.91988620171, 5383.461653834664, 4792.400949881265, 4889.997550502138, 4898.4121905371585, 5328.547073498796, 5332.9733351333, 2618.7430033583605, 2752.8073034887766, 2864.756495697889, 2904.8257104573795, 2906.3579077820964, 4115.9176816463505, 5474.808381706621, 5637.323521177403, 5684.715764211773, 5744.770209191585, 5227.529522342931, 5545.889082218414, 5610.961972035187, 5663.292088488939, 5681.403452637496, 5103.770330335218, 5580.972095139498, 5648.265725455664, 5760.8190320984095, 5768.423157684198, 5230.712310822942, 5479.53423958968, 5487.780488780564, 5492.4507549246355, 5525.336959564878, 4601.469191944484, 4746.5490778376, 4747.982107604185, 5455.9454405455435, 5466.699331536644, 5125.846224613268, 5693.202951586864, 5730.541556675373, 5746.310442746897, 5784.652920824764, 3135.5453459247824, 3296.208909861664, 3309.768316217842, 3503.915170473564, 3602.6397360263763, 4480.61914737251, 5014.34813474246, 5419.617997410635, 5454.127339625641, 5457.990271799571, 4832.371791667061, 5244.76398562058, 5284.445133260952, 5315.548178404879, 5362.356517217959, 3983.402489626463, 4442.911486685783, 4628.9537104628525, 4699.459562150259, 4715.41057367829, 4615.538446155492, 5159.380874295109, 5184.740762961912, 5221.556167725634, 5359.222912677717, 4706.599939005086, 4785.114753770564, 4802.543758342952, 5381.300430943952, 5474.987127381447, 4710.387649605529, 5403.378611459732, 5427.430119837518, 5439.891202176013, 5460.781568737206], "value": 3976.950810500852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.4834119434006, 759.9658015389307, 769.0, 828.7430896422109, 831.6216121664643, 14139.08095973761, 15329.156896370696, 15356.308966096525, 15384.846151538495, 15387.615309617251, 13766.105203161787, 13953.720925581481, 13961.790573141385, 13967.720645587082, 14015.43938242469, 688.2738710660251, 709.0286307758378, 836.4521238588734, 852.8123812761214, 870.4385671242045, 802.2619190344897, 838.5471845203613, 849.1381248033251, 853.8804567360575, 855.2345650642671, 910.81328327693, 917.0233701108299, 919.0671468459519, 920.2453987730031, 921.0743203080895, 908.0510866144862, 908.8364094462994, 909.495230147268, 914.931380146485, 915.2677857713869, 678.6233640329615, 680.7141000779684, 684.2815044203616, 686.6772616870063, 687.1582311668217, 14114.153150810984, 14134.434622615083, 14166.362513686805, 14167.574972750834, 14816.62958426048, 13885.514007009808, 14218.289085545784, 14229.928850355682, 14254.216018119, 14331.0, 11418.257813242113, 11425.0, 11667.941660291644, 11670.474828632732, 11679.416029198506, 3666.5050218220467, 3713.628637136265, 3768.698504119664, 3873.341531939577, 3951.7826519541413, 90111.0, 92806.07193928042, 93399.0, 93576.0, 95543.0, 10332.328398654214, 10475.84286235707, 10591.470426478645, 10746.462676866126, 10761.83857242142, 19528.804711952984, 19772.90113549423, 19799.802001979795, 20075.799242007393, 20076.799232007786, 6679.599224046573, 7643.388528917673, 7687.0, 7734.5359278443475, 7793.844123117506, 4274.422952901381, 4277.144571085795, 4462.821487140543, 4534.433195850519, 4535.9546404536195, 3453.913652158666, 3570.696490798259, 3572.231970126383, 3573.5175751273246, 3573.8034408107283, 656.2617055812211, 657.2572992518519, 657.3426573426574, 680.6902859199053, 686.2862622872257, 625.6996641611961, 641.9903701444482, 671.9361660642231, 683.5932620091038, 692.7021380806201, 9112.316576256808, 9163.404378715362, 9274.629014839331, 9365.812683746422, 9419.905800941902, 586.642148289543, 631.5011141198494, 657.57914934442, 692.705600119947, 696.1194089476816, 4419.425474688334, 4586.564276393738, 4604.263317869192, 4618.1918164321105, 4624.745638989888, 110857.0, 111267.44366278117, 112436.4378178104, 112732.0, 113319.43340283411, 64759.0, 70819.64590177016, 72763.0, 96540.06919861563, 96661.51669241609, 66259.66870165618, 88034.55982720046, 89458.55270723604, 90229.09770902207, 91219.5439022814, 8791.164839340252, 8873.866891996755, 8929.464232146092, 9004.36969412135, 9009.729708108767, 55967.0, 56186.1572076411, 56433.0, 57547.71226143843, 57849.843003140544, 61279.08081378694, 69273.0, 81006.0, 81486.0, 82317.11890083818, 11098.445077746243, 11466.2546934449, 11519.94240028828, 11667.708307292385, 11968.581099661471, 12509.812352814533, 12663.438497410076, 13008.284544350152, 13202.735945281232, 13623.591292261248, 12144.453499592717, 12178.939105304416, 12191.146619736888, 12506.937465312616, 12588.181768185039, 11817.645470635895, 11939.582114626293, 11996.280223186637, 12027.699307517381, 12162.087843411957, 10149.644762433574, 12124.575639852563, 12141.392930353624, 12195.0, 12463.189892656948, 10612.681619551426, 10839.349639021684, 11471.0, 11607.477663504993, 11769.0, 10092.444915529717, 11458.19792614509, 11460.718908692423, 11648.534058637899, 11676.474558644712], "value": 7349.417601727953, "unit": "score"}], "name": "dromaeo_css", "value": 7168.228171141717, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 114.0, 114.0, 117.0, 113.0, 114.0, 109.0, 92.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 108.0, 138.0, 109.0, 104.0, 110.0, 107.0, 136.0, 109.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 180.0, 180.0, 184.0, 183.0, 180.0, 183.0, 179.0, 179.0, 181.0], "value": 181.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 81.0, 111.0, 70.0, 58.0, 59.0, 58.0, 81.0, 57.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 92.0, 69.0, 67.0, 69.0, 87.0, 68.0, 69.0, 89.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 130.0, 87.0, 89.0, 134.0, 84.0, 89.0, 85.0, 90.0, 130.0], "value": 101.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 80.0, 79.0, 83.0, 82.0, 84.0, 98.0, 126.0, 84.0], "value": 88.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 58.0, 59.0, 57.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 89.0, 118.0, 109.0, 67.0, 66.0, 66.0, 68.0, 68.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 91.0, 101.0, 102.0, 75.0, 81.0, 81.0, 80.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 132.0, 135.0, 140.0, 134.0, 176.0, 149.0, 178.0, 138.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 160.0, 162.0, 162.0, 160.0, 159.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 82.0, 85.0, 58.0, 79.0, 84.0, 71.0, 64.0, 65.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1441.5, "alertThreshold": 2.0}]} 13:14:38 INFO - Return code: 0 13:14:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:38 INFO - # TBPL SUCCESS # 13:14:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:14:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:14:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:14:38 INFO - 2017-02-09 13:14:38.601 screenresolution[1660:10075] starting screenresolution argv=screenresolution get 13:14:38 INFO - 2017-02-09 13:14:38.603 screenresolution[1660:10075] Display 0: 1600x1200x32@60 13:14:38 INFO - 2017-02-09 13:14:38.609 screenresolution[1661:10078] starting screenresolution argv=screenresolution list 13:14:38 INFO - Available Modes on Display 0 13:14:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:14:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:14:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:14:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:14:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:14:38 INFO - Intel Iris: 13:14:38 INFO - Chipset Model: Intel Iris 13:14:38 INFO - Type: GPU 13:14:38 INFO - Bus: Built-In 13:14:38 INFO - VRAM (Dynamic, Max): 1536 MB 13:14:38 INFO - Vendor: Intel (0x8086) 13:14:38 INFO - Device ID: 0x0a2e 13:14:38 INFO - Revision ID: 0x0009 13:14:38 INFO - Displays: 13:14:38 INFO - Display: 13:14:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:14:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:14:38 INFO - Display Serial Number: 1600x1200 60 13:14:38 INFO - Main Display: Yes 13:14:38 INFO - Mirror: Off 13:14:38 INFO - Online: Yes 13:14:38 INFO - Rotation: Supported 13:14:38 INFO - Return code: 0 13:14:38 INFO - Running post-action listener: _resource_record_post_action 13:14:38 INFO - [mozharness: 2017-02-09 21:14:38.853957Z] Finished run-tests step (success) 13:14:38 INFO - Running post-run listener: _resource_record_post_run 13:14:38 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 37749760; Write bytes: 500887552; Read time: 242; Write time: 1591 13:14:38 INFO - TinderboxPrint: CPU usage
53.4% 13:14:38 INFO - TinderboxPrint: I/O read bytes / time
37,749,760 / 242 13:14:38 INFO - TinderboxPrint: I/O write bytes / time
500,887,552 / 1,591 13:14:38 INFO - TinderboxPrint: CPU idle
2,232.3 (46.6%) 13:14:38 INFO - TinderboxPrint: CPU system
954.1 (19.9%) 13:14:38 INFO - TinderboxPrint: CPU user
1,607.2 (33.5%) 13:14:38 INFO - TinderboxPrint: Swap in / out
229,167,104 / 0 13:14:38 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 185330176; Write bytes: 179501056; Read time: 16762; Write time: 401 13:14:38 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 36811776; Write bytes: 306776064; Read time: 229; Write time: 1140 13:14:39 INFO - Running post-run listener: _upload_blobber_files 13:14:39 INFO - Blob upload gear active. 13:14:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:39 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 13:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:14:39 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:41 INFO - (blobuploader) - INFO - Done attempting. 13:14:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:14:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:42 INFO - (blobuploader) - INFO - Done attempting. 13:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:45 INFO - (blobuploader) - INFO - Done attempting. 13:14:45 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:45 INFO - Return code: 0 13:14:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2452f6f501caf67f724ee7cfc1546461baa14fe0a4653bd47f762d4844072da861fe26cf32c6096552d9af50dac6c6ffd537a1708b54446ca745a85a5c975fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54981659a10d4f7bdf5ffdf8b147e5a5cd8efcfbbce31b250a407700ede48bc7c8cc76d4b325bd625ca319bb50ce18f2c54216bcd0cf00e599082e091858732b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c743769524e1767d8c3198140f58849c8d8602c2307462a26a30481228d9acd8c0ff1c11548e0968257377a5d7af920445551c3a489b5db043c6fa28098ef92"} 13:14:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:45 INFO - Contents: 13:14:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2452f6f501caf67f724ee7cfc1546461baa14fe0a4653bd47f762d4844072da861fe26cf32c6096552d9af50dac6c6ffd537a1708b54446ca745a85a5c975fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54981659a10d4f7bdf5ffdf8b147e5a5cd8efcfbbce31b250a407700ede48bc7c8cc76d4b325bd625ca319bb50ce18f2c54216bcd0cf00e599082e091858732b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c743769524e1767d8c3198140f58849c8d8602c2307462a26a30481228d9acd8c0ff1c11548e0968257377a5d7af920445551c3a489b5db043c6fa28098ef92"} 13:14:45 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:45 INFO - Copying logs to upload dir... 13:14:45 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.510915 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-09 13:14:45.327733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 13:14:45.331043) ========= 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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2452f6f501caf67f724ee7cfc1546461baa14fe0a4653bd47f762d4844072da861fe26cf32c6096552d9af50dac6c6ffd537a1708b54446ca745a85a5c975fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54981659a10d4f7bdf5ffdf8b147e5a5cd8efcfbbce31b250a407700ede48bc7c8cc76d4b325bd625ca319bb50ce18f2c54216bcd0cf00e599082e091858732b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c743769524e1767d8c3198140f58849c8d8602c2307462a26a30481228d9acd8c0ff1c11548e0968257377a5d7af920445551c3a489b5db043c6fa28098ef92"} build_url:https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011039 build_url: 'https://queue.taskcluster.net/v1/task/J_4MUMLGQ5q1d6gMEsvrAg/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2452f6f501caf67f724ee7cfc1546461baa14fe0a4653bd47f762d4844072da861fe26cf32c6096552d9af50dac6c6ffd537a1708b54446ca745a85a5c975fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54981659a10d4f7bdf5ffdf8b147e5a5cd8efcfbbce31b250a407700ede48bc7c8cc76d4b325bd625ca319bb50ce18f2c54216bcd0cf00e599082e091858732b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c743769524e1767d8c3198140f58849c8d8602c2307462a26a30481228d9acd8c0ff1c11548e0968257377a5d7af920445551c3a489b5db043c6fa28098ef92"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 13:14:45.365819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:14:45.366149) ========= 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.0CIxVyUYq2/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.ZWN08JNljQ/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.005029 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 13:14:45.414732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 13:14:45.415094) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 13:14:45.415424) ========= ========= Total master_lag: 0.20 =========