builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1475558408.25 results: success (0) buildid: 20161003192400 builduid: c27b5bc58f2549e18cc4f48a9c69676e revision: ebe183f4b76104ef999c08213d30c6972f52cb96 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:08.251884) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:08.252278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:08.252543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:08.282637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:08.282910) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 22:20:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.8M=0.001s 2016-10-03 22:20:09 (19.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125171 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:08.439897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:08.440174) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020668 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:08.496199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:08.496510) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ebe183f4b76104ef999c08213d30c6972f52cb96 --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-aurora --rev ebe183f4b76104ef999c08213d30c6972f52cb96 --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=a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 22:20:09,261 truncating revision to first 12 chars 2016-10-03 22:20:09,261 Setting DEBUG logging. 2016-10-03 22:20:09,261 attempt 1/10 2016-10-03 22:20:09,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ebe183f4b761?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 22:20:09,563 unpacking tar archive at: mozilla-aurora-ebe183f4b761/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736188 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:09.246079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:09.246423) ========= script_repo_revision: ebe183f4b76104ef999c08213d30c6972f52cb96 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:09.246840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:09.247114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 22:20:09.257804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-03 22:20:09.258070) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:20:10 INFO - MultiFileLogger online at 20161003 22:20:10 in /builds/slave/test 22:20:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:20:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:20:10 INFO - {'append_to_log': False, 22:20:10 INFO - 'base_work_dir': '/builds/slave/test', 22:20:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:20:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:20:10 INFO - 'branch': 'Mozilla-Aurora', 22:20:10 INFO - 'buildbot_json_path': 'buildprops.json', 22:20:10 INFO - 'config_files': ('talos/linux_config.py',), 22:20:10 INFO - 'default_actions': ('clobber', 22:20:10 INFO - 'read-buildbot-config', 22:20:10 INFO - 'download-and-extract', 22:20:10 INFO - 'populate-webroot', 22:20:10 INFO - 'create-virtualenv', 22:20:10 INFO - 'install', 22:20:10 INFO - 'run-tests'), 22:20:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:20:10 INFO - 'download_minidump_stackwalk': True, 22:20:10 INFO - 'download_symbols': 'ondemand', 22:20:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:20:10 INFO - 'tooltool.py': '/tools/tooltool.py', 22:20:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:20:10 INFO - '/tools/misc-python/virtualenv.py')}, 22:20:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:20:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:20:10 INFO - 'installer_path': 'installer.exe', 22:20:10 INFO - 'log_level': 'info', 22:20:10 INFO - 'log_name': 'talos', 22:20:10 INFO - 'log_to_console': True, 22:20:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:20:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:20:10 INFO - 'opt_config_files': (), 22:20:10 INFO - 'pip_index': False, 22:20:10 INFO - 'sps_profile': False, 22:20:10 INFO - 'sps_profile_interval': 0, 22:20:10 INFO - 'suite': 'dromaeojs', 22:20:10 INFO - 'system_bits': '32', 22:20:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:20:10 INFO - 'title': 'talos-linux64-ix-064', 22:20:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:20:10 INFO - 'use_talos_json': True, 22:20:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:20:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:20:10 INFO - 'work_dir': 'build'} 22:20:10 INFO - [mozharness: 2016-10-04 05:20:10.111541Z] Running clobber step. 22:20:10 INFO - Running pre-action listener: _resource_record_pre_action 22:20:10 INFO - Running main action method: clobber 22:20:10 INFO - rmtree: /builds/slave/test/build 22:20:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:20:10 INFO - Running post-action listener: _resource_record_post_action 22:20:10 INFO - [mozharness: 2016-10-04 05:20:10.572275Z] Finished clobber step (success) 22:20:10 INFO - [mozharness: 2016-10-04 05:20:10.572376Z] Running read-buildbot-config step. 22:20:10 INFO - Running pre-action listener: _resource_record_pre_action 22:20:10 INFO - Running main action method: read_buildbot_config 22:20:10 INFO - Using buildbot properties: 22:20:10 INFO - { 22:20:10 INFO - "project": "", 22:20:10 INFO - "product": "firefox", 22:20:10 INFO - "script_repo_revision": "production", 22:20:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 22:20:10 INFO - "repository": "", 22:20:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 22:20:10 INFO - "buildid": "20161003192400", 22:20:10 INFO - "pgo_build": "True", 22:20:10 INFO - "basedir": "/builds/slave/test", 22:20:10 INFO - "buildnumber": 549, 22:20:10 INFO - "slavename": "talos-linux64-ix-064", 22:20:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:20:10 INFO - "platform": "ubuntu64_hw", 22:20:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:20:10 INFO - "branch": "mozilla-aurora", 22:20:10 INFO - "repo_path": "releases/mozilla-aurora", 22:20:10 INFO - "revision": "ebe183f4b76104ef999c08213d30c6972f52cb96", 22:20:10 INFO - "stage_platform": "linux64-pgo", 22:20:10 INFO - "builduid": "c27b5bc58f2549e18cc4f48a9c69676e", 22:20:10 INFO - "slavebuilddir": "test" 22:20:10 INFO - } 22:20:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 22:20:10 INFO - Running post-action listener: _resource_record_post_action 22:20:10 INFO - [mozharness: 2016-10-04 05:20:10.575167Z] Finished read-buildbot-config step (success) 22:20:10 INFO - [mozharness: 2016-10-04 05:20:10.575257Z] Running download-and-extract step. 22:20:10 INFO - Running pre-action listener: _resource_record_pre_action 22:20:10 INFO - Running main action method: download_and_extract 22:20:10 INFO - mkdir: /builds/slave/test/build/tests 22:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:10 INFO - trying https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 22:20:10 INFO - Downloading https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 22:20:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:20:12 INFO - Downloaded 1361 bytes. 22:20:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 22:20:12 INFO - Using the following test package requirements: 22:20:12 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 22:20:12 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:20:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:20:12 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:20:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:20:12 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:20:12 INFO - u'jsshell-linux-x86_64.zip'], 22:20:12 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:20:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:20:12 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 22:20:12 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:20:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:20:12 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:20:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:20:12 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:20:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:20:12 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:20:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:20:12 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:20:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 22:20:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:20:12 INFO - Fetch https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:20:12 INFO - Expected file size: 21906192 22:20:17 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:20:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 22:20:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:20:17 INFO - Fetch https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:20:17 INFO - Expected file size: 21906192 22:20:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 22:20:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:20:22 INFO - Fetch https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 22:20:22 INFO - Expected file size: 14414059 22:20: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')]} 22:20:23 INFO - trying https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:20:23 INFO - Downloading https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:20:24 INFO - Downloaded 63935511 bytes. 22:20:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:20:24 INFO - mkdir: /builds/slave/test/properties 22:20:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:20:24 INFO - Writing to file /builds/slave/test/properties/build_url 22:20:24 INFO - Contents: 22:20:24 INFO - build_url:https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:20:25 INFO - Running post-action listener: _resource_record_post_action 22:20:25 INFO - Running post-action listener: set_extra_try_arguments 22:20:25 INFO - [mozharness: 2016-10-04 05:20:25.074454Z] Finished download-and-extract step (success) 22:20:25 INFO - [mozharness: 2016-10-04 05:20:25.074682Z] Running populate-webroot step. 22:20:25 INFO - Running pre-action listener: _resource_record_pre_action 22:20:25 INFO - Running main action method: populate_webroot 22:20:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:20:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:20:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:20:25 INFO - '--tppagecycles', 22:20:25 INFO - '7'], 22:20:25 INFO - 'tests': ['tsvgm']}}, 22:20:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:20:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:20:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:20:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:20:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:20:25 INFO - 'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:20:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:20:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:20:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:20:25 INFO - 'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['damp', 'tps']}, 22:20:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:20:25 INFO - 'tests': ['damp', 'tps']}, 22:20:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['dromaeo_dom']}, 22:20:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:20:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['basic_compositor_video']}, 22:20:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:20:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['a11yr', 22:20:25 INFO - 'ts_paint', 22:20:25 INFO - 'tpaint', 22:20:25 INFO - 'sessionrestore', 22:20:25 INFO - 'sessionrestore_no_auto_restore', 22:20:25 INFO - 'tabpaint']}, 22:20:25 INFO - 'other-e10s': {'tests': ['a11yr', 22:20:25 INFO - 'ts_paint', 22:20:25 INFO - 'tpaint', 22:20:25 INFO - 'sessionrestore', 22:20:25 INFO - 'sessionrestore_no_auto_restore', 22:20:25 INFO - 'tabpaint']}, 22:20:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:20:25 INFO - 'ts_paint', 22:20:25 INFO - 'tpaint', 22:20:25 INFO - 'sessionrestore', 22:20:25 INFO - 'sessionrestore_no_auto_restore', 22:20:25 INFO - 'tabpaint']}, 22:20:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:20:25 INFO - 'ts_paint', 22:20:25 INFO - 'tpaint', 22:20:25 INFO - 'sessionrestore', 22:20:25 INFO - 'sessionrestore_no_auto_restore', 22:20:25 INFO - 'tabpaint']}, 22:20:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['a11yr', 22:20:25 INFO - 'ts_paint', 22:20:25 INFO - 'tpaint', 22:20:25 INFO - 'sessionrestore', 22:20:25 INFO - 'sessionrestore_no_auto_restore', 22:20:25 INFO - 'tabpaint']}, 22:20:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['a11yr', 22:20:25 INFO - 'ts_paint', 22:20:25 INFO - 'tpaint', 22:20:25 INFO - 'sessionrestore', 22:20:25 INFO - 'sessionrestore_no_auto_restore', 22:20:25 INFO - 'tabpaint']}, 22:20:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['tsvgx', 22:20:25 INFO - 'tsvgr_opacity', 22:20:25 INFO - 'tart', 22:20:25 INFO - 'tscrollx', 22:20:25 INFO - 'cart']}, 22:20:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:20:25 INFO - 'tsvgr_opacity', 22:20:25 INFO - 'tart', 22:20:25 INFO - 'tscrollx', 22:20:25 INFO - 'cart']}, 22:20:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:20:25 INFO - 'talos_options': ['--disable-e10s'], 22:20:25 INFO - 'tests': ['tp5o']}, 22:20:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:20:25 INFO - 'tests': ['tp5o']}, 22:20:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:20:25 INFO - 'talos_options': ['--disable-e10s', 22:20:25 INFO - '--xperf_path', 22:20:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:20:25 INFO - 'tests': ['tp5n']}, 22:20:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:20:25 INFO - 'talos_options': ['--xperf_path', 22:20:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:20:25 INFO - 'tests': ['tp5n']}}, 22:20:25 INFO - 'talos.zip': {'path': '', 22:20:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:20:25 INFO - Running post-action listener: _resource_record_post_action 22:20:25 INFO - [mozharness: 2016-10-04 05:20:25.094914Z] Finished populate-webroot step (success) 22:20:25 INFO - [mozharness: 2016-10-04 05:20:25.095002Z] Running create-virtualenv step. 22:20:25 INFO - Running pre-action listener: _resource_record_pre_action 22:20:25 INFO - Running main action method: create_virtualenv 22:20:25 INFO - Creating virtualenv /builds/slave/test/build/venv 22:20:25 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 22:20:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:20:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:20:25 INFO - Using real prefix '/usr' 22:20:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:20:25 INFO - Installing distribute.............................................................................................................................................................................................done. 22:20:27 INFO - Installing pip.................done. 22:20:27 INFO - Return code: 0 22:20:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:27 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 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:27 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 22:20:27 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 22:20:27 INFO - Using env: {'DISPLAY': ':0', 22:20:27 INFO - 'HOME': '/home/cltbld', 22:20:27 INFO - 'LANG': 'en_US.UTF-8', 22:20:27 INFO - 'LANGUAGE': 'en_US:en', 22:20:27 INFO - 'LOGNAME': 'cltbld', 22:20:27 INFO - 'MAIL': '/var/mail/cltbld', 22:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:27 INFO - 'MOZ_NO_REMOTE': '1', 22:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:27 INFO - 'NO_EM_RESTART': '1', 22:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:27 INFO - 'PWD': '/builds/slave/test', 22:20:27 INFO - 'SHELL': '/bin/bash', 22:20:27 INFO - 'SHLVL': '1', 22:20:27 INFO - 'TERM': 'linux', 22:20:27 INFO - 'TMOUT': '86400', 22:20:27 INFO - 'USER': 'cltbld', 22:20:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:27 INFO - '_': '/tools/buildbot/bin/python'} 22:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:27 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 22:20:27 INFO - Cleaning up... 22:20:27 INFO - Return code: 0 22:20:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:27 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 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:27 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 22:20:27 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 22:20:27 INFO - Using env: {'DISPLAY': ':0', 22:20:27 INFO - 'HOME': '/home/cltbld', 22:20:27 INFO - 'LANG': 'en_US.UTF-8', 22:20:27 INFO - 'LANGUAGE': 'en_US:en', 22:20:27 INFO - 'LOGNAME': 'cltbld', 22:20:27 INFO - 'MAIL': '/var/mail/cltbld', 22:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:27 INFO - 'MOZ_NO_REMOTE': '1', 22:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:27 INFO - 'NO_EM_RESTART': '1', 22:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:27 INFO - 'PWD': '/builds/slave/test', 22:20:27 INFO - 'SHELL': '/bin/bash', 22:20:27 INFO - 'SHLVL': '1', 22:20:27 INFO - 'TERM': 'linux', 22:20:27 INFO - 'TMOUT': '86400', 22:20:27 INFO - 'USER': 'cltbld', 22:20:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:27 INFO - '_': '/tools/buildbot/bin/python'} 22:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:28 INFO - Downloading/unpacking psutil>=3.1.1 22:20:28 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 22:20:28 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 22:20:28 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 22:20:28 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 22:20:28 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 22:20:28 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 22:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:20:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:20:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:20:30 INFO - Installing collected packages: psutil 22:20:30 INFO - Running setup.py install for psutil 22:20:30 INFO - building 'psutil._psutil_linux' extension 22:20:30 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 22:20:30 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 22:20:30 INFO - building 'psutil._psutil_posix' extension 22:20:30 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 22:20:30 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 22:20:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:20:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:20:30 INFO - Successfully installed psutil 22:20:30 INFO - Cleaning up... 22:20:30 INFO - Return code: 0 22:20:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:20:30 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')]} 22:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:30 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')]} 22:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:30 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 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:30 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 22:20:30 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 22:20:30 INFO - Using env: {'DISPLAY': ':0', 22:20:30 INFO - 'HOME': '/home/cltbld', 22:20:30 INFO - 'LANG': 'en_US.UTF-8', 22:20:30 INFO - 'LANGUAGE': 'en_US:en', 22:20:30 INFO - 'LOGNAME': 'cltbld', 22:20:30 INFO - 'MAIL': '/var/mail/cltbld', 22:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:30 INFO - 'MOZ_NO_REMOTE': '1', 22:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:30 INFO - 'NO_EM_RESTART': '1', 22:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:30 INFO - 'PWD': '/builds/slave/test', 22:20:30 INFO - 'SHELL': '/bin/bash', 22:20:30 INFO - 'SHLVL': '1', 22:20:30 INFO - 'TERM': 'linux', 22:20:30 INFO - 'TMOUT': '86400', 22:20:30 INFO - 'USER': 'cltbld', 22:20:30 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:30 INFO - '_': '/tools/buildbot/bin/python'} 22:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:20:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:20:32 INFO - Installing collected packages: mozsystemmonitor 22:20:32 INFO - Running setup.py install for mozsystemmonitor 22:20:32 INFO - Successfully installed mozsystemmonitor 22:20:32 INFO - Cleaning up... 22:20:32 INFO - Return code: 0 22:20:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:32 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 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:32 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 22:20:32 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 22:20:32 INFO - Using env: {'DISPLAY': ':0', 22:20:32 INFO - 'HOME': '/home/cltbld', 22:20:32 INFO - 'LANG': 'en_US.UTF-8', 22:20:32 INFO - 'LANGUAGE': 'en_US:en', 22:20:32 INFO - 'LOGNAME': 'cltbld', 22:20:32 INFO - 'MAIL': '/var/mail/cltbld', 22:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:32 INFO - 'MOZ_NO_REMOTE': '1', 22:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:32 INFO - 'NO_EM_RESTART': '1', 22:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:32 INFO - 'PWD': '/builds/slave/test', 22:20:32 INFO - 'SHELL': '/bin/bash', 22:20:32 INFO - 'SHLVL': '1', 22:20:32 INFO - 'TERM': 'linux', 22:20:32 INFO - 'TMOUT': '86400', 22:20:32 INFO - 'USER': 'cltbld', 22:20:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:32 INFO - '_': '/tools/buildbot/bin/python'} 22:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:33 INFO - Downloading/unpacking jsonschema==2.5.1 22:20:33 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 22:20:33 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 22:20:33 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 22:20:33 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 22:20:33 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 22:20:33 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 22:20:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:20:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:20:35 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 22:20:35 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 22:20:35 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 22:20:35 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 22:20:35 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 22:20:35 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 22:20:35 INFO - Downloading functools32-3.2.3-2.tar.gz 22:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:20:35 INFO - warning: no files found matching '*.txt' 22:20:35 INFO - no previously-included directories found matching 'build' 22:20:35 INFO - no previously-included directories found matching 'dist' 22:20:35 INFO - no previously-included directories found matching '.git*' 22:20:35 INFO - Installing collected packages: jsonschema, functools32 22:20:35 INFO - Running setup.py install for functools32 22:20:35 INFO - warning: no files found matching '*.txt' 22:20:35 INFO - no previously-included directories found matching 'build' 22:20:35 INFO - no previously-included directories found matching 'dist' 22:20:35 INFO - no previously-included directories found matching '.git*' 22:20:35 INFO - Successfully installed jsonschema functools32 22:20:35 INFO - Cleaning up... 22:20:35 INFO - Return code: 0 22:20:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:35 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 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:35 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 22:20:35 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 22:20:35 INFO - Using env: {'DISPLAY': ':0', 22:20:35 INFO - 'HOME': '/home/cltbld', 22:20:35 INFO - 'LANG': 'en_US.UTF-8', 22:20:35 INFO - 'LANGUAGE': 'en_US:en', 22:20:35 INFO - 'LOGNAME': 'cltbld', 22:20:35 INFO - 'MAIL': '/var/mail/cltbld', 22:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:35 INFO - 'MOZ_NO_REMOTE': '1', 22:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:35 INFO - 'NO_EM_RESTART': '1', 22:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:35 INFO - 'PWD': '/builds/slave/test', 22:20:35 INFO - 'SHELL': '/bin/bash', 22:20:35 INFO - 'SHLVL': '1', 22:20:35 INFO - 'TERM': 'linux', 22:20:35 INFO - 'TMOUT': '86400', 22:20:35 INFO - 'USER': 'cltbld', 22:20:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:35 INFO - '_': '/tools/buildbot/bin/python'} 22:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:20:35 INFO - Cleaning up... 22:20:35 INFO - Return code: 0 22:20:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:35 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 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:35 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 22:20:35 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 22:20:35 INFO - Using env: {'DISPLAY': ':0', 22:20:35 INFO - 'HOME': '/home/cltbld', 22:20:35 INFO - 'LANG': 'en_US.UTF-8', 22:20:35 INFO - 'LANGUAGE': 'en_US:en', 22:20:35 INFO - 'LOGNAME': 'cltbld', 22:20:35 INFO - 'MAIL': '/var/mail/cltbld', 22:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:35 INFO - 'MOZ_NO_REMOTE': '1', 22:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:35 INFO - 'NO_EM_RESTART': '1', 22:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:35 INFO - 'PWD': '/builds/slave/test', 22:20:35 INFO - 'SHELL': '/bin/bash', 22:20:35 INFO - 'SHLVL': '1', 22:20:35 INFO - 'TERM': 'linux', 22:20:35 INFO - 'TMOUT': '86400', 22:20:35 INFO - 'USER': 'cltbld', 22:20:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:35 INFO - '_': '/tools/buildbot/bin/python'} 22:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:35 INFO - Downloading/unpacking blobuploader==1.2.4 22:20:35 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 22:20:35 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 22:20:35 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 22:20:35 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 22:20:35 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 22:20:35 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 22:20:37 INFO - Downloading blobuploader-1.2.4.tar.gz 22:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:20:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:20:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:20:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:20:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:20:38 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 22:20:38 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 22:20:38 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 22:20:38 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 22:20:38 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 22:20:38 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 22:20:38 INFO - Downloading docopt-0.6.1.tar.gz 22:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:20:38 INFO - Installing collected packages: blobuploader, requests, docopt 22:20:38 INFO - Running setup.py install for blobuploader 22:20:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:20:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:20:38 INFO - Running setup.py install for requests 22:20:39 INFO - Running setup.py install for docopt 22:20:39 INFO - Successfully installed blobuploader requests docopt 22:20:39 INFO - Cleaning up... 22:20:39 INFO - Return code: 0 22:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:20:39 INFO - Using env: {'DISPLAY': ':0', 22:20:39 INFO - 'HOME': '/home/cltbld', 22:20:39 INFO - 'LANG': 'en_US.UTF-8', 22:20:39 INFO - 'LANGUAGE': 'en_US:en', 22:20:39 INFO - 'LOGNAME': 'cltbld', 22:20:39 INFO - 'MAIL': '/var/mail/cltbld', 22:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:39 INFO - 'MOZ_NO_REMOTE': '1', 22:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:39 INFO - 'NO_EM_RESTART': '1', 22:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:39 INFO - 'PWD': '/builds/slave/test', 22:20:39 INFO - 'SHELL': '/bin/bash', 22:20:39 INFO - 'SHLVL': '1', 22:20:39 INFO - 'TERM': 'linux', 22:20:39 INFO - 'TMOUT': '86400', 22:20:39 INFO - 'USER': 'cltbld', 22:20:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:39 INFO - '_': '/tools/buildbot/bin/python'} 22:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:20:39 INFO - Running setup.py (path:/tmp/pip-6ubscE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:20:39 INFO - Running setup.py (path:/tmp/pip-61F0nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:20:39 INFO - Running setup.py (path:/tmp/pip-y5IcWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:20:39 INFO - Running setup.py (path:/tmp/pip-fElU2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:20:39 INFO - Running setup.py (path:/tmp/pip-bIBei5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:20:39 INFO - Running setup.py (path:/tmp/pip-CQRICv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:20:39 INFO - Running setup.py (path:/tmp/pip-MTrBfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:20:39 INFO - Running setup.py (path:/tmp/pip-aK1zcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:20:40 INFO - Running setup.py (path:/tmp/pip-ckeq6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:20:40 INFO - Running setup.py (path:/tmp/pip-AFj7lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:20:40 INFO - Running setup.py (path:/tmp/pip-4Vy4d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:20:40 INFO - Running setup.py (path:/tmp/pip-SkELmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:20:40 INFO - Running setup.py (path:/tmp/pip-fwftrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:20:40 INFO - Running setup.py (path:/tmp/pip-gBNnl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:20:40 INFO - Running setup.py (path:/tmp/pip-9awncA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:20:40 INFO - Running setup.py (path:/tmp/pip-FdlmLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:20:40 INFO - Running setup.py (path:/tmp/pip-eWFjwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:20:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:20:40 INFO - Running setup.py install for manifestparser 22:20:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:20:40 INFO - Running setup.py install for mozcrash 22:20:40 INFO - Running setup.py install for mozdebug 22:20:40 INFO - Running setup.py install for mozdevice 22:20:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for mozfile 22:20:41 INFO - Running setup.py install for mozhttpd 22:20:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for mozinfo 22:20:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for mozInstall 22:20:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for mozleak 22:20:41 INFO - Running setup.py install for mozlog 22:20:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for moznetwork 22:20:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for mozprocess 22:20:41 INFO - Running setup.py install for mozprofile 22:20:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Running setup.py install for mozrunner 22:20:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Running setup.py install for mozscreenshot 22:20:42 INFO - Running setup.py install for moztest 22:20:42 INFO - Running setup.py install for mozversion 22:20:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:20:42 INFO - Cleaning up... 22:20:42 INFO - Return code: 0 22:20:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:20:42 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')]} 22:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:42 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')]} 22:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:42 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 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:42 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 22:20:42 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 22:20:42 INFO - Using env: {'DISPLAY': ':0', 22:20:42 INFO - 'HOME': '/home/cltbld', 22:20:42 INFO - 'LANG': 'en_US.UTF-8', 22:20:42 INFO - 'LANGUAGE': 'en_US:en', 22:20:42 INFO - 'LOGNAME': 'cltbld', 22:20:42 INFO - 'MAIL': '/var/mail/cltbld', 22:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:42 INFO - 'MOZ_NO_REMOTE': '1', 22:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:42 INFO - 'NO_EM_RESTART': '1', 22:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:42 INFO - 'PWD': '/builds/slave/test', 22:20:42 INFO - 'SHELL': '/bin/bash', 22:20:42 INFO - 'SHLVL': '1', 22:20:42 INFO - 'TERM': 'linux', 22:20:42 INFO - 'TMOUT': '86400', 22:20:42 INFO - 'USER': 'cltbld', 22:20:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:42 INFO - '_': '/tools/buildbot/bin/python'} 22:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:20:42 INFO - Running setup.py (path:/tmp/pip-u2SE_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:20:42 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)) 22:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:20:42 INFO - Running setup.py (path:/tmp/pip-j7vLmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:20:42 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)) 22:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:20:42 INFO - Running setup.py (path:/tmp/pip-EFRLeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:20:42 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)) 22:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:20:42 INFO - Running setup.py (path:/tmp/pip-zuvrO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:20:43 INFO - Running setup.py (path:/tmp/pip-MeQv1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:20:43 INFO - Running setup.py (path:/tmp/pip-U_j151-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:20:43 INFO - Running setup.py (path:/tmp/pip-uPVIJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:20:43 INFO - Running setup.py (path:/tmp/pip-89p6Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:20:43 INFO - Running setup.py (path:/tmp/pip-i0nZVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:20:43 INFO - Running setup.py (path:/tmp/pip-ugi0nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:20:43 INFO - Running setup.py (path:/tmp/pip-hb0xEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:20:43 INFO - Running setup.py (path:/tmp/pip-C1ttIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:20:43 INFO - Running setup.py (path:/tmp/pip-25uxGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:20:43 INFO - Running setup.py (path:/tmp/pip-cxXq2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:20:43 INFO - Running setup.py (path:/tmp/pip-uQXu00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:20:43 INFO - Running setup.py (path:/tmp/pip-Ha_pEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:20:43 INFO - Running setup.py (path:/tmp/pip-BPoNms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:20:43 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)) 22:20:43 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)) 22:20:43 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)) 22:20:43 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)) 22:20:43 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)) 22:20:43 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)) 22:20:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:20:43 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 22:20:43 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 22:20:43 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 22:20:43 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 22:20:43 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 22:20:43 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 22:20:45 INFO - Downloading blessings-1.6.tar.gz 22:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:20:45 INFO - Installing collected packages: blessings 22:20:45 INFO - Running setup.py install for blessings 22:20:46 INFO - Successfully installed blessings 22:20:46 INFO - Cleaning up... 22:20:46 INFO - Return code: 0 22:20:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:20:46 INFO - Reading from file tmpfile_stdout 22:20:46 INFO - Current package versions: 22:20:46 INFO - argparse == 1.2.1 22:20:46 INFO - blessings == 1.6 22:20:46 INFO - blobuploader == 1.2.4 22:20:46 INFO - docopt == 0.6.1 22:20:46 INFO - functools32 == 3.2.3-2 22:20:46 INFO - jsonschema == 2.5.1 22:20:46 INFO - manifestparser == 1.1 22:20:46 INFO - mozInstall == 1.12 22:20:46 INFO - mozcrash == 0.17 22:20:46 INFO - mozdebug == 0.1 22:20:46 INFO - mozdevice == 0.48 22:20:46 INFO - mozfile == 1.2 22:20:46 INFO - mozhttpd == 0.7 22:20:46 INFO - mozinfo == 0.9 22:20:46 INFO - mozleak == 0.1 22:20:46 INFO - mozlog == 3.4 22:20:46 INFO - moznetwork == 0.27 22:20:46 INFO - mozprocess == 0.23 22:20:46 INFO - mozprofile == 0.28 22:20:46 INFO - mozrunner == 6.12 22:20:46 INFO - mozscreenshot == 0.1 22:20:46 INFO - mozsystemmonitor == 0.3 22:20:46 INFO - moztest == 0.7 22:20:46 INFO - mozversion == 1.4 22:20:46 INFO - psutil == 3.1.1 22:20:46 INFO - requests == 1.2.3 22:20:46 INFO - wsgiref == 0.1.2 22:20:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:46 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 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:46 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 22:20:46 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 22:20:46 INFO - Using env: {'DISPLAY': ':0', 22:20:46 INFO - 'HOME': '/home/cltbld', 22:20:46 INFO - 'LANG': 'en_US.UTF-8', 22:20:46 INFO - 'LANGUAGE': 'en_US:en', 22:20:46 INFO - 'LOGNAME': 'cltbld', 22:20:46 INFO - 'MAIL': '/var/mail/cltbld', 22:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:46 INFO - 'MOZ_NO_REMOTE': '1', 22:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:46 INFO - 'NO_EM_RESTART': '1', 22:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:46 INFO - 'PWD': '/builds/slave/test', 22:20:46 INFO - 'SHELL': '/bin/bash', 22:20:46 INFO - 'SHLVL': '1', 22:20:46 INFO - 'TERM': 'linux', 22:20:46 INFO - 'TMOUT': '86400', 22:20:46 INFO - 'USER': 'cltbld', 22:20:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:46 INFO - '_': '/tools/buildbot/bin/python'} 22:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:46 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)) 22:20:46 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)) 22:20:46 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)) 22:20:46 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)) 22:20:46 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)) 22:20:46 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)) 22:20:46 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)) 22:20:46 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)) 22:20:46 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)) 22:20:46 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)) 22:20:46 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)) 22:20:46 INFO - Cleaning up... 22:20:46 INFO - Return code: 0 22:20:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:46 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 0x7fdddb4caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', '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 22:20:46 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 22:20:46 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 22:20:46 INFO - Using env: {'DISPLAY': ':0', 22:20:46 INFO - 'HOME': '/home/cltbld', 22:20:46 INFO - 'LANG': 'en_US.UTF-8', 22:20:46 INFO - 'LANGUAGE': 'en_US:en', 22:20:46 INFO - 'LOGNAME': 'cltbld', 22:20:46 INFO - 'MAIL': '/var/mail/cltbld', 22:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:46 INFO - 'MOZ_NO_REMOTE': '1', 22:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:20:46 INFO - 'NO_EM_RESTART': '1', 22:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:46 INFO - 'PWD': '/builds/slave/test', 22:20:46 INFO - 'SHELL': '/bin/bash', 22:20:46 INFO - 'SHLVL': '1', 22:20:46 INFO - 'TERM': 'linux', 22:20:46 INFO - 'TMOUT': '86400', 22:20:46 INFO - 'USER': 'cltbld', 22:20:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:46 INFO - '_': '/tools/buildbot/bin/python'} 22:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:20:46 INFO - Cleaning up... 22:20:46 INFO - Return code: 0 22:20:46 INFO - Running post-action listener: _resource_record_post_action 22:20:46 INFO - Running post-action listener: _start_resource_monitoring 22:20:46 INFO - Starting resource monitoring. 22:20:46 INFO - [mozharness: 2016-10-04 05:20:46.796410Z] Finished create-virtualenv step (success) 22:20:46 INFO - [mozharness: 2016-10-04 05:20:46.796905Z] Running install step. 22:20:46 INFO - Running pre-action listener: _resource_record_pre_action 22:20:46 INFO - Running main action method: install 22:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:20:47 INFO - Reading from file tmpfile_stdout 22:20:47 INFO - Detecting whether we're running mozinstall >=1.0... 22:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:20:47 INFO - Reading from file tmpfile_stdout 22:20:47 INFO - Output received: 22:20:47 INFO - Usage: mozinstall [options] installer 22:20:47 INFO - Options: 22:20:47 INFO - -h, --help show this help message and exit 22:20:47 INFO - -d DEST, --destination=DEST 22:20:47 INFO - Directory to install application into. [default: 22:20:47 INFO - "/builds/slave/test"] 22:20:47 INFO - --app=APP Application being installed. [default: firefox] 22:20:47 INFO - mkdir: /builds/slave/test/build/application 22:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:21:03 INFO - Reading from file tmpfile_stdout 22:21:03 INFO - Output received: 22:21:03 INFO - /builds/slave/test/build/application/firefox/firefox 22:21:03 INFO - Running post-action listener: _resource_record_post_action 22:21:03 INFO - [mozharness: 2016-10-04 05:21:03.079411Z] Finished install step (success) 22:21:03 INFO - [mozharness: 2016-10-04 05:21:03.079656Z] Running run-tests step. 22:21:03 INFO - Running pre-action listener: _resource_record_pre_action 22:21:03 INFO - Running main action method: run_tests 22:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:21:03 INFO - Python 2.7.3 22:21:03 INFO - Return code: 0 22:21:03 INFO - grabbing minidump binary from tooltool 22:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:03 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 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:21:03 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 22:21:03 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 22:21:03 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 22:21:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:21:03 INFO - Return code: 0 22:21:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:21:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:21:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:21:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:21:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 22:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 22:21:03 INFO - Using env: {'DISPLAY': ':0', 22:21:03 INFO - 'HOME': '/home/cltbld', 22:21:03 INFO - 'LANG': 'en_US.UTF-8', 22:21:03 INFO - 'LANGUAGE': 'en_US:en', 22:21:03 INFO - 'LOGNAME': 'cltbld', 22:21:03 INFO - 'MAIL': '/var/mail/cltbld', 22:21:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:21:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:03 INFO - 'MOZ_NO_REMOTE': '1', 22:21:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:21:03 INFO - 'NO_EM_RESTART': '1', 22:21:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:03 INFO - 'PWD': '/builds/slave/test', 22:21:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:21:03 INFO - 'SHELL': '/bin/bash', 22:21:03 INFO - 'SHLVL': '1', 22:21:03 INFO - 'TERM': 'linux', 22:21:03 INFO - 'TMOUT': '86400', 22:21:03 INFO - 'USER': 'cltbld', 22:21:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483', 22:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:03 INFO - '_': '/tools/buildbot/bin/python'} 22:21:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 22:21:03 INFO - mozversion application_buildid: 20161003192400 22:21:03 INFO - mozversion application_changeset: ebe183f4b76104ef999c08213d30c6972f52cb96 22:21:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:21:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:21:03 INFO - mozversion application_name: Firefox 22:21:03 INFO - mozversion application_remotingname: firefox-dev 22:21:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:21:03 INFO - mozversion application_vendor: Mozilla 22:21:03 INFO - mozversion application_version: 51.0a2 22:21:03 INFO - mozversion platform_buildid: 20161003192400 22:21:03 INFO - mozversion platform_changeset: ebe183f4b76104ef999c08213d30c6972f52cb96 22:21:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:21:03 INFO - mozversion platform_version: 51.0a2 22:21:03 INFO - using testdate: 1475558463 22:21:03 INFO - actual date: 1475558463 22:21:03 INFO - starting webserver on 'localhost:56634' 22:21:03 INFO - SUITE-START | Running 2 tests 22:21:03 INFO - TEST-START | dromaeo_css 22:21:03 INFO - operating with platform_type : linux_ 22:21:03 INFO - Initialising browser for dromaeo_css test... 22:21:03 INFO - TEST-INFO | started process 20424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG4eNNQ/profile http://localhost:56634/getInfo.html) 22:21:07 INFO - PROCESS | 20424 | __metrics Screen width/height:1600/1200 22:21:07 INFO - PROCESS | 20424 | colorDepth:24 22:21:07 INFO - PROCESS | 20424 | Browser inner width/height: 1024/697 22:21:07 INFO - PROCESS | 20424 | __metrics 22:21:08 INFO - PROCESS | 20424 | 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" 22:21:08 INFO - PROCESS | 20424 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:21:09 INFO - PROCESS | 20424 | console.error: PushService: 22:21:09 INFO - PROCESS | 20424 | stateChangeProcessEnqueue: Error transitioning state 22:21:09 INFO - PROCESS | 20424 | UnknownError 22:21:09 INFO - TEST-INFO | 20424: exit 0 22:21:09 INFO - Browser initialized. 22:21:09 INFO - Running cycle 1/1 for dromaeo_css test... 22:21:09 INFO - TEST-INFO | started process 20514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG4eNNQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:21:21 INFO - PROCESS | 20514 | RSS: Main: 144482304 22:21:21 INFO - PROCESS | 20514 | 22:22:12 INFO - PROCESS | 20514 | 1475558532687 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] 22:24:21 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:56634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56634/tests/dromaeo/cssquery-ext.html) 22:24:22 INFO - PROCESS | 20514 | RSS: Main: 247255040 22:24:22 INFO - PROCESS | 20514 | 22:27:25 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:56634/tests/dromaeo/cssquery-ext.html (next: http://localhost:56634/tests/dromaeo/cssquery-jquery.html) 22:27:25 INFO - PROCESS | 20514 | RSS: Main: 231559168 22:27:25 INFO - PROCESS | 20514 | 22:30:27 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:56634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56634/tests/dromaeo/cssquery-mootools.html) 22:30:28 INFO - PROCESS | 20514 | RSS: Main: 204177408 22:30:28 INFO - PROCESS | 20514 | 22:33:30 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:56634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56634/tests/dromaeo/cssquery-prototype.html) 22:33:30 INFO - PROCESS | 20514 | RSS: Main: 226897920 22:33:30 INFO - PROCESS | 20514 | 22:36:33 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:56634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56634/tests/dromaeo/cssquery-yui.html) 22:36:34 INFO - PROCESS | 20514 | RSS: Main: 176005120 22:36:34 INFO - PROCESS | 20514 | 22:39:36 INFO - PROCESS | 20514 | Cycle 1(1): loaded http://localhost:56634/tests/dromaeo/cssquery-yui.html (next: http://localhost:56634/tests/dromaeo/cssquery-dojo.html) 22:39:37 INFO - PROCESS | 20514 | RSS: Main: 263045120 22:39:37 INFO - PROCESS | 20514 | 22:39:37 INFO - PROCESS | 20514 | __start_tp_report 22:39:37 INFO - PROCESS | 20514 | _x_x_mozilla_page_load 22:39:37 INFO - PROCESS | 20514 | _x_x_mozilla_page_load_details 22:39:37 INFO - PROCESS | 20514 | |i|pagename|runs| 22:39:37 INFO - PROCESS | 20514 | |0;dojo.html;3111.7355024822887;3143.968560314396;3147.5593416921633;3160.9367812643764;3191.6329622093454;5594.356648985363;5668.489835914766;5674.886502269957;5692.601517893749;5698.971505142474;5584.1902924075985;5689.3172819261745;5699.800506982257;5707.343655479621;5738.713064346776;5101.821436249732;5129.743512824344;5141.1003074462005;5164.612654050942;5200.635955483118;4918.311436398907;4918.409790825088;5204.115300398922;5205.27126202332;5228.241904923784;4994.750262486879;5016.949830501703;5021.598272138239;5054.69671819692;5081.237814327862;5030.974845125787;5081.314022606938;5093.18509038552;5153.252778347156;5175.560077393388;4994.675346102528;5048.9495105048845;5109.642325037249;5112.948870511284;5116.2069879168785;5399.595030372738;5416.702081385522;5417.26866872971;5418.051840927822;5426.403095659474;5917.112433135064;5936.703164841784;6051.243594550681;6061.272647282311;6063.575549711522;6073.878522429571;6077.453029227347;6086.391360863922;6097.817065488042;6104;5399.541039011689;5431.809886653988;5508.256385387961;5533.972330138324;5543.833684989457;6076.27084749824;6109.755609775648;6111.633302001894;6115.847103822351;6120.877582448326;5741.971290143522;5864.618799778001;5869.530437564985;5872.17789509469;5880.059190529495;5871.500922421642;5915.08316210988;5916.1421593868645;5952.136940143655;6049.727762250709;5963.4334738199805;5976.043832986701;5976.671283079472;5986.790462333797;5987.922174008633;5935.406459354116;5979.970100149559;5988.131720900445;5998.040313549811;6029.909551356734;4505.864824055284;4529.6376289896725;4566.70316429431;4568.314752787109;4588.26587745959;4047.559574361769;4078.632923036941;4089.5092588889524;4101.487314085739;4138.689598280141;5740.827775166752;5743.396943320975;5747.281589801275;5757.078867381283;5759.827205183851;5703.315602127688;5748.166515855261;5977.6114552553945;6024;6032.819015429544;5754.625949313365;5779.566532510079;5780.88438231233;5793.2179155814265;5811.680357580289;5150.27896094547;5172.508611681884;5181.689098654093;5187.507186817246;5209.270702101709;5902.38025007368;5998.040313549811;6134.926457743637;6257.96939751357;6302.747890084345;5980.162777211281;6036.547258955508;6047.153398524122;6079.392060793885;6083.178770865877;6158.414950579688;6201.441870231521;6237.5633705641985;6251.281102673069;6253.218347706536;5657.60396772222;5704.686242256716;5930.555208359304;5934.1988831508925;5943.970280148572;5932.525397968238;5945.435183657545;5961.016432288624;6032.939670603413;6086.117512960507;5851.736671849691;5861.765529378948;5862.062070068769;5863.237779088691;5882.735276912635;5536.141898005815;5879.911801323069;5892.558058145571;5894.322152952465;5902.350741418355;5547.667139971614;5762.337331206965;5779.884402312015;5801.071828507418;5881.7647294107755;5946.048632218824;5977.163197152315;5990.7304171311525;5992.730327135202;5993.820185394445;5616.69108199053;5653.123765816305;5831.067029275296;5832.387599302012;5833.4749872511675 22:39:37 INFO - PROCESS | 20514 | |1;ext.html;592.029072321393;628.6102616377844;652.840054186724;658.8451713847245;668.869570433765;35951.2809743805;47720.522794772085;48904.26643600349;49192.50807491933;49240.01519969603;49189.50810491894;49458.50541494584;49593.25610115851;49808.75095624526;49809.50190498094;8442.240198382144;9377.343585948985;9459.57431915562;9492.66775662852;9502.144806967372;8441.366897482683;11120.777584448306;11291.153163512728;11295.378754168518;11758.529658813637;11589.072874170088;11647.6505704829;11658.708532286719;11659.825102623467;11667.766644667101;11407.942960285187;11464.426778661034;11478.827817582744;11483.483243254032;11484.770304593945;11033.227674062819;11088.944555277252;11096.833547496793;11107.500162492626;11109.333439993627;46493;46671.76664116692;46839.76580117112;46881.53118468806;46881.5311846884;3616.5298511193378;3637.9892708126417;3719.367707489733;3723.6834869036165;4158.209940111369;35615;35692.82153589241;35748.28503429943;36108.27783444343;37316;4511.481179664315;4516.232240519087;4537.773111344452;4635.814567417333;4640.32715256286;367865;368196.9999999973;369435;370764;371895;41121.383179252334;42169.578304217175;66862;67214;67281.66359168173;43433;43824.56175438205;43838.56161438409;43866.56133438625;43868.341974870404;17314;17438.82561174372;17448.214830332665;17476.213570389107;17477.82522174762;13307.401166947511;13641.317934103256;14031.719365612631;14395.712085758227;14504.057236279608;9576.47329396876;9691.757706057264;9712.805743885225;9721.659741909;9756.365836220764;3599.208174201671;3633.182533929845;3676.191237927652;3719.1260053887313;3739.439084137401;1052.5737076484036;1056.155075939261;1109.938953357557;1110.4836251143095;1166.7258194324327;35617.82191089028;35747.10632234215;35987.28025439476;36059.819700901855;36064;1134.5170327095902;1140.566584697826;1151.3552410650063;1184.1651635597057;1191.1483289447913;18102.27590896376;18509.907450462662;18640.254389824255;18828.24687012504;18837.24651013944;548940;557784;559142;559431;559557;66432;67207;67287;67331.32668673349;67335.32664673388;1296.0603562417361;1357.742029014504;1367.2275164532007;1424.2807382271887;1430.8569143085608;30624.693753063075;36965.260694785415;37131;37752.43371349377;38230.42654360242;61996.38003620086;62843;62895.6855215721;62933.370666294584;62995;510047;512719;515150;515783;516665;27195;28714.138575841924;28931.987380441584;32571.837140814143;33112.668873310955;47771;52517.7374113127;52620.473795261554;52655.47344526506;52904.73547632237;44072;44425.33361999508;45163.54836451593;45886;46433.30350044685;44451.77774111109;45684.77157614191;46282.76858615685;46491;46783.298250525586;45599;48343.75828120837;48905.51094489152;49721.25418118659;49900.25149622831;43516;46975;48043.51956480391;48286;50106;35433.82283088671;37551.43672844964;37898.43152352772;38143.80928095342;38521.422178667905 22:39:37 INFO - PROCESS | 20514 | |2;jquery.html;386.3432165318957;392.86053451024867;410.3700819242462;424.72392944586016;424.9723767955083;19296.51758706033;19926.302579409723;20589.794102058975;21023.369298921018;21054.36836894892;13369.465221391132;13674.863251367484;19104.808951910476;19682.91743954082;19700.704489432635;5446.183072539111;5470.261514695505;5577.2191893135;5602.495775380215;5602.747876345574;4111.97944010281;5533.08704063831;5556.777728890839;5566.443355664422;5585.329760428734;4368.803403846835;4646;4658.627309815207;6712.295209003058;6756.087928129713;6136.447719705203;6421.8394540136405;6771;6814.386705196532;6826.726930922757;5994.13085102662;6011.489023433013;6014.12795144706;6020.608660437058;6022.819315420545;15116.244187790566;17531;21095.472613184793;24552.754472455224;24663.87668061666;2401.5076909233567;2428.878556072207;2547.7707006369515;2647.139679604117;2884.9134525964255;10362.689119326356;10434.791304173874;10708.089812365959;10958.616448424267;10974.122070234362;2037.4702577329854;2090.278853795438;2092.225876425717;2122.7983341582526;2130.531283117727;69887;72985.27014729891;79386;84122;90294.09705902988;12017.699557511132;12076.758464830655;12289.201201922026;12316.261024338568;12331.99999999982;17458.65082698339;17476.650466990588;17482.388116415863;17491.650166996587;17494.825051749573;8780.912190878009;8953.418027828171;9031.232345250595;9166.312526560534;9219.07809219086;8385.287250583646;8498.617562209716;8627.396082274307;8639.827203455896;8841.55792210387;5138.409082955433;5164.870878228075;5187.610929180327;5196.376434827845;5201.479852014844;2056.4550394145563;2103.9579208415744;2114.059243636567;2181.182056728727;2196.8242540597034;937.7093101138669;937.779621788879;1027.984580231297;1073.393532654048;1110.3580256757848;20048.39854804358;20878.37364879056;20955;21123.7656057806;21161.68257476139;1029.7425643589104;1039.9652345915863;1044.1072882685346;1076.4671487613525;1086.809808283563;10002.749931251778;10987.39569323695;11805.52777888892;11965.341906195068;12249.877501225052;410164;414570;417151;547075;568260;60414.39585604176;76438;77228;94239.58640620396;96947;966.4974213409129;1047.8061558611682;1079.1528650009861;1079.5681727308981;1081.502508845924;18481.630367392845;18875.339363122224;19018.52453688669;19078.618427631092;19445;43130.218687872766;44091.11817763691;44094;44293.55706442894;44838.327425088;58288.4171158283;59367;59465;60119.39880601313;60908.086378705244;9124.45253284805;9143.679971201242;9154.816903661756;9261.351705380559;9336.253099752139;6595.307492713196;8173.550454724809;12325.322107284186;12615.558455454382;12850.871491284968;11648.242864213798;11711.88288117142;11876.76246475083;12043.458044387848;12303.630891073282;11236.66290011301;11334.60328888485;11384.772304554028;11892.702682433008;12389.19470234468;11513.53945842157;11809.940950295537;11951.581694640647;12136;12188.146829722189;9153.862692059758;9185.081491850762;9238.95380523093;9447.669331573363;9547.796108353941;9696.321257511907;11919.463624137108;12024.639260822189;12136.817947730968;12243.32661703615 22:39:37 INFO - PROCESS | 20514 | |3;mootools.html;1485.680578675585;1515.7347464193765;1676.8993860368378;1832.221305944973;1851.1022154255184;8911.68809091682;9748.415095094299;9751.756206094851;9760.4631745254;9765.609375624967;8267.875981860278;8541.35939804514;8550.102239264881;8804.8679269811;9514.143727064562;2490.10356271742;2592.857392843393;2593.1053786443645;2599.4411201591656;2599.454114635929;2514.7736703696664;2538.70804857441;2547.223096955428;2556.718760936305;2573.4595734895693;2473.5300292944285;2477.702675678912;2479.0331770609387;2480.355107672;2485.8508489490596;2463.4457247119435;2473.9010439582394;2485.465624890648;2485.5774518331928;2487.4278915849454;2439.5852705040184;2485.801135909141;2488.278399264211;2488.601823708216;2488.875556222182;9374.437533747998;9446.905530944672;9547.522623868848;9572.186364159055;9574.47340396278;5262.210668399733;5411.621186516945;5418.187271909206;5427.6472029317965;5431.293931788881;3313.6520665330277;3334.199792049915;3468.601110872257;3479.6868281854754;3499.30013997199;1184.4433116435348;1186.5075993462704;1187.5606025770435;1195.1932445599186;1211.7515909238673;12725.809112863315;12847.74304513914;12904.80642790359;12930.48278068876;13050.216986980811;4678.064387122589;4852.296417019513;4892.437369702458;4916.328448327515;5067.341245638044;11227.607033753779;11232.213745037769;11239.044681202025;11239.157063220291;11242.94378528102;5336.039512887717;5369.19462080691;5373.086575282211;5392.083345831218;5396.7571459283645;4870.853874383774;4941.357623508921;4944.307796908436;4947.777350019258;4960.330355401975;4165.2111879166805;4166.479190101238;4224.8732538023905;4243.193793179286;4264.786760662017;1234.2841152131741;1237.9319137447346;1253.8808813162734;1254.799232122856;1270.5426046623393;948.9098535639104;1053.1627356251797;1061.3419679798574;1064.2284343850647;1069.4599227390117;6370.968145159244;6539.640319782363;6540.117084193668;6656.833579160463;6779.186497620219;456.24491466622794;465.51586350196095;467.81053673262386;472.2892047468538;479.4438451396363;4232.64022558086;4513.848968513008;4586.97706511472;4616.8614941551805;4620.953790462119;11535.192536522363;11787.115966302561;11863.11026673003;11889.108316876269;11893.40532973348;10749.032587067202;11133.220674552704;11138.3873886937;11760.411979400995;11862.644120676394;8672.392932494791;8870.334724895658;8874;8876.289896808239;8886.86669699955;6305.905855912099;6567.343265673395;6579.407853293226;6616.2060552732055;6721.361470660279;10457.68626941193;10769.892301076889;10889.237753357505;11017;11080.224384293022;11107.611233606785;11121.777564448828;11194.888051119384;11211.775764484502;11213.943930280297;7628.732994345171;7742.38060955111;8120;8255.215754503313;8460.746177614681;8884.244839188483;9100.362974591715;9112.681056163003;9120.954395227982;9165.450072995642;8323.95838020806;8410.621522031646;8474.983002039795;8501.064882863004;8660.566971651519;8096.757097286855;8229.382796290422;8237.135100814328;8298.08721040673;8340.541270230196;7497.700091996478;7511.549307041595;7532.246775322424;7539.396848252017;7543.698252069856;5379.273798037371;5436.673799572039;5452.863678408072;5589.189567512769;5594.524465420485;5428.697112693004;5565.387807341108;5620.943790562042;5644.153376993484;5690.231818704588 22:39:37 INFO - PROCESS | 20514 | |4;prototype.html;347.7061882709111;356.65582712682266;365.50839121381733;369.6451406649616;370.0711214850724;5511.586631002676;5532.5573954083675;5558.110702287635;5563.415841336662;5605.747741351639;5187.896242075156;5297.337832770903;5342.477393942727;5369.650972686773;5544.253560128556;4330;4338.84814031509;4339.071126989285;4343.9565604344025;4359.825606975733;4342.609165175134;4348;4352.368906508555;4366.148601022802;4381.233284175272;4142.316517774579;4293.205756934962;4298.914021719579;4316.223079845627;4336.761478118702;4280.272353699847;4285.164392943378;4286.871393858158;4296.37702533131;4296.720713153651;3799.3351163546545;3808.6762625176893;3818.7899665518385;3828.272628200633;3830.5211848518934;5169.087437648094;5312.6281160318795;5369.543588794957;5375.494861438803;5396.19057141428;4961.891196241583;4964.751762411865;4965;4966.789778548511;4973.5523802857915;5770.8268751937085;5779.572579516571;5791.89953908756;5795.246617939683;5819.068948968187;4129.669626429908;4205.3481710334945;4233.809478573472;4238.152369526107;4240.9151816963795;6026.60827046245;6038.396160383971;6041.214642096499;6043.1841701370195;6052.546059045545;4315.805788739452;4321.114171594815;4323.935140972888;4326.480822301344;4326.610605045498;4284.700070995001;4334.5882141196535;4338.739675619473;4362.236608593484;4398.538153493901;4929.556339929423;4937.284093806378;4944.802207911644;4945.134601444733;4952.034353301072;5790.478856902899;5810.704771615273;5820.563457740686;5833.162553795541;5862.355140934494;1424.2380326525467;1450.485077797388;1453.7165252775608;1495.8429364916744;1502.4966636177003;1009.2985375164191;1012.6303899076784;1040.8230600797883;1041.8801837788599;1043.6451606453843;5585.972070139624;5595.412481689364;5613.091548873403;5619.241402410622;5632.746526406321;5871.943050250996;5915.674637894871;5918.638713096012;5919.556033297434;5934.287885453773;5411.83764487066;5493.176023596492;5571.609987300931;5610.607257491936;5616.747246373841;3104.7516198704047;3110.5178697301953;3118.3919135768306;3136.3811217633074;3138.3880143371825;6094.263135006502;6101.816945491642;6102.755889764359;6117.663528505886;6127.356627554132;5904.4095590441475;6076.605020673642;6087.847803804941;6102.359252278447;6102.847428814226;6179.443850053517;6180.412860778219;6180.567360284737;6184.845378865474;6200.782972595937;5744.942550574608;5978.730957106854;5997.250343707036;6015.2781666200335;6015.5488338373925;5911.822645320647;5947.256592925884;5953.553483488669;5972.5520585955355;5983.461488466059;5925.348211696796;6147.231596050494;6173.197484327009;6177.880170513862;6180;4305.655547556125;4336.457942757155;4359.912801744011;4370.584794444522;4386.7367957922625;6013.488853447331;6021.939780602138;6032.215811944419;6032.577719559588;6035.637861728134;5592.930615672228;5742.224799651994;5748.511376533042;5861.589688721749;5882.676452795137;5852.985712358054;5860.472557469848;5862.501687356623;5879.970600146972;5901.141140540716;5691.373948865538;5751.986804618517;5791.82624521265;5793.449622286044;5819.301683797971;5868.354481007171;5880.558958078247;5900.468957793819;5906.202662640489;5906.557008224315;5583.553315734813;5709.22925405065;5739.598228123991;5743.472871936335;5771.394003629558 22:39:37 INFO - PROCESS | 20514 | |5;yui.html;745.3478206569251;779.7894568466514;791.4064451661254;857.5112186053948;857.5155037403863;15857.920710396445;16249.350025998945;16612.916935415335;17185.742213866786;17198.05410702411;15494.69010619787;15798;15814.367425302975;15833.762493562606;15844.683106337867;725.2964624314407;743.9070116235471;892.1881088209747;898.0390981649638;900.4192295969096;861.5864385095158;896.8520194167987;898.1333013641867;903.4804987132393;904.1997831918734;945.0219023310875;948.2556193388192;948.6347756113877;949.9477528735916;951.5242378810594;757.7044952468542;942.8161508505844;944.6740874398322;944.9291303152291;945.1918609588806;580.5181699189662;655.0338251079667;673.1518286958419;673.71367168953;678.389449495453;15784.842151578452;15787.605309867231;15809.841901580952;15825.52523424299;15838.841611583966;14745.852541474555;15256.923715381352;15367.538973830802;15489.302981365865;15545.22273886301;14194;14221.928890355586;14263.928680356636;14977;15252.542423727306;4634.119517291738;4641.3270075839155;4657.953420465786;4694.906101877978;4887.682300650482;83662.58168709178;84669.57665211696;84854;85065.57467212624;85276.14723852806;11969.581064662694;12177.878221217852;12258;12304.200226985397;12437.191582547106;22586;22616.208432704778;22617.09531618717;22669.43326416853;22707.09171633149;8853.38026338163;8866.157715017063;8903.510306933182;8952.507612081397;8954.194122529003;4707.646926480527;4822.614190864722;4921.532454416824;4992.176290911959;5064.18972964324;3569.1790888095884;3689.612590677994;3703.3519134151416;3711.406175011985;3714.4242642390473;603.538293205698;612.9601575897552;617.521420898807;618.5824568416391;623.6943897490288;676.070403195606;708.6102643546029;729.3071581997124;731.7256028989129;755.8601658693159;9932.553035113437;9962.452065136487;10332.431716255527;10722.356658600509;10738.087262582612;688.3735800421592;715.3883429667663;716.691822516323;728.9599072050981;734.2363941500779;5062.544371006627;5129.12804823181;5444.5916556258435;5696.686682232517;5802.187693722883;77091.61454192693;82512.58743706363;86480.97316593889;137170;138115;75464.62267688627;93146.53426732823;115836.42081789537;116605.41697291628;118132;63819.04271435932;66758.33241667521;97413.02586974182;98647;101029.49485252527;10356.653635027398;10796.077944644408;10860.511276992713;11023.669289921316;11314.94342528315;58601.4139858613;59121.70439147777;59808.401915980285;60322.698386507785;60794.69602651958;79641.01794910347;84211;88168;88214.55892720495;91419.54290228506;14366.425342986582;14792.63018424505;14878.553643390716;14953.177575233467;15177.392904283704;14924.850751492346;15299.694006119593;15427.228638568251;15829;16378.508644740677;15134.621634459227;15175.468858589897;15860.286287116876;16174.919125404298;16341.428050018192;14403;14665.26673666291;14972.251387430802;15091;15092.245387730789;14375.137491750529;14376.353064112349;14830.184339861411;14921.477748278758;15849.841501584837;12076.577319793765;13093.345332733516;13210.537631182862;13404;13405.329733513481;12513.749725005631;13052.738945220852;13342.399592018577;13437.865621344052;13499.527516536875 22:39:37 INFO - PROCESS | 20514 | __end_tp_report 22:39:37 INFO - PROCESS | 20514 | __start_cc_report 22:39:37 INFO - PROCESS | 20514 | _x_x_mozilla_cycle_collect,859 22:39:37 INFO - PROCESS | 20514 | __end_cc_report 22:39:37 INFO - PROCESS | 20514 | __startTimestamp1475559577184__endTimestamp 22:39:37 INFO - PROCESS | 20514 | 22:39:37 INFO - PROCESS | 20514 | ------- Summary: start ------- 22:39:37 INFO - PROCESS | 20514 | Number of tests: 6 22:39:37 INFO - PROCESS | 20514 | 22:39:37 INFO - PROCESS | 20514 | [#0] dojo.html Cycles:165 Average:5559.08 Median:5779.88 stddev:645.17 (11.2%) stddev-sans-first:617.92 22:39:37 INFO - PROCESS | 20514 | Values: 3111.7 3144.0 3147.6 3160.9 3191.6 5594.4 5668.5 5674.9 5692.6 5699.0 5584.2 5689.3 5699.8 5707.3 5738.7 5101.8 5129.7 5141.1 5164.6 5200.6 4918.3 4918.4 5204.1 5205.3 5228.2 4994.8 5016.9 5021.6 5054.7 5081.2 5031.0 5081.3 5093.2 5153.3 5175.6 4994.7 5048.9 5109.6 5112.9 5116.2 5399.6 5416.7 5417.3 5418.1 5426.4 5917.1 5936.7 6051.2 6061.3 6063.6 6073.9 6077.5 6086.4 6097.8 6104.0 5399.5 5431.8 5508.3 5534.0 5543.8 6076.3 6109.8 6111.6 6115.8 6120.9 5742.0 5864.6 5869.5 5872.2 5880.1 5871.5 5915.1 5916.1 5952.1 6049.7 5963.4 5976.0 5976.7 5986.8 5987.9 5935.4 5980.0 5988.1 5998.0 6029.9 4505.9 4529.6 4566.7 4568.3 4588.3 4047.6 4078.6 4089.5 4101.5 4138.7 5740.8 5743.4 5747.3 5757.1 5759.8 5703.3 5748.2 5977.6 6024.0 6032.8 5754.6 5779.6 5780.9 5793.2 5811.7 5150.3 5172.5 5181.7 5187.5 5209.3 5902.4 5998.0 6134.9 6258.0 6302.7 5980.2 6036.5 6047.2 6079.4 6083.2 6158.4 6201.4 6237.6 6251.3 6253.2 5657.6 5704.7 5930.6 5934.2 5944.0 5932.5 5945.4 5961.0 6032.9 6086.1 5851.7 5861.8 5862.1 5863.2 5882.7 5536.1 5879.9 5892.6 5894.3 5902.4 5547.7 5762.3 5779.9 5801.1 5881.8 5946.0 5977.2 5990.7 5992.7 5993.8 5616.7 5653.1 5831.1 5832.4 5833.5 22:39:37 INFO - PROCESS | 20514 | 22:39:37 INFO - PROCESS | 20514 | [#1] ext.html Cycles:180 Average:65511.28 Median:23163.89 stddev:129074.97 (557.2%) stddev-sans-first:129345.03 22:39:37 INFO - PROCESS | 20514 | Values: 592.0 628.6 652.8 658.8 668.9 35951.3 47720.5 48904.3 49192.5 49240.0 49189.5 49458.5 49593.3 49808.8 49809.5 8442.2 9377.3 9459.6 9492.7 9502.1 8441.4 11120.8 11291.2 11295.4 11758.5 11589.1 11647.7 11658.7 11659.8 11667.8 11407.9 11464.4 11478.8 11483.5 11484.8 11033.2 11088.9 11096.8 11107.5 11109.3 46493.0 46671.8 46839.8 46881.5 46881.5 3616.5 3638.0 3719.4 3723.7 4158.2 35615.0 35692.8 35748.3 36108.3 37316.0 4511.5 4516.2 4537.8 4635.8 4640.3 367865.0 368197.0 369435.0 370764.0 371895.0 41121.4 42169.6 66862.0 67214.0 67281.7 43433.0 43824.6 43838.6 43866.6 43868.3 17314.0 17438.8 17448.2 17476.2 17477.8 13307.4 13641.3 14031.7 14395.7 14504.1 9576.5 9691.8 9712.8 9721.7 9756.4 3599.2 3633.2 3676.2 3719.1 3739.4 1052.6 1056.2 1109.9 1110.5 1166.7 35617.8 35747.1 35987.3 36059.8 36064.0 1134.5 1140.6 1151.4 1184.2 1191.1 18102.3 18509.9 18640.3 18828.2 18837.2 548940.0 557784.0 559142.0 559431.0 559557.0 66432.0 67207.0 67287.0 67331.3 67335.3 1296.1 1357.7 1367.2 1424.3 1430.9 30624.7 36965.3 37131.0 37752.4 38230.4 61996.4 62843.0 62895.7 62933.4 62995.0 510047.0 512719.0 515150.0 515783.0 516665.0 27195.0 28714.1 28932.0 32571.8 33112.7 47771.0 52517.7 52620.5 52655.5 52904.7 44072.0 44425.3 45163.5 45886.0 46433.3 44451.8 45684.8 46282.8 46491.0 46783.3 45599.0 48343.8 48905.5 49721.3 49900.3 43516.0 46975.0 48043.5 48286.0 50106.0 35433.8 37551.4 37898.4 38143.8 38521.4 22:39:37 INFO - PROCESS | 20514 | 22:39:37 INFO - PROCESS | 20514 | [#2] jquery.html Cycles:180 Average:28425.78 Median:13605.82 stddev:78505.18 (577.0%) stddev-sans-first:78697.18 22:39:37 INFO - PROCESS | 20514 | Values: 386.3 392.9 410.4 424.7 425.0 19296.5 19926.3 20589.8 21023.4 21054.4 13369.5 13674.9 19104.8 19682.9 19700.7 5446.2 5470.3 5577.2 5602.5 5602.7 4112.0 5533.1 5556.8 5566.4 5585.3 4368.8 4646.0 4658.6 6712.3 6756.1 6136.4 6421.8 6771.0 6814.4 6826.7 5994.1 6011.5 6014.1 6020.6 6022.8 15116.2 17531.0 21095.5 24552.8 24663.9 2401.5 2428.9 2547.8 2647.1 2884.9 10362.7 10434.8 10708.1 10958.6 10974.1 2037.5 2090.3 2092.2 2122.8 2130.5 69887.0 72985.3 79386.0 84122.0 90294.1 12017.7 12076.8 12289.2 12316.3 12332.0 17458.7 17476.7 17482.4 17491.7 17494.8 8780.9 8953.4 9031.2 9166.3 9219.1 8385.3 8498.6 8627.4 8639.8 8841.6 5138.4 5164.9 5187.6 5196.4 5201.5 2056.5 2104.0 2114.1 2181.2 2196.8 937.7 937.8 1028.0 1073.4 1110.4 20048.4 20878.4 20955.0 21123.8 21161.7 1029.7 1040.0 1044.1 1076.5 1086.8 10002.7 10987.4 11805.5 11965.3 12249.9 410164.0 414570.0 417151.0 547075.0 568260.0 60414.4 76438.0 77228.0 94239.6 96947.0 966.5 1047.8 1079.2 1079.6 1081.5 18481.6 18875.3 19018.5 19078.6 19445.0 43130.2 44091.1 44094.0 44293.6 44838.3 58288.4 59367.0 59465.0 60119.4 60908.1 9124.5 9143.7 9154.8 9261.4 9336.3 6595.3 8173.6 12325.3 12615.6 12850.9 11648.2 11711.9 11876.8 12043.5 12303.6 11236.7 11334.6 11384.8 11892.7 12389.2 11513.5 11809.9 11951.6 12136.0 12188.1 9153.9 9185.1 9239.0 9447.7 9547.8 9696.3 11919.5 12024.6 12136.8 12243.3 22:39:37 INFO - PROCESS | 20514 | 22:39:37 INFO - PROCESS | 20514 | [#3] mootools.html Cycles:180 Average:6177.90 Median:466.66 stddev:3550.34 (760.8%) stddev-sans-first:3542.79 22:39:37 INFO - PROCESS | 20514 | Values: 1485.7 1515.7 1676.9 1832.2 1851.1 8911.7 9748.4 9751.8 9760.5 9765.6 8267.9 8541.4 8550.1 8804.9 9514.1 2490.1 2592.9 2593.1 2599.4 2599.5 2514.8 2538.7 2547.2 2556.7 2573.5 2473.5 2477.7 2479.0 2480.4 2485.9 2463.4 2473.9 2485.5 2485.6 2487.4 2439.6 2485.8 2488.3 2488.6 2488.9 9374.4 9446.9 9547.5 9572.2 9574.5 5262.2 5411.6 5418.2 5427.6 5431.3 3313.7 3334.2 3468.6 3479.7 3499.3 1184.4 1186.5 1187.6 1195.2 1211.8 12725.8 12847.7 12904.8 12930.5 13050.2 4678.1 4852.3 4892.4 4916.3 5067.3 11227.6 11232.2 11239.0 11239.2 11242.9 5336.0 5369.2 5373.1 5392.1 5396.8 4870.9 4941.4 4944.3 4947.8 4960.3 4165.2 4166.5 4224.9 4243.2 4264.8 1234.3 1237.9 1253.9 1254.8 1270.5 948.9 1053.2 1061.3 1064.2 1069.5 6371.0 6539.6 6540.1 6656.8 6779.2 456.2 465.5 467.8 472.3 479.4 4232.6 4513.8 4587.0 4616.9 4621.0 11535.2 11787.1 11863.1 11889.1 11893.4 10749.0 11133.2 11138.4 11760.4 11862.6 8672.4 8870.3 8874.0 8876.3 8886.9 6305.9 6567.3 6579.4 6616.2 6721.4 10457.7 10769.9 10889.2 11017.0 11080.2 11107.6 11121.8 11194.9 11211.8 11213.9 7628.7 7742.4 8120.0 8255.2 8460.7 8884.2 9100.4 9112.7 9121.0 9165.5 8324.0 8410.6 8475.0 8501.1 8660.6 8096.8 8229.4 8237.1 8298.1 8340.5 7497.7 7511.5 7532.2 7539.4 7543.7 5379.3 5436.7 5452.9 5589.2 5594.5 5428.7 5565.4 5620.9 5644.2 5690.2 22:39:37 INFO - PROCESS | 20514 | 22:39:37 INFO - PROCESS | 20514 | [#4] prototype.html Cycles:180 Average:4904.24 Median:5567.51 stddev:1435.63 (25.8%) stddev-sans-first:1398.33 22:39:37 INFO - PROCESS | 20514 | Values: 347.7 356.7 365.5 369.6 370.1 5511.6 5532.6 5558.1 5563.4 5605.7 5187.9 5297.3 5342.5 5369.7 5544.3 4330.0 4338.8 4339.1 4344.0 4359.8 4342.6 4348.0 4352.4 4366.1 4381.2 4142.3 4293.2 4298.9 4316.2 4336.8 4280.3 4285.2 4286.9 4296.4 4296.7 3799.3 3808.7 3818.8 3828.3 3830.5 5169.1 5312.6 5369.5 5375.5 5396.2 4961.9 4964.8 4965.0 4966.8 4973.6 5770.8 5779.6 5791.9 5795.2 5819.1 4129.7 4205.3 4233.8 4238.2 4240.9 6026.6 6038.4 6041.2 6043.2 6052.5 4315.8 4321.1 4323.9 4326.5 4326.6 4284.7 4334.6 4338.7 4362.2 4398.5 4929.6 4937.3 4944.8 4945.1 4952.0 5790.5 5810.7 5820.6 5833.2 5862.4 1424.2 1450.5 1453.7 1495.8 1502.5 1009.3 1012.6 1040.8 1041.9 1043.6 5586.0 5595.4 5613.1 5619.2 5632.7 5871.9 5915.7 5918.6 5919.6 5934.3 5411.8 5493.2 5571.6 5610.6 5616.7 3104.8 3110.5 3118.4 3136.4 3138.4 6094.3 6101.8 6102.8 6117.7 6127.4 5904.4 6076.6 6087.8 6102.4 6102.8 6179.4 6180.4 6180.6 6184.8 6200.8 5744.9 5978.7 5997.3 6015.3 6015.5 5911.8 5947.3 5953.6 5972.6 5983.5 5925.3 6147.2 6173.2 6177.9 6180.0 4305.7 4336.5 4359.9 4370.6 4386.7 6013.5 6021.9 6032.2 6032.6 6035.6 5592.9 5742.2 5748.5 5861.6 5882.7 5853.0 5860.5 5862.5 5880.0 5901.1 5691.4 5752.0 5791.8 5793.4 5819.3 5868.4 5880.6 5900.5 5906.2 5906.6 5583.6 5709.2 5739.6 5743.5 5771.4 22:39:37 INFO - PROCESS | 20514 | 22:39:37 INFO - PROCESS | 20514 | [#5] yui.html Cycles:180 Average:22091.93 Median:4649.64 stddev:31136.02 (669.6%) stddev-sans-first:31182.11 22:39:37 INFO - PROCESS | 20514 | Values: 745.3 779.8 791.4 857.5 857.5 15857.9 16249.4 16612.9 17185.7 17198.1 15494.7 15798.0 15814.4 15833.8 15844.7 725.3 743.9 892.2 898.0 900.4 861.6 896.9 898.1 903.5 904.2 945.0 948.3 948.6 949.9 951.5 757.7 942.8 944.7 944.9 945.2 580.5 655.0 673.2 673.7 678.4 15784.8 15787.6 15809.8 15825.5 15838.8 14745.9 15256.9 15367.5 15489.3 15545.2 14194.0 14221.9 14263.9 14977.0 15252.5 4634.1 4641.3 4658.0 4694.9 4887.7 83662.6 84669.6 84854.0 85065.6 85276.1 11969.6 12177.9 12258.0 12304.2 12437.2 22586.0 22616.2 22617.1 22669.4 22707.1 8853.4 8866.2 8903.5 8952.5 8954.2 4707.6 4822.6 4921.5 4992.2 5064.2 3569.2 3689.6 3703.4 3711.4 3714.4 603.5 613.0 617.5 618.6 623.7 676.1 708.6 729.3 731.7 755.9 9932.6 9962.5 10332.4 10722.4 10738.1 688.4 715.4 716.7 729.0 734.2 5062.5 5129.1 5444.6 5696.7 5802.2 77091.6 82512.6 86481.0 137170.0 138115.0 75464.6 93146.5 115836.4 116605.4 118132.0 63819.0 66758.3 97413.0 98647.0 101029.5 10356.7 10796.1 10860.5 11023.7 11314.9 58601.4 59121.7 59808.4 60322.7 60794.7 79641.0 84211.0 88168.0 88214.6 91419.5 14366.4 14792.6 14878.6 14953.2 15177.4 14924.9 15299.7 15427.2 15829.0 16378.5 15134.6 15175.5 15860.3 16174.9 16341.4 14403.0 14665.3 14972.3 15091.0 15092.2 14375.1 14376.4 14830.2 14921.5 15849.8 12076.6 13093.3 13210.5 13404.0 13405.3 12513.7 13052.7 13342.4 13437.9 13499.5 22:39:37 INFO - PROCESS | 20514 | -------- Summary: end -------- 22:39:37 INFO - PROCESS | 20514 | 22:39:37 INFO - TEST-INFO | 20514: exit 0 22:39:37 INFO - TEST-OK | dromaeo_css | took 1114620ms 22:39:37 INFO - TEST-START | kraken 22:39:37 INFO - operating with platform_type : linux_ 22:39:37 INFO - Initialising browser for kraken test... 22:39:37 INFO - TEST-INFO | started process 20832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNMHX38/profile http://localhost:56634/getInfo.html) 22:39:42 INFO - PROCESS | 20832 | __metrics Screen width/height:1600/1200 22:39:42 INFO - PROCESS | 20832 | colorDepth:24 22:39:42 INFO - PROCESS | 20832 | Browser inner width/height: 1024/697 22:39:42 INFO - PROCESS | 20832 | __metrics 22:39:43 INFO - PROCESS | 20832 | 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" 22:39:43 INFO - PROCESS | 20832 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:39:43 INFO - PROCESS | 20832 | console.error: PushService: 22:39:43 INFO - PROCESS | 20832 | stateChangeProcessEnqueue: Error transitioning state 22:39:43 INFO - PROCESS | 20832 | UnknownError 22:39:44 INFO - TEST-INFO | 20832: exit 0 22:39:44 INFO - Browser initialized. 22:39:44 INFO - Running cycle 1/1 for kraken test... 22:39:44 INFO - TEST-INFO | started process 20924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNMHX38/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:39:55 INFO - PROCESS | 20924 | RSS: Main: 144674816 22:39:55 INFO - PROCESS | 20924 | 22:39:58 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56634/tests/kraken/driver.html?testName=audio-beat-detection) 22:39:59 INFO - PROCESS | 20924 | RSS: Main: 186155008 22:39:59 INFO - PROCESS | 20924 | 22:40:01 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56634/tests/kraken/driver.html?testName=audio-dft) 22:40:02 INFO - PROCESS | 20924 | RSS: Main: 174841856 22:40:02 INFO - PROCESS | 20924 | 22:40:05 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56634/tests/kraken/driver.html?testName=audio-fft) 22:40:05 INFO - PROCESS | 20924 | RSS: Main: 266756096 22:40:05 INFO - PROCESS | 20924 | 22:40:07 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56634/tests/kraken/driver.html?testName=audio-oscillator) 22:40:08 INFO - PROCESS | 20924 | RSS: Main: 172654592 22:40:08 INFO - PROCESS | 20924 | 22:40:10 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:40:11 INFO - PROCESS | 20924 | RSS: Main: 174071808 22:40:11 INFO - PROCESS | 20924 | 22:40:14 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56634/tests/kraken/driver.html?testName=imaging-darkroom) 22:40:14 INFO - PROCESS | 20924 | RSS: Main: 210501632 22:40:14 INFO - PROCESS | 20924 | 22:40:18 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56634/tests/kraken/driver.html?testName=imaging-desaturate) 22:40:18 INFO - PROCESS | 20924 | RSS: Main: 209260544 22:40:18 INFO - PROCESS | 20924 | 22:40:21 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56634/tests/kraken/driver.html?testName=json-parse-financial) 22:40:22 INFO - PROCESS | 20924 | RSS: Main: 209281024 22:40:22 INFO - PROCESS | 20924 | 22:40:23 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:40:24 INFO - PROCESS | 20924 | RSS: Main: 171278336 22:40:24 INFO - PROCESS | 20924 | 22:40:25 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56634/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:40:26 INFO - PROCESS | 20924 | RSS: Main: 180072448 22:40:26 INFO - PROCESS | 20924 | 22:40:28 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:40:29 INFO - PROCESS | 20924 | RSS: Main: 183578624 22:40:29 INFO - PROCESS | 20924 | 22:40:31 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:40:32 INFO - PROCESS | 20924 | RSS: Main: 184205312 22:40:32 INFO - PROCESS | 20924 | 22:40:34 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:40:35 INFO - PROCESS | 20924 | RSS: Main: 182042624 22:40:35 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | Cycle 1(1): loaded http://localhost:56634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56634/tests/kraken/driver.html?testName=ai-astar) 22:40:37 INFO - PROCESS | 20924 | RSS: Main: 233799680 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | __start_tp_report 22:40:37 INFO - PROCESS | 20924 | _x_x_mozilla_page_load 22:40:37 INFO - PROCESS | 20924 | _x_x_mozilla_page_load_details 22:40:37 INFO - PROCESS | 20924 | |i|pagename|runs| 22:40:37 INFO - PROCESS | 20924 | |0;ai-astar;110;112;112;112;111;112;113;112;111;114 22:40:37 INFO - PROCESS | 20924 | |1;audio-beat-detection;139;118;115;157;121;121;117;115;145;117 22:40:37 INFO - PROCESS | 20924 | |2;audio-dft;160;160;161;160;161;159;160;160;159;160 22:40:37 INFO - PROCESS | 20924 | |3;audio-fft;74;76;76;114;76;76;75;76;107;77 22:40:37 INFO - PROCESS | 20924 | |4;audio-oscillator;81;80;130;81;82;82;101;82;82;109 22:40:37 INFO - PROCESS | 20924 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 22:40:37 INFO - PROCESS | 20924 | |6;imaging-darkroom;146;146;145;145;146;145;146;146;147;146 22:40:37 INFO - PROCESS | 20924 | |7;imaging-desaturate;95;95;95;95;94;94;95;95;95;95 22:40:37 INFO - PROCESS | 20924 | |8;json-parse-financial;50;49;50;51;49;50;50;50;49;50 22:40:37 INFO - PROCESS | 20924 | |9;json-stringify-tinderbox;58;58;58;58;58;58;59;63;58;59 22:40:37 INFO - PROCESS | 20924 | |10;stanford-crypto-aes;79;76;80;73;73;81;73;74;77;74 22:40:37 INFO - PROCESS | 20924 | |11;stanford-crypto-ccm;130;118;134;118;116;119;116;123;155;127 22:40:37 INFO - PROCESS | 20924 | |12;stanford-crypto-pbkdf2;153;155;151;150;155;153;154;152;151;151 22:40:37 INFO - PROCESS | 20924 | |13;stanford-crypto-sha256-iterative;67;62;61;61;61;63;66;61;61;61 22:40:37 INFO - PROCESS | 20924 | __end_tp_report 22:40:37 INFO - PROCESS | 20924 | __start_cc_report 22:40:37 INFO - PROCESS | 20924 | _x_x_mozilla_cycle_collect,1581 22:40:37 INFO - PROCESS | 20924 | __end_cc_report 22:40:37 INFO - PROCESS | 20924 | __startTimestamp1475559637393__endTimestamp 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | ------- Summary: start ------- 22:40:37 INFO - PROCESS | 20924 | Number of tests: 14 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:1.10 (1.0%) stddev-sans-first:0.93 22:40:37 INFO - PROCESS | 20924 | Values: 110.0 112.0 112.0 112.0 111.0 112.0 113.0 112.0 111.0 114.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#1] audio-beat-detection Cycles:10 Average:126.50 Median:121.00 stddev:14.93 (12.3%) stddev-sans-first:15.14 22:40:37 INFO - PROCESS | 20924 | Values: 139.0 118.0 115.0 157.0 121.0 121.0 117.0 115.0 145.0 117.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 22:40:37 INFO - PROCESS | 20924 | Values: 160.0 160.0 161.0 160.0 161.0 159.0 160.0 160.0 159.0 160.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:14.77 (19.4%) stddev-sans-first:15.32 22:40:37 INFO - PROCESS | 20924 | Values: 74.0 76.0 76.0 114.0 76.0 76.0 75.0 76.0 107.0 77.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:81.50 stddev:16.96 (20.8%) stddev-sans-first:17.60 22:40:37 INFO - PROCESS | 20924 | Values: 81.0 80.0 130.0 81.0 82.0 82.0 101.0 82.0 82.0 109.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 22:40:37 INFO - PROCESS | 20924 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 22:40:37 INFO - PROCESS | 20924 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 147.0 146.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:40:37 INFO - PROCESS | 20924 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.00 stddev:0.63 (1.3%) stddev-sans-first:0.67 22:40:37 INFO - PROCESS | 20924 | Values: 50.0 49.0 50.0 51.0 49.0 50.0 50.0 50.0 49.0 50.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.00 stddev:1.57 (2.7%) stddev-sans-first:1.64 22:40:37 INFO - PROCESS | 20924 | Values: 58.0 58.0 58.0 58.0 58.0 58.0 59.0 63.0 58.0 59.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.50 stddev:3.09 (4.0%) stddev-sans-first:3.08 22:40:37 INFO - PROCESS | 20924 | Values: 79.0 76.0 80.0 73.0 73.0 81.0 73.0 74.0 77.0 74.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:125.00 stddev:12.05 (9.6%) stddev-sans-first:12.67 22:40:37 INFO - PROCESS | 20924 | Values: 130.0 118.0 134.0 118.0 116.0 119.0 116.0 123.0 155.0 127.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:153.00 stddev:1.78 (1.2%) stddev-sans-first:1.88 22:40:37 INFO - PROCESS | 20924 | Values: 153.0 155.0 151.0 150.0 155.0 153.0 154.0 152.0 151.0 151.0 22:40:37 INFO - PROCESS | 20924 | 22:40:37 INFO - PROCESS | 20924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:61.50 stddev:2.27 (3.7%) stddev-sans-first:1.69 22:40:37 INFO - PROCESS | 20924 | Values: 67.0 62.0 61.0 61.0 61.0 63.0 66.0 61.0 61.0 61.0 22:40:37 INFO - PROCESS | 20924 | -------- Summary: end -------- 22:40:37 INFO - PROCESS | 20924 | 22:40:38 INFO - TEST-INFO | 20924: exit 0 22:40:38 INFO - TEST-OK | kraken | took 60402ms 22:40:38 INFO - SUITE-END | took 1175s 22:40:38 INFO - Completed test suite (00:19:35) 22:40:38 INFO - javascript benchmark 22:40:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.7355024822887, 3143.968560314396, 3147.5593416921633, 3160.9367812643764, 3191.6329622093454, 5594.356648985363, 5668.489835914766, 5674.886502269957, 5692.601517893749, 5698.971505142474, 5584.1902924075985, 5689.3172819261745, 5699.800506982257, 5707.343655479621, 5738.713064346776, 5101.821436249732, 5129.743512824344, 5141.1003074462005, 5164.612654050942, 5200.635955483118, 4918.311436398907, 4918.409790825088, 5204.115300398922, 5205.27126202332, 5228.241904923784, 4994.750262486879, 5016.949830501703, 5021.598272138239, 5054.69671819692, 5081.237814327862, 5030.974845125787, 5081.314022606938, 5093.18509038552, 5153.252778347156, 5175.560077393388, 4994.675346102528, 5048.9495105048845, 5109.642325037249, 5112.948870511284, 5116.2069879168785, 5399.595030372738, 5416.702081385522, 5417.26866872971, 5418.051840927822, 5426.403095659474, 5917.112433135064, 5936.703164841784, 6051.243594550681, 6061.272647282311, 6063.575549711522, 6073.878522429571, 6077.453029227347, 6086.391360863922, 6097.817065488042, 6104.0, 5399.541039011689, 5431.809886653988, 5508.256385387961, 5533.972330138324, 5543.833684989457, 6076.27084749824, 6109.755609775648, 6111.633302001894, 6115.847103822351, 6120.877582448326, 5741.971290143522, 5864.618799778001, 5869.530437564985, 5872.17789509469, 5880.059190529495, 5871.500922421642, 5915.08316210988, 5916.1421593868645, 5952.136940143655, 6049.727762250709, 5963.4334738199805, 5976.043832986701, 5976.671283079472, 5986.790462333797, 5987.922174008633, 5935.406459354116, 5979.970100149559, 5988.131720900445, 5998.040313549811, 6029.909551356734, 4505.864824055284, 4529.6376289896725, 4566.70316429431, 4568.314752787109, 4588.26587745959, 4047.559574361769, 4078.632923036941, 4089.5092588889524, 4101.487314085739, 4138.689598280141, 5740.827775166752, 5743.396943320975, 5747.281589801275, 5757.078867381283, 5759.827205183851, 5703.315602127688, 5748.166515855261, 5977.6114552553945, 6024.0, 6032.819015429544, 5754.625949313365, 5779.566532510079, 5780.88438231233, 5793.2179155814265, 5811.680357580289, 5150.27896094547, 5172.508611681884, 5181.689098654093, 5187.507186817246, 5209.270702101709, 5902.38025007368, 5998.040313549811, 6134.926457743637, 6257.96939751357, 6302.747890084345, 5980.162777211281, 6036.547258955508, 6047.153398524122, 6079.392060793885, 6083.178770865877, 6158.414950579688, 6201.441870231521, 6237.5633705641985, 6251.281102673069, 6253.218347706536, 5657.60396772222, 5704.686242256716, 5930.555208359304, 5934.1988831508925, 5943.970280148572, 5932.525397968238, 5945.435183657545, 5961.016432288624, 6032.939670603413, 6086.117512960507, 5851.736671849691, 5861.765529378948, 5862.062070068769, 5863.237779088691, 5882.735276912635, 5536.141898005815, 5879.911801323069, 5892.558058145571, 5894.322152952465, 5902.350741418355, 5547.667139971614, 5762.337331206965, 5779.884402312015, 5801.071828507418, 5881.7647294107755, 5946.048632218824, 5977.163197152315, 5990.7304171311525, 5992.730327135202, 5993.820185394445, 5616.69108199053, 5653.123765816305, 5831.067029275296, 5832.387599302012, 5833.4749872511675], "value": 5514.213396155459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.029072321393, 628.6102616377844, 652.840054186724, 658.8451713847245, 668.869570433765, 35951.2809743805, 47720.522794772085, 48904.26643600349, 49192.50807491933, 49240.01519969603, 49189.50810491894, 49458.50541494584, 49593.25610115851, 49808.75095624526, 49809.50190498094, 8442.240198382144, 9377.343585948985, 9459.57431915562, 9492.66775662852, 9502.144806967372, 8441.366897482683, 11120.777584448306, 11291.153163512728, 11295.378754168518, 11758.529658813637, 11589.072874170088, 11647.6505704829, 11658.708532286719, 11659.825102623467, 11667.766644667101, 11407.942960285187, 11464.426778661034, 11478.827817582744, 11483.483243254032, 11484.770304593945, 11033.227674062819, 11088.944555277252, 11096.833547496793, 11107.500162492626, 11109.333439993627, 46493.0, 46671.76664116692, 46839.76580117112, 46881.53118468806, 46881.5311846884, 3616.5298511193378, 3637.9892708126417, 3719.367707489733, 3723.6834869036165, 4158.209940111369, 35615.0, 35692.82153589241, 35748.28503429943, 36108.27783444343, 37316.0, 4511.481179664315, 4516.232240519087, 4537.773111344452, 4635.814567417333, 4640.32715256286, 367865.0, 368196.9999999973, 369435.0, 370764.0, 371895.0, 41121.383179252334, 42169.578304217175, 66862.0, 67214.0, 67281.66359168173, 43433.0, 43824.56175438205, 43838.56161438409, 43866.56133438625, 43868.341974870404, 17314.0, 17438.82561174372, 17448.214830332665, 17476.213570389107, 17477.82522174762, 13307.401166947511, 13641.317934103256, 14031.719365612631, 14395.712085758227, 14504.057236279608, 9576.47329396876, 9691.757706057264, 9712.805743885225, 9721.659741909, 9756.365836220764, 3599.208174201671, 3633.182533929845, 3676.191237927652, 3719.1260053887313, 3739.439084137401, 1052.5737076484036, 1056.155075939261, 1109.938953357557, 1110.4836251143095, 1166.7258194324327, 35617.82191089028, 35747.10632234215, 35987.28025439476, 36059.819700901855, 36064.0, 1134.5170327095902, 1140.566584697826, 1151.3552410650063, 1184.1651635597057, 1191.1483289447913, 18102.27590896376, 18509.907450462662, 18640.254389824255, 18828.24687012504, 18837.24651013944, 548940.0, 557784.0, 559142.0, 559431.0, 559557.0, 66432.0, 67207.0, 67287.0, 67331.32668673349, 67335.32664673388, 1296.0603562417361, 1357.742029014504, 1367.2275164532007, 1424.2807382271887, 1430.8569143085608, 30624.693753063075, 36965.260694785415, 37131.0, 37752.43371349377, 38230.42654360242, 61996.38003620086, 62843.0, 62895.6855215721, 62933.370666294584, 62995.0, 510047.0, 512719.0, 515150.0, 515783.0, 516665.0, 27195.0, 28714.138575841924, 28931.987380441584, 32571.837140814143, 33112.668873310955, 47771.0, 52517.7374113127, 52620.473795261554, 52655.47344526506, 52904.73547632237, 44072.0, 44425.33361999508, 45163.54836451593, 45886.0, 46433.30350044685, 44451.77774111109, 45684.77157614191, 46282.76858615685, 46491.0, 46783.298250525586, 45599.0, 48343.75828120837, 48905.51094489152, 49721.25418118659, 49900.25149622831, 43516.0, 46975.0, 48043.51956480391, 48286.0, 50106.0, 35433.82283088671, 37551.43672844964, 37898.43152352772, 38143.80928095342, 38521.422178667905], "value": 21346.240048171476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3432165318957, 392.86053451024867, 410.3700819242462, 424.72392944586016, 424.9723767955083, 19296.51758706033, 19926.302579409723, 20589.794102058975, 21023.369298921018, 21054.36836894892, 13369.465221391132, 13674.863251367484, 19104.808951910476, 19682.91743954082, 19700.704489432635, 5446.183072539111, 5470.261514695505, 5577.2191893135, 5602.495775380215, 5602.747876345574, 4111.97944010281, 5533.08704063831, 5556.777728890839, 5566.443355664422, 5585.329760428734, 4368.803403846835, 4646.0, 4658.627309815207, 6712.295209003058, 6756.087928129713, 6136.447719705203, 6421.8394540136405, 6771.0, 6814.386705196532, 6826.726930922757, 5994.13085102662, 6011.489023433013, 6014.12795144706, 6020.608660437058, 6022.819315420545, 15116.244187790566, 17531.0, 21095.472613184793, 24552.754472455224, 24663.87668061666, 2401.5076909233567, 2428.878556072207, 2547.7707006369515, 2647.139679604117, 2884.9134525964255, 10362.689119326356, 10434.791304173874, 10708.089812365959, 10958.616448424267, 10974.122070234362, 2037.4702577329854, 2090.278853795438, 2092.225876425717, 2122.7983341582526, 2130.531283117727, 69887.0, 72985.27014729891, 79386.0, 84122.0, 90294.09705902988, 12017.699557511132, 12076.758464830655, 12289.201201922026, 12316.261024338568, 12331.99999999982, 17458.65082698339, 17476.650466990588, 17482.388116415863, 17491.650166996587, 17494.825051749573, 8780.912190878009, 8953.418027828171, 9031.232345250595, 9166.312526560534, 9219.07809219086, 8385.287250583646, 8498.617562209716, 8627.396082274307, 8639.827203455896, 8841.55792210387, 5138.409082955433, 5164.870878228075, 5187.610929180327, 5196.376434827845, 5201.479852014844, 2056.4550394145563, 2103.9579208415744, 2114.059243636567, 2181.182056728727, 2196.8242540597034, 937.7093101138669, 937.779621788879, 1027.984580231297, 1073.393532654048, 1110.3580256757848, 20048.39854804358, 20878.37364879056, 20955.0, 21123.7656057806, 21161.68257476139, 1029.7425643589104, 1039.9652345915863, 1044.1072882685346, 1076.4671487613525, 1086.809808283563, 10002.749931251778, 10987.39569323695, 11805.52777888892, 11965.341906195068, 12249.877501225052, 410164.0, 414570.0, 417151.0, 547075.0, 568260.0, 60414.39585604176, 76438.0, 77228.0, 94239.58640620396, 96947.0, 966.4974213409129, 1047.8061558611682, 1079.1528650009861, 1079.5681727308981, 1081.502508845924, 18481.630367392845, 18875.339363122224, 19018.52453688669, 19078.618427631092, 19445.0, 43130.218687872766, 44091.11817763691, 44094.0, 44293.55706442894, 44838.327425088, 58288.4171158283, 59367.0, 59465.0, 60119.39880601313, 60908.086378705244, 9124.45253284805, 9143.679971201242, 9154.816903661756, 9261.351705380559, 9336.253099752139, 6595.307492713196, 8173.550454724809, 12325.322107284186, 12615.558455454382, 12850.871491284968, 11648.242864213798, 11711.88288117142, 11876.76246475083, 12043.458044387848, 12303.630891073282, 11236.66290011301, 11334.60328888485, 11384.772304554028, 11892.702682433008, 12389.19470234468, 11513.53945842157, 11809.940950295537, 11951.581694640647, 12136.0, 12188.146829722189, 9153.862692059758, 9185.081491850762, 9238.95380523093, 9447.669331573363, 9547.796108353941, 9696.321257511907, 11919.463624137108, 12024.639260822189, 12136.817947730968, 12243.32661703615], "value": 9463.045909941962, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.680578675585, 1515.7347464193765, 1676.8993860368378, 1832.221305944973, 1851.1022154255184, 8911.68809091682, 9748.415095094299, 9751.756206094851, 9760.4631745254, 9765.609375624967, 8267.875981860278, 8541.35939804514, 8550.102239264881, 8804.8679269811, 9514.143727064562, 2490.10356271742, 2592.857392843393, 2593.1053786443645, 2599.4411201591656, 2599.454114635929, 2514.7736703696664, 2538.70804857441, 2547.223096955428, 2556.718760936305, 2573.4595734895693, 2473.5300292944285, 2477.702675678912, 2479.0331770609387, 2480.355107672, 2485.8508489490596, 2463.4457247119435, 2473.9010439582394, 2485.465624890648, 2485.5774518331928, 2487.4278915849454, 2439.5852705040184, 2485.801135909141, 2488.278399264211, 2488.601823708216, 2488.875556222182, 9374.437533747998, 9446.905530944672, 9547.522623868848, 9572.186364159055, 9574.47340396278, 5262.210668399733, 5411.621186516945, 5418.187271909206, 5427.6472029317965, 5431.293931788881, 3313.6520665330277, 3334.199792049915, 3468.601110872257, 3479.6868281854754, 3499.30013997199, 1184.4433116435348, 1186.5075993462704, 1187.5606025770435, 1195.1932445599186, 1211.7515909238673, 12725.809112863315, 12847.74304513914, 12904.80642790359, 12930.48278068876, 13050.216986980811, 4678.064387122589, 4852.296417019513, 4892.437369702458, 4916.328448327515, 5067.341245638044, 11227.607033753779, 11232.213745037769, 11239.044681202025, 11239.157063220291, 11242.94378528102, 5336.039512887717, 5369.19462080691, 5373.086575282211, 5392.083345831218, 5396.7571459283645, 4870.853874383774, 4941.357623508921, 4944.307796908436, 4947.777350019258, 4960.330355401975, 4165.2111879166805, 4166.479190101238, 4224.8732538023905, 4243.193793179286, 4264.786760662017, 1234.2841152131741, 1237.9319137447346, 1253.8808813162734, 1254.799232122856, 1270.5426046623393, 948.9098535639104, 1053.1627356251797, 1061.3419679798574, 1064.2284343850647, 1069.4599227390117, 6370.968145159244, 6539.640319782363, 6540.117084193668, 6656.833579160463, 6779.186497620219, 456.24491466622794, 465.51586350196095, 467.81053673262386, 472.2892047468538, 479.4438451396363, 4232.64022558086, 4513.848968513008, 4586.97706511472, 4616.8614941551805, 4620.953790462119, 11535.192536522363, 11787.115966302561, 11863.11026673003, 11889.108316876269, 11893.40532973348, 10749.032587067202, 11133.220674552704, 11138.3873886937, 11760.411979400995, 11862.644120676394, 8672.392932494791, 8870.334724895658, 8874.0, 8876.289896808239, 8886.86669699955, 6305.905855912099, 6567.343265673395, 6579.407853293226, 6616.2060552732055, 6721.361470660279, 10457.68626941193, 10769.892301076889, 10889.237753357505, 11017.0, 11080.224384293022, 11107.611233606785, 11121.777564448828, 11194.888051119384, 11211.775764484502, 11213.943930280297, 7628.732994345171, 7742.38060955111, 8120.0, 8255.215754503313, 8460.746177614681, 8884.244839188483, 9100.362974591715, 9112.681056163003, 9120.954395227982, 9165.450072995642, 8323.95838020806, 8410.621522031646, 8474.983002039795, 8501.064882863004, 8660.566971651519, 8096.757097286855, 8229.382796290422, 8237.135100814328, 8298.08721040673, 8340.541270230196, 7497.700091996478, 7511.549307041595, 7532.246775322424, 7539.396848252017, 7543.698252069856, 5379.273798037371, 5436.673799572039, 5452.863678408072, 5589.189567512769, 5594.524465420485, 5428.697112693004, 5565.387807341108, 5620.943790562042, 5644.153376993484, 5690.231818704588], "value": 4843.153323160401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7061882709111, 356.65582712682266, 365.50839121381733, 369.6451406649616, 370.0711214850724, 5511.586631002676, 5532.5573954083675, 5558.110702287635, 5563.415841336662, 5605.747741351639, 5187.896242075156, 5297.337832770903, 5342.477393942727, 5369.650972686773, 5544.253560128556, 4330.0, 4338.84814031509, 4339.071126989285, 4343.9565604344025, 4359.825606975733, 4342.609165175134, 4348.0, 4352.368906508555, 4366.148601022802, 4381.233284175272, 4142.316517774579, 4293.205756934962, 4298.914021719579, 4316.223079845627, 4336.761478118702, 4280.272353699847, 4285.164392943378, 4286.871393858158, 4296.37702533131, 4296.720713153651, 3799.3351163546545, 3808.6762625176893, 3818.7899665518385, 3828.272628200633, 3830.5211848518934, 5169.087437648094, 5312.6281160318795, 5369.543588794957, 5375.494861438803, 5396.19057141428, 4961.891196241583, 4964.751762411865, 4965.0, 4966.789778548511, 4973.5523802857915, 5770.8268751937085, 5779.572579516571, 5791.89953908756, 5795.246617939683, 5819.068948968187, 4129.669626429908, 4205.3481710334945, 4233.809478573472, 4238.152369526107, 4240.9151816963795, 6026.60827046245, 6038.396160383971, 6041.214642096499, 6043.1841701370195, 6052.546059045545, 4315.805788739452, 4321.114171594815, 4323.935140972888, 4326.480822301344, 4326.610605045498, 4284.700070995001, 4334.5882141196535, 4338.739675619473, 4362.236608593484, 4398.538153493901, 4929.556339929423, 4937.284093806378, 4944.802207911644, 4945.134601444733, 4952.034353301072, 5790.478856902899, 5810.704771615273, 5820.563457740686, 5833.162553795541, 5862.355140934494, 1424.2380326525467, 1450.485077797388, 1453.7165252775608, 1495.8429364916744, 1502.4966636177003, 1009.2985375164191, 1012.6303899076784, 1040.8230600797883, 1041.8801837788599, 1043.6451606453843, 5585.972070139624, 5595.412481689364, 5613.091548873403, 5619.241402410622, 5632.746526406321, 5871.943050250996, 5915.674637894871, 5918.638713096012, 5919.556033297434, 5934.287885453773, 5411.83764487066, 5493.176023596492, 5571.609987300931, 5610.607257491936, 5616.747246373841, 3104.7516198704047, 3110.5178697301953, 3118.3919135768306, 3136.3811217633074, 3138.3880143371825, 6094.263135006502, 6101.816945491642, 6102.755889764359, 6117.663528505886, 6127.356627554132, 5904.4095590441475, 6076.605020673642, 6087.847803804941, 6102.359252278447, 6102.847428814226, 6179.443850053517, 6180.412860778219, 6180.567360284737, 6184.845378865474, 6200.782972595937, 5744.942550574608, 5978.730957106854, 5997.250343707036, 6015.2781666200335, 6015.5488338373925, 5911.822645320647, 5947.256592925884, 5953.553483488669, 5972.5520585955355, 5983.461488466059, 5925.348211696796, 6147.231596050494, 6173.197484327009, 6177.880170513862, 6180.0, 4305.655547556125, 4336.457942757155, 4359.912801744011, 4370.584794444522, 4386.7367957922625, 6013.488853447331, 6021.939780602138, 6032.215811944419, 6032.577719559588, 6035.637861728134, 5592.930615672228, 5742.224799651994, 5748.511376533042, 5861.589688721749, 5882.676452795137, 5852.985712358054, 5860.472557469848, 5862.501687356623, 5879.970600146972, 5901.141140540716, 5691.373948865538, 5751.986804618517, 5791.82624521265, 5793.449622286044, 5819.301683797971, 5868.354481007171, 5880.558958078247, 5900.468957793819, 5906.202662640489, 5906.557008224315, 5583.553315734813, 5709.22925405065, 5739.598228123991, 5743.472871936335, 5771.394003629558], "value": 4451.794216886036, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.3478206569251, 779.7894568466514, 791.4064451661254, 857.5112186053948, 857.5155037403863, 15857.920710396445, 16249.350025998945, 16612.916935415335, 17185.742213866786, 17198.05410702411, 15494.69010619787, 15798.0, 15814.367425302975, 15833.762493562606, 15844.683106337867, 725.2964624314407, 743.9070116235471, 892.1881088209747, 898.0390981649638, 900.4192295969096, 861.5864385095158, 896.8520194167987, 898.1333013641867, 903.4804987132393, 904.1997831918734, 945.0219023310875, 948.2556193388192, 948.6347756113877, 949.9477528735916, 951.5242378810594, 757.7044952468542, 942.8161508505844, 944.6740874398322, 944.9291303152291, 945.1918609588806, 580.5181699189662, 655.0338251079667, 673.1518286958419, 673.71367168953, 678.389449495453, 15784.842151578452, 15787.605309867231, 15809.841901580952, 15825.52523424299, 15838.841611583966, 14745.852541474555, 15256.923715381352, 15367.538973830802, 15489.302981365865, 15545.22273886301, 14194.0, 14221.928890355586, 14263.928680356636, 14977.0, 15252.542423727306, 4634.119517291738, 4641.3270075839155, 4657.953420465786, 4694.906101877978, 4887.682300650482, 83662.58168709178, 84669.57665211696, 84854.0, 85065.57467212624, 85276.14723852806, 11969.581064662694, 12177.878221217852, 12258.0, 12304.200226985397, 12437.191582547106, 22586.0, 22616.208432704778, 22617.09531618717, 22669.43326416853, 22707.09171633149, 8853.38026338163, 8866.157715017063, 8903.510306933182, 8952.507612081397, 8954.194122529003, 4707.646926480527, 4822.614190864722, 4921.532454416824, 4992.176290911959, 5064.18972964324, 3569.1790888095884, 3689.612590677994, 3703.3519134151416, 3711.406175011985, 3714.4242642390473, 603.538293205698, 612.9601575897552, 617.521420898807, 618.5824568416391, 623.6943897490288, 676.070403195606, 708.6102643546029, 729.3071581997124, 731.7256028989129, 755.8601658693159, 9932.553035113437, 9962.452065136487, 10332.431716255527, 10722.356658600509, 10738.087262582612, 688.3735800421592, 715.3883429667663, 716.691822516323, 728.9599072050981, 734.2363941500779, 5062.544371006627, 5129.12804823181, 5444.5916556258435, 5696.686682232517, 5802.187693722883, 77091.61454192693, 82512.58743706363, 86480.97316593889, 137170.0, 138115.0, 75464.62267688627, 93146.53426732823, 115836.42081789537, 116605.41697291628, 118132.0, 63819.04271435932, 66758.33241667521, 97413.02586974182, 98647.0, 101029.49485252527, 10356.653635027398, 10796.077944644408, 10860.511276992713, 11023.669289921316, 11314.94342528315, 58601.4139858613, 59121.70439147777, 59808.401915980285, 60322.698386507785, 60794.69602651958, 79641.01794910347, 84211.0, 88168.0, 88214.55892720495, 91419.54290228506, 14366.425342986582, 14792.63018424505, 14878.553643390716, 14953.177575233467, 15177.392904283704, 14924.850751492346, 15299.694006119593, 15427.228638568251, 15829.0, 16378.508644740677, 15134.621634459227, 15175.468858589897, 15860.286287116876, 16174.919125404298, 16341.428050018192, 14403.0, 14665.26673666291, 14972.251387430802, 15091.0, 15092.245387730789, 14375.137491750529, 14376.353064112349, 14830.184339861411, 14921.477748278758, 15849.841501584837, 12076.577319793765, 13093.345332733516, 13210.537631182862, 13404.0, 13405.329733513481, 12513.749725005631, 13052.738945220852, 13342.399592018577, 13437.865621344052, 13499.527516536875], "value": 8174.774686902549, "unit": "score"}], "name": "dromaeo_css", "value": 7623.769491636741, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 112.0, 111.0, 112.0, 113.0, 112.0, 111.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 118.0, 115.0, 157.0, 121.0, 121.0, 117.0, 115.0, 145.0, 117.0], "value": 126.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 159.0, 160.0, 160.0, 159.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 114.0, 76.0, 76.0, 75.0, 76.0, 107.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 130.0, 81.0, 82.0, 82.0, 101.0, 82.0, 82.0, 109.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 51.0, 49.0, 50.0, 50.0, 50.0, 49.0, 50.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 63.0, 58.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 80.0, 73.0, 73.0, 81.0, 73.0, 74.0, 77.0, 74.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 118.0, 134.0, 118.0, 116.0, 119.0, 116.0, 123.0, 155.0, 127.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 151.0, 150.0, 155.0, 153.0, 154.0, 152.0, 151.0, 151.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 61.0, 61.0, 61.0, 63.0, 66.0, 61.0, 61.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1454.6, "alertThreshold": 2.0}]} 22:40:38 INFO - Return code: 0 22:40:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:40:38 INFO - # TBPL SUCCESS # 22:40:38 INFO - Running post-action listener: _resource_record_post_action 22:40:38 INFO - [mozharness: 2016-10-04 05:40:38.677696Z] Finished run-tests step (success) 22:40:38 INFO - Running post-run listener: _resource_record_post_run 22:40:38 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 365871104; Read time: 24; Write time: 312396 22:40:38 INFO - TinderboxPrint: CPU usage
12.9% 22:40:38 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 22:40:38 INFO - TinderboxPrint: I/O write bytes / time
365,871,104 / 312,396 22:40:38 INFO - TinderboxPrint: CPU idle
8,277.6 (87.1%) 22:40:38 INFO - TinderboxPrint: CPU user
1,182.4 (12.4%) 22:40:38 INFO - TinderboxPrint: Swap in / out
0 / 0 22:40:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119123968; Read time: 0; Write time: 94320 22:40:38 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246747136; Read time: 20; Write time: 218076 22:40:39 INFO - Running post-run listener: _upload_blobber_files 22:40:39 INFO - Blob upload gear active. 22:40:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:40:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:40:39 INFO - (blobuploader) - INFO - Open directory for files ... 22:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:40 INFO - (blobuploader) - INFO - Done attempting. 22:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:40:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:43 INFO - (blobuploader) - INFO - Done attempting. 22:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:44 INFO - (blobuploader) - INFO - Done attempting. 22:40:44 INFO - (blobuploader) - INFO - Iteration through files over. 22:40:44 INFO - Return code: 0 22:40:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:40:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:40:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9894a2bc09d921ed34f85fb3cd94e70e7455204237a0bf9d9476720daf5ea4b1360783084f98edb3b2ddffee0c188f8ae7a68e8a38e3bcc0f48353522d23142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f40f7d9c1ecad3e99de13418a392eb15ba808beb488dfc2e92593a9b7df4695d39035efa285cd92aebfbbdaafa334270d7cd7a1b83143d26f3ffa075615b79b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f5d0cf4e4f96b2cff1dd872db9cc78eefd047658c70ca5fdbd6b861831f12a2e32be54ecf91887c4bdf254529b138b164bc23b8b05a5c1499178e3bf7feef68"} 22:40:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:40:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:40:44 INFO - Contents: 22:40:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9894a2bc09d921ed34f85fb3cd94e70e7455204237a0bf9d9476720daf5ea4b1360783084f98edb3b2ddffee0c188f8ae7a68e8a38e3bcc0f48353522d23142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f40f7d9c1ecad3e99de13418a392eb15ba808beb488dfc2e92593a9b7df4695d39035efa285cd92aebfbbdaafa334270d7cd7a1b83143d26f3ffa075615b79b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f5d0cf4e4f96b2cff1dd872db9cc78eefd047658c70ca5fdbd6b861831f12a2e32be54ecf91887c4bdf254529b138b164bc23b8b05a5c1499178e3bf7feef68"} 22:40:44 INFO - Running post-run listener: copy_logs_to_upload_dir 22:40:44 INFO - Copying logs to upload dir... 22:40:44 INFO - mkdir: /builds/slave/test/build/upload/logs 22:40:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.586111 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-03 22:40:43.856382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 22:40:43.861131) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483 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-Aurora/sha512/a9894a2bc09d921ed34f85fb3cd94e70e7455204237a0bf9d9476720daf5ea4b1360783084f98edb3b2ddffee0c188f8ae7a68e8a38e3bcc0f48353522d23142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f40f7d9c1ecad3e99de13418a392eb15ba808beb488dfc2e92593a9b7df4695d39035efa285cd92aebfbbdaafa334270d7cd7a1b83143d26f3ffa075615b79b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f5d0cf4e4f96b2cff1dd872db9cc78eefd047658c70ca5fdbd6b861831f12a2e32be54ecf91887c4bdf254529b138b164bc23b8b05a5c1499178e3bf7feef68"} build_url:https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/V-hAjVs5RoyHR1elKsAXrg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9894a2bc09d921ed34f85fb3cd94e70e7455204237a0bf9d9476720daf5ea4b1360783084f98edb3b2ddffee0c188f8ae7a68e8a38e3bcc0f48353522d23142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f40f7d9c1ecad3e99de13418a392eb15ba808beb488dfc2e92593a9b7df4695d39035efa285cd92aebfbbdaafa334270d7cd7a1b83143d26f3ffa075615b79b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f5d0cf4e4f96b2cff1dd872db9cc78eefd047658c70ca5fdbd6b861831f12a2e32be54ecf91887c4bdf254529b138b164bc23b8b05a5c1499178e3bf7feef68"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 22:40:43.890535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:40:43.891101) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475556047.839531-650656483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:40:43.970637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 22:40:43.974029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 22:40:43.974353) ========= ========= Total master_lag: 0.19 =========