builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1480011871.7 results: success (0) buildid: 20161124073320 builduid: b0e3313adb3b4db383c0709379384882 revision: f37e99ebc6e0c682003b52573f415e5fd78d425a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:31.704716) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:31.705285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:31.705611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:31.720732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:31.721139) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 10:24:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-11-24 10:24:32 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152153 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:31.887912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:31.888304) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014332 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:31.938022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:31.938415) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f37e99ebc6e0c682003b52573f415e5fd78d425a --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 f37e99ebc6e0c682003b52573f415e5fd78d425a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 10:24:32,375 truncating revision to first 12 chars 2016-11-24 10:24:32,375 Setting DEBUG logging. 2016-11-24 10:24:32,375 attempt 1/10 2016-11-24 10:24:32,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f37e99ebc6e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 10:24:32,682 unpacking tar archive at: mozilla-beta-f37e99ebc6e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626877 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:32.616523) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:32.616898) ========= script_repo_revision: f37e99ebc6e0c682003b52573f415e5fd78d425a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:32.617349) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:32.617660) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 10:24:32.628383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-11-24 10:24:32.628720) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:24:33 INFO - MultiFileLogger online at 20161124 10:24:33 in /builds/slave/test 10:24:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:24:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:24:33 INFO - {'append_to_log': False, 10:24:33 INFO - 'base_work_dir': '/builds/slave/test', 10:24:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:24:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:24:33 INFO - 'branch': 'Mozilla-Beta', 10:24:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:24:33 INFO - 'config_files': ('talos/linux_config.py',), 10:24:33 INFO - 'default_actions': ('clobber', 10:24:33 INFO - 'read-buildbot-config', 10:24:33 INFO - 'download-and-extract', 10:24:33 INFO - 'populate-webroot', 10:24:33 INFO - 'create-virtualenv', 10:24:33 INFO - 'install', 10:24:33 INFO - 'run-tests'), 10:24:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:24:33 INFO - 'download_minidump_stackwalk': True, 10:24:33 INFO - 'download_symbols': 'ondemand', 10:24:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:24:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:24:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:24:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:24:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:24:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:24:33 INFO - 'installer_path': 'installer.exe', 10:24:33 INFO - 'log_level': 'info', 10:24:33 INFO - 'log_name': 'talos', 10:24:33 INFO - 'log_to_console': True, 10:24:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:24:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:24:33 INFO - 'opt_config_files': (), 10:24:33 INFO - 'pip_index': False, 10:24:33 INFO - 'sps_profile': False, 10:24:33 INFO - 'sps_profile_interval': 0, 10:24:33 INFO - 'suite': 'dromaeojs', 10:24:33 INFO - 'system_bits': '32', 10:24:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:24:33 INFO - 'title': 'talos-linux64-ix-024', 10:24:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:24:33 INFO - 'use_talos_json': True, 10:24:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:24:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:24:33 INFO - 'work_dir': 'build'} 10:24:33 INFO - [mozharness: 2016-11-24 18:24:33.161987Z] Running clobber step. 10:24:33 INFO - Running pre-action listener: _resource_record_pre_action 10:24:33 INFO - Running main action method: clobber 10:24:33 INFO - rmtree: /builds/slave/test/build 10:24:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:24:34 INFO - Running post-action listener: _resource_record_post_action 10:24:34 INFO - [mozharness: 2016-11-24 18:24:34.142699Z] Finished clobber step (success) 10:24:34 INFO - [mozharness: 2016-11-24 18:24:34.142799Z] Running read-buildbot-config step. 10:24:34 INFO - Running pre-action listener: _resource_record_pre_action 10:24:34 INFO - Running main action method: read_buildbot_config 10:24:34 INFO - Using buildbot properties: 10:24:34 INFO - { 10:24:34 INFO - "project": "", 10:24:34 INFO - "product": "firefox", 10:24:34 INFO - "script_repo_revision": "production", 10:24:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:24:34 INFO - "repository": "", 10:24:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:24:34 INFO - "buildid": "20161124073320", 10:24:34 INFO - "pgo_build": "True", 10:24:34 INFO - "basedir": "/builds/slave/test", 10:24:34 INFO - "buildnumber": 33, 10:24:34 INFO - "slavename": "talos-linux64-ix-024", 10:24:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:24:34 INFO - "platform": "ubuntu64_hw", 10:24:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:24:34 INFO - "branch": "mozilla-beta", 10:24:34 INFO - "repo_path": "releases/mozilla-beta", 10:24:34 INFO - "revision": "f37e99ebc6e0c682003b52573f415e5fd78d425a", 10:24:34 INFO - "stage_platform": "linux64-pgo", 10:24:34 INFO - "builduid": "b0e3313adb3b4db383c0709379384882", 10:24:34 INFO - "slavebuilddir": "test" 10:24:34 INFO - } 10:24:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 10:24:34 INFO - Running post-action listener: _resource_record_post_action 10:24:34 INFO - [mozharness: 2016-11-24 18:24:34.145239Z] Finished read-buildbot-config step (success) 10:24:34 INFO - [mozharness: 2016-11-24 18:24:34.145328Z] Running download-and-extract step. 10:24:34 INFO - Running pre-action listener: _resource_record_pre_action 10:24:34 INFO - Running main action method: download_and_extract 10:24:34 INFO - mkdir: /builds/slave/test/build/tests 10:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:34 INFO - trying https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 10:24:34 INFO - Downloading https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 10:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:24:34 INFO - Downloaded 1327 bytes. 10:24:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 10:24:34 INFO - Using the following test package requirements: 10:24:34 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 10:24:34 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:24:34 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:24:34 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:24:34 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 10:24:34 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:24:34 INFO - u'jsshell-linux-x86_64.zip'], 10:24:34 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:24:34 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:24:34 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 10:24:34 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:24:34 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 10:24:34 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:24:34 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 10:24:34 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:24:34 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:24:34 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:24:34 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:24:34 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:24:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 10:24:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:24:34 INFO - Fetch https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 10:24:35 INFO - Expected file size: 21963353 10:24:39 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:24:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 10:24:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:24:39 INFO - Fetch https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 10:24:39 INFO - Expected file size: 21963353 10:24:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 10:24:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:24:44 INFO - Fetch https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 10:24:45 INFO - Expected file size: 14414089 10:24:45 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')]} 10:24:45 INFO - trying https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:24:45 INFO - Downloading https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:24:46 INFO - Downloaded 56982561 bytes. 10:24:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:24:46 INFO - mkdir: /builds/slave/test/properties 10:24:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:24:46 INFO - Writing to file /builds/slave/test/properties/build_url 10:24:46 INFO - Contents: 10:24:46 INFO - build_url:https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:24:47 INFO - Running post-action listener: _resource_record_post_action 10:24:47 INFO - Running post-action listener: set_extra_try_arguments 10:24:47 INFO - [mozharness: 2016-11-24 18:24:47.291408Z] Finished download-and-extract step (success) 10:24:47 INFO - [mozharness: 2016-11-24 18:24:47.291636Z] Running populate-webroot step. 10:24:47 INFO - Running pre-action listener: _resource_record_pre_action 10:24:47 INFO - Running main action method: populate_webroot 10:24:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:24:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:24:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:24:47 INFO - '--tppagecycles', 10:24:47 INFO - '7'], 10:24:47 INFO - 'tests': ['tsvgm']}}, 10:24:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:24:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:24:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:24:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:24:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:47 INFO - 'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:24:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:24:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:47 INFO - 'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['damp', 'tps']}, 10:24:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:47 INFO - 'tests': ['damp', 'tps']}, 10:24:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['dromaeo_dom']}, 10:24:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:24:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['basic_compositor_video']}, 10:24:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:24:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['a11yr', 10:24:47 INFO - 'ts_paint', 10:24:47 INFO - 'tpaint', 10:24:47 INFO - 'sessionrestore', 10:24:47 INFO - 'sessionrestore_no_auto_restore', 10:24:47 INFO - 'tabpaint']}, 10:24:47 INFO - 'other-e10s': {'tests': ['a11yr', 10:24:47 INFO - 'ts_paint', 10:24:47 INFO - 'tpaint', 10:24:47 INFO - 'sessionrestore', 10:24:47 INFO - 'sessionrestore_no_auto_restore', 10:24:47 INFO - 'tabpaint']}, 10:24:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:24:47 INFO - 'ts_paint', 10:24:47 INFO - 'tpaint', 10:24:47 INFO - 'sessionrestore', 10:24:47 INFO - 'sessionrestore_no_auto_restore', 10:24:47 INFO - 'tabpaint']}, 10:24:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:24:47 INFO - 'ts_paint', 10:24:47 INFO - 'tpaint', 10:24:47 INFO - 'sessionrestore', 10:24:47 INFO - 'sessionrestore_no_auto_restore', 10:24:47 INFO - 'tabpaint']}, 10:24:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['a11yr', 10:24:47 INFO - 'ts_paint', 10:24:47 INFO - 'tpaint', 10:24:47 INFO - 'sessionrestore', 10:24:47 INFO - 'sessionrestore_no_auto_restore', 10:24:47 INFO - 'tabpaint']}, 10:24:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['a11yr', 10:24:47 INFO - 'ts_paint', 10:24:47 INFO - 'tpaint', 10:24:47 INFO - 'sessionrestore', 10:24:47 INFO - 'sessionrestore_no_auto_restore', 10:24:47 INFO - 'tabpaint']}, 10:24:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['tsvgx', 10:24:47 INFO - 'tsvgr_opacity', 10:24:47 INFO - 'tart', 10:24:47 INFO - 'tscrollx', 10:24:47 INFO - 'cart']}, 10:24:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:24:47 INFO - 'tsvgr_opacity', 10:24:47 INFO - 'tart', 10:24:47 INFO - 'tscrollx', 10:24:47 INFO - 'cart']}, 10:24:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:47 INFO - 'talos_options': ['--disable-e10s'], 10:24:47 INFO - 'tests': ['tp5o']}, 10:24:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:47 INFO - 'tests': ['tp5o']}, 10:24:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:47 INFO - 'talos_options': ['--disable-e10s', 10:24:47 INFO - '--xperf_path', 10:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:24:47 INFO - 'tests': ['tp5n']}, 10:24:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:47 INFO - 'talos_options': ['--xperf_path', 10:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:24:47 INFO - 'tests': ['tp5n']}}, 10:24:47 INFO - 'talos.zip': {'path': '', 10:24:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:24:47 INFO - Running post-action listener: _resource_record_post_action 10:24:47 INFO - [mozharness: 2016-11-24 18:24:47.313659Z] Finished populate-webroot step (success) 10:24:47 INFO - [mozharness: 2016-11-24 18:24:47.313753Z] Running create-virtualenv step. 10:24:47 INFO - Running pre-action listener: _resource_record_pre_action 10:24:47 INFO - Running main action method: create_virtualenv 10:24:47 INFO - Creating virtualenv /builds/slave/test/build/venv 10:24:47 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 10:24:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:24:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:24:47 INFO - Using real prefix '/usr' 10:24:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:24:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:24:49 INFO - Installing pip.................done. 10:24:49 INFO - Return code: 0 10:24:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:24:49 INFO - Using env: {'DISPLAY': ':0', 10:24:49 INFO - 'HOME': '/home/cltbld', 10:24:49 INFO - 'LANG': 'en_US.UTF-8', 10:24:49 INFO - 'LANGUAGE': 'en_US:en', 10:24:49 INFO - 'LOGNAME': 'cltbld', 10:24:49 INFO - 'MAIL': '/var/mail/cltbld', 10:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:49 INFO - 'MOZ_NO_REMOTE': '1', 10:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:49 INFO - 'NO_EM_RESTART': '1', 10:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:49 INFO - 'PWD': '/builds/slave/test', 10:24:49 INFO - 'SHELL': '/bin/bash', 10:24:49 INFO - 'SHLVL': '1', 10:24:49 INFO - 'TERM': 'linux', 10:24:49 INFO - 'TMOUT': '86400', 10:24:49 INFO - 'USER': 'cltbld', 10:24:49 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:49 INFO - '_': '/tools/buildbot/bin/python'} 10:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:50 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 10:24:50 INFO - Cleaning up... 10:24:50 INFO - Return code: 0 10:24:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:24:50 INFO - Using env: {'DISPLAY': ':0', 10:24:50 INFO - 'HOME': '/home/cltbld', 10:24:50 INFO - 'LANG': 'en_US.UTF-8', 10:24:50 INFO - 'LANGUAGE': 'en_US:en', 10:24:50 INFO - 'LOGNAME': 'cltbld', 10:24:50 INFO - 'MAIL': '/var/mail/cltbld', 10:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:50 INFO - 'MOZ_NO_REMOTE': '1', 10:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:50 INFO - 'NO_EM_RESTART': '1', 10:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:50 INFO - 'PWD': '/builds/slave/test', 10:24:50 INFO - 'SHELL': '/bin/bash', 10:24:50 INFO - 'SHLVL': '1', 10:24:50 INFO - 'TERM': 'linux', 10:24:50 INFO - 'TMOUT': '86400', 10:24:50 INFO - 'USER': 'cltbld', 10:24:50 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:50 INFO - '_': '/tools/buildbot/bin/python'} 10:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:50 INFO - Downloading/unpacking psutil>=3.1.1 10:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:24:52 INFO - Installing collected packages: psutil 10:24:52 INFO - Running setup.py install for psutil 10:24:52 INFO - building 'psutil._psutil_linux' extension 10:24:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:24:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:24:52 INFO - building 'psutil._psutil_posix' extension 10:24:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:24:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:24:52 INFO - Successfully installed psutil 10:24:52 INFO - Cleaning up... 10:24:52 INFO - Return code: 0 10:24:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:24:52 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')]} 10:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:52 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')]} 10:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:52 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 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:52 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 10:24:52 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 10:24:52 INFO - Using env: {'DISPLAY': ':0', 10:24:52 INFO - 'HOME': '/home/cltbld', 10:24:52 INFO - 'LANG': 'en_US.UTF-8', 10:24:52 INFO - 'LANGUAGE': 'en_US:en', 10:24:52 INFO - 'LOGNAME': 'cltbld', 10:24:52 INFO - 'MAIL': '/var/mail/cltbld', 10:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:52 INFO - 'MOZ_NO_REMOTE': '1', 10:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:52 INFO - 'NO_EM_RESTART': '1', 10:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:52 INFO - 'PWD': '/builds/slave/test', 10:24:52 INFO - 'SHELL': '/bin/bash', 10:24:52 INFO - 'SHLVL': '1', 10:24:52 INFO - 'TERM': 'linux', 10:24:52 INFO - 'TMOUT': '86400', 10:24:52 INFO - 'USER': 'cltbld', 10:24:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:52 INFO - '_': '/tools/buildbot/bin/python'} 10:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:24:55 INFO - Installing collected packages: mozsystemmonitor 10:24:55 INFO - Running setup.py install for mozsystemmonitor 10:24:55 INFO - Successfully installed mozsystemmonitor 10:24:55 INFO - Cleaning up... 10:24:55 INFO - Return code: 0 10:24:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:24:55 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')]} 10:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:55 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')]} 10:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:55 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 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:55 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 10:24:55 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 10:24:55 INFO - Using env: {'DISPLAY': ':0', 10:24:55 INFO - 'HOME': '/home/cltbld', 10:24:55 INFO - 'LANG': 'en_US.UTF-8', 10:24:55 INFO - 'LANGUAGE': 'en_US:en', 10:24:55 INFO - 'LOGNAME': 'cltbld', 10:24:55 INFO - 'MAIL': '/var/mail/cltbld', 10:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:55 INFO - 'MOZ_NO_REMOTE': '1', 10:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:55 INFO - 'NO_EM_RESTART': '1', 10:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:55 INFO - 'PWD': '/builds/slave/test', 10:24:55 INFO - 'SHELL': '/bin/bash', 10:24:55 INFO - 'SHLVL': '1', 10:24:55 INFO - 'TERM': 'linux', 10:24:55 INFO - 'TMOUT': '86400', 10:24:55 INFO - 'USER': 'cltbld', 10:24:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:55 INFO - '_': '/tools/buildbot/bin/python'} 10:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:55 INFO - Downloading/unpacking jsonschema==2.5.1 10:24:55 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 10:24:55 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 10:24:55 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 10:24:55 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 10:24:55 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 10:24:55 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 10:24:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:24:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:57 INFO - Downloading functools32-3.2.3-2.tar.gz 10:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:24:57 INFO - warning: no files found matching '*.txt' 10:24:57 INFO - no previously-included directories found matching 'build' 10:24:57 INFO - no previously-included directories found matching 'dist' 10:24:57 INFO - no previously-included directories found matching '.git*' 10:24:57 INFO - Installing collected packages: jsonschema, functools32 10:24:57 INFO - Running setup.py install for functools32 10:24:57 INFO - warning: no files found matching '*.txt' 10:24:57 INFO - no previously-included directories found matching 'build' 10:24:57 INFO - no previously-included directories found matching 'dist' 10:24:57 INFO - no previously-included directories found matching '.git*' 10:24:57 INFO - Successfully installed jsonschema functools32 10:24:57 INFO - Cleaning up... 10:24:57 INFO - Return code: 0 10:24:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:24:57 INFO - Using env: {'DISPLAY': ':0', 10:24:57 INFO - 'HOME': '/home/cltbld', 10:24:57 INFO - 'LANG': 'en_US.UTF-8', 10:24:57 INFO - 'LANGUAGE': 'en_US:en', 10:24:57 INFO - 'LOGNAME': 'cltbld', 10:24:57 INFO - 'MAIL': '/var/mail/cltbld', 10:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:57 INFO - 'MOZ_NO_REMOTE': '1', 10:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:57 INFO - 'NO_EM_RESTART': '1', 10:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:57 INFO - 'PWD': '/builds/slave/test', 10:24:57 INFO - 'SHELL': '/bin/bash', 10:24:57 INFO - 'SHLVL': '1', 10:24:57 INFO - 'TERM': 'linux', 10:24:57 INFO - 'TMOUT': '86400', 10:24:57 INFO - 'USER': 'cltbld', 10:24:57 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:57 INFO - '_': '/tools/buildbot/bin/python'} 10:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:24:58 INFO - Cleaning up... 10:24:58 INFO - Return code: 0 10:24:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:24:58 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')]} 10:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:58 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')]} 10:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:58 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 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:58 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 10:24:58 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 10:24:58 INFO - Using env: {'DISPLAY': ':0', 10:24:58 INFO - 'HOME': '/home/cltbld', 10:24:58 INFO - 'LANG': 'en_US.UTF-8', 10:24:58 INFO - 'LANGUAGE': 'en_US:en', 10:24:58 INFO - 'LOGNAME': 'cltbld', 10:24:58 INFO - 'MAIL': '/var/mail/cltbld', 10:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:58 INFO - 'MOZ_NO_REMOTE': '1', 10:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:58 INFO - 'NO_EM_RESTART': '1', 10:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:58 INFO - 'PWD': '/builds/slave/test', 10:24:58 INFO - 'SHELL': '/bin/bash', 10:24:58 INFO - 'SHLVL': '1', 10:24:58 INFO - 'TERM': 'linux', 10:24:58 INFO - 'TMOUT': '86400', 10:24:58 INFO - 'USER': 'cltbld', 10:24:58 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:58 INFO - '_': '/tools/buildbot/bin/python'} 10:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:58 INFO - Downloading/unpacking blobuploader==1.2.4 10:24:58 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 10:24:58 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 10:24:58 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 10:24:58 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 10:24:58 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 10:24:58 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 10:25:00 INFO - Downloading blobuploader-1.2.4.tar.gz 10:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:25:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:25:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:00 INFO - Downloading docopt-0.6.1.tar.gz 10:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:25:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:25:01 INFO - Running setup.py install for blobuploader 10:25:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:25:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:25:01 INFO - Running setup.py install for requests 10:25:01 INFO - Running setup.py install for docopt 10:25:01 INFO - Successfully installed blobuploader requests docopt 10:25:01 INFO - Cleaning up... 10:25:01 INFO - Return code: 0 10:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25: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')]} 10:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25: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')]} 10:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:01 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 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:25:01 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 10:25:01 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 10:25:01 INFO - Using env: {'DISPLAY': ':0', 10:25:01 INFO - 'HOME': '/home/cltbld', 10:25:01 INFO - 'LANG': 'en_US.UTF-8', 10:25:01 INFO - 'LANGUAGE': 'en_US:en', 10:25:01 INFO - 'LOGNAME': 'cltbld', 10:25:01 INFO - 'MAIL': '/var/mail/cltbld', 10:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:01 INFO - 'MOZ_NO_REMOTE': '1', 10:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:01 INFO - 'NO_EM_RESTART': '1', 10:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:01 INFO - 'PWD': '/builds/slave/test', 10:25:01 INFO - 'SHELL': '/bin/bash', 10:25:01 INFO - 'SHLVL': '1', 10:25:01 INFO - 'TERM': 'linux', 10:25:01 INFO - 'TMOUT': '86400', 10:25:01 INFO - 'USER': 'cltbld', 10:25:01 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:01 INFO - '_': '/tools/buildbot/bin/python'} 10:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:01 INFO - Running setup.py (path:/tmp/pip-R959sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:01 INFO - Running setup.py (path:/tmp/pip-wZWKgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:02 INFO - Running setup.py (path:/tmp/pip-450DJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:02 INFO - Running setup.py (path:/tmp/pip-5oqxnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:02 INFO - Running setup.py (path:/tmp/pip-VEBmcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:02 INFO - Running setup.py (path:/tmp/pip-VVPOcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:02 INFO - Running setup.py (path:/tmp/pip-UjEVpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:02 INFO - Running setup.py (path:/tmp/pip-kvzr_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:02 INFO - Running setup.py (path:/tmp/pip-cwmRvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:02 INFO - Running setup.py (path:/tmp/pip-SZbPD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:02 INFO - Running setup.py (path:/tmp/pip-nsj6O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:02 INFO - Running setup.py (path:/tmp/pip-26bY1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:02 INFO - Running setup.py (path:/tmp/pip-SMF7RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:02 INFO - Running setup.py (path:/tmp/pip-rcW5_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:02 INFO - Running setup.py (path:/tmp/pip-Y3dzos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:02 INFO - Running setup.py (path:/tmp/pip-GqNVFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:03 INFO - Running setup.py (path:/tmp/pip-8gz1Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:25:03 INFO - Running setup.py install for manifestparser 10:25:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:25:03 INFO - Running setup.py install for mozcrash 10:25:03 INFO - Running setup.py install for mozdebug 10:25:03 INFO - Running setup.py install for mozdevice 10:25:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:25:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:25:03 INFO - Running setup.py install for mozfile 10:25:03 INFO - Running setup.py install for mozhttpd 10:25:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:25:03 INFO - Running setup.py install for mozinfo 10:25:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:25:03 INFO - Running setup.py install for mozInstall 10:25:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:25:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:25:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:25:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:25:03 INFO - Running setup.py install for mozleak 10:25:03 INFO - Running setup.py install for mozlog 10:25:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:25:04 INFO - Running setup.py install for moznetwork 10:25:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:25:04 INFO - Running setup.py install for mozprocess 10:25:04 INFO - Running setup.py install for mozprofile 10:25:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:25:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:25:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:25:04 INFO - Running setup.py install for mozrunner 10:25:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:25:04 INFO - Running setup.py install for mozscreenshot 10:25:04 INFO - Running setup.py install for moztest 10:25:04 INFO - Running setup.py install for mozversion 10:25:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:25:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:25:04 INFO - Cleaning up... 10:25:04 INFO - Return code: 0 10:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:04 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 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:25:04 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 10:25:04 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 10:25:04 INFO - Using env: {'DISPLAY': ':0', 10:25:04 INFO - 'HOME': '/home/cltbld', 10:25:04 INFO - 'LANG': 'en_US.UTF-8', 10:25:04 INFO - 'LANGUAGE': 'en_US:en', 10:25:04 INFO - 'LOGNAME': 'cltbld', 10:25:04 INFO - 'MAIL': '/var/mail/cltbld', 10:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:04 INFO - 'MOZ_NO_REMOTE': '1', 10:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:04 INFO - 'NO_EM_RESTART': '1', 10:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:04 INFO - 'PWD': '/builds/slave/test', 10:25:04 INFO - 'SHELL': '/bin/bash', 10:25:04 INFO - 'SHLVL': '1', 10:25:04 INFO - 'TERM': 'linux', 10:25:04 INFO - 'TMOUT': '86400', 10:25:04 INFO - 'USER': 'cltbld', 10:25:04 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:04 INFO - '_': '/tools/buildbot/bin/python'} 10:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:05 INFO - Running setup.py (path:/tmp/pip-0qhcHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:05 INFO - Running setup.py (path:/tmp/pip-RynHF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:05 INFO - Running setup.py (path:/tmp/pip-KmpVb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:05 INFO - Running setup.py (path:/tmp/pip-8lAION-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:05 INFO - Running setup.py (path:/tmp/pip-E8q3Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:05 INFO - Running setup.py (path:/tmp/pip-bhQbCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:05 INFO - Running setup.py (path:/tmp/pip-2Xa4zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:05 INFO - Running setup.py (path:/tmp/pip-WXkrg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:05 INFO - Running setup.py (path:/tmp/pip-kxEryR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:05 INFO - Running setup.py (path:/tmp/pip-UCgCk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:05 INFO - Running setup.py (path:/tmp/pip-LrchZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:05 INFO - Running setup.py (path:/tmp/pip-yGb64N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:05 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)) 10:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:05 INFO - Running setup.py (path:/tmp/pip-l4fdVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:06 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)) 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:06 INFO - Running setup.py (path:/tmp/pip-M8z6HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:06 INFO - Running setup.py (path:/tmp/pip-xpWKK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:06 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)) 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:06 INFO - Running setup.py (path:/tmp/pip-1TJLlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:06 INFO - Running setup.py (path:/tmp/pip-ymKxIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:06 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)) 10:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:06 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)) 10:25:06 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)) 10:25:06 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)) 10:25:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:25:06 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 10:25:06 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 10:25:06 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 10:25:06 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 10:25:06 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 10:25:06 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 10:25:08 INFO - Downloading blessings-1.6.tar.gz 10:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:25:08 INFO - Installing collected packages: blessings 10:25:08 INFO - Running setup.py install for blessings 10:25:08 INFO - Successfully installed blessings 10:25:08 INFO - Cleaning up... 10:25:08 INFO - Return code: 0 10:25:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:25:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:25:08 INFO - Reading from file tmpfile_stdout 10:25:08 INFO - Current package versions: 10:25:08 INFO - argparse == 1.2.1 10:25:08 INFO - blessings == 1.6 10:25:08 INFO - blobuploader == 1.2.4 10:25:08 INFO - docopt == 0.6.1 10:25:08 INFO - functools32 == 3.2.3-2 10:25:08 INFO - jsonschema == 2.5.1 10:25:08 INFO - manifestparser == 1.1 10:25:08 INFO - mozInstall == 1.12 10:25:08 INFO - mozcrash == 0.17 10:25:08 INFO - mozdebug == 0.1 10:25:08 INFO - mozdevice == 0.48 10:25:08 INFO - mozfile == 1.2 10:25:08 INFO - mozhttpd == 0.7 10:25:08 INFO - mozinfo == 0.9 10:25:08 INFO - mozleak == 0.1 10:25:08 INFO - mozlog == 3.4 10:25:08 INFO - moznetwork == 0.27 10:25:08 INFO - mozprocess == 0.23 10:25:08 INFO - mozprofile == 0.28 10:25:08 INFO - mozrunner == 6.12 10:25:08 INFO - mozscreenshot == 0.1 10:25:08 INFO - mozsystemmonitor == 0.3 10:25:08 INFO - moztest == 0.7 10:25:08 INFO - mozversion == 1.4 10:25:08 INFO - psutil == 3.1.1 10:25:08 INFO - requests == 1.2.3 10:25:08 INFO - wsgiref == 0.1.2 10:25:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:08 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 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:25:08 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 10:25:08 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 10:25:08 INFO - Using env: {'DISPLAY': ':0', 10:25:08 INFO - 'HOME': '/home/cltbld', 10:25:08 INFO - 'LANG': 'en_US.UTF-8', 10:25:08 INFO - 'LANGUAGE': 'en_US:en', 10:25:08 INFO - 'LOGNAME': 'cltbld', 10:25:08 INFO - 'MAIL': '/var/mail/cltbld', 10:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:08 INFO - 'MOZ_NO_REMOTE': '1', 10:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:08 INFO - 'NO_EM_RESTART': '1', 10:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:08 INFO - 'PWD': '/builds/slave/test', 10:25:08 INFO - 'SHELL': '/bin/bash', 10:25:08 INFO - 'SHLVL': '1', 10:25:08 INFO - 'TERM': 'linux', 10:25:08 INFO - 'TMOUT': '86400', 10:25:08 INFO - 'USER': 'cltbld', 10:25:08 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:08 INFO - '_': '/tools/buildbot/bin/python'} 10:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:08 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)) 10:25:08 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)) 10:25:08 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)) 10:25:08 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)) 10:25:08 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)) 10:25:08 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)) 10:25:08 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)) 10:25:08 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)) 10:25:08 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)) 10:25:08 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)) 10:25:08 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)) 10:25:08 INFO - Cleaning up... 10:25:08 INFO - Return code: 0 10:25:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b3f7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:25:08 INFO - Using env: {'DISPLAY': ':0', 10:25:08 INFO - 'HOME': '/home/cltbld', 10:25:08 INFO - 'LANG': 'en_US.UTF-8', 10:25:08 INFO - 'LANGUAGE': 'en_US:en', 10:25:08 INFO - 'LOGNAME': 'cltbld', 10:25:08 INFO - 'MAIL': '/var/mail/cltbld', 10:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:08 INFO - 'MOZ_NO_REMOTE': '1', 10:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:08 INFO - 'NO_EM_RESTART': '1', 10:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:08 INFO - 'PWD': '/builds/slave/test', 10:25:08 INFO - 'SHELL': '/bin/bash', 10:25:08 INFO - 'SHLVL': '1', 10:25:08 INFO - 'TERM': 'linux', 10:25:08 INFO - 'TMOUT': '86400', 10:25:08 INFO - 'USER': 'cltbld', 10:25:08 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:08 INFO - '_': '/tools/buildbot/bin/python'} 10:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:25:09 INFO - Cleaning up... 10:25:09 INFO - Return code: 0 10:25:09 INFO - Running post-action listener: _resource_record_post_action 10:25:09 INFO - Running post-action listener: _start_resource_monitoring 10:25:09 INFO - Starting resource monitoring. 10:25:09 INFO - [mozharness: 2016-11-24 18:25:09.235161Z] Finished create-virtualenv step (success) 10:25:09 INFO - [mozharness: 2016-11-24 18:25:09.235618Z] Running install step. 10:25:09 INFO - Running pre-action listener: _resource_record_pre_action 10:25:09 INFO - Running main action method: install 10:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:25:09 INFO - Reading from file tmpfile_stdout 10:25:09 INFO - Detecting whether we're running mozinstall >=1.0... 10:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:25:09 INFO - Reading from file tmpfile_stdout 10:25:09 INFO - Output received: 10:25:09 INFO - Usage: mozinstall [options] installer 10:25:09 INFO - Options: 10:25:09 INFO - -h, --help show this help message and exit 10:25:09 INFO - -d DEST, --destination=DEST 10:25:09 INFO - Directory to install application into. [default: 10:25:09 INFO - "/builds/slave/test"] 10:25:09 INFO - --app=APP Application being installed. [default: firefox] 10:25:09 INFO - mkdir: /builds/slave/test/build/application 10:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:25:23 INFO - Reading from file tmpfile_stdout 10:25:23 INFO - Output received: 10:25:23 INFO - /builds/slave/test/build/application/firefox/firefox 10:25:23 INFO - Running post-action listener: _resource_record_post_action 10:25:23 INFO - [mozharness: 2016-11-24 18:25:23.018357Z] Finished install step (success) 10:25:23 INFO - [mozharness: 2016-11-24 18:25:23.018603Z] Running run-tests step. 10:25:23 INFO - Running pre-action listener: _resource_record_pre_action 10:25:23 INFO - Running main action method: run_tests 10:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:25:23 INFO - Python 2.7.3 10:25:23 INFO - Return code: 0 10:25:23 INFO - grabbing minidump binary from tooltool 10:25: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')]} 10:25:23 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/linux64/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 0x13f9f60>, '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 0x13fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:25:23 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:25:23 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/linux64/releng.manifest -o -c /builds/tooltool_cache 10:25:23 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:25:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:25:23 INFO - Return code: 0 10:25:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:25:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:25:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:25:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:25:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:25:23 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/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 10:25:23 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/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 10:25:23 INFO - Using env: {'DISPLAY': ':0', 10:25:23 INFO - 'HOME': '/home/cltbld', 10:25:23 INFO - 'LANG': 'en_US.UTF-8', 10:25:23 INFO - 'LANGUAGE': 'en_US:en', 10:25:23 INFO - 'LOGNAME': 'cltbld', 10:25:23 INFO - 'MAIL': '/var/mail/cltbld', 10:25:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:25:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:23 INFO - 'MOZ_NO_REMOTE': '1', 10:25:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:23 INFO - 'NO_EM_RESTART': '1', 10:25:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:23 INFO - 'PWD': '/builds/slave/test', 10:25:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:25:23 INFO - 'SHELL': '/bin/bash', 10:25:23 INFO - 'SHLVL': '1', 10:25:23 INFO - 'TERM': 'linux', 10:25:23 INFO - 'TMOUT': '86400', 10:25:23 INFO - 'USER': 'cltbld', 10:25:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528', 10:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:23 INFO - '_': '/tools/buildbot/bin/python'} 10:25:23 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/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 10:25:23 INFO - mozversion application_buildid: 20161124073320 10:25:23 INFO - mozversion application_changeset: f37e99ebc6e0c682003b52573f415e5fd78d425a 10:25:23 INFO - mozversion application_display_name: Firefox 10:25:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:25:23 INFO - mozversion application_name: Firefox 10:25:23 INFO - mozversion application_remotingname: firefox 10:25:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:25:23 INFO - mozversion application_vendor: Mozilla 10:25:23 INFO - mozversion application_version: 51.0 10:25:23 INFO - mozversion platform_buildid: 20161124073320 10:25:23 INFO - mozversion platform_changeset: f37e99ebc6e0c682003b52573f415e5fd78d425a 10:25:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:25:23 INFO - mozversion platform_version: 51.0 10:25:23 INFO - using testdate: 1480011923 10:25:23 INFO - actual date: 1480011923 10:25:23 INFO - starting webserver on 'localhost:41659' 10:25:23 INFO - SUITE-START | Running 2 tests 10:25:23 INFO - TEST-START | dromaeo_css 10:25:23 INFO - operating with platform_type : linux_ 10:25:23 INFO - Initialising browser for dromaeo_css test... 10:25:23 INFO - TEST-INFO | started process 9836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPnNCgz/profile http://localhost:41659/getInfo.html) 10:25:27 INFO - PROCESS | 9836 | __metrics Screen width/height:1600/1200 10:25:27 INFO - PROCESS | 9836 | colorDepth:24 10:25:27 INFO - PROCESS | 9836 | Browser inner width/height: 1024/697 10:25:27 INFO - PROCESS | 9836 | __metrics 10:25:27 INFO - PROCESS | 9836 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:25:27 INFO - PROCESS | 9836 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:28 INFO - PROCESS | 9836 | console.error: PushService: 10:25:28 INFO - PROCESS | 9836 | stateChangeProcessEnqueue: Error transitioning state 10:25:28 INFO - PROCESS | 9836 | UnknownError 10:25:28 INFO - TEST-INFO | 9836: exit 0 10:25:28 INFO - Browser initialized. 10:25:28 INFO - Running cycle 1/1 for dromaeo_css test... 10:25:28 INFO - TEST-INFO | started process 9928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPnNCgz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:40 INFO - PROCESS | 9928 | RSS: Main: 142618624 10:25:40 INFO - PROCESS | 9928 | 10:26:31 INFO - PROCESS | 9928 | 1480011991723 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:28:40 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:41659/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41659/tests/dromaeo/cssquery-ext.html) 10:28:42 INFO - PROCESS | 9928 | RSS: Main: 250556416 10:28:42 INFO - PROCESS | 9928 | 10:31:44 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:41659/tests/dromaeo/cssquery-ext.html (next: http://localhost:41659/tests/dromaeo/cssquery-jquery.html) 10:31:44 INFO - PROCESS | 9928 | RSS: Main: 235687936 10:31:44 INFO - PROCESS | 9928 | 10:34:46 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:41659/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41659/tests/dromaeo/cssquery-mootools.html) 10:34:47 INFO - PROCESS | 9928 | RSS: Main: 173703168 10:34:47 INFO - PROCESS | 9928 | 10:37:49 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:41659/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41659/tests/dromaeo/cssquery-prototype.html) 10:37:49 INFO - PROCESS | 9928 | RSS: Main: 175591424 10:37:49 INFO - PROCESS | 9928 | 10:40:52 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:41659/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41659/tests/dromaeo/cssquery-yui.html) 10:40:52 INFO - PROCESS | 9928 | RSS: Main: 172982272 10:40:52 INFO - PROCESS | 9928 | 10:43:55 INFO - PROCESS | 9928 | Cycle 1(1): loaded http://localhost:41659/tests/dromaeo/cssquery-yui.html (next: http://localhost:41659/tests/dromaeo/cssquery-dojo.html) 10:43:55 INFO - PROCESS | 9928 | RSS: Main: 263299072 10:43:55 INFO - PROCESS | 9928 | 10:43:55 INFO - PROCESS | 9928 | __start_tp_report 10:43:55 INFO - PROCESS | 9928 | _x_x_mozilla_page_load 10:43:55 INFO - PROCESS | 9928 | _x_x_mozilla_page_load_details 10:43:55 INFO - PROCESS | 9928 | |i|pagename|runs| 10:43:55 INFO - PROCESS | 9928 | |0;dojo.html;3137.8117312961217;3172.825494597796;3176.6823317668236;3198.6481487036435;3205.8076515409075;5609;5682.772689092441;5700.486956173949;5707.828765137042;5741.655500669957;5666.858328541788;5726.541876649869;5736.942630573703;5743.942560574393;5745.482906538411;5167.044096842087;5220.373555173384;5220.765065572058;5225.529702326789;5246.842594722164;5128.5640720538795;5179.844604661847;5267.157254839227;5287.2862163608;5294.814681486148;5154.355705536808;5179.922301165486;5199.506046925555;5202.271681964528;5252.133397989327;5257.080010998079;5272.1300985337375;5310.548603368679;5322.494363035506;5324.041672498949;5043.041822053798;5140.588752899759;5222.112240919053;5248.448912864171;5253.44838791929;5550.86122846928;5557.944420555783;5588.552915766729;5618.410066942953;5619.522340601054;6012.488938440238;6057.212562366908;6134.478569321613;6134.846628834315;6144.5084393248435;5916.3787802281;6148.7233074511305;6173;6177.4749146322165;6181.598196117238;5501.257330260403;5605.1872478490795;5643.322801263793;5661.405552417019;5740.282464691913;6280.466160376328;6293;6309.779157729549;6313.842153946188;6314.02132669437;6051.939480605226;6069.696515174312;6085.208922840003;6088.391160883876;6090.116933044684;5876.236089308362;5947.910781338283;6016.789412370546;6065.150878876961;6080.787172448943;6107.447682086317;6119.377697160598;6123.191113103653;6130.340846152681;6131.778844714162;6079.483243924227;6106.206193194945;6143;6145.385461453819;6146.262448506119;4565.0641618468135;4594.104149690778;4599.356090147382;4610.308453731967;4673.883152921137;4119.279126152911;4128.112455822013;4131.421600975866;4150.418941348214;4158.521769996489;5831.067029275296;5845.88308233833;5853.707314634251;5854.2096816930025;5855.268091488564;5899.115132730125;5960.821175364746;6037.849053773691;6084.056971169476;6146.446819786241;5838.620489668243;5858.384869588717;5886.587938844325;5888.705564721747;5889.352171261158;5293.602979776532;5295.761690723926;5298.92051619226;5300.602454815904;5305.1776974569;6130.367562715059;6182.103594978613;6291.811245662638;6350.714217860115;6362.618242905441;6028;6088.878222435438;6129.233845769279;6139.079138129317;6156.661383623944;6338.429541341301;6356.491480681627;6361.650109244036;6368;6376.681165941777;5834.883302334015;5960.582759206987;6021.849453763691;6036.215292012011;6036.426539478743;6050.42520960508;6052.243469566304;6096.847578810565;6142.078688196806;6150.323464419;5998.880022399615;5999.940000599938;6002.819915402545;6007.90988135187;6039.456448919618;5788.82633520995;5844.357120716632;5990.7004649768205;5992.730327135202;5995.5803093783015;5890.204822348928;5901.970490147522;5969.52243820502;6009.098635204754;6037.6679282638115;6019.819405417845;6060.090986352083;6080.361562035922;6081.027035674271;6081.5134789217645;5729.4843464088435;5807.128930660435;5844.707764611838;5915.319738230159;5925.05199168131 10:43:55 INFO - PROCESS | 9928 | |1;ext.html;589.9085641725534;615.1940957345877;644.8484606117563;651.569963823876;663.3499170812601;34736;47631.52368476314;48865.75567122168;48885;52559.47440525593;49064.75467622666;49584;49595.75202123993;49608;49704.25443618349;8542.615582298811;9442.433453992766;9599.040095990415;9599.568019439143;9606.75983100421;8411.789705257357;8814.162654547808;8814.25078868297;11201.495932683009;11482.827757583644;11589.36258505782;11602.825957610643;11653.941730291337;11663.766724665502;11668.35824029678;11259.605913793019;11325.150613704005;11326.943365283203;11333.206675532716;11338.886611133907;11211.831822522669;11261.15541334395;11289.661310160709;11291.661250162508;11300.265482743594;46234;46873.76563117163;46895;46913.53086469126;47035.529644703456;3743.8689645862264;3755.2114056048263;3768.6042965488778;3950.308695978192;4441.356003379524;34759;35096;35419.64580354189;35683.10792230189;35810.820945895364;4463.308187230984;4585.862424127282;4741.668083234175;4829.951700482985;4922.655414121013;393095;396262.01868990756;397917;398055;398130.9999999971;68361.3163868365;68913;69338;69442;69517.3048269521;41108.177836443705;42199.15601688011;42268;44260;44339;18741.7188742169;18938.90530547366;18940.337088201846;18943.81056189448;18976.146073426728;12492.687682808002;14411.207383593794;14536.85463145355;14545.41818327255;14549.92725036368;19175.424737257905;20578.27976020832;21112.366629001153;21306.147754089663;21858.562828743656;7378.151512576015;7693.730719424793;7723.884141737878;7757.26306000929;7866.960665196638;1063.8882917293727;1072.2119242356862;1089.0742868561658;1148.328227986637;1167.7664467106613;35859.28281434357;35890.461643075374;36215;36256.63743362533;36402;1170.6253998720329;1185.016436357821;1193.6001439517859;1224.5714000100072;1229.2071613809044;18401.81598184028;18762.0618969051;18819.71770423445;18951.62096758057;19158.808411915983;534350;535095;536809;536890;537307;64117;64442.35557644457;64469.35530644727;64478.355216447235;64480.35519644837;1305.1907817153235;1384.2801743093737;1408.8591140885828;1461.0868207370393;1484.7550154224432;32409;36424.81787591045;36647.63352366549;36708.632913670524;36841.815790920875;55315;55765;55816.720916396785;55912.720436397554;56039.439605603424;439331;442254;443790;445636;446246;31651.20871978219;32918.177045574055;33072.834635826664;33176;33250.33499330048;53514.73242633762;53591.73204133954;53827.730861345444;53853.73073134609;53863.73068134791;44325.55674443343;45936.54063459457;46310.768446157555;46564.7671761639;47229.76385118053;46358.30462543132;46652;47214.527854722386;47486.287705685136;48396.75801620969;45994.08011839678;46553;47175;47236;47288.05423891434;38075;39706.2058758829;39761.2047759049;40939.59060409358;41298;29608.40783184281;30183;30247.395052099277;30390.696093038787;30472.542911856784 10:43:55 INFO - PROCESS | 9928 | |2;jquery.html;437.20647025648424;439.88782860370605;440.49783247098316;441.09575370490495;443.95891634118004;18661.346852860137;19021.61956760864;20340.288089916856;20425.693614595773;20537.691934620994;17481.300747970065;18889.433317000512;19502.122404491798;19546.804531954713;19605.803941960578;5323.520883120518;5555.166724991243;5556.083246264382;5566.666000039991;5611.102223644218;5422.674639521641;5490.917636235459;5554.1391084381785;5555.027870122733;5976.163337132805;6013.909791353133;6016;6019.699015049252;6022.488088512482;6022.969885150568;5506.091494903376;5529.751161197735;5560.499555040065;6001.309849367313;6006.669633170174;5413.133898576249;5420.13277875542;5423.891522169534;5424.457554244584;5426.050441172779;14863.405463781435;15035.548933531902;15256.847431525654;15386.230688465532;15415.3833846646;2427.5751743445003;2490.439651078511;2979.5232762757855;3017.8641961111803;3088.3977624363256;10706.839397409045;10755.946220268926;10942.835857462145;10948.686457178746;11184.049355804686;2026.7365242518526;2066.741657292838;2094.172801743303;2193.824494040489;2237.5524895021063;81706.59146704288;82459;83773;95894.52052739762;97431.51284243533;10414.687559373231;11369.772604548029;11543.826842597367;11628.709282267842;11850.940745296391;16167.353305867633;16173.4339298124;16194.02835829854;16207.756883646754;16230.756538651929;8203.71287004952;8608.913910860936;8648.827023459495;8653.048164701877;8713.3464990126;8219.013718353835;8263.132371101068;8371.246587807005;8503.61733721984;8512.65949362031;4770.570648641639;4843.588294994965;4875.881657041058;4950.331705219821;4965.875853103701;2129.542148438093;2191.594555007329;2207.779222077779;2216.656418255173;2219.5117074243963;1014.9545967653329;1064.6593090211059;1069.8020866139789;1085.782843431301;1146.083133493202;20118.295859645135;20848.061837217363;21028.369148925558;21232.256871009442;21321.867813218552;1048.2400259811575;1052.905238528536;1080.4057768227444;1089.7929393415225;1127.785720713062;10767.83848242277;11566.47950842214;11688.532458701728;11737.119716021332;11760.117991150526;428944;440213;442767;447676;450007;56440.717796411576;71630;88512.5574372124;88760;97389.51305243428;1008.6318493749728;1024.1039090795555;1032.26193271811;1033.0960409641564;1043.5773511727914;17898;18251.45245642633;18476.538086547946;18612;18890.3388381406;44423.33364999463;44738;45125.77437112793;45721.31418028799;47087;62187;63075.053874191006;63181.36818631755;64360.678196608715;64439;8770.68439734045;9024.909750902669;9040.186383225542;9066.773330666787;9223.16991470744;10154.593816247563;12438;13884.722305554034;14245.786313205517;14397.928010359881;11849.111316651113;12013.314807225364;12044.457999390224;12070;12370.62888113358;11413.059779837282;11448.656540303804;11754.353510557;12151.939240304095;12239.822031085007;11605.187636865337;12307.75384492323;12359.196652217577;12457.563985260473;12607.306598137191;9490.383125096847;9507.239420846454;9604.27967902396;9680;9693.70918872435;11858.169928105295;12365.196262242926;12472.563460278847;12656.683582910133;12677.556285529961 10:43:55 INFO - PROCESS | 9928 | |3;mootools.html;1517.6737001544666;1545.057514915901;1692.5260926940452;1838.6598479281333;1869.38310357582;9175.678851240207;9811.31320807543;9831.75420614485;9837;9852.113309802126;8498.915010849889;8734.91265087349;9167.541622918861;9368.34421590489;9619.08618681226;2561.8078644101674;2590.961135582968;2592.066855931863;2593.8962441502317;2601.1676263595655;2464.137551856854;2573.7040240372407;2576.510463012031;2581.5224183526016;2583.922482325524;2551.4514379408424;2567.114345550782;2580.9741902581018;2581.509513192497;2583.5607946649116;2414.8068154547595;2420.552197843396;2474.40614252579;2530.9240722778345;2538.4034751833487;2488.377905523619;2492.538880307149;2497.2757900208917;2499.662545556345;2514.245726282108;9594.136527712539;9706.805863882753;9711.125998660154;9721.70834874955;9732.90267097327;5669.659820410789;5807.738651760638;5809.82570522885;5815.796447124372;5828.650280983112;3531.187826799825;3643.36241157799;3686.2443199144377;3714.0900479382453;3718.6653201211752;1220.2190598017276;1270.8093785932092;1282.5254655777421;1289.9484020639163;1294.7604693131707;13049.86950130496;13373.264470454122;13373.598792036255;13594.660133496644;13838.30808459573;4909.828156014522;4943.752812359439;4968.254761785761;4991.151504244287;5077.949220507748;10630.415327157081;10630.893691063146;10648.467576621293;10649.89350106489;10680.89319106799;5755.827325180251;5758;5766.94233057664;5767.971160144256;5770.855728606818;4732.645051621073;4745.572898439088;5332.226827110047;5357.142857142916;5398.2982212312145;4138.317177665712;4189.979050104791;4257.106007738348;4296.2911119664905;4309.806058727365;1261.0416083776213;1265.5633806336798;1267.752788206291;1285.7749893768553;1307.8626744191913;913.2921985461188;920.3833431600843;1028.6605420211313;1039.6776999130293;1047.7852040331866;6315.305316415191;6367.395097465734;6405.391487808651;6569.310222426577;6811.693473793691;488.57982135363557;507.13533425509416;509.4828748819951;509.8980203959223;512.5643203277184;4291.420658211102;4295.420118284054;4349.956500435019;4376.496702879146;4409.669274804339;11554.59558915434;12030.699232519257;12049.819252711217;12056.095792815398;12072.034237260998;11416.42917854104;11885.88114118865;11941.880581194251;12165.270083795001;12176;8838.690645827364;8951.328650351119;8979.461232326212;9034.186923176945;9034.322425817958;6508.674566271762;6670.299618539983;6787.932120678927;6793.490488213502;6818.249992500921;10944.39805810688;11018.779624407307;11142.498587563741;11212.159088068265;11246.550137994716;11030.558777648805;11098.334099954029;11296.774064518828;11468.885311146782;11501.597444089417;7699.807504812425;7928.326092282221;8163;8208.753737387888;8309.916900830915;9330.813383732151;9622.807543849223;9630.855537167088;9645.517724113906;9648.71053868385;8202.917970820454;8368.288695460711;8376.748697539084;8501.95749021251;8782.077881822317;8409.915900841159;8425.452345597516;8436.957815210884;8476.364272679697;8521.488710677379;7467.327940485382;7543.321101100927;7582.582957937367;7623.085229772241;7627.970224019687;5326.627136100591;5397.676139431646;5405.108157154025;5491.6979566122645;5729.914051289151;5252.238425428215;5427.409762967626;5463.098588732814;5547.195656629847;5570.498655121059 10:43:55 INFO - PROCESS | 9928 | |4;prototype.html;359.06284597201306;363.4366731566072;368.90777305673583;369.69684858416076;373.3690063792193;5566.666000040001;5593.8601534961645;5624.859378515529;5628.662280263182;5653.1237658162945;5189.896202075965;5590.692511911843;5596.272484576999;5601.215829783833;5653.265075540185;3880.20455806559;4298.978505107486;4344.500382456011;4359.891002724926;4372.934405983913;4357.847475338363;4363.978180109111;4375.584319489643;4381.518033016366;4408.537103604108;4376.221099601744;4380.978095109536;4404.493483249419;4409.382686423904;4424.314231294138;4154.0445697489595;4342.652587792969;4355.954570902961;4365.12697460506;4395.516493185747;3845.750026248285;3856.267309211241;3863.150106976461;3876.2247550489733;3889.241597888413;5400.945990540084;5408.593176036666;5427.864303392407;5444.646098003656;5447.210154527571;4897.853064408074;4903.730294833783;4943.382077240345;5012.899742005139;5029.245613158019;5760.8847823043725;5761;5771.365149833515;5784.334801497797;5784.421557844224;4236.788160591958;4250.553691862341;4261.659067274611;4261.893452663678;4262.676841121596;5715.999700052515;5856.76572937082;5857.443542863463;6052.303985041733;6072.332043475214;4170.979145104316;4207.894802629959;4211.073563815956;4219.43037689914;4222.311075569796;4282.785860706952;4287.464066991626;4314.61168494837;4316.539572443677;4318.3738357938555;4738.1708201064675;4914.041761856403;4920.507949205051;4927.260910863399;4943.1596628573225;5757.366689664133;5796.362400135981;5806.622569533051;5807.680577568274;5837.94162058374;1505.44298609513;1528.1900592685895;1528.4867980699028;1529.8929074964647;1536.6081649179387;916.8578870275118;970.6942313171328;979.8873129590188;981.7251169672503;990.846418805072;5020.870304181603;5043.84868453947;5061.7975280989085;5061.898762024739;5080.974595127001;5226.477352264743;5244.931714946799;5271.6309858310315;5290.81482148123;5291.497307755757;4966.404031516241;4968.534282386705;5010.774515146827;5365.995042776058;5731.971340143273;3158.583683482138;3161.130689060527;3161.351922855809;3170.8596697229277;3208.727258183034;6012.188354572077;6119.449249567471;6158.121772859231;6166;6203;5996.4603185713495;6049.909251361233;6077.574569780073;6082.635041897412;6113.8471538211015;6126.95841706902;6136.539759518054;6157.507399408037;6161.44546990782;6191.659458729813;5656.264685591012;5984.970075149597;6007.047709494344;6021.849453763691;6021.969890150521;5945.057196687667;5955.851103722442;5963.612365196248;5964.8807023860145;5988.251468566429;5913.201717768046;6015.187949626745;6075.2405949256345;6189.514516516094;6228.968855155696;4341.175176716414;4356.368326592563;4357.498887627837;4364.061726728769;4364.9524114213;5854.707264636836;6047.879042419215;6078.574499784972;6078.969605152123;6085.6348619083;5877.2376982818005;5902.970485147547;5910.231669882888;5912.349641539341;5927.762889484372;5912.290525137011;5927.673977931255;5929.6145750526075;5929.822105336847;5936.168936349001;5746.540276777764;5831.679257640871;5875.764969401176;5882.617629854046;5904.498117660047;5926.67403292823;5941.435563621449;5954.255718035246;5955.171293635489;5961.344252132349;5514.862128446821;5781.219535362672;5785.479306862234;5809.390014048464;5824.70876456167 10:43:55 INFO - PROCESS | 9928 | |5;yui.html;805.6294104711832;860.2515811244218;874.5059041641473;883.5802993578047;930.6151574315418;17068.317267309307;17508;17727.64544709105;17758.556036099104;17784.64430711385;16326.265318060687;16485.093319867403;16495.257713402894;16513.33946642136;16528.75206871895;722.0468980945154;741.6328917186;841.4698739793952;863.1454859688926;868.9826203475958;873.7640836974014;876.4215617692324;877.0221203358242;877.0790669796688;877.1666916429385;922.6355589542127;925.8842644669417;928.5171710710426;929.2194556572477;930.8417569013284;921.6958403726754;921.8478950973115;925.3892430995544;925.555733248038;925.8102089071724;675.2808259203932;679.6499802601664;682.2290811383106;682.494953734233;682.5495173185674;15776.447824326207;15812.60468488297;15821.762673559791;15832.841671583366;15844.603884902854;14530.200838953853;14801.40794368224;14979.400823967027;15133.167675777828;15300;12769.297688627123;12989.545365912149;13006.934965325207;13077.346132693423;13156.342182890818;4054.9797251013556;4065.7560546367313;4090.550039495653;4110.937351672993;4263.189993901149;88696.99999999936;88726.55636721839;88792.5560372194;88821.55589222077;89355.55322223347;12402.81395779064;12483.75032499363;12505.49978000888;12568.560100396442;12618.305993170463;24408.511829763305;24537.263882083567;24556.263312100666;24558.508829823302;24578.139765108135;9155.176034156957;9160.129787670161;9175.954120229357;9261.073892610684;9287.48918809472;5187.533122018961;5288.198349739709;5362.410134885159;5410.97294513525;5472.124460086367;3796.52543432071;3890.8638197662945;3922.097917478996;3923.8234279457492;3927.842886284574;619.5693992675048;632.0393002635967;635.2599221906427;635.3900255754435;638.7476946606065;660.7522179182806;797.7327595255655;810.2505182705974;818.7134502923928;822.0402084884587;10563.419011954262;10574.312669676447;10910.727231819268;11045.171612129123;11069.446527673585;700.509643249717;712.1632082303273;788.8106854354913;806.7418426103591;825.5789547330904;4847.927281090787;4893.143699852582;4909.337239472626;4919;4921.261810728348;74132;81006.18993810104;135515;135933;136937;112871;114701;114875;116913;118594;58918.41081589215;93528.53235733778;98219;98487.01512984921;101391;9248.815023699353;9552.558402355558;9578.658987741861;9745.013633231023;9840.852387214341;49269.75365123151;57794.4220557789;58663.12005320009;58687.501560121156;58894.4110558906;50435.74782126066;57460.71269643625;75454.27286356821;79457.60271198838;83525.58237208775;13848.16649356894;14344.784828227794;14390.56828295111;14655.63360915943;14688.192149431883;14501.20243386624;14855.09767858022;15038.398464061314;15968.441104561285;16966.151692415082;15535.300911459237;15841.841581584498;16562.420315288906;16864.072476013447;16869.15654217309;15142;15655.37378504847;16136;16169.67660646757;16307.347706092098;14958.850411495745;15159.772603410736;16016.439424620083;16036.759448608513;16382.26279817435;11226.158038147008;11724.120690948384;12240.510379584717;12311.076669250022;12454.43955022008;12112.333821639895;12469.75060498803;12505.374731263582;12662.873371266169;12827.807582886451 10:43:55 INFO - PROCESS | 9928 | __end_tp_report 10:43:55 INFO - PROCESS | 9928 | __start_cc_report 10:43:55 INFO - PROCESS | 9928 | _x_x_mozilla_cycle_collect,928 10:43:55 INFO - PROCESS | 9928 | __end_cc_report 10:43:55 INFO - PROCESS | 9928 | __startTimestamp1480013035842__endTimestamp 10:43:55 INFO - PROCESS | 9928 | 10:43:55 INFO - PROCESS | 9928 | ------- Summary: start ------- 10:43:55 INFO - PROCESS | 9928 | Number of tests: 6 10:43:55 INFO - PROCESS | 9928 | 10:43:55 INFO - PROCESS | 9928 | [#0] dojo.html Cycles:165 Average:5671.93 Median:5890.20 stddev:661.14 (11.2%) stddev-sans-first:632.57 10:43:55 INFO - PROCESS | 9928 | Values: 3137.8 3172.8 3176.7 3198.6 3205.8 5609.0 5682.8 5700.5 5707.8 5741.7 5666.9 5726.5 5736.9 5743.9 5745.5 5167.0 5220.4 5220.8 5225.5 5246.8 5128.6 5179.8 5267.2 5287.3 5294.8 5154.4 5179.9 5199.5 5202.3 5252.1 5257.1 5272.1 5310.5 5322.5 5324.0 5043.0 5140.6 5222.1 5248.4 5253.4 5550.9 5557.9 5588.6 5618.4 5619.5 6012.5 6057.2 6134.5 6134.8 6144.5 5916.4 6148.7 6173.0 6177.5 6181.6 5501.3 5605.2 5643.3 5661.4 5740.3 6280.5 6293.0 6309.8 6313.8 6314.0 6051.9 6069.7 6085.2 6088.4 6090.1 5876.2 5947.9 6016.8 6065.2 6080.8 6107.4 6119.4 6123.2 6130.3 6131.8 6079.5 6106.2 6143.0 6145.4 6146.3 4565.1 4594.1 4599.4 4610.3 4673.9 4119.3 4128.1 4131.4 4150.4 4158.5 5831.1 5845.9 5853.7 5854.2 5855.3 5899.1 5960.8 6037.8 6084.1 6146.4 5838.6 5858.4 5886.6 5888.7 5889.4 5293.6 5295.8 5298.9 5300.6 5305.2 6130.4 6182.1 6291.8 6350.7 6362.6 6028.0 6088.9 6129.2 6139.1 6156.7 6338.4 6356.5 6361.7 6368.0 6376.7 5834.9 5960.6 6021.8 6036.2 6036.4 6050.4 6052.2 6096.8 6142.1 6150.3 5998.9 5999.9 6002.8 6007.9 6039.5 5788.8 5844.4 5990.7 5992.7 5995.6 5890.2 5902.0 5969.5 6009.1 6037.7 6019.8 6060.1 6080.4 6081.0 6081.5 5729.5 5807.1 5844.7 5915.3 5925.1 10:43:55 INFO - PROCESS | 9928 | 10:43:55 INFO - PROCESS | 9928 | [#1] ext.html Cycles:180 Average:63942.74 Median:41023.88 stddev:122111.78 (297.7%) stddev-sans-first:122361.69 10:43:55 INFO - PROCESS | 9928 | Values: 589.9 615.2 644.8 651.6 663.3 34736.0 47631.5 48865.8 48885.0 52559.5 49064.8 49584.0 49595.8 49608.0 49704.3 8542.6 9442.4 9599.0 9599.6 9606.8 8411.8 8814.2 8814.3 11201.5 11482.8 11589.4 11602.8 11653.9 11663.8 11668.4 11259.6 11325.2 11326.9 11333.2 11338.9 11211.8 11261.2 11289.7 11291.7 11300.3 46234.0 46873.8 46895.0 46913.5 47035.5 3743.9 3755.2 3768.6 3950.3 4441.4 34759.0 35096.0 35419.6 35683.1 35810.8 4463.3 4585.9 4741.7 4830.0 4922.7 393095.0 396262.0 397917.0 398055.0 398131.0 68361.3 68913.0 69338.0 69442.0 69517.3 41108.2 42199.2 42268.0 44260.0 44339.0 18741.7 18938.9 18940.3 18943.8 18976.1 12492.7 14411.2 14536.9 14545.4 14549.9 19175.4 20578.3 21112.4 21306.1 21858.6 7378.2 7693.7 7723.9 7757.3 7867.0 1063.9 1072.2 1089.1 1148.3 1167.8 35859.3 35890.5 36215.0 36256.6 36402.0 1170.6 1185.0 1193.6 1224.6 1229.2 18401.8 18762.1 18819.7 18951.6 19158.8 534350.0 535095.0 536809.0 536890.0 537307.0 64117.0 64442.4 64469.4 64478.4 64480.4 1305.2 1384.3 1408.9 1461.1 1484.8 32409.0 36424.8 36647.6 36708.6 36841.8 55315.0 55765.0 55816.7 55912.7 56039.4 439331.0 442254.0 443790.0 445636.0 446246.0 31651.2 32918.2 33072.8 33176.0 33250.3 53514.7 53591.7 53827.7 53853.7 53863.7 44325.6 45936.5 46310.8 46564.8 47229.8 46358.3 46652.0 47214.5 47486.3 48396.8 45994.1 46553.0 47175.0 47236.0 47288.1 38075.0 39706.2 39761.2 40939.6 41298.0 29608.4 30183.0 30247.4 30390.7 30472.5 10:43:55 INFO - PROCESS | 9928 | 10:43:55 INFO - PROCESS | 9928 | [#2] jquery.html Cycles:180 Average:27886.72 Median:2200.80 stddev:73170.66 (3324.7%) stddev-sans-first:73346.89 10:43:55 INFO - PROCESS | 9928 | Values: 437.2 439.9 440.5 441.1 444.0 18661.3 19021.6 20340.3 20425.7 20537.7 17481.3 18889.4 19502.1 19546.8 19605.8 5323.5 5555.2 5556.1 5566.7 5611.1 5422.7 5490.9 5554.1 5555.0 5976.2 6013.9 6016.0 6019.7 6022.5 6023.0 5506.1 5529.8 5560.5 6001.3 6006.7 5413.1 5420.1 5423.9 5424.5 5426.1 14863.4 15035.5 15256.8 15386.2 15415.4 2427.6 2490.4 2979.5 3017.9 3088.4 10706.8 10755.9 10942.8 10948.7 11184.0 2026.7 2066.7 2094.2 2193.8 2237.6 81706.6 82459.0 83773.0 95894.5 97431.5 10414.7 11369.8 11543.8 11628.7 11850.9 16167.4 16173.4 16194.0 16207.8 16230.8 8203.7 8608.9 8648.8 8653.0 8713.3 8219.0 8263.1 8371.2 8503.6 8512.7 4770.6 4843.6 4875.9 4950.3 4965.9 2129.5 2191.6 2207.8 2216.7 2219.5 1015.0 1064.7 1069.8 1085.8 1146.1 20118.3 20848.1 21028.4 21232.3 21321.9 1048.2 1052.9 1080.4 1089.8 1127.8 10767.8 11566.5 11688.5 11737.1 11760.1 428944.0 440213.0 442767.0 447676.0 450007.0 56440.7 71630.0 88512.6 88760.0 97389.5 1008.6 1024.1 1032.3 1033.1 1043.6 17898.0 18251.5 18476.5 18612.0 18890.3 44423.3 44738.0 45125.8 45721.3 47087.0 62187.0 63075.1 63181.4 64360.7 64439.0 8770.7 9024.9 9040.2 9066.8 9223.2 10154.6 12438.0 13884.7 14245.8 14397.9 11849.1 12013.3 12044.5 12070.0 12370.6 11413.1 11448.7 11754.4 12151.9 12239.8 11605.2 12307.8 12359.2 12457.6 12607.3 9490.4 9507.2 9604.3 9680.0 9693.7 11858.2 12365.2 12472.6 12656.7 12677.6 10:43:55 INFO - PROCESS | 9928 | 10:43:55 INFO - PROCESS | 9928 | [#3] mootools.html Cycles:180 Average:6287.41 Median:2699.20 stddev:3621.36 (134.2%) stddev-sans-first:3613.77 10:43:55 INFO - PROCESS | 9928 | Values: 1517.7 1545.1 1692.5 1838.7 1869.4 9175.7 9811.3 9831.8 9837.0 9852.1 8498.9 8734.9 9167.5 9368.3 9619.1 2561.8 2591.0 2592.1 2593.9 2601.2 2464.1 2573.7 2576.5 2581.5 2583.9 2551.5 2567.1 2581.0 2581.5 2583.6 2414.8 2420.6 2474.4 2530.9 2538.4 2488.4 2492.5 2497.3 2499.7 2514.2 9594.1 9706.8 9711.1 9721.7 9732.9 5669.7 5807.7 5809.8 5815.8 5828.7 3531.2 3643.4 3686.2 3714.1 3718.7 1220.2 1270.8 1282.5 1289.9 1294.8 13049.9 13373.3 13373.6 13594.7 13838.3 4909.8 4943.8 4968.3 4991.2 5077.9 10630.4 10630.9 10648.5 10649.9 10680.9 5755.8 5758.0 5766.9 5768.0 5770.9 4732.6 4745.6 5332.2 5357.1 5398.3 4138.3 4190.0 4257.1 4296.3 4309.8 1261.0 1265.6 1267.8 1285.8 1307.9 913.3 920.4 1028.7 1039.7 1047.8 6315.3 6367.4 6405.4 6569.3 6811.7 488.6 507.1 509.5 509.9 512.6 4291.4 4295.4 4350.0 4376.5 4409.7 11554.6 12030.7 12049.8 12056.1 12072.0 11416.4 11885.9 11941.9 12165.3 12176.0 8838.7 8951.3 8979.5 9034.2 9034.3 6508.7 6670.3 6787.9 6793.5 6818.2 10944.4 11018.8 11142.5 11212.2 11246.6 11030.6 11098.3 11296.8 11468.9 11501.6 7699.8 7928.3 8163.0 8208.8 8309.9 9330.8 9622.8 9630.9 9645.5 9648.7 8202.9 8368.3 8376.7 8502.0 8782.1 8409.9 8425.5 8437.0 8476.4 8521.5 7467.3 7543.3 7582.6 7623.1 7628.0 5326.6 5397.7 5405.1 5491.7 5729.9 5252.2 5427.4 5463.1 5547.2 5570.5 10:43:55 INFO - PROCESS | 9928 | 10:43:55 INFO - PROCESS | 9928 | [#4] prototype.html Cycles:180 Average:4875.93 Median:5540.76 stddev:1424.57 (25.7%) stddev-sans-first:1387.63 10:43:55 INFO - PROCESS | 9928 | Values: 359.1 363.4 368.9 369.7 373.4 5566.7 5593.9 5624.9 5628.7 5653.1 5189.9 5590.7 5596.3 5601.2 5653.3 3880.2 4299.0 4344.5 4359.9 4372.9 4357.8 4364.0 4375.6 4381.5 4408.5 4376.2 4381.0 4404.5 4409.4 4424.3 4154.0 4342.7 4356.0 4365.1 4395.5 3845.8 3856.3 3863.2 3876.2 3889.2 5400.9 5408.6 5427.9 5444.6 5447.2 4897.9 4903.7 4943.4 5012.9 5029.2 5760.9 5761.0 5771.4 5784.3 5784.4 4236.8 4250.6 4261.7 4261.9 4262.7 5716.0 5856.8 5857.4 6052.3 6072.3 4171.0 4207.9 4211.1 4219.4 4222.3 4282.8 4287.5 4314.6 4316.5 4318.4 4738.2 4914.0 4920.5 4927.3 4943.2 5757.4 5796.4 5806.6 5807.7 5837.9 1505.4 1528.2 1528.5 1529.9 1536.6 916.9 970.7 979.9 981.7 990.8 5020.9 5043.8 5061.8 5061.9 5081.0 5226.5 5244.9 5271.6 5290.8 5291.5 4966.4 4968.5 5010.8 5366.0 5732.0 3158.6 3161.1 3161.4 3170.9 3208.7 6012.2 6119.4 6158.1 6166.0 6203.0 5996.5 6049.9 6077.6 6082.6 6113.8 6127.0 6136.5 6157.5 6161.4 6191.7 5656.3 5985.0 6007.0 6021.8 6022.0 5945.1 5955.9 5963.6 5964.9 5988.3 5913.2 6015.2 6075.2 6189.5 6229.0 4341.2 4356.4 4357.5 4364.1 4365.0 5854.7 6047.9 6078.6 6079.0 6085.6 5877.2 5903.0 5910.2 5912.3 5927.8 5912.3 5927.7 5929.6 5929.8 5936.2 5746.5 5831.7 5875.8 5882.6 5904.5 5926.7 5941.4 5954.3 5955.2 5961.3 5514.9 5781.2 5785.5 5809.4 5824.7 10:43:55 INFO - PROCESS | 9928 | 10:43:55 INFO - PROCESS | 9928 | [#5] yui.html Cycles:180 Average:22374.98 Median:4078.15 stddev:32240.14 (790.6%) stddev-sans-first:32289.90 10:43:55 INFO - PROCESS | 9928 | Values: 805.6 860.3 874.5 883.6 930.6 17068.3 17508.0 17727.6 17758.6 17784.6 16326.3 16485.1 16495.3 16513.3 16528.8 722.0 741.6 841.5 863.1 869.0 873.8 876.4 877.0 877.1 877.2 922.6 925.9 928.5 929.2 930.8 921.7 921.8 925.4 925.6 925.8 675.3 679.6 682.2 682.5 682.5 15776.4 15812.6 15821.8 15832.8 15844.6 14530.2 14801.4 14979.4 15133.2 15300.0 12769.3 12989.5 13006.9 13077.3 13156.3 4055.0 4065.8 4090.6 4110.9 4263.2 88697.0 88726.6 88792.6 88821.6 89355.6 12402.8 12483.8 12505.5 12568.6 12618.3 24408.5 24537.3 24556.3 24558.5 24578.1 9155.2 9160.1 9176.0 9261.1 9287.5 5187.5 5288.2 5362.4 5411.0 5472.1 3796.5 3890.9 3922.1 3923.8 3927.8 619.6 632.0 635.3 635.4 638.7 660.8 797.7 810.3 818.7 822.0 10563.4 10574.3 10910.7 11045.2 11069.4 700.5 712.2 788.8 806.7 825.6 4847.9 4893.1 4909.3 4919.0 4921.3 74132.0 81006.2 135515.0 135933.0 136937.0 112871.0 114701.0 114875.0 116913.0 118594.0 58918.4 93528.5 98219.0 98487.0 101391.0 9248.8 9552.6 9578.7 9745.0 9840.9 49269.8 57794.4 58663.1 58687.5 58894.4 50435.7 57460.7 75454.3 79457.6 83525.6 13848.2 14344.8 14390.6 14655.6 14688.2 14501.2 14855.1 15038.4 15968.4 16966.2 15535.3 15841.8 16562.4 16864.1 16869.2 15142.0 15655.4 16136.0 16169.7 16307.3 14958.9 15159.8 16016.4 16036.8 16382.3 11226.2 11724.1 12240.5 12311.1 12454.4 12112.3 12469.8 12505.4 12662.9 12827.8 10:43:55 INFO - PROCESS | 9928 | -------- Summary: end -------- 10:43:55 INFO - PROCESS | 9928 | 10:43:56 INFO - TEST-INFO | 9928: exit 0 10:43:56 INFO - TEST-OK | dromaeo_css | took 1113205ms 10:43:56 INFO - TEST-START | kraken 10:43:56 INFO - operating with platform_type : linux_ 10:43:56 INFO - Initialising browser for kraken test... 10:43:56 INFO - TEST-INFO | started process 10232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFZuoAc/profile http://localhost:41659/getInfo.html) 10:44:00 INFO - PROCESS | 10232 | __metrics Screen width/height:1600/1200 10:44:00 INFO - PROCESS | 10232 | colorDepth:24 10:44:00 INFO - PROCESS | 10232 | Browser inner width/height: 1024/697 10:44:00 INFO - PROCESS | 10232 | __metrics 10:44:00 INFO - PROCESS | 10232 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:44:00 INFO - PROCESS | 10232 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:44:01 INFO - PROCESS | 10232 | console.error: PushService: 10:44:01 INFO - PROCESS | 10232 | stateChangeProcessEnqueue: Error transitioning state 10:44:01 INFO - PROCESS | 10232 | UnknownError 10:44:01 INFO - TEST-INFO | 10232: exit 0 10:44:01 INFO - Browser initialized. 10:44:01 INFO - Running cycle 1/1 for kraken test... 10:44:02 INFO - TEST-INFO | started process 10322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFZuoAc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:44:13 INFO - PROCESS | 10322 | RSS: Main: 143007744 10:44:13 INFO - PROCESS | 10322 | 10:44:16 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41659/tests/kraken/driver.html?testName=audio-beat-detection) 10:44:17 INFO - PROCESS | 10322 | RSS: Main: 186142720 10:44:17 INFO - PROCESS | 10322 | 10:44:19 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41659/tests/kraken/driver.html?testName=audio-dft) 10:44:20 INFO - PROCESS | 10322 | RSS: Main: 172961792 10:44:20 INFO - PROCESS | 10322 | 10:44:23 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41659/tests/kraken/driver.html?testName=audio-fft) 10:44:23 INFO - PROCESS | 10322 | RSS: Main: 265691136 10:44:23 INFO - PROCESS | 10322 | 10:44:25 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41659/tests/kraken/driver.html?testName=audio-oscillator) 10:44:26 INFO - PROCESS | 10322 | RSS: Main: 170917888 10:44:26 INFO - PROCESS | 10322 | 10:44:28 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41659/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:44:28 INFO - PROCESS | 10322 | RSS: Main: 173195264 10:44:28 INFO - PROCESS | 10322 | 10:44:31 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41659/tests/kraken/driver.html?testName=imaging-darkroom) 10:44:32 INFO - PROCESS | 10322 | RSS: Main: 208576512 10:44:32 INFO - PROCESS | 10322 | 10:44:35 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41659/tests/kraken/driver.html?testName=imaging-desaturate) 10:44:36 INFO - PROCESS | 10322 | RSS: Main: 208138240 10:44:36 INFO - PROCESS | 10322 | 10:44:39 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41659/tests/kraken/driver.html?testName=json-parse-financial) 10:44:39 INFO - PROCESS | 10322 | RSS: Main: 207953920 10:44:39 INFO - PROCESS | 10322 | 10:44:41 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41659/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:44:41 INFO - PROCESS | 10322 | RSS: Main: 169304064 10:44:41 INFO - PROCESS | 10322 | 10:44:43 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41659/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:44:44 INFO - PROCESS | 10322 | RSS: Main: 176979968 10:44:44 INFO - PROCESS | 10322 | 10:44:46 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41659/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:44:46 INFO - PROCESS | 10322 | RSS: Main: 186433536 10:44:46 INFO - PROCESS | 10322 | 10:44:49 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:44:49 INFO - PROCESS | 10322 | RSS: Main: 195203072 10:44:49 INFO - PROCESS | 10322 | 10:44:52 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:44:53 INFO - PROCESS | 10322 | RSS: Main: 190820352 10:44:53 INFO - PROCESS | 10322 | 10:44:54 INFO - PROCESS | 10322 | Cycle 1(1): loaded http://localhost:41659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41659/tests/kraken/driver.html?testName=ai-astar) 10:44:54 INFO - PROCESS | 10322 | RSS: Main: 242839552 10:44:54 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | __start_tp_report 10:44:55 INFO - PROCESS | 10322 | _x_x_mozilla_page_load 10:44:55 INFO - PROCESS | 10322 | _x_x_mozilla_page_load_details 10:44:55 INFO - PROCESS | 10322 | |i|pagename|runs| 10:44:55 INFO - PROCESS | 10322 | |0;ai-astar;111;111;109;112;112;112;111;111;111;110 10:44:55 INFO - PROCESS | 10322 | |1;audio-beat-detection;146;116;121;160;122;118;121;117;148;117 10:44:55 INFO - PROCESS | 10322 | |2;audio-dft;161;160;160;160;160;160;162;160;160;160 10:44:55 INFO - PROCESS | 10322 | |3;audio-fft;74;76;75;116;75;75;77;76;99;76 10:44:55 INFO - PROCESS | 10322 | |4;audio-oscillator;82;82;118;80;82;81;99;81;81;112 10:44:55 INFO - PROCESS | 10322 | |5;imaging-gaussian-blur;117;117;123;117;117;117;117;117;116;116 10:44:55 INFO - PROCESS | 10322 | |6;imaging-darkroom;146;145;146;146;145;145;145;146;145;145 10:44:55 INFO - PROCESS | 10322 | |7;imaging-desaturate;95;95;95;96;95;96;95;96;96;97 10:44:55 INFO - PROCESS | 10322 | |8;json-parse-financial;50;52;50;50;50;50;50;49;51;49 10:44:55 INFO - PROCESS | 10322 | |9;json-stringify-tinderbox;57;58;58;58;58;58;57;59;58;58 10:44:55 INFO - PROCESS | 10322 | |10;stanford-crypto-aes;74;74;72;73;74;73;77;73;81;74 10:44:55 INFO - PROCESS | 10322 | |11;stanford-crypto-ccm;124;120;119;122;122;122;118;121;162;128 10:44:55 INFO - PROCESS | 10322 | |12;stanford-crypto-pbkdf2;154;153;156;154;157;158;154;156;153;156 10:44:55 INFO - PROCESS | 10322 | |13;stanford-crypto-sha256-iterative;63;66;65;63;62;76;63;65;61;60 10:44:55 INFO - PROCESS | 10322 | __end_tp_report 10:44:55 INFO - PROCESS | 10322 | __start_cc_report 10:44:55 INFO - PROCESS | 10322 | _x_x_mozilla_cycle_collect,1566 10:44:55 INFO - PROCESS | 10322 | __end_cc_report 10:44:55 INFO - PROCESS | 10322 | __startTimestamp1480013094998__endTimestamp 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | ------- Summary: start ------- 10:44:55 INFO - PROCESS | 10322 | Number of tests: 14 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 10:44:55 INFO - PROCESS | 10322 | Values: 111.0 111.0 109.0 112.0 112.0 112.0 111.0 111.0 111.0 110.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:121.50 stddev:16.21 (13.3%) stddev-sans-first:15.92 10:44:55 INFO - PROCESS | 10322 | Values: 146.0 116.0 121.0 160.0 122.0 118.0 121.0 117.0 148.0 117.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 10:44:55 INFO - PROCESS | 10322 | Values: 161.0 160.0 160.0 160.0 160.0 160.0 162.0 160.0 160.0 160.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:14.10 (18.6%) stddev-sans-first:14.66 10:44:55 INFO - PROCESS | 10322 | Values: 74.0 76.0 75.0 116.0 75.0 75.0 77.0 76.0 99.0 76.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:81.50 stddev:14.47 (17.8%) stddev-sans-first:15.07 10:44:55 INFO - PROCESS | 10322 | Values: 82.0 82.0 118.0 80.0 82.0 81.0 99.0 81.0 81.0 112.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:2.01 (1.7%) stddev-sans-first:2.13 10:44:55 INFO - PROCESS | 10322 | Values: 117.0 117.0 123.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:44:55 INFO - PROCESS | 10322 | Values: 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 10:44:55 INFO - PROCESS | 10322 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 97.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:0.88 (1.8%) stddev-sans-first:0.93 10:44:55 INFO - PROCESS | 10322 | Values: 50.0 52.0 50.0 50.0 50.0 50.0 50.0 49.0 51.0 49.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 10:44:55 INFO - PROCESS | 10322 | Values: 57.0 58.0 58.0 58.0 58.0 58.0 57.0 59.0 58.0 58.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.64 (3.6%) stddev-sans-first:2.79 10:44:55 INFO - PROCESS | 10322 | Values: 74.0 74.0 72.0 73.0 74.0 73.0 77.0 73.0 81.0 74.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:122.00 stddev:13.02 (10.7%) stddev-sans-first:13.79 10:44:55 INFO - PROCESS | 10322 | Values: 124.0 120.0 119.0 122.0 122.0 122.0 118.0 121.0 162.0 128.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:156.00 stddev:1.73 (1.1%) stddev-sans-first:1.79 10:44:55 INFO - PROCESS | 10322 | Values: 154.0 153.0 156.0 154.0 157.0 158.0 154.0 156.0 153.0 156.0 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - PROCESS | 10322 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:4.48 (7.0%) stddev-sans-first:4.72 10:44:55 INFO - PROCESS | 10322 | Values: 63.0 66.0 65.0 63.0 62.0 76.0 63.0 65.0 61.0 60.0 10:44:55 INFO - PROCESS | 10322 | -------- Summary: end -------- 10:44:55 INFO - PROCESS | 10322 | 10:44:55 INFO - TEST-INFO | 10322: exit 0 10:44:55 INFO - TEST-OK | kraken | took 59467ms 10:44:55 INFO - SUITE-END | took 1172s 10:44:56 INFO - Completed test suite (00:19:32) 10:44:56 INFO - javascript benchmark 10:44:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.8117312961217, 3172.825494597796, 3176.6823317668236, 3198.6481487036435, 3205.8076515409075, 5609.0, 5682.772689092441, 5700.486956173949, 5707.828765137042, 5741.655500669957, 5666.858328541788, 5726.541876649869, 5736.942630573703, 5743.942560574393, 5745.482906538411, 5167.044096842087, 5220.373555173384, 5220.765065572058, 5225.529702326789, 5246.842594722164, 5128.5640720538795, 5179.844604661847, 5267.157254839227, 5287.2862163608, 5294.814681486148, 5154.355705536808, 5179.922301165486, 5199.506046925555, 5202.271681964528, 5252.133397989327, 5257.080010998079, 5272.1300985337375, 5310.548603368679, 5322.494363035506, 5324.041672498949, 5043.041822053798, 5140.588752899759, 5222.112240919053, 5248.448912864171, 5253.44838791929, 5550.86122846928, 5557.944420555783, 5588.552915766729, 5618.410066942953, 5619.522340601054, 6012.488938440238, 6057.212562366908, 6134.478569321613, 6134.846628834315, 6144.5084393248435, 5916.3787802281, 6148.7233074511305, 6173.0, 6177.4749146322165, 6181.598196117238, 5501.257330260403, 5605.1872478490795, 5643.322801263793, 5661.405552417019, 5740.282464691913, 6280.466160376328, 6293.0, 6309.779157729549, 6313.842153946188, 6314.02132669437, 6051.939480605226, 6069.696515174312, 6085.208922840003, 6088.391160883876, 6090.116933044684, 5876.236089308362, 5947.910781338283, 6016.789412370546, 6065.150878876961, 6080.787172448943, 6107.447682086317, 6119.377697160598, 6123.191113103653, 6130.340846152681, 6131.778844714162, 6079.483243924227, 6106.206193194945, 6143.0, 6145.385461453819, 6146.262448506119, 4565.0641618468135, 4594.104149690778, 4599.356090147382, 4610.308453731967, 4673.883152921137, 4119.279126152911, 4128.112455822013, 4131.421600975866, 4150.418941348214, 4158.521769996489, 5831.067029275296, 5845.88308233833, 5853.707314634251, 5854.2096816930025, 5855.268091488564, 5899.115132730125, 5960.821175364746, 6037.849053773691, 6084.056971169476, 6146.446819786241, 5838.620489668243, 5858.384869588717, 5886.587938844325, 5888.705564721747, 5889.352171261158, 5293.602979776532, 5295.761690723926, 5298.92051619226, 5300.602454815904, 5305.1776974569, 6130.367562715059, 6182.103594978613, 6291.811245662638, 6350.714217860115, 6362.618242905441, 6028.0, 6088.878222435438, 6129.233845769279, 6139.079138129317, 6156.661383623944, 6338.429541341301, 6356.491480681627, 6361.650109244036, 6368.0, 6376.681165941777, 5834.883302334015, 5960.582759206987, 6021.849453763691, 6036.215292012011, 6036.426539478743, 6050.42520960508, 6052.243469566304, 6096.847578810565, 6142.078688196806, 6150.323464419, 5998.880022399615, 5999.940000599938, 6002.819915402545, 6007.90988135187, 6039.456448919618, 5788.82633520995, 5844.357120716632, 5990.7004649768205, 5992.730327135202, 5995.5803093783015, 5890.204822348928, 5901.970490147522, 5969.52243820502, 6009.098635204754, 6037.6679282638115, 6019.819405417845, 6060.090986352083, 6080.361562035922, 6081.027035674271, 6081.5134789217645, 5729.4843464088435, 5807.128930660435, 5844.707764611838, 5915.319738230159, 5925.05199168131], "value": 5625.139667555217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.9085641725534, 615.1940957345877, 644.8484606117563, 651.569963823876, 663.3499170812601, 34736.0, 47631.52368476314, 48865.75567122168, 48885.0, 52559.47440525593, 49064.75467622666, 49584.0, 49595.75202123993, 49608.0, 49704.25443618349, 8542.615582298811, 9442.433453992766, 9599.040095990415, 9599.568019439143, 9606.75983100421, 8411.789705257357, 8814.162654547808, 8814.25078868297, 11201.495932683009, 11482.827757583644, 11589.36258505782, 11602.825957610643, 11653.941730291337, 11663.766724665502, 11668.35824029678, 11259.605913793019, 11325.150613704005, 11326.943365283203, 11333.206675532716, 11338.886611133907, 11211.831822522669, 11261.15541334395, 11289.661310160709, 11291.661250162508, 11300.265482743594, 46234.0, 46873.76563117163, 46895.0, 46913.53086469126, 47035.529644703456, 3743.8689645862264, 3755.2114056048263, 3768.6042965488778, 3950.308695978192, 4441.356003379524, 34759.0, 35096.0, 35419.64580354189, 35683.10792230189, 35810.820945895364, 4463.308187230984, 4585.862424127282, 4741.668083234175, 4829.951700482985, 4922.655414121013, 393095.0, 396262.01868990756, 397917.0, 398055.0, 398130.9999999971, 68361.3163868365, 68913.0, 69338.0, 69442.0, 69517.3048269521, 41108.177836443705, 42199.15601688011, 42268.0, 44260.0, 44339.0, 18741.7188742169, 18938.90530547366, 18940.337088201846, 18943.81056189448, 18976.146073426728, 12492.687682808002, 14411.207383593794, 14536.85463145355, 14545.41818327255, 14549.92725036368, 19175.424737257905, 20578.27976020832, 21112.366629001153, 21306.147754089663, 21858.562828743656, 7378.151512576015, 7693.730719424793, 7723.884141737878, 7757.26306000929, 7866.960665196638, 1063.8882917293727, 1072.2119242356862, 1089.0742868561658, 1148.328227986637, 1167.7664467106613, 35859.28281434357, 35890.461643075374, 36215.0, 36256.63743362533, 36402.0, 1170.6253998720329, 1185.016436357821, 1193.6001439517859, 1224.5714000100072, 1229.2071613809044, 18401.81598184028, 18762.0618969051, 18819.71770423445, 18951.62096758057, 19158.808411915983, 534350.0, 535095.0, 536809.0, 536890.0, 537307.0, 64117.0, 64442.35557644457, 64469.35530644727, 64478.355216447235, 64480.35519644837, 1305.1907817153235, 1384.2801743093737, 1408.8591140885828, 1461.0868207370393, 1484.7550154224432, 32409.0, 36424.81787591045, 36647.63352366549, 36708.632913670524, 36841.815790920875, 55315.0, 55765.0, 55816.720916396785, 55912.720436397554, 56039.439605603424, 439331.0, 442254.0, 443790.0, 445636.0, 446246.0, 31651.20871978219, 32918.177045574055, 33072.834635826664, 33176.0, 33250.33499330048, 53514.73242633762, 53591.73204133954, 53827.730861345444, 53853.73073134609, 53863.73068134791, 44325.55674443343, 45936.54063459457, 46310.768446157555, 46564.7671761639, 47229.76385118053, 46358.30462543132, 46652.0, 47214.527854722386, 47486.287705685136, 48396.75801620969, 45994.08011839678, 46553.0, 47175.0, 47236.0, 47288.05423891434, 38075.0, 39706.2058758829, 39761.2047759049, 40939.59060409358, 41298.0, 29608.40783184281, 30183.0, 30247.395052099277, 30390.696093038787, 30472.542911856784], "value": 22115.876104892348, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.20647025648424, 439.88782860370605, 440.49783247098316, 441.09575370490495, 443.95891634118004, 18661.346852860137, 19021.61956760864, 20340.288089916856, 20425.693614595773, 20537.691934620994, 17481.300747970065, 18889.433317000512, 19502.122404491798, 19546.804531954713, 19605.803941960578, 5323.520883120518, 5555.166724991243, 5556.083246264382, 5566.666000039991, 5611.102223644218, 5422.674639521641, 5490.917636235459, 5554.1391084381785, 5555.027870122733, 5976.163337132805, 6013.909791353133, 6016.0, 6019.699015049252, 6022.488088512482, 6022.969885150568, 5506.091494903376, 5529.751161197735, 5560.499555040065, 6001.309849367313, 6006.669633170174, 5413.133898576249, 5420.13277875542, 5423.891522169534, 5424.457554244584, 5426.050441172779, 14863.405463781435, 15035.548933531902, 15256.847431525654, 15386.230688465532, 15415.3833846646, 2427.5751743445003, 2490.439651078511, 2979.5232762757855, 3017.8641961111803, 3088.3977624363256, 10706.839397409045, 10755.946220268926, 10942.835857462145, 10948.686457178746, 11184.049355804686, 2026.7365242518526, 2066.741657292838, 2094.172801743303, 2193.824494040489, 2237.5524895021063, 81706.59146704288, 82459.0, 83773.0, 95894.52052739762, 97431.51284243533, 10414.687559373231, 11369.772604548029, 11543.826842597367, 11628.709282267842, 11850.940745296391, 16167.353305867633, 16173.4339298124, 16194.02835829854, 16207.756883646754, 16230.756538651929, 8203.71287004952, 8608.913910860936, 8648.827023459495, 8653.048164701877, 8713.3464990126, 8219.013718353835, 8263.132371101068, 8371.246587807005, 8503.61733721984, 8512.65949362031, 4770.570648641639, 4843.588294994965, 4875.881657041058, 4950.331705219821, 4965.875853103701, 2129.542148438093, 2191.594555007329, 2207.779222077779, 2216.656418255173, 2219.5117074243963, 1014.9545967653329, 1064.6593090211059, 1069.8020866139789, 1085.782843431301, 1146.083133493202, 20118.295859645135, 20848.061837217363, 21028.369148925558, 21232.256871009442, 21321.867813218552, 1048.2400259811575, 1052.905238528536, 1080.4057768227444, 1089.7929393415225, 1127.785720713062, 10767.83848242277, 11566.47950842214, 11688.532458701728, 11737.119716021332, 11760.117991150526, 428944.0, 440213.0, 442767.0, 447676.0, 450007.0, 56440.717796411576, 71630.0, 88512.5574372124, 88760.0, 97389.51305243428, 1008.6318493749728, 1024.1039090795555, 1032.26193271811, 1033.0960409641564, 1043.5773511727914, 17898.0, 18251.45245642633, 18476.538086547946, 18612.0, 18890.3388381406, 44423.33364999463, 44738.0, 45125.77437112793, 45721.31418028799, 47087.0, 62187.0, 63075.053874191006, 63181.36818631755, 64360.678196608715, 64439.0, 8770.68439734045, 9024.909750902669, 9040.186383225542, 9066.773330666787, 9223.16991470744, 10154.593816247563, 12438.0, 13884.722305554034, 14245.786313205517, 14397.928010359881, 11849.111316651113, 12013.314807225364, 12044.457999390224, 12070.0, 12370.62888113358, 11413.059779837282, 11448.656540303804, 11754.353510557, 12151.939240304095, 12239.822031085007, 11605.187636865337, 12307.75384492323, 12359.196652217577, 12457.563985260473, 12607.306598137191, 9490.383125096847, 9507.239420846454, 9604.27967902396, 9680.0, 9693.70918872435, 11858.169928105295, 12365.196262242926, 12472.563460278847, 12656.683582910133, 12677.556285529961], "value": 9498.752367281506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.6737001544666, 1545.057514915901, 1692.5260926940452, 1838.6598479281333, 1869.38310357582, 9175.678851240207, 9811.31320807543, 9831.75420614485, 9837.0, 9852.113309802126, 8498.915010849889, 8734.91265087349, 9167.541622918861, 9368.34421590489, 9619.08618681226, 2561.8078644101674, 2590.961135582968, 2592.066855931863, 2593.8962441502317, 2601.1676263595655, 2464.137551856854, 2573.7040240372407, 2576.510463012031, 2581.5224183526016, 2583.922482325524, 2551.4514379408424, 2567.114345550782, 2580.9741902581018, 2581.509513192497, 2583.5607946649116, 2414.8068154547595, 2420.552197843396, 2474.40614252579, 2530.9240722778345, 2538.4034751833487, 2488.377905523619, 2492.538880307149, 2497.2757900208917, 2499.662545556345, 2514.245726282108, 9594.136527712539, 9706.805863882753, 9711.125998660154, 9721.70834874955, 9732.90267097327, 5669.659820410789, 5807.738651760638, 5809.82570522885, 5815.796447124372, 5828.650280983112, 3531.187826799825, 3643.36241157799, 3686.2443199144377, 3714.0900479382453, 3718.6653201211752, 1220.2190598017276, 1270.8093785932092, 1282.5254655777421, 1289.9484020639163, 1294.7604693131707, 13049.86950130496, 13373.264470454122, 13373.598792036255, 13594.660133496644, 13838.30808459573, 4909.828156014522, 4943.752812359439, 4968.254761785761, 4991.151504244287, 5077.949220507748, 10630.415327157081, 10630.893691063146, 10648.467576621293, 10649.89350106489, 10680.89319106799, 5755.827325180251, 5758.0, 5766.94233057664, 5767.971160144256, 5770.855728606818, 4732.645051621073, 4745.572898439088, 5332.226827110047, 5357.142857142916, 5398.2982212312145, 4138.317177665712, 4189.979050104791, 4257.106007738348, 4296.2911119664905, 4309.806058727365, 1261.0416083776213, 1265.5633806336798, 1267.752788206291, 1285.7749893768553, 1307.8626744191913, 913.2921985461188, 920.3833431600843, 1028.6605420211313, 1039.6776999130293, 1047.7852040331866, 6315.305316415191, 6367.395097465734, 6405.391487808651, 6569.310222426577, 6811.693473793691, 488.57982135363557, 507.13533425509416, 509.4828748819951, 509.8980203959223, 512.5643203277184, 4291.420658211102, 4295.420118284054, 4349.956500435019, 4376.496702879146, 4409.669274804339, 11554.59558915434, 12030.699232519257, 12049.819252711217, 12056.095792815398, 12072.034237260998, 11416.42917854104, 11885.88114118865, 11941.880581194251, 12165.270083795001, 12176.0, 8838.690645827364, 8951.328650351119, 8979.461232326212, 9034.186923176945, 9034.322425817958, 6508.674566271762, 6670.299618539983, 6787.932120678927, 6793.490488213502, 6818.249992500921, 10944.39805810688, 11018.779624407307, 11142.498587563741, 11212.159088068265, 11246.550137994716, 11030.558777648805, 11098.334099954029, 11296.774064518828, 11468.885311146782, 11501.597444089417, 7699.807504812425, 7928.326092282221, 8163.0, 8208.753737387888, 8309.916900830915, 9330.813383732151, 9622.807543849223, 9630.855537167088, 9645.517724113906, 9648.71053868385, 8202.917970820454, 8368.288695460711, 8376.748697539084, 8501.95749021251, 8782.077881822317, 8409.915900841159, 8425.452345597516, 8436.957815210884, 8476.364272679697, 8521.488710677379, 7467.327940485382, 7543.321101100927, 7582.582957937367, 7623.085229772241, 7627.970224019687, 5326.627136100591, 5397.676139431646, 5405.108157154025, 5491.6979566122645, 5729.914051289151, 5252.238425428215, 5427.409762967626, 5463.098588732814, 5547.195656629847, 5570.498655121059], "value": 4931.111276390966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.06284597201306, 363.4366731566072, 368.90777305673583, 369.69684858416076, 373.3690063792193, 5566.666000040001, 5593.8601534961645, 5624.859378515529, 5628.662280263182, 5653.1237658162945, 5189.896202075965, 5590.692511911843, 5596.272484576999, 5601.215829783833, 5653.265075540185, 3880.20455806559, 4298.978505107486, 4344.500382456011, 4359.891002724926, 4372.934405983913, 4357.847475338363, 4363.978180109111, 4375.584319489643, 4381.518033016366, 4408.537103604108, 4376.221099601744, 4380.978095109536, 4404.493483249419, 4409.382686423904, 4424.314231294138, 4154.0445697489595, 4342.652587792969, 4355.954570902961, 4365.12697460506, 4395.516493185747, 3845.750026248285, 3856.267309211241, 3863.150106976461, 3876.2247550489733, 3889.241597888413, 5400.945990540084, 5408.593176036666, 5427.864303392407, 5444.646098003656, 5447.210154527571, 4897.853064408074, 4903.730294833783, 4943.382077240345, 5012.899742005139, 5029.245613158019, 5760.8847823043725, 5761.0, 5771.365149833515, 5784.334801497797, 5784.421557844224, 4236.788160591958, 4250.553691862341, 4261.659067274611, 4261.893452663678, 4262.676841121596, 5715.999700052515, 5856.76572937082, 5857.443542863463, 6052.303985041733, 6072.332043475214, 4170.979145104316, 4207.894802629959, 4211.073563815956, 4219.43037689914, 4222.311075569796, 4282.785860706952, 4287.464066991626, 4314.61168494837, 4316.539572443677, 4318.3738357938555, 4738.1708201064675, 4914.041761856403, 4920.507949205051, 4927.260910863399, 4943.1596628573225, 5757.366689664133, 5796.362400135981, 5806.622569533051, 5807.680577568274, 5837.94162058374, 1505.44298609513, 1528.1900592685895, 1528.4867980699028, 1529.8929074964647, 1536.6081649179387, 916.8578870275118, 970.6942313171328, 979.8873129590188, 981.7251169672503, 990.846418805072, 5020.870304181603, 5043.84868453947, 5061.7975280989085, 5061.898762024739, 5080.974595127001, 5226.477352264743, 5244.931714946799, 5271.6309858310315, 5290.81482148123, 5291.497307755757, 4966.404031516241, 4968.534282386705, 5010.774515146827, 5365.995042776058, 5731.971340143273, 3158.583683482138, 3161.130689060527, 3161.351922855809, 3170.8596697229277, 3208.727258183034, 6012.188354572077, 6119.449249567471, 6158.121772859231, 6166.0, 6203.0, 5996.4603185713495, 6049.909251361233, 6077.574569780073, 6082.635041897412, 6113.8471538211015, 6126.95841706902, 6136.539759518054, 6157.507399408037, 6161.44546990782, 6191.659458729813, 5656.264685591012, 5984.970075149597, 6007.047709494344, 6021.849453763691, 6021.969890150521, 5945.057196687667, 5955.851103722442, 5963.612365196248, 5964.8807023860145, 5988.251468566429, 5913.201717768046, 6015.187949626745, 6075.2405949256345, 6189.514516516094, 6228.968855155696, 4341.175176716414, 4356.368326592563, 4357.498887627837, 4364.061726728769, 4364.9524114213, 5854.707264636836, 6047.879042419215, 6078.574499784972, 6078.969605152123, 6085.6348619083, 5877.2376982818005, 5902.970485147547, 5910.231669882888, 5912.349641539341, 5927.762889484372, 5912.290525137011, 5927.673977931255, 5929.6145750526075, 5929.822105336847, 5936.168936349001, 5746.540276777764, 5831.679257640871, 5875.764969401176, 5882.617629854046, 5904.498117660047, 5926.67403292823, 5941.435563621449, 5954.255718035246, 5955.171293635489, 5961.344252132349, 5514.862128446821, 5781.219535362672, 5785.479306862234, 5809.390014048464, 5824.70876456167], "value": 4428.473281743328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.6294104711832, 860.2515811244218, 874.5059041641473, 883.5802993578047, 930.6151574315418, 17068.317267309307, 17508.0, 17727.64544709105, 17758.556036099104, 17784.64430711385, 16326.265318060687, 16485.093319867403, 16495.257713402894, 16513.33946642136, 16528.75206871895, 722.0468980945154, 741.6328917186, 841.4698739793952, 863.1454859688926, 868.9826203475958, 873.7640836974014, 876.4215617692324, 877.0221203358242, 877.0790669796688, 877.1666916429385, 922.6355589542127, 925.8842644669417, 928.5171710710426, 929.2194556572477, 930.8417569013284, 921.6958403726754, 921.8478950973115, 925.3892430995544, 925.555733248038, 925.8102089071724, 675.2808259203932, 679.6499802601664, 682.2290811383106, 682.494953734233, 682.5495173185674, 15776.447824326207, 15812.60468488297, 15821.762673559791, 15832.841671583366, 15844.603884902854, 14530.200838953853, 14801.40794368224, 14979.400823967027, 15133.167675777828, 15300.0, 12769.297688627123, 12989.545365912149, 13006.934965325207, 13077.346132693423, 13156.342182890818, 4054.9797251013556, 4065.7560546367313, 4090.550039495653, 4110.937351672993, 4263.189993901149, 88696.99999999936, 88726.55636721839, 88792.5560372194, 88821.55589222077, 89355.55322223347, 12402.81395779064, 12483.75032499363, 12505.49978000888, 12568.560100396442, 12618.305993170463, 24408.511829763305, 24537.263882083567, 24556.263312100666, 24558.508829823302, 24578.139765108135, 9155.176034156957, 9160.129787670161, 9175.954120229357, 9261.073892610684, 9287.48918809472, 5187.533122018961, 5288.198349739709, 5362.410134885159, 5410.97294513525, 5472.124460086367, 3796.52543432071, 3890.8638197662945, 3922.097917478996, 3923.8234279457492, 3927.842886284574, 619.5693992675048, 632.0393002635967, 635.2599221906427, 635.3900255754435, 638.7476946606065, 660.7522179182806, 797.7327595255655, 810.2505182705974, 818.7134502923928, 822.0402084884587, 10563.419011954262, 10574.312669676447, 10910.727231819268, 11045.171612129123, 11069.446527673585, 700.509643249717, 712.1632082303273, 788.8106854354913, 806.7418426103591, 825.5789547330904, 4847.927281090787, 4893.143699852582, 4909.337239472626, 4919.0, 4921.261810728348, 74132.0, 81006.18993810104, 135515.0, 135933.0, 136937.0, 112871.0, 114701.0, 114875.0, 116913.0, 118594.0, 58918.41081589215, 93528.53235733778, 98219.0, 98487.01512984921, 101391.0, 9248.815023699353, 9552.558402355558, 9578.658987741861, 9745.013633231023, 9840.852387214341, 49269.75365123151, 57794.4220557789, 58663.12005320009, 58687.501560121156, 58894.4110558906, 50435.74782126066, 57460.71269643625, 75454.27286356821, 79457.60271198838, 83525.58237208775, 13848.16649356894, 14344.784828227794, 14390.56828295111, 14655.63360915943, 14688.192149431883, 14501.20243386624, 14855.09767858022, 15038.398464061314, 15968.441104561285, 16966.151692415082, 15535.300911459237, 15841.841581584498, 16562.420315288906, 16864.072476013447, 16869.15654217309, 15142.0, 15655.37378504847, 16136.0, 16169.67660646757, 16307.347706092098, 14958.850411495745, 15159.772603410736, 16016.439424620083, 16036.759448608513, 16382.26279817435, 11226.158038147008, 11724.120690948384, 12240.510379584717, 12311.076669250022, 12454.43955022008, 12112.333821639895, 12469.75060498803, 12505.374731263582, 12662.873371266169, 12827.807582886451], "value": 8214.031971897211, "unit": "score"}], "name": "dromaeo_css", "value": 7721.776474577966, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 109.0, 112.0, 112.0, 112.0, 111.0, 111.0, 111.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 121.0, 160.0, 122.0, 118.0, 121.0, 117.0, 148.0, 117.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 160.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 116.0, 75.0, 75.0, 77.0, 76.0, 99.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 118.0, 80.0, 82.0, 81.0, 99.0, 81.0, 81.0, 112.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 123.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 50.0, 50.0, 50.0, 50.0, 50.0, 49.0, 51.0, 49.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 59.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 72.0, 73.0, 74.0, 73.0, 77.0, 73.0, 81.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 119.0, 122.0, 122.0, 122.0, 118.0, 121.0, 162.0, 128.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 156.0, 154.0, 157.0, 158.0, 154.0, 156.0, 153.0, 156.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 63.0, 62.0, 76.0, 63.0, 65.0, 61.0, 60.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1457.8, "alertThreshold": 2.0}]} 10:44:56 INFO - Return code: 0 10:44:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:44:56 INFO - # TBPL SUCCESS # 10:44:56 INFO - Running post-action listener: _resource_record_post_action 10:44:56 INFO - [mozharness: 2016-11-24 18:44:56.312421Z] Finished run-tests step (success) 10:44:56 INFO - Running post-run listener: _resource_record_post_run 10:44:56 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 308797440; Read time: 0; Write time: 191856 10:44:56 INFO - TinderboxPrint: CPU usage
12.9% 10:44:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:44:56 INFO - TinderboxPrint: I/O write bytes / time
308,797,440 / 191,856 10:44:56 INFO - TinderboxPrint: CPU idle
8,243.0 (87.1%) 10:44:56 INFO - TinderboxPrint: CPU user
1,182.5 (12.5%) 10:44:56 INFO - TinderboxPrint: Swap in / out
0 / 0 10:44:56 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100536320; Read time: 0; Write time: 84648 10:44:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 208261120; Read time: 0; Write time: 107208 10:44:56 INFO - Running post-run listener: _upload_blobber_files 10:44:56 INFO - Blob upload gear active. 10:44:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:44:56 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 10:44:56 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'] 10:44:56 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 10:44:57 INFO - (blobuploader) - INFO - Open directory for files ... 10:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:45:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:00 INFO - (blobuploader) - INFO - Done attempting. 10:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:45:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:02 INFO - (blobuploader) - INFO - Done attempting. 10:45:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:45:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:04 INFO - (blobuploader) - INFO - Done attempting. 10:45:04 INFO - (blobuploader) - INFO - Iteration through files over. 10:45:04 INFO - Return code: 0 10:45:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:45:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:45:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dcc8f038234c564df3af1776bf8033357ab24eaef0cf82a71209bb92da3656f535d66c6fc87fa377f0fc86972d261806cb31e35ab54aa6df167231d06383810d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee09486c5fffaedd7ef406386ea489002fb69b0477a3fc0497ff129dc15baefe344a88ba30f72e6bc513148b50f21121534a244b34c3d55ef1c917a729712135", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a48e8ab76f505184ab94c09fed98afb43512b72f82bec7776e3d41c61d868437122831ad4a1b066768178e102239748d5f3ea2c8776bcb3ac47b628f585bc43"} 10:45:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:45:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:45:04 INFO - Contents: 10:45:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dcc8f038234c564df3af1776bf8033357ab24eaef0cf82a71209bb92da3656f535d66c6fc87fa377f0fc86972d261806cb31e35ab54aa6df167231d06383810d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee09486c5fffaedd7ef406386ea489002fb69b0477a3fc0497ff129dc15baefe344a88ba30f72e6bc513148b50f21121534a244b34c3d55ef1c917a729712135", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a48e8ab76f505184ab94c09fed98afb43512b72f82bec7776e3d41c61d868437122831ad4a1b066768178e102239748d5f3ea2c8776bcb3ac47b628f585bc43"} 10:45:04 INFO - Running post-run listener: copy_logs_to_upload_dir 10:45:04 INFO - Copying logs to upload dir... 10:45:04 INFO - mkdir: /builds/slave/test/build/upload/logs 10:45:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.310512 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-11-24 10:45:03.959928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 10:45:03.963373) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dcc8f038234c564df3af1776bf8033357ab24eaef0cf82a71209bb92da3656f535d66c6fc87fa377f0fc86972d261806cb31e35ab54aa6df167231d06383810d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee09486c5fffaedd7ef406386ea489002fb69b0477a3fc0497ff129dc15baefe344a88ba30f72e6bc513148b50f21121534a244b34c3d55ef1c917a729712135", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a48e8ab76f505184ab94c09fed98afb43512b72f82bec7776e3d41c61d868437122831ad4a1b066768178e102239748d5f3ea2c8776bcb3ac47b628f585bc43"} build_url:https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/eXNjiGiMT5KHVnwr1T0AyA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dcc8f038234c564df3af1776bf8033357ab24eaef0cf82a71209bb92da3656f535d66c6fc87fa377f0fc86972d261806cb31e35ab54aa6df167231d06383810d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee09486c5fffaedd7ef406386ea489002fb69b0477a3fc0497ff129dc15baefe344a88ba30f72e6bc513148b50f21121534a244b34c3d55ef1c917a729712135", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a48e8ab76f505184ab94c09fed98afb43512b72f82bec7776e3d41c61d868437122831ad4a1b066768178e102239748d5f3ea2c8776bcb3ac47b628f585bc43"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 10:45:03.991328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:45:03.991661) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1480011871.382604-1364544528 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:45:04.073775) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 10:45:04.074142) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 10:45:04.074468) ========= ========= Total master_lag: 0.22 =========