builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1472610172.46 results: success (0) buildid: 20160830163004 builduid: 70ff2a3933f34cb0923d417a88f73445 revision: 41d8277af19246308bdf51bf0cd60da3498681b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:52.464220) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:52.464665) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:52.464944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:52.479352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:52.479610) ========= 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=db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 19:22:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.8K=0.2s 2016-08-30 19:22:52 (65.8 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.291607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:52.784996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:52.785332) ========= 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=db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019138 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:52.834724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:52.835094) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 41d8277af19246308bdf51bf0cd60da3498681b1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 41d8277af19246308bdf51bf0cd60da3498681b1 --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=db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 19:22:52,969 truncating revision to first 12 chars 2016-08-30 19:22:52,969 Setting DEBUG logging. 2016-08-30 19:22:52,969 attempt 1/10 2016-08-30 19:22:52,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/41d8277af192?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 19:22:53,229 unpacking tar archive at: mozilla-inbound-41d8277af192/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:53.393152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:53.393458) ========= script_repo_revision: 41d8277af19246308bdf51bf0cd60da3498681b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:53.393838) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:53.394134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 19:22:53.402126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-30 19:22:53.402392) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:22:53 INFO - MultiFileLogger online at 20160830 19:22:53 in /builds/slave/test 19:22:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:22:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:22:53 INFO - {'append_to_log': False, 19:22:53 INFO - 'base_work_dir': '/builds/slave/test', 19:22:53 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:22:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:22:53 INFO - 'branch': 'Mozilla-Inbound', 19:22:53 INFO - 'buildbot_json_path': 'buildprops.json', 19:22:53 INFO - 'config_files': ('talos/linux_config.py',), 19:22:53 INFO - 'default_actions': ('clobber', 19:22:53 INFO - 'read-buildbot-config', 19:22:53 INFO - 'download-and-extract', 19:22:53 INFO - 'populate-webroot', 19:22:53 INFO - 'create-virtualenv', 19:22:53 INFO - 'install', 19:22:53 INFO - 'run-tests'), 19:22:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:22:53 INFO - 'download_minidump_stackwalk': True, 19:22:53 INFO - 'download_symbols': 'ondemand', 19:22:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:22:53 INFO - 'tooltool.py': '/tools/tooltool.py', 19:22:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:22:53 INFO - '/tools/misc-python/virtualenv.py')}, 19:22:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:22:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:22:53 INFO - 'installer_path': 'installer.exe', 19:22:53 INFO - 'log_level': 'info', 19:22:53 INFO - 'log_name': 'talos', 19:22:53 INFO - 'log_to_console': True, 19:22:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:22:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:22:53 INFO - 'opt_config_files': (), 19:22:53 INFO - 'pip_index': False, 19:22:53 INFO - 'sps_profile': False, 19:22:53 INFO - 'sps_profile_interval': 0, 19:22:53 INFO - 'suite': 'dromaeojs', 19:22:53 INFO - 'system_bits': '32', 19:22:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:22:53 INFO - 'title': 'talos-linux64-ix-031', 19:22:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:22:53 INFO - 'use_talos_json': True, 19:22:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:22:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:22:53 INFO - 'work_dir': 'build'} 19:22:53 INFO - [mozharness: 2016-08-31 02:22:53.630982Z] Running clobber step. 19:22:53 INFO - Running pre-action listener: _resource_record_pre_action 19:22:53 INFO - Running main action method: clobber 19:22:53 INFO - rmtree: /builds/slave/test/build 19:22:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:22:54 INFO - Running post-action listener: _resource_record_post_action 19:22:54 INFO - [mozharness: 2016-08-31 02:22:54.127309Z] Finished clobber step (success) 19:22:54 INFO - [mozharness: 2016-08-31 02:22:54.127411Z] Running read-buildbot-config step. 19:22:54 INFO - Running pre-action listener: _resource_record_pre_action 19:22:54 INFO - Running main action method: read_buildbot_config 19:22:54 INFO - Using buildbot properties: 19:22:54 INFO - { 19:22:54 INFO - "project": "", 19:22:54 INFO - "product": "firefox", 19:22:54 INFO - "script_repo_revision": "production", 19:22:54 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:22:54 INFO - "repository": "", 19:22:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:22:54 INFO - "buildid": "20160830163004", 19:22:54 INFO - "pgo_build": "True", 19:22:54 INFO - "basedir": "/builds/slave/test", 19:22:54 INFO - "buildnumber": 1625, 19:22:54 INFO - "slavename": "talos-linux64-ix-031", 19:22:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:22:54 INFO - "platform": "ubuntu64_hw", 19:22:54 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:22:54 INFO - "branch": "mozilla-inbound", 19:22:54 INFO - "repo_path": "integration/mozilla-inbound", 19:22:54 INFO - "revision": "41d8277af19246308bdf51bf0cd60da3498681b1", 19:22:54 INFO - "stage_platform": "linux64-pgo", 19:22:54 INFO - "builduid": "70ff2a3933f34cb0923d417a88f73445", 19:22:54 INFO - "slavebuilddir": "test" 19:22:54 INFO - } 19:22:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:22:54 INFO - Running post-action listener: _resource_record_post_action 19:22:54 INFO - [mozharness: 2016-08-31 02:22:54.129980Z] Finished read-buildbot-config step (success) 19:22:54 INFO - [mozharness: 2016-08-31 02:22:54.130071Z] Running download-and-extract step. 19:22:54 INFO - Running pre-action listener: _resource_record_pre_action 19:22:54 INFO - Running main action method: download_and_extract 19:22:54 INFO - mkdir: /builds/slave/test/build/tests 19:22:54 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')]} 19:22:54 INFO - trying https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:22:54 INFO - Downloading https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:22:54 INFO - Downloaded 1361 bytes. 19:22:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:22:54 INFO - Using the following test package requirements: 19:22:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:22:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:22:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:22:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:54 INFO - u'jsshell-linux-x86_64.zip'], 19:22:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:22:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:22:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:22:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:22:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:22:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:22:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:22:54 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')]} 19:22:54 INFO - trying https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:22:54 INFO - Downloading https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:22:55 INFO - Downloaded 21901238 bytes. 19:22:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 19:22:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:22:59 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')]} 19:22:59 INFO - trying https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:22:59 INFO - Downloading https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:23:00 INFO - Downloaded 21901238 bytes. 19:23:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 19:23:05 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')]} 19:23:05 INFO - trying https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:23:05 INFO - Downloading https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:23:06 INFO - Downloaded 14413998 bytes. 19:23:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 19:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:06 INFO - trying https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:23:06 INFO - Downloading https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:23:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:23:07 INFO - Downloaded 59731014 bytes. 19:23:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:23:07 INFO - mkdir: /builds/slave/test/properties 19:23:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:23:07 INFO - Writing to file /builds/slave/test/properties/build_url 19:23:07 INFO - Contents: 19:23:07 INFO - build_url:https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:23:08 INFO - Running post-action listener: _resource_record_post_action 19:23:08 INFO - Running post-action listener: set_extra_try_arguments 19:23:08 INFO - [mozharness: 2016-08-31 02:23:08.120332Z] Finished download-and-extract step (success) 19:23:08 INFO - [mozharness: 2016-08-31 02:23:08.120559Z] Running populate-webroot step. 19:23:08 INFO - Running pre-action listener: _resource_record_pre_action 19:23:08 INFO - Running main action method: populate_webroot 19:23:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:23:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:23:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:23:08 INFO - '--tppagecycles', 19:23:08 INFO - '7'], 19:23:08 INFO - 'tests': ['tsvgm']}}, 19:23:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:23:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:23:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:23:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:23:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:08 INFO - 'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:08 INFO - 'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['damp', 'tps']}, 19:23:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:08 INFO - 'tests': ['damp', 'tps']}, 19:23:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['dromaeo_dom']}, 19:23:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:23:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['basic_compositor_video']}, 19:23:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:23:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['a11yr', 19:23:08 INFO - 'ts_paint', 19:23:08 INFO - 'tpaint', 19:23:08 INFO - 'sessionrestore', 19:23:08 INFO - 'sessionrestore_no_auto_restore', 19:23:08 INFO - 'tabpaint']}, 19:23:08 INFO - 'other-e10s': {'tests': ['a11yr', 19:23:08 INFO - 'ts_paint', 19:23:08 INFO - 'tpaint', 19:23:08 INFO - 'sessionrestore', 19:23:08 INFO - 'sessionrestore_no_auto_restore', 19:23:08 INFO - 'tabpaint']}, 19:23:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:23:08 INFO - 'ts_paint', 19:23:08 INFO - 'tpaint', 19:23:08 INFO - 'sessionrestore', 19:23:08 INFO - 'sessionrestore_no_auto_restore', 19:23:08 INFO - 'tabpaint']}, 19:23:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:23:08 INFO - 'ts_paint', 19:23:08 INFO - 'tpaint', 19:23:08 INFO - 'sessionrestore', 19:23:08 INFO - 'sessionrestore_no_auto_restore', 19:23:08 INFO - 'tabpaint']}, 19:23:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['a11yr', 19:23:08 INFO - 'ts_paint', 19:23:08 INFO - 'tpaint', 19:23:08 INFO - 'sessionrestore', 19:23:08 INFO - 'sessionrestore_no_auto_restore', 19:23:08 INFO - 'tabpaint']}, 19:23:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['a11yr', 19:23:08 INFO - 'ts_paint', 19:23:08 INFO - 'tpaint', 19:23:08 INFO - 'sessionrestore', 19:23:08 INFO - 'sessionrestore_no_auto_restore', 19:23:08 INFO - 'tabpaint']}, 19:23:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['tsvgx', 19:23:08 INFO - 'tsvgr_opacity', 19:23:08 INFO - 'tart', 19:23:08 INFO - 'tscrollx', 19:23:08 INFO - 'cart']}, 19:23:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:23:08 INFO - 'tsvgr_opacity', 19:23:08 INFO - 'tart', 19:23:08 INFO - 'tscrollx', 19:23:08 INFO - 'cart']}, 19:23:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:08 INFO - 'talos_options': ['--disable-e10s'], 19:23:08 INFO - 'tests': ['tp5o']}, 19:23:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:08 INFO - 'tests': ['tp5o']}, 19:23:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:08 INFO - 'talos_options': ['--disable-e10s', 19:23:08 INFO - '--xperf_path', 19:23:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:08 INFO - 'tests': ['tp5n']}, 19:23:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:08 INFO - 'talos_options': ['--xperf_path', 19:23:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:08 INFO - 'tests': ['tp5n']}}, 19:23:08 INFO - 'talos.zip': {'path': '', 19:23:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:23:08 INFO - Running post-action listener: _resource_record_post_action 19:23:08 INFO - [mozharness: 2016-08-31 02:23:08.137085Z] Finished populate-webroot step (success) 19:23:08 INFO - [mozharness: 2016-08-31 02:23:08.137175Z] Running create-virtualenv step. 19:23:08 INFO - Running pre-action listener: _resource_record_pre_action 19:23:08 INFO - Running main action method: create_virtualenv 19:23:08 INFO - Creating virtualenv /builds/slave/test/build/venv 19:23:08 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 19:23:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:23:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:23:08 INFO - Using real prefix '/usr' 19:23:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:23:08 INFO - Installing distribute.............................................................................................................................................................................................done. 19:23:10 INFO - Installing pip.................done. 19:23:10 INFO - Return code: 0 19:23:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:23: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')]} 19:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:23:10 INFO - Using env: {'DISPLAY': ':0', 19:23:10 INFO - 'HOME': '/home/cltbld', 19:23:10 INFO - 'LANG': 'en_US.UTF-8', 19:23:10 INFO - 'LANGUAGE': 'en_US:en', 19:23:10 INFO - 'LOGNAME': 'cltbld', 19:23:10 INFO - 'MAIL': '/var/mail/cltbld', 19:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:10 INFO - 'MOZ_NO_REMOTE': '1', 19:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:10 INFO - 'NO_EM_RESTART': '1', 19:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:10 INFO - 'PWD': '/builds/slave/test', 19:23:10 INFO - 'SHELL': '/bin/bash', 19:23:10 INFO - 'SHLVL': '1', 19:23:10 INFO - 'TERM': 'linux', 19:23:10 INFO - 'TMOUT': '86400', 19:23:10 INFO - 'USER': 'cltbld', 19:23:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:10 INFO - '_': '/tools/buildbot/bin/python'} 19:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:23:10 INFO - Cleaning up... 19:23:10 INFO - Return code: 0 19:23:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:23: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')]} 19:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:23:10 INFO - Using env: {'DISPLAY': ':0', 19:23:10 INFO - 'HOME': '/home/cltbld', 19:23:10 INFO - 'LANG': 'en_US.UTF-8', 19:23:10 INFO - 'LANGUAGE': 'en_US:en', 19:23:10 INFO - 'LOGNAME': 'cltbld', 19:23:10 INFO - 'MAIL': '/var/mail/cltbld', 19:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:10 INFO - 'MOZ_NO_REMOTE': '1', 19:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:10 INFO - 'NO_EM_RESTART': '1', 19:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:10 INFO - 'PWD': '/builds/slave/test', 19:23:10 INFO - 'SHELL': '/bin/bash', 19:23:10 INFO - 'SHLVL': '1', 19:23:10 INFO - 'TERM': 'linux', 19:23:10 INFO - 'TMOUT': '86400', 19:23:10 INFO - 'USER': 'cltbld', 19:23:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:10 INFO - '_': '/tools/buildbot/bin/python'} 19:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:11 INFO - Downloading/unpacking psutil>=3.1.1 19:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:23:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:13 INFO - Installing collected packages: psutil 19:23:13 INFO - Running setup.py install for psutil 19:23:13 INFO - building 'psutil._psutil_linux' extension 19:23:13 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 19:23:13 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 19:23:13 INFO - building 'psutil._psutil_posix' extension 19:23:13 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 19:23:13 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 19:23:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:13 INFO - Successfully installed psutil 19:23:13 INFO - Cleaning up... 19:23:13 INFO - Return code: 0 19:23:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:23:13 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')]} 19:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:13 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')]} 19:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:13 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 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:13 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 19:23:13 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 19:23:13 INFO - Using env: {'DISPLAY': ':0', 19:23:13 INFO - 'HOME': '/home/cltbld', 19:23:13 INFO - 'LANG': 'en_US.UTF-8', 19:23:13 INFO - 'LANGUAGE': 'en_US:en', 19:23:13 INFO - 'LOGNAME': 'cltbld', 19:23:13 INFO - 'MAIL': '/var/mail/cltbld', 19:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:13 INFO - 'MOZ_NO_REMOTE': '1', 19:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:13 INFO - 'NO_EM_RESTART': '1', 19:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:13 INFO - 'PWD': '/builds/slave/test', 19:23:13 INFO - 'SHELL': '/bin/bash', 19:23:13 INFO - 'SHLVL': '1', 19:23:13 INFO - 'TERM': 'linux', 19:23:13 INFO - 'TMOUT': '86400', 19:23:13 INFO - 'USER': 'cltbld', 19:23:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:13 INFO - '_': '/tools/buildbot/bin/python'} 19:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:23:13 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 19:23:13 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 19:23:13 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 19:23:13 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 19:23:13 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 19:23:13 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 19:23:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:23:15 INFO - Installing collected packages: mozsystemmonitor 19:23:15 INFO - Running setup.py install for mozsystemmonitor 19:23:15 INFO - Successfully installed mozsystemmonitor 19:23:15 INFO - Cleaning up... 19:23:16 INFO - Return code: 0 19:23:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:23:16 INFO - Using env: {'DISPLAY': ':0', 19:23:16 INFO - 'HOME': '/home/cltbld', 19:23:16 INFO - 'LANG': 'en_US.UTF-8', 19:23:16 INFO - 'LANGUAGE': 'en_US:en', 19:23:16 INFO - 'LOGNAME': 'cltbld', 19:23:16 INFO - 'MAIL': '/var/mail/cltbld', 19:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:16 INFO - 'MOZ_NO_REMOTE': '1', 19:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:16 INFO - 'NO_EM_RESTART': '1', 19:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:16 INFO - 'PWD': '/builds/slave/test', 19:23:16 INFO - 'SHELL': '/bin/bash', 19:23:16 INFO - 'SHLVL': '1', 19:23:16 INFO - 'TERM': 'linux', 19:23:16 INFO - 'TMOUT': '86400', 19:23:16 INFO - 'USER': 'cltbld', 19:23:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:16 INFO - '_': '/tools/buildbot/bin/python'} 19:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:16 INFO - Downloading/unpacking jsonschema==2.5.1 19:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:23:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:23:18 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 19:23:18 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 19:23:18 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 19:23:18 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 19:23:18 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 19:23:18 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 19:23:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:23:18 INFO - warning: no files found matching '*.txt' 19:23:18 INFO - no previously-included directories found matching 'build' 19:23:18 INFO - no previously-included directories found matching 'dist' 19:23:18 INFO - no previously-included directories found matching '.git*' 19:23:18 INFO - Installing collected packages: jsonschema, functools32 19:23:18 INFO - Running setup.py install for functools32 19:23:18 INFO - warning: no files found matching '*.txt' 19:23:18 INFO - no previously-included directories found matching 'build' 19:23:18 INFO - no previously-included directories found matching 'dist' 19:23:18 INFO - no previously-included directories found matching '.git*' 19:23:18 INFO - Successfully installed jsonschema functools32 19:23:18 INFO - Cleaning up... 19:23:18 INFO - Return code: 0 19:23:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:23:18 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')]} 19:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:18 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')]} 19:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:18 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 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:18 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 19:23:18 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 19:23:18 INFO - Using env: {'DISPLAY': ':0', 19:23:18 INFO - 'HOME': '/home/cltbld', 19:23:18 INFO - 'LANG': 'en_US.UTF-8', 19:23:18 INFO - 'LANGUAGE': 'en_US:en', 19:23:18 INFO - 'LOGNAME': 'cltbld', 19:23:18 INFO - 'MAIL': '/var/mail/cltbld', 19:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:18 INFO - 'MOZ_NO_REMOTE': '1', 19:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:18 INFO - 'NO_EM_RESTART': '1', 19:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:18 INFO - 'PWD': '/builds/slave/test', 19:23:18 INFO - 'SHELL': '/bin/bash', 19:23:18 INFO - 'SHLVL': '1', 19:23:18 INFO - 'TERM': 'linux', 19:23:18 INFO - 'TMOUT': '86400', 19:23:18 INFO - 'USER': 'cltbld', 19:23:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:18 INFO - '_': '/tools/buildbot/bin/python'} 19:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:23:18 INFO - Cleaning up... 19:23:18 INFO - Return code: 0 19:23:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:23:18 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')]} 19:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:18 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')]} 19:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:18 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 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:18 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 19:23:18 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 19:23:18 INFO - Using env: {'DISPLAY': ':0', 19:23:18 INFO - 'HOME': '/home/cltbld', 19:23:18 INFO - 'LANG': 'en_US.UTF-8', 19:23:18 INFO - 'LANGUAGE': 'en_US:en', 19:23:18 INFO - 'LOGNAME': 'cltbld', 19:23:18 INFO - 'MAIL': '/var/mail/cltbld', 19:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:18 INFO - 'MOZ_NO_REMOTE': '1', 19:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:18 INFO - 'NO_EM_RESTART': '1', 19:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:18 INFO - 'PWD': '/builds/slave/test', 19:23:18 INFO - 'SHELL': '/bin/bash', 19:23:18 INFO - 'SHLVL': '1', 19:23:18 INFO - 'TERM': 'linux', 19:23:18 INFO - 'TMOUT': '86400', 19:23:18 INFO - 'USER': 'cltbld', 19:23:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:18 INFO - '_': '/tools/buildbot/bin/python'} 19:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:18 INFO - Downloading/unpacking blobuploader==1.2.4 19:23:18 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 19:23:18 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 19:23:18 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 19:23:18 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 19:23:18 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 19:23:18 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 19:23:20 INFO - Downloading blobuploader-1.2.4.tar.gz 19:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:23:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:23:20 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 19:23:20 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 19:23:20 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 19:23:20 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 19:23:20 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 19:23:20 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 19:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:23:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:23:21 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 19:23:21 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 19:23:21 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 19:23:21 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 19:23:21 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 19:23:21 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 19:23:21 INFO - Downloading docopt-0.6.1.tar.gz 19:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:23:21 INFO - Installing collected packages: blobuploader, requests, docopt 19:23:21 INFO - Running setup.py install for blobuploader 19:23:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:23:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:23:21 INFO - Running setup.py install for requests 19:23:22 INFO - Running setup.py install for docopt 19:23:22 INFO - Successfully installed blobuploader requests docopt 19:23:22 INFO - Cleaning up... 19:23:22 INFO - Return code: 0 19:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:22 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 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:22 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 19:23:22 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 19:23:22 INFO - Using env: {'DISPLAY': ':0', 19:23:22 INFO - 'HOME': '/home/cltbld', 19:23:22 INFO - 'LANG': 'en_US.UTF-8', 19:23:22 INFO - 'LANGUAGE': 'en_US:en', 19:23:22 INFO - 'LOGNAME': 'cltbld', 19:23:22 INFO - 'MAIL': '/var/mail/cltbld', 19:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:22 INFO - 'MOZ_NO_REMOTE': '1', 19:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:22 INFO - 'NO_EM_RESTART': '1', 19:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:22 INFO - 'PWD': '/builds/slave/test', 19:23:22 INFO - 'SHELL': '/bin/bash', 19:23:22 INFO - 'SHLVL': '1', 19:23:22 INFO - 'TERM': 'linux', 19:23:22 INFO - 'TMOUT': '86400', 19:23:22 INFO - 'USER': 'cltbld', 19:23:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:22 INFO - '_': '/tools/buildbot/bin/python'} 19:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:22 INFO - Running setup.py (path:/tmp/pip-tskFTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:22 INFO - Running setup.py (path:/tmp/pip-o2cNfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:22 INFO - Running setup.py (path:/tmp/pip-_RuXj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:22 INFO - Running setup.py (path:/tmp/pip-3URNKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:22 INFO - Running setup.py (path:/tmp/pip-j_5Sne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:22 INFO - Running setup.py (path:/tmp/pip-PhWCZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:22 INFO - Running setup.py (path:/tmp/pip-Icvkrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:22 INFO - Running setup.py (path:/tmp/pip-KtI7Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:23 INFO - Running setup.py (path:/tmp/pip-gsdiO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:23 INFO - Running setup.py (path:/tmp/pip-FrHDui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:23 INFO - Running setup.py (path:/tmp/pip-5B6jKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:23 INFO - Running setup.py (path:/tmp/pip-QbiJjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:23 INFO - Running setup.py (path:/tmp/pip-ijfu7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:23 INFO - Running setup.py (path:/tmp/pip-SEmVW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:23 INFO - Running setup.py (path:/tmp/pip-TP4JYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:23 INFO - Running setup.py (path:/tmp/pip-fDwlBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:23 INFO - Running setup.py (path:/tmp/pip-5asys1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:23:23 INFO - Running setup.py install for manifestparser 19:23:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:23:23 INFO - Running setup.py install for mozcrash 19:23:23 INFO - Running setup.py install for mozdebug 19:23:23 INFO - Running setup.py install for mozdevice 19:23:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Running setup.py install for mozfile 19:23:24 INFO - Running setup.py install for mozhttpd 19:23:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Running setup.py install for mozinfo 19:23:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Running setup.py install for mozInstall 19:23:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Running setup.py install for mozleak 19:23:24 INFO - Running setup.py install for mozlog 19:23:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Running setup.py install for moznetwork 19:23:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Running setup.py install for mozprocess 19:23:24 INFO - Running setup.py install for mozprofile 19:23:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:23:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:23:25 INFO - Running setup.py install for mozrunner 19:23:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:23:25 INFO - Running setup.py install for mozscreenshot 19:23:25 INFO - Running setup.py install for moztest 19:23:25 INFO - Running setup.py install for mozversion 19:23:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:23:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:23:25 INFO - Cleaning up... 19:23:25 INFO - Return code: 0 19:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:25 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')]} 19:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:25 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')]} 19:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:25 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 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:25 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 19:23:25 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 19:23:25 INFO - Using env: {'DISPLAY': ':0', 19:23:25 INFO - 'HOME': '/home/cltbld', 19:23:25 INFO - 'LANG': 'en_US.UTF-8', 19:23:25 INFO - 'LANGUAGE': 'en_US:en', 19:23:25 INFO - 'LOGNAME': 'cltbld', 19:23:25 INFO - 'MAIL': '/var/mail/cltbld', 19:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:25 INFO - 'MOZ_NO_REMOTE': '1', 19:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:25 INFO - 'NO_EM_RESTART': '1', 19:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:25 INFO - 'PWD': '/builds/slave/test', 19:23:25 INFO - 'SHELL': '/bin/bash', 19:23:25 INFO - 'SHLVL': '1', 19:23:25 INFO - 'TERM': 'linux', 19:23:25 INFO - 'TMOUT': '86400', 19:23:25 INFO - 'USER': 'cltbld', 19:23:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:25 INFO - '_': '/tools/buildbot/bin/python'} 19:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:25 INFO - Running setup.py (path:/tmp/pip-RAMrTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:25 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)) 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:25 INFO - Running setup.py (path:/tmp/pip-AwbPqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:25 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)) 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:25 INFO - Running setup.py (path:/tmp/pip-sfARIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:25 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)) 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:25 INFO - Running setup.py (path:/tmp/pip-BSKsme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:25 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)) 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:25 INFO - Running setup.py (path:/tmp/pip-li3qWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:26 INFO - Running setup.py (path:/tmp/pip-2RimTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:26 INFO - Running setup.py (path:/tmp/pip-CHG3N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:26 INFO - Running setup.py (path:/tmp/pip-fNqjTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:26 INFO - Running setup.py (path:/tmp/pip-edw_np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:26 INFO - Running setup.py (path:/tmp/pip-RPN26W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:26 INFO - Running setup.py (path:/tmp/pip-KIZ83m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:26 INFO - Running setup.py (path:/tmp/pip-XJ6qAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:26 INFO - Running setup.py (path:/tmp/pip-jqmfSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:26 INFO - Running setup.py (path:/tmp/pip-N1M1aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:26 INFO - Running setup.py (path:/tmp/pip-VpqANo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:26 INFO - Running setup.py (path:/tmp/pip-GICwye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:26 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)) 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:26 INFO - Running setup.py (path:/tmp/pip-_TzeDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:26 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)) 19:23:26 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)) 19:23:26 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)) 19:23:26 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)) 19:23:26 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)) 19:23:26 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)) 19:23:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:28 INFO - Downloading blessings-1.6.tar.gz 19:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:23:28 INFO - Installing collected packages: blessings 19:23:28 INFO - Running setup.py install for blessings 19:23:28 INFO - Successfully installed blessings 19:23:28 INFO - Cleaning up... 19:23:29 INFO - Return code: 0 19:23:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:29 INFO - Reading from file tmpfile_stdout 19:23:29 INFO - Current package versions: 19:23:29 INFO - argparse == 1.2.1 19:23:29 INFO - blessings == 1.6 19:23:29 INFO - blobuploader == 1.2.4 19:23:29 INFO - docopt == 0.6.1 19:23:29 INFO - functools32 == 3.2.3-2 19:23:29 INFO - jsonschema == 2.5.1 19:23:29 INFO - manifestparser == 1.1 19:23:29 INFO - mozInstall == 1.12 19:23:29 INFO - mozcrash == 0.17 19:23:29 INFO - mozdebug == 0.1 19:23:29 INFO - mozdevice == 0.48 19:23:29 INFO - mozfile == 1.2 19:23:29 INFO - mozhttpd == 0.7 19:23:29 INFO - mozinfo == 0.9 19:23:29 INFO - mozleak == 0.1 19:23:29 INFO - mozlog == 3.3 19:23:29 INFO - moznetwork == 0.27 19:23:29 INFO - mozprocess == 0.23 19:23:29 INFO - mozprofile == 0.28 19:23:29 INFO - mozrunner == 6.12 19:23:29 INFO - mozscreenshot == 0.1 19:23:29 INFO - mozsystemmonitor == 0.3 19:23:29 INFO - moztest == 0.7 19:23:29 INFO - mozversion == 1.4 19:23:29 INFO - psutil == 3.1.1 19:23:29 INFO - requests == 1.2.3 19:23:29 INFO - wsgiref == 0.1.2 19:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:29 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 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:29 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 19:23:29 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 19:23:29 INFO - Using env: {'DISPLAY': ':0', 19:23:29 INFO - 'HOME': '/home/cltbld', 19:23:29 INFO - 'LANG': 'en_US.UTF-8', 19:23:29 INFO - 'LANGUAGE': 'en_US:en', 19:23:29 INFO - 'LOGNAME': 'cltbld', 19:23:29 INFO - 'MAIL': '/var/mail/cltbld', 19:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:29 INFO - 'MOZ_NO_REMOTE': '1', 19:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:29 INFO - 'NO_EM_RESTART': '1', 19:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:29 INFO - 'PWD': '/builds/slave/test', 19:23:29 INFO - 'SHELL': '/bin/bash', 19:23:29 INFO - 'SHLVL': '1', 19:23:29 INFO - 'TERM': 'linux', 19:23:29 INFO - 'TMOUT': '86400', 19:23:29 INFO - 'USER': 'cltbld', 19:23:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:29 INFO - '_': '/tools/buildbot/bin/python'} 19:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:29 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)) 19:23:29 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)) 19:23:29 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)) 19:23:29 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)) 19:23:29 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)) 19:23:29 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)) 19:23:29 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)) 19:23:29 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)) 19:23:29 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)) 19:23:29 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)) 19:23:29 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)) 19:23:29 INFO - Cleaning up... 19:23:29 INFO - Return code: 0 19:23:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f715d621f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', '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 19:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:23:29 INFO - Using env: {'DISPLAY': ':0', 19:23:29 INFO - 'HOME': '/home/cltbld', 19:23:29 INFO - 'LANG': 'en_US.UTF-8', 19:23:29 INFO - 'LANGUAGE': 'en_US:en', 19:23:29 INFO - 'LOGNAME': 'cltbld', 19:23:29 INFO - 'MAIL': '/var/mail/cltbld', 19:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:29 INFO - 'MOZ_NO_REMOTE': '1', 19:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:29 INFO - 'NO_EM_RESTART': '1', 19:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:29 INFO - 'PWD': '/builds/slave/test', 19:23:29 INFO - 'SHELL': '/bin/bash', 19:23:29 INFO - 'SHLVL': '1', 19:23:29 INFO - 'TERM': 'linux', 19:23:29 INFO - 'TMOUT': '86400', 19:23:29 INFO - 'USER': 'cltbld', 19:23:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:29 INFO - '_': '/tools/buildbot/bin/python'} 19:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:23:29 INFO - Cleaning up... 19:23:29 INFO - Return code: 0 19:23:29 INFO - Running post-action listener: _resource_record_post_action 19:23:29 INFO - Running post-action listener: _start_resource_monitoring 19:23:29 INFO - Starting resource monitoring. 19:23:29 INFO - [mozharness: 2016-08-31 02:23:29.764343Z] Finished create-virtualenv step (success) 19:23:29 INFO - [mozharness: 2016-08-31 02:23:29.764843Z] Running install step. 19:23:29 INFO - Running pre-action listener: _resource_record_pre_action 19:23:29 INFO - Running main action method: install 19:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:29 INFO - Reading from file tmpfile_stdout 19:23:29 INFO - Detecting whether we're running mozinstall >=1.0... 19:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:23:30 INFO - Reading from file tmpfile_stdout 19:23:30 INFO - Output received: 19:23:30 INFO - Usage: mozinstall [options] installer 19:23:30 INFO - Options: 19:23:30 INFO - -h, --help show this help message and exit 19:23:30 INFO - -d DEST, --destination=DEST 19:23:30 INFO - Directory to install application into. [default: 19:23:30 INFO - "/builds/slave/test"] 19:23:30 INFO - --app=APP Application being installed. [default: firefox] 19:23:30 INFO - mkdir: /builds/slave/test/build/application 19:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:23:47 INFO - Reading from file tmpfile_stdout 19:23:47 INFO - Output received: 19:23:47 INFO - /builds/slave/test/build/application/firefox/firefox 19:23:47 INFO - Running post-action listener: _resource_record_post_action 19:23:47 INFO - [mozharness: 2016-08-31 02:23:47.054717Z] Finished install step (success) 19:23:47 INFO - [mozharness: 2016-08-31 02:23:47.054996Z] Running run-tests step. 19:23:47 INFO - Running pre-action listener: _resource_record_pre_action 19:23:47 INFO - Running main action method: run_tests 19:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:23:47 INFO - Python 2.7.3 19:23:47 INFO - Return code: 0 19:23:47 INFO - grabbing minidump binary from tooltool 19:23:47 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')]} 19:23:47 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 0x15ad090>, '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 0x15b09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b0e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:23:47 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 19:23:47 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 19:23:47 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 19:23:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:23:47 INFO - Return code: 0 19:23:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:23:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:23:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:23:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:23:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 19:23:47 INFO - Using env: {'DISPLAY': ':0', 19:23:47 INFO - 'HOME': '/home/cltbld', 19:23:47 INFO - 'LANG': 'en_US.UTF-8', 19:23:47 INFO - 'LANGUAGE': 'en_US:en', 19:23:47 INFO - 'LOGNAME': 'cltbld', 19:23:47 INFO - 'MAIL': '/var/mail/cltbld', 19:23:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:23:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:47 INFO - 'MOZ_NO_REMOTE': '1', 19:23:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:47 INFO - 'NO_EM_RESTART': '1', 19:23:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:47 INFO - 'PWD': '/builds/slave/test', 19:23:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:23:47 INFO - 'SHELL': '/bin/bash', 19:23:47 INFO - 'SHLVL': '1', 19:23:47 INFO - 'TERM': 'linux', 19:23:47 INFO - 'TMOUT': '86400', 19:23:47 INFO - 'USER': 'cltbld', 19:23:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739', 19:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:47 INFO - '_': '/tools/buildbot/bin/python'} 19:23:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:23:47 INFO - mozversion application_buildid: 20160830163004 19:23:47 INFO - mozversion application_changeset: 41d8277af19246308bdf51bf0cd60da3498681b1 19:23:47 INFO - mozversion application_display_name: Nightly 19:23:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:23:47 INFO - mozversion application_name: Firefox 19:23:47 INFO - mozversion application_remotingname: firefox 19:23:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:23:47 INFO - mozversion application_vendor: Mozilla 19:23:47 INFO - mozversion application_version: 51.0a1 19:23:47 INFO - mozversion platform_buildid: 20160830163004 19:23:47 INFO - mozversion platform_changeset: 41d8277af19246308bdf51bf0cd60da3498681b1 19:23:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:23:47 INFO - mozversion platform_version: 51.0a1 19:23:47 INFO - using testdate: 1472610227 19:23:47 INFO - actual date: 1472610227 19:23:47 INFO - starting webserver on 'localhost:51101' 19:23:47 INFO - SUITE-START | Running 2 tests 19:23:47 INFO - TEST-START | dromaeo_css 19:23:47 INFO - operating with platform_type : linux_ 19:23:47 INFO - Initialising browser for dromaeo_css test... 19:23:47 INFO - TEST-INFO | started process 17737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT45uLi/profile http://localhost:51101/getInfo.html) 19:23:51 INFO - PROCESS | 17737 | __metrics Screen width/height:1600/1200 19:23:51 INFO - PROCESS | 17737 | colorDepth:24 19:23:51 INFO - PROCESS | 17737 | Browser inner width/height: 1024/697 19:23:51 INFO - PROCESS | 17737 | __metrics 19:23:52 INFO - PROCESS | 17737 | 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" 19:23:52 INFO - PROCESS | 17737 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:23:52 INFO - PROCESS | 17737 | console.error: PushService: 19:23:52 INFO - PROCESS | 17737 | stateChangeProcessEnqueue: Error transitioning state 19:23:52 INFO - PROCESS | 17737 | UnknownError 19:23:53 INFO - TEST-INFO | 17737: exit 0 19:23:53 INFO - Browser initialized. 19:23:53 INFO - Running cycle 1/1 for dromaeo_css test... 19:23:53 INFO - TEST-INFO | started process 17820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT45uLi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:05 INFO - PROCESS | 17820 | RSS: Main: 180088832 19:24:05 INFO - PROCESS | 17820 | 19:24:57 INFO - PROCESS | 17820 | 1472610297157 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] 19:27:06 INFO - PROCESS | 17820 | Cycle 1(1): loaded http://localhost:51101/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51101/tests/dromaeo/cssquery-ext.html) 19:27:07 INFO - PROCESS | 17820 | RSS: Main: 301105152 19:27:07 INFO - PROCESS | 17820 | 19:30:10 INFO - PROCESS | 17820 | Cycle 1(1): loaded http://localhost:51101/tests/dromaeo/cssquery-ext.html (next: http://localhost:51101/tests/dromaeo/cssquery-jquery.html) 19:30:10 INFO - PROCESS | 17820 | RSS: Main: 270934016 19:30:10 INFO - PROCESS | 17820 | 19:33:12 INFO - PROCESS | 17820 | Cycle 1(1): loaded http://localhost:51101/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51101/tests/dromaeo/cssquery-mootools.html) 19:33:13 INFO - PROCESS | 17820 | RSS: Main: 215445504 19:33:13 INFO - PROCESS | 17820 | 19:36:15 INFO - PROCESS | 17820 | Cycle 1(1): loaded http://localhost:51101/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51101/tests/dromaeo/cssquery-prototype.html) 19:36:16 INFO - PROCESS | 17820 | RSS: Main: 214790144 19:36:16 INFO - PROCESS | 17820 | 19:39:19 INFO - PROCESS | 17820 | Cycle 1(1): loaded http://localhost:51101/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51101/tests/dromaeo/cssquery-yui.html) 19:39:19 INFO - PROCESS | 17820 | RSS: Main: 218906624 19:39:19 INFO - PROCESS | 17820 | 19:42:22 INFO - PROCESS | 17820 | Cycle 1(1): loaded http://localhost:51101/tests/dromaeo/cssquery-yui.html (next: http://localhost:51101/tests/dromaeo/cssquery-dojo.html) 19:42:22 INFO - PROCESS | 17820 | RSS: Main: 302448640 19:42:22 INFO - PROCESS | 17820 | 19:42:22 INFO - PROCESS | 17820 | __start_tp_report 19:42:22 INFO - PROCESS | 17820 | _x_x_mozilla_page_load 19:42:22 INFO - PROCESS | 17820 | _x_x_mozilla_page_load_details 19:42:22 INFO - PROCESS | 17820 | |i|pagename|runs| 19:42:22 INFO - PROCESS | 17820 | |0;dojo.html;3004.4591973444785;3018.200176953108;3023.4860073787454;3045.7563394928407;3078.353545755391;5214.895702085956;5280.419153893069;5290.920636190451;5333.546648534874;5349.866253343664;5359.785608575652;5391.622586418952;5429.945700542993;5453.263809385731;5471.671699698021;4844.733539655317;4882.072406242803;4930.7534623268875;4942.703437793726;5059.620528460362;5000.624953128512;5040.1179793535985;5042.546170844624;5059.747012649371;5059.7723102460295;4753.073150735625;4813.109574728686;4874.610031197496;4875.366202393666;4952.405711314629;4832.806687732486;4842.41890973082;4849.5635392814465;4864.464908860023;4946.530079642428;4844.176489996674;4858.684185527929;4873.195922672755;4876.21980483121;4928.802847886081;5206.947930520684;5270.130428479296;5371.248025276464;5404.486573775485;5406.08096623575;5628.352739434977;5635.830925072254;5646.2942132233475;5650.943490565083;5661.179129026309;5707.600467967244;5715.599908006441;5716.085426331809;5722.713864306768;5728.398518155617;5186.7147306898105;5300.2314664373835;5347.2781174541715;5350.91973620396;5427.728613569306;5824.621399609096;5827.59206855516;5828.562857785683;5828.6794226317115;5832.679202643895;5602.803901863415;5609.551235901118;5610.579206559442;5613.158026296088;5613.494785469327;5517.889642207214;5683.943160568424;5715.9142612860005;5733.741981610838;5821.912671309934;5731.455511726379;5736.483716465538;5736.770529178786;5737.8565535861935;5796.536277097822;5693.601447898607;5735.8852822944145;5746.827595172152;5748.856278592985;5750;4338.631216346583;4379.167958088017;4381.802818873159;4418.33724941255;4424.845130420485;3970.06703424695;3987.641112299907;3987.900302492461;3988.0827409695353;3989.7805620691142;5383.569314454834;5391.946080539223;5392;5394.973025134927;5394.974954758583;5702.401247868997;5707;5748.166515855178;5794.072948328248;5803.158542011384;5433.809816656398;5493.917591236134;5498.037843377473;5507.256520369779;5534.861628459321;4996.825111121093;5002.824901128443;5003.72479513623;5003.724795136302;5060.645754797202;5794.275715535558;5951.345352011275;6019.759209631653;6026.54800889935;6044.304904935901;5783.103618939072;5784.681842498703;5788.986927287624;5830;5843.620164689281;5961.910571341346;5969.134475501115;5976.133460648269;5978.103284507359;5981.9401805983125;5416.918746218731;5634.85912852182;5673.06394444912;5678.2050512929045;5680.11958146488;5801.535877129735;5808.651480910989;5809.2738407699035;5862.501687356623;5869.970650146722;5671.177679236405;5680.403557626555;5683.232763576864;5684.744186511534;5690.004249256281;5380.11228147367;5610.382857885547;5638.182463542681;5655.660660360391;5667.20659107717;5624.3250809903075;5665.461781130786;5688.232088667977;5692.260006199168;5694.943050569607;5659.39978478331;5722.313322401338;5739.569532285179;5744.339400968942;5748.48263656273;5397.433269506802;5555.444455554412;5600.047991841316;5630.577706671934;5632.831015069554 19:42:22 INFO - PROCESS | 17820 | |1;ext.html;553.5073784331945;604.2084868821844;611.1596554737235;615.3477314047108;622.2905887288495;43528;45065.098698026064;45069.09861802762;45116.54883451165;48650.27024594634;45348.319775203396;45726;45802.41975802418;45828.31257531131;45861.31208031882;8996.460212387261;9174.724758257264;9179.173874351307;9182.449053056838;9185.173334399902;8988.056254093324;9073.59168837404;9082.727518174466;9084.591193396313;9088.091190880892;9088;9118.361714679975;9123.315751318645;9125.908740912606;9128.132827381389;9086.04596517366;9112.908870911273;9118.452892826452;9119.908800911971;9124.726258212264;9007.774805629911;9073.773155671095;9081.091890810932;9085.954570227173;9088.863667045;42034.78982605068;42072.789636051624;42225.57774422247;42498.575014250084;42563;3496.4411930665196;3665.486831843544;3669.284489524544;3678.70570354371;3707.5921648618632;31538.4769218462;31547;31727.681438664116;31906.521402178987;32049.679503205134;3662.61542538035;3665.6151104133946;3693.9865682267136;3696.5933747287777;3735.7384983051197;317133.9999999977;317511.1982082879;317544;317567.1216439192;318557;57697.711511442176;57953;57976.13035804466;58006.7099664499;58030.41969580334;52340.47659523356;58059;59517.881960066894;60944.695276523336;61027.694861526295;16917.49247522576;17277.308907643805;17388.3044678214;17443;17448;13666.658333541542;13757;13781.655458613413;13783.241921694202;13797.310134493235;15152.393904243927;16715.414960476326;16850.157492125345;17101.947766268127;17246.396376126777;5897.823065308047;6014.278286605635;6058.666773327509;6172.567920245539;6266.436020758154;963.325672029582;1051.4546945265813;1091.8034753744244;1102.2559772153763;1140.0960396138469;30936.69063309338;31033.844830776154;31217.219569510944;31782.2054448636;31829.20426989344;1077.0629552289558;1084.6637542361893;1117.2291119127938;1127.2447460201683;1133.3143448213877;15976.440824571084;16613.50159495217;16657.666846663;16669;16830.15849207535;518979;525752;526161;526672;526897;56513.71743141258;56617;56781;56815.431845681844;56882.14676779851;1319.1755153029358;1334.499562664001;1357.7895426208756;1358.2936872826076;1358.436248956672;29570.556441653822;30260.24349391283;30825.229369265948;31198.844005779825;31227.84386078055;50213;50752;50873.23690144725;50889.23666145085;50919.74540127424;399997;401080;402800;404169;405471;34659;39874;40774.59225407708;40866.89163854518;41720.20217674885;45690.77154614338;46118;46361.30458043199;46926;47399.289010665554;37646.62353376431;38781;40418.79790601146;40562.39156412715;41443.37834932539;39069;39350.40974385444;39923;40156;41798.58201417947;39257;39409.211815764094;40218.3639699458;40297.597024030554;40491.79754101211;32478;35890.28219435649;36178.8191059043;36890.262194755414;37204.627953721196;27331.59002615002;27452.313692157855;27571.448571028064;27680.723192767815;27733.168004959884 19:42:22 INFO - PROCESS | 17820 | |2;jquery.html;398.4620761971341;398.8903051660791;407.6799712225902;407.70645135502446;425.2706608166993;13281.468741250339;18209.271629134837;19014.14436350364;20170;20205.696914546294;14765.18791466469;15157.393704251845;18223.817761822378;18461.44615661529;18542.72185917209;5574.5506168396205;5755.597108202427;5755.683437410961;5758.798442054529;5764.481196692297;5657.462541058593;5711.257536520267;5746.913796293059;5759.107338362561;5759.827205183851;5583.888322233553;5692.174634677969;5725.656460612356;5731.885362292752;5757.510611598019;5637.408072152447;5671.319441667027;5709.086546152616;5709.400512946143;5710.486056254937;5016.724080175625;5136.04983078128;5145.819896303648;5154.974225128888;5158.974205128988;16199.271032803552;20588.27941022072;21058.052387642594;21262.787372126237;23087;2345.3901985483726;2351.0948284910432;2436.8903399347073;2462.5936720441105;2779.63864697588;9721;10184.592616295413;10298.433586152758;10383.740406489822;13760.724785504233;1848.7134494153427;1874.9156287967073;1917.319351630165;1918.4340619517277;1948.912298946551;75957;78222;78434;79766.60116699379;85773;11028.393438360967;11079.446027698583;11435.656930292105;11481.483333250024;11930.284182949052;15528.84471155274;15538.922305388627;15540.611484712746;15559.922200388926;15571.454999074978;8171.142030086755;8202.302804261586;8342.499450033018;8393.160683931681;8534.103919088406;7929.960350198327;7953.642086106023;8026.919730802734;8307.501549906903;8347.582620868932;4386.649068074546;4545.931811022837;4571.268597024527;4783.306420569068;4829.9275510867365;1919.9232030718895;2001.1695146514035;2028.4016215216252;2048.4673984764067;2061.309461330441;835.3359079531787;897.9955100224457;932.38462614674;978.217426059164;983.7589790501373;18081.819181808278;18670.159842807105;18822.435326940213;18872.339468118826;18966;943.4716558727134;968.7093871838421;973.3964941736169;975.6048800235774;1007.9445630490393;9910.405375677483;10567.682969510926;10579.94710026445;10646.680599582025;10647.201459890539;367909;370736;371284;480967;500491.9458859523;95657.52171239238;96106.51946740222;100791.49604252078;101610;102679;989.8267803134567;1006.3659894266711;1044.1646682653998;1050.81610718124;1056.8256237720843;16172.838271617133;16938.322467101178;17580.648387032445;17995.190216440555;18115.81884181141;39751.40372894351;42940.78529607332;44079.559204408826;44617;45947.77026114848;52665.47334526606;57357.71321143368;58641.4135858653;59084.704576478565;59504.10743838759;8037.517748935083;8112.797180070545;8202.958985205036;8352.707655232038;8382.119877412784;12402.627921162379;12503.812442813547;12669.683257918257;13218.140820846615;13275.933620331836;11490.82763758561;11643.12676549279;11707.121965852424;11727.47226374798;12069.27584344942;6825.726970921108;11360.659180224606;11490.425478726198;11651;11691.707707307045;11055.336679799238;11420.885791141982;11485.19603627738;11693.356865372147;11793.764124717629;8136.796580085545;8148.185181481805;8228.465149765247;8300.675810772993;8534.146585341665;10796.730081748019;11421.657350279505;11491.597794077166;11555.653330400102;11961.162718609961 19:42:22 INFO - PROCESS | 17820 | |3;mootools.html;1361.4554178328674;1482.4811316039388;1500.7223663622228;1630.1278815833523;1823.507652933708;8526.616302266397;8925.330600204987;8980.550972451376;9156.90843091569;9273.258139348853;8949.731508054769;9160.496172710515;9177.724668259963;9185.311101667368;9198.126178013095;2116.608427440921;2375.5605213035556;2414.311921102482;2442.3649851038767;2443.1815341860497;2453.288546321565;2479;2479.0827393864297;2483.801295896333;2486.5648511510503;2387.7134743830766;2399.2202534176463;2405.927822165338;2408.1089996701157;2410.8553486790847;2348.4598542335357;2380.5119950410212;2388.379021454417;2437.573424650679;2441.609342505191;2408.337707130536;2441.1944058460667;2453.031052734178;2458.1027924807495;2460.90156393744;9190.21883139934;9254.768630784218;9258.814823703555;9267.3976191548;9277.489738064403;5236.554892834076;5403.918941215885;5453.318335208099;5463.071277882769;5467.808626698086;3408.6761757632985;3418.6581341865863;3493.650634936486;3502.509648649191;3602.171500554887;1101.944902754859;1136.6476392318325;1152.8501294831701;1158.3455347728507;1188.875168107345;11469;11569.826452603302;11610.825837612443;11648.475818588184;11651.825222621668;4169.353750168729;4441.289393696993;4543.750093744809;4556.339330797082;4580.496145424001;9158.633654653739;9178.586963586522;9181.632734690671;9194.080591940752;9195.954020229856;5040.168372218616;5061.240813877874;5061.974690126526;5062.645614807002;5062.873428164326;4302.3546468030045;4783.234682450791;4854;4913.287573301851;4975.676581022222;3822.5412950446125;3873.8063096845044;3965.940510892339;4005.5193376794973;4123.0310876943895;1242.589945318043;1254.861965183829;1255.8430196225472;1266.1516783754905;1276.8340115784888;977.2084611464736;1002.7793885345212;1003.934744241622;1020.5713600287897;1025.466757286207;6014.699265036731;6179.598326108789;6309.179806625109;6390.648514331757;6420.967895160495;469.1086934823862;476.4711170600631;478.30645563931745;492.0896341767701;507.92888995540653;4224.17711970667;4336.761478118734;4455.598996090367;4468.9106217876115;4526.524714904954;10799.568017279378;11126.777464450666;11220.66338009861;11285.887141128647;11287.322760634388;10916.290441121302;11094.278871873303;11240.437978101227;11261.943690281496;11272.154588405903;8133.633986470505;8205.630746616416;8210.343172546181;8235.176482351717;8246.340292776564;6140.662263575547;6176.752929882754;6227;6242.906356404566;6304.905426418516;10056;10354.275200735876;10369.118624916664;10407.47962601882;10410.73973150647;9908.900910990798;10040.64857729976;10175.542100605639;10269.794604108025;10576.629817956335;7159.319864612853;7841.686332546634;7975.7607271781935;8004.279614834692;8264.380171487042;8961.283097352065;9031.909680903107;9034.45793252407;9037.864432033393;9045.638174472948;7667.616619168908;7912.881306780518;7932.524048557105;7986.560739159402;8213;7838;7868.409869259714;7921.603919804102;7923.762287131395;7952.721654742057;7203.891941620985;7231.602261875647;7298.197198308288;7304.598247096461;7308.415326773739;5418.566514678895;5452.890942181055;5502.147167189092;5541.445855414427;5635.211070450058;5331.466853314638;5424.511793938565;5496.890062198813;5586.720663966867;5592.860178495407 19:42:22 INFO - PROCESS | 17820 | |4;prototype.html;324.4792108665592;332.09172912085455;332.31543021375967;335.7968429100394;337.7973216070358;5218.947810521893;5234.068921404017;5267.499587539187;5280.940433231043;5332.760025798839;5188.325517682696;5254.264402983576;5259.8422047338545;5274.103402421598;5277.70972596508;4021.698372622065;4154.688398370126;4169.166166766644;4177.436046133764;4181.498220213563;4136.841684328393;4171.186618609372;4187.916241675165;4189.685773566979;4202.138561594881;4115.641838193389;4118.979405102985;4122.587741225869;4137.710360274782;4148.792560371984;3928.135810121769;3967.940480892789;4108.849522133807;4135.304525144691;4141.068259641572;3659.670629643318;3665.7250706196874;3672.8347224374966;3679.2641471705497;3691.7231207659534;5110.2590124431745;5129.410117836422;5132.538071573539;5134.8202812901745;5141.460146684619;4338.956610433886;4433.512313645497;4533.342665313544;4734.19518681825;4771.8091276348905;5334.146536554172;5364.839054828361;5371.248025276464;5386.542143917772;5407.891842163174;4009.659178969791;4017.5178978522763;4034.616711412411;4037.555868854424;4041.9191616167805;5557.3886872444;5558.86102847428;5591.580631452657;5625.803096891589;5698.1452782083015;4105.4252404662775;4119.92881850721;4130.339145736728;4136.772477513766;4137.937930931039;4194.3289073748665;4195.5315639525925;4200.529814564878;4215.178040282116;4218.620324170839;4403.3174857897075;4640.721556706609;4720.905581888343;4721.622270218374;4732.077244937204;5418.729063546807;5442.564594832404;5442.945570544323;5444.972775136099;5447.210154527571;1400.8093120847197;1418.3971811979868;1419.5812235390586;1424.5583869000436;1426.486464872645;921.0634980009661;945.7682867697321;948.7153853843819;953.1612181280428;965.3773316211004;4672;4680.4149481314835;4708.79925618965;4712.151812673752;4755.500672429345;4847.394075740533;4861.829835955725;4886.29148773433;4917.197197597407;4925.827596034122;4721;4721.95278047222;4723.811047558128;4734.55021772931;4978.377702787152;2865.6131422258145;2891.103757835078;2962.8370439625596;2969.8515074246634;2973.836438995876;5732.942670573324;5774;5775.133729940542;5776.364599894008;5784.652920824764;5545.7781688732;5658.575606829504;5709.885802283931;5716.114002329646;5727.398623144593;5659.745311461076;5727.541796656257;5762.654240745569;5764.193012978187;5777.19119323295;5502.871911258102;5558.527525160245;5563.58273129525;5638.154276858504;5647.491725744702;5336.573074153981;5455.427180146027;5492.52836223693;5508.283923090133;5594.776208951596;5736.42635736423;5739;5740.598158128891;5752.654840709571;5810.389909059657;3984.681225501895;3987.900302492461;4007.89782809718;4011.338129208648;4012.7191096622955;5425.83722488326;5505.366882808528;5528.226048353315;5544.168374743659;5549.722513874371;5392.51467367923;5393.164059570773;5398.730063496888;5407.486288802557;5412.972935135299;5285.814996475105;5410.7284788073985;5430.67415955044;5470.206820010996;5477.507024367826;5304.58641318207;5330.680159190461;5334.253204551288;5347.385050719217;5353.97323013398;5391.838244852661;5394.622376433612;5447.836564903059;5482.369527504388;5486.286782718221;5152.793888244429;5315.893682126413;5343.248227162936;5384.300040994645;5387.568994480511 19:42:22 INFO - PROCESS | 17820 | |5;yui.html;768.9281321122118;793.5040599625235;804.5735760047173;834.9863226470253;846.5767116441777;15486.92256538717;16920.83079169208;17018.574535636617;17021.65956680867;17024.404145854896;14846.480373186942;15137.772933406008;15288.159151246677;15380.230988450561;15393.461228856992;797.1789057271005;823.8022874510134;824.8680211166214;825.6614787936948;826.2563692676579;666.4002397841957;811.0470197517923;821.7452589697183;822.8765685147216;823.5840900345318;823.3660081737058;837.9287760540361;846.6571038729325;849.4733265375476;849.6389034660244;827.4869580859905;832.6045128563944;833.1626715151234;833.3458235285302;834.0658462521953;502.1012387825787;609.5002098279368;609.893268677984;610.7770663707759;611.4588589098636;14177.220252886087;14554.272286385638;14658.706825863423;15082.622934426727;15138;14194;15375.308111134915;15482.22588870552;15589.610259743484;15638.609034774108;12320.938395307967;12353.876461235452;12392.194507356993;12496.187747796364;13260.138091024053;3904.219156168749;3970.007498125469;3978.781167035812;4005.7396269242404;4090.8159132839096;78889.60555197245;79417.20582794157;82093;82680;82822;11779.293242405483;11816.409179540988;11931.761364772656;12015.699607509881;12160.817587736192;21347.46631334229;21481.140754369964;21867.890660546913;21899.562008759734;21924.780752192593;8492.333518188316;8641.265492433087;8836.91163088361;8961.059088795713;9002.774930626656;4713.622910167179;4840.733759643183;4927.310176575283;4969.254611808257;5078.7460626968505;3562.3765840977726;3702.777833330009;3724.944125838115;3727.7576957497677;3729.776213427203;638.0588631768105;646.5118835279428;651.0884761334075;653.4706887421204;661.0183876942737;738.7525179065074;741.280957471252;756.8486302739474;760.8636347854535;774.3727580659684;9277.443353398818;10250.436226007641;10809;10911.34531928071;10964.276494767486;659.3274859643137;679.6126208061357;719.0544434069183;770.6416516319827;787.173467858746;4813.4945830687975;4873.31773551703;5006.849794506171;5019.272205530177;5035.093683136997;103592.48203758933;103748;104186;104363;108714;94954;95465.52267238758;95723.52138239403;95979;96562.51718741361;85521.14478855132;88175;89441.55279223563;89597.55201223952;89835;9460.526973651427;9646.710598682052;9732.75668108303;9735.756606084904;9740.512974351395;49369.753151234014;49515;49627.50372496373;50641.493585063676;51050;71749;71952.64023679848;74066.62966685132;74410.62794685992;77105.6630939047;11954.701132471759;12231.204971676812;12411.193272437262;12512.061595380565;12964.286964217059;13852.93073534626;13970.091944023607;14065.296735163405;14109.717805643624;14178;12976.545820896223;13023;13605.659858503617;13715.245661488714;14141.080829746033;12075.57735479254;13145.60563183106;13408.865911341152;13914.86085139176;14735.92632036833;13868.93065534666;14113.717725645225;14413.711725765635;14486.927565362106;14507.637309067357;11003.390944535018;11268.492917818554;11293.548258069914;11959.521619135137;12043;11689.998413705422;12081.214721043105;12085.335306558223;12148.167353919645;12227.388630568614 19:42:22 INFO - PROCESS | 17820 | __end_tp_report 19:42:22 INFO - PROCESS | 17820 | __start_cc_report 19:42:22 INFO - PROCESS | 17820 | _x_x_mozilla_cycle_collect,1046 19:42:22 INFO - PROCESS | 17820 | __end_cc_report 19:42:22 INFO - PROCESS | 17820 | __startTimestamp1472611342868__endTimestamp 19:42:22 INFO - PROCESS | 17820 | 19:42:22 INFO - PROCESS | 17820 | ------- Summary: start ------- 19:42:22 INFO - PROCESS | 17820 | Number of tests: 6 19:42:22 INFO - PROCESS | 17820 | 19:42:22 INFO - PROCESS | 17820 | [#0] dojo.html Cycles:165 Average:5345.44 Median:5609.55 stddev:609.84 (10.9%) stddev-sans-first:583.40 19:42:22 INFO - PROCESS | 17820 | Values: 3004.5 3018.2 3023.5 3045.8 3078.4 5214.9 5280.4 5290.9 5333.5 5349.9 5359.8 5391.6 5429.9 5453.3 5471.7 4844.7 4882.1 4930.8 4942.7 5059.6 5000.6 5040.1 5042.5 5059.7 5059.8 4753.1 4813.1 4874.6 4875.4 4952.4 4832.8 4842.4 4849.6 4864.5 4946.5 4844.2 4858.7 4873.2 4876.2 4928.8 5206.9 5270.1 5371.2 5404.5 5406.1 5628.4 5635.8 5646.3 5650.9 5661.2 5707.6 5715.6 5716.1 5722.7 5728.4 5186.7 5300.2 5347.3 5350.9 5427.7 5824.6 5827.6 5828.6 5828.7 5832.7 5602.8 5609.6 5610.6 5613.2 5613.5 5517.9 5683.9 5715.9 5733.7 5821.9 5731.5 5736.5 5736.8 5737.9 5796.5 5693.6 5735.9 5746.8 5748.9 5750.0 4338.6 4379.2 4381.8 4418.3 4424.8 3970.1 3987.6 3987.9 3988.1 3989.8 5383.6 5391.9 5392.0 5395.0 5395.0 5702.4 5707.0 5748.2 5794.1 5803.2 5433.8 5493.9 5498.0 5507.3 5534.9 4996.8 5002.8 5003.7 5003.7 5060.6 5794.3 5951.3 6019.8 6026.5 6044.3 5783.1 5784.7 5789.0 5830.0 5843.6 5961.9 5969.1 5976.1 5978.1 5981.9 5416.9 5634.9 5673.1 5678.2 5680.1 5801.5 5808.7 5809.3 5862.5 5870.0 5671.2 5680.4 5683.2 5684.7 5690.0 5380.1 5610.4 5638.2 5655.7 5667.2 5624.3 5665.5 5688.2 5692.3 5694.9 5659.4 5722.3 5739.6 5744.3 5748.5 5397.4 5555.4 5600.0 5630.6 5632.8 19:42:22 INFO - PROCESS | 17820 | 19:42:22 INFO - PROCESS | 17820 | [#1] ext.html Cycles:180 Average:58128.13 Median:40455.30 stddev:112176.15 (277.3%) stddev-sans-first:112407.54 19:42:22 INFO - PROCESS | 17820 | Values: 553.5 604.2 611.2 615.3 622.3 43528.0 45065.1 45069.1 45116.5 48650.3 45348.3 45726.0 45802.4 45828.3 45861.3 8996.5 9174.7 9179.2 9182.4 9185.2 8988.1 9073.6 9082.7 9084.6 9088.1 9088.0 9118.4 9123.3 9125.9 9128.1 9086.0 9112.9 9118.5 9119.9 9124.7 9007.8 9073.8 9081.1 9086.0 9088.9 42034.8 42072.8 42225.6 42498.6 42563.0 3496.4 3665.5 3669.3 3678.7 3707.6 31538.5 31547.0 31727.7 31906.5 32049.7 3662.6 3665.6 3694.0 3696.6 3735.7 317134.0 317511.2 317544.0 317567.1 318557.0 57697.7 57953.0 57976.1 58006.7 58030.4 52340.5 58059.0 59517.9 60944.7 61027.7 16917.5 17277.3 17388.3 17443.0 17448.0 13666.7 13757.0 13781.7 13783.2 13797.3 15152.4 16715.4 16850.2 17101.9 17246.4 5897.8 6014.3 6058.7 6172.6 6266.4 963.3 1051.5 1091.8 1102.3 1140.1 30936.7 31033.8 31217.2 31782.2 31829.2 1077.1 1084.7 1117.2 1127.2 1133.3 15976.4 16613.5 16657.7 16669.0 16830.2 518979.0 525752.0 526161.0 526672.0 526897.0 56513.7 56617.0 56781.0 56815.4 56882.1 1319.2 1334.5 1357.8 1358.3 1358.4 29570.6 30260.2 30825.2 31198.8 31227.8 50213.0 50752.0 50873.2 50889.2 50919.7 399997.0 401080.0 402800.0 404169.0 405471.0 34659.0 39874.0 40774.6 40866.9 41720.2 45690.8 46118.0 46361.3 46926.0 47399.3 37646.6 38781.0 40418.8 40562.4 41443.4 39069.0 39350.4 39923.0 40156.0 41798.6 39257.0 39409.2 40218.4 40297.6 40491.8 32478.0 35890.3 36178.8 36890.3 37204.6 27331.6 27452.3 27571.4 27680.7 27733.2 19:42:22 INFO - PROCESS | 17820 | 19:42:22 INFO - PROCESS | 17820 | [#2] jquery.html Cycles:180 Average:26985.49 Median:369322.50 stddev:70347.73 (19.0%) stddev-sans-first:70516.75 19:42:22 INFO - PROCESS | 17820 | Values: 398.5 398.9 407.7 407.7 425.3 13281.5 18209.3 19014.1 20170.0 20205.7 14765.2 15157.4 18223.8 18461.4 18542.7 5574.6 5755.6 5755.7 5758.8 5764.5 5657.5 5711.3 5746.9 5759.1 5759.8 5583.9 5692.2 5725.7 5731.9 5757.5 5637.4 5671.3 5709.1 5709.4 5710.5 5016.7 5136.0 5145.8 5155.0 5159.0 16199.3 20588.3 21058.1 21262.8 23087.0 2345.4 2351.1 2436.9 2462.6 2779.6 9721.0 10184.6 10298.4 10383.7 13760.7 1848.7 1874.9 1917.3 1918.4 1948.9 75957.0 78222.0 78434.0 79766.6 85773.0 11028.4 11079.4 11435.7 11481.5 11930.3 15528.8 15538.9 15540.6 15559.9 15571.5 8171.1 8202.3 8342.5 8393.2 8534.1 7930.0 7953.6 8026.9 8307.5 8347.6 4386.6 4545.9 4571.3 4783.3 4829.9 1919.9 2001.2 2028.4 2048.5 2061.3 835.3 898.0 932.4 978.2 983.8 18081.8 18670.2 18822.4 18872.3 18966.0 943.5 968.7 973.4 975.6 1007.9 9910.4 10567.7 10579.9 10646.7 10647.2 367909.0 370736.0 371284.0 480967.0 500491.9 95657.5 96106.5 100791.5 101610.0 102679.0 989.8 1006.4 1044.2 1050.8 1056.8 16172.8 16938.3 17580.6 17995.2 18115.8 39751.4 42940.8 44079.6 44617.0 45947.8 52665.5 57357.7 58641.4 59084.7 59504.1 8037.5 8112.8 8203.0 8352.7 8382.1 12402.6 12503.8 12669.7 13218.1 13275.9 11490.8 11643.1 11707.1 11727.5 12069.3 6825.7 11360.7 11490.4 11651.0 11691.7 11055.3 11420.9 11485.2 11693.4 11793.8 8136.8 8148.2 8228.5 8300.7 8534.1 10796.7 11421.7 11491.6 11555.7 11961.2 19:42:22 INFO - PROCESS | 17820 | 19:42:22 INFO - PROCESS | 17820 | [#3] mootools.html Cycles:180 Average:5880.06 Median:477.39 stddev:3302.72 (691.8%) stddev-sans-first:3294.52 19:42:22 INFO - PROCESS | 17820 | Values: 1361.5 1482.5 1500.7 1630.1 1823.5 8526.6 8925.3 8980.6 9156.9 9273.3 8949.7 9160.5 9177.7 9185.3 9198.1 2116.6 2375.6 2414.3 2442.4 2443.2 2453.3 2479.0 2479.1 2483.8 2486.6 2387.7 2399.2 2405.9 2408.1 2410.9 2348.5 2380.5 2388.4 2437.6 2441.6 2408.3 2441.2 2453.0 2458.1 2460.9 9190.2 9254.8 9258.8 9267.4 9277.5 5236.6 5403.9 5453.3 5463.1 5467.8 3408.7 3418.7 3493.7 3502.5 3602.2 1101.9 1136.6 1152.9 1158.3 1188.9 11469.0 11569.8 11610.8 11648.5 11651.8 4169.4 4441.3 4543.8 4556.3 4580.5 9158.6 9178.6 9181.6 9194.1 9196.0 5040.2 5061.2 5062.0 5062.6 5062.9 4302.4 4783.2 4854.0 4913.3 4975.7 3822.5 3873.8 3965.9 4005.5 4123.0 1242.6 1254.9 1255.8 1266.2 1276.8 977.2 1002.8 1003.9 1020.6 1025.5 6014.7 6179.6 6309.2 6390.6 6421.0 469.1 476.5 478.3 492.1 507.9 4224.2 4336.8 4455.6 4468.9 4526.5 10799.6 11126.8 11220.7 11285.9 11287.3 10916.3 11094.3 11240.4 11261.9 11272.2 8133.6 8205.6 8210.3 8235.2 8246.3 6140.7 6176.8 6227.0 6242.9 6304.9 10056.0 10354.3 10369.1 10407.5 10410.7 9908.9 10040.6 10175.5 10269.8 10576.6 7159.3 7841.7 7975.8 8004.3 8264.4 8961.3 9031.9 9034.5 9037.9 9045.6 7667.6 7912.9 7932.5 7986.6 8213.0 7838.0 7868.4 7921.6 7923.8 7952.7 7203.9 7231.6 7298.2 7304.6 7308.4 5418.6 5452.9 5502.1 5541.4 5635.2 5331.5 5424.5 5496.9 5586.7 5592.9 19:42:22 INFO - PROCESS | 17820 | 19:42:22 INFO - PROCESS | 17820 | [#4] prototype.html Cycles:180 Average:4561.69 Median:5170.56 stddev:1313.00 (25.4%) stddev-sans-first:1277.59 19:42:22 INFO - PROCESS | 17820 | Values: 324.5 332.1 332.3 335.8 337.8 5218.9 5234.1 5267.5 5280.9 5332.8 5188.3 5254.3 5259.8 5274.1 5277.7 4021.7 4154.7 4169.2 4177.4 4181.5 4136.8 4171.2 4187.9 4189.7 4202.1 4115.6 4119.0 4122.6 4137.7 4148.8 3928.1 3967.9 4108.8 4135.3 4141.1 3659.7 3665.7 3672.8 3679.3 3691.7 5110.3 5129.4 5132.5 5134.8 5141.5 4339.0 4433.5 4533.3 4734.2 4771.8 5334.1 5364.8 5371.2 5386.5 5407.9 4009.7 4017.5 4034.6 4037.6 4041.9 5557.4 5558.9 5591.6 5625.8 5698.1 4105.4 4119.9 4130.3 4136.8 4137.9 4194.3 4195.5 4200.5 4215.2 4218.6 4403.3 4640.7 4720.9 4721.6 4732.1 5418.7 5442.6 5442.9 5445.0 5447.2 1400.8 1418.4 1419.6 1424.6 1426.5 921.1 945.8 948.7 953.2 965.4 4672.0 4680.4 4708.8 4712.2 4755.5 4847.4 4861.8 4886.3 4917.2 4925.8 4721.0 4722.0 4723.8 4734.6 4978.4 2865.6 2891.1 2962.8 2969.9 2973.8 5732.9 5774.0 5775.1 5776.4 5784.7 5545.8 5658.6 5709.9 5716.1 5727.4 5659.7 5727.5 5762.7 5764.2 5777.2 5502.9 5558.5 5563.6 5638.2 5647.5 5336.6 5455.4 5492.5 5508.3 5594.8 5736.4 5739.0 5740.6 5752.7 5810.4 3984.7 3987.9 4007.9 4011.3 4012.7 5425.8 5505.4 5528.2 5544.2 5549.7 5392.5 5393.2 5398.7 5407.5 5413.0 5285.8 5410.7 5430.7 5470.2 5477.5 5304.6 5330.7 5334.3 5347.4 5354.0 5391.8 5394.6 5447.8 5482.4 5486.3 5152.8 5315.9 5343.2 5384.3 5387.6 19:42:22 INFO - PROCESS | 17820 | 19:42:22 INFO - PROCESS | 17820 | [#5] yui.html Cycles:180 Average:20744.82 Median:4827.11 stddev:29126.74 (603.4%) stddev-sans-first:29169.82 19:42:22 INFO - PROCESS | 17820 | Values: 768.9 793.5 804.6 835.0 846.6 15486.9 16920.8 17018.6 17021.7 17024.4 14846.5 15137.8 15288.2 15380.2 15393.5 797.2 823.8 824.9 825.7 826.3 666.4 811.0 821.7 822.9 823.6 823.4 837.9 846.7 849.5 849.6 827.5 832.6 833.2 833.3 834.1 502.1 609.5 609.9 610.8 611.5 14177.2 14554.3 14658.7 15082.6 15138.0 14194.0 15375.3 15482.2 15589.6 15638.6 12320.9 12353.9 12392.2 12496.2 13260.1 3904.2 3970.0 3978.8 4005.7 4090.8 78889.6 79417.2 82093.0 82680.0 82822.0 11779.3 11816.4 11931.8 12015.7 12160.8 21347.5 21481.1 21867.9 21899.6 21924.8 8492.3 8641.3 8836.9 8961.1 9002.8 4713.6 4840.7 4927.3 4969.3 5078.7 3562.4 3702.8 3724.9 3727.8 3729.8 638.1 646.5 651.1 653.5 661.0 738.8 741.3 756.8 760.9 774.4 9277.4 10250.4 10809.0 10911.3 10964.3 659.3 679.6 719.1 770.6 787.2 4813.5 4873.3 5006.8 5019.3 5035.1 103592.5 103748.0 104186.0 104363.0 108714.0 94954.0 95465.5 95723.5 95979.0 96562.5 85521.1 88175.0 89441.6 89597.6 89835.0 9460.5 9646.7 9732.8 9735.8 9740.5 49369.8 49515.0 49627.5 50641.5 51050.0 71749.0 71952.6 74066.6 74410.6 77105.7 11954.7 12231.2 12411.2 12512.1 12964.3 13852.9 13970.1 14065.3 14109.7 14178.0 12976.5 13023.0 13605.7 13715.2 14141.1 12075.6 13145.6 13408.9 13914.9 14735.9 13868.9 14113.7 14413.7 14486.9 14507.6 11003.4 11268.5 11293.5 11959.5 12043.0 11690.0 12081.2 12085.3 12148.2 12227.4 19:42:22 INFO - PROCESS | 17820 | -------- Summary: end -------- 19:42:22 INFO - PROCESS | 17820 | 19:42:23 INFO - TEST-INFO | 17820: exit 0 19:42:23 INFO - TEST-OK | dromaeo_css | took 1116546ms 19:42:23 INFO - TEST-START | kraken 19:42:23 INFO - operating with platform_type : linux_ 19:42:23 INFO - Initialising browser for kraken test... 19:42:23 INFO - TEST-INFO | started process 18129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXP_pmK/profile http://localhost:51101/getInfo.html) 19:42:28 INFO - PROCESS | 18129 | __metrics Screen width/height:1600/1200 19:42:28 INFO - PROCESS | 18129 | colorDepth:24 19:42:28 INFO - PROCESS | 18129 | Browser inner width/height: 1024/697 19:42:28 INFO - PROCESS | 18129 | __metrics 19:42:28 INFO - PROCESS | 18129 | 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" 19:42:28 INFO - PROCESS | 18129 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:42:29 INFO - PROCESS | 18129 | console.error: PushService: 19:42:29 INFO - PROCESS | 18129 | stateChangeProcessEnqueue: Error transitioning state 19:42:29 INFO - PROCESS | 18129 | UnknownError 19:42:30 INFO - TEST-INFO | 18129: exit 0 19:42:30 INFO - Browser initialized. 19:42:30 INFO - Running cycle 1/1 for kraken test... 19:42:30 INFO - TEST-INFO | started process 18210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXP_pmK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:42:42 INFO - PROCESS | 18210 | RSS: Main: 180973568 19:42:42 INFO - PROCESS | 18210 | 19:42:44 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51101/tests/kraken/driver.html?testName=audio-beat-detection) 19:42:45 INFO - PROCESS | 18210 | RSS: Main: 238182400 19:42:45 INFO - PROCESS | 18210 | 19:42:48 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51101/tests/kraken/driver.html?testName=audio-dft) 19:42:48 INFO - PROCESS | 18210 | RSS: Main: 224382976 19:42:48 INFO - PROCESS | 18210 | 19:42:51 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51101/tests/kraken/driver.html?testName=audio-fft) 19:42:52 INFO - PROCESS | 18210 | RSS: Main: 301764608 19:42:52 INFO - PROCESS | 18210 | 19:42:54 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51101/tests/kraken/driver.html?testName=audio-oscillator) 19:42:55 INFO - PROCESS | 18210 | RSS: Main: 212316160 19:42:55 INFO - PROCESS | 18210 | 19:42:57 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51101/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:42:57 INFO - PROCESS | 18210 | RSS: Main: 213917696 19:42:57 INFO - PROCESS | 18210 | 19:43:00 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51101/tests/kraken/driver.html?testName=imaging-darkroom) 19:43:01 INFO - PROCESS | 18210 | RSS: Main: 252284928 19:43:01 INFO - PROCESS | 18210 | 19:43:04 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51101/tests/kraken/driver.html?testName=imaging-desaturate) 19:43:05 INFO - PROCESS | 18210 | RSS: Main: 251166720 19:43:05 INFO - PROCESS | 18210 | 19:43:08 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51101/tests/kraken/driver.html?testName=json-parse-financial) 19:43:08 INFO - PROCESS | 18210 | RSS: Main: 251473920 19:43:08 INFO - PROCESS | 18210 | 19:43:10 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51101/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:43:10 INFO - PROCESS | 18210 | RSS: Main: 213504000 19:43:10 INFO - PROCESS | 18210 | 19:43:12 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51101/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:43:13 INFO - PROCESS | 18210 | RSS: Main: 220520448 19:43:13 INFO - PROCESS | 18210 | 19:43:15 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51101/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:43:16 INFO - PROCESS | 18210 | RSS: Main: 222412800 19:43:16 INFO - PROCESS | 18210 | 19:43:18 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:43:19 INFO - PROCESS | 18210 | RSS: Main: 223129600 19:43:19 INFO - PROCESS | 18210 | 19:43:21 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:43:22 INFO - PROCESS | 18210 | RSS: Main: 221032448 19:43:22 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | Cycle 1(1): loaded http://localhost:51101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51101/tests/kraken/driver.html?testName=ai-astar) 19:43:24 INFO - PROCESS | 18210 | RSS: Main: 271257600 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | __start_tp_report 19:43:24 INFO - PROCESS | 18210 | _x_x_mozilla_page_load 19:43:24 INFO - PROCESS | 18210 | _x_x_mozilla_page_load_details 19:43:24 INFO - PROCESS | 18210 | |i|pagename|runs| 19:43:24 INFO - PROCESS | 18210 | |0;ai-astar;114;114;131;111;113;113;111;113;112;113 19:43:24 INFO - PROCESS | 18210 | |1;audio-beat-detection;144;123;144;179;125;145;142;123;186;131 19:43:24 INFO - PROCESS | 18210 | |2;audio-dft;160;162;161;162;162;162;162;162;161;163 19:43:24 INFO - PROCESS | 18210 | |3;audio-fft;76;75;76;174;78;78;74;75;175;76 19:43:24 INFO - PROCESS | 18210 | |4;audio-oscillator;91;82;150;82;83;83;146;82;82;141 19:43:24 INFO - PROCESS | 18210 | |5;imaging-gaussian-blur;116;117;116;116;117;116;116;117;117;117 19:43:24 INFO - PROCESS | 18210 | |6;imaging-darkroom;146;147;146;146;146;147;147;146;147;146 19:43:24 INFO - PROCESS | 18210 | |7;imaging-desaturate;95;94;95;95;95;94;95;95;96;96 19:43:24 INFO - PROCESS | 18210 | |8;json-parse-financial;52;51;52;52;52;55;52;52;52;53 19:43:24 INFO - PROCESS | 18210 | |9;json-stringify-tinderbox;60;61;61;61;61;61;64;61;61;62 19:43:24 INFO - PROCESS | 18210 | |10;stanford-crypto-aes;80;78;78;79;78;87;81;79;87;79 19:43:24 INFO - PROCESS | 18210 | |11;stanford-crypto-ccm;136;123;126;122;124;140;140;128;165;127 19:43:24 INFO - PROCESS | 18210 | |12;stanford-crypto-pbkdf2;163;163;161;164;161;163;163;160;165;162 19:43:24 INFO - PROCESS | 18210 | |13;stanford-crypto-sha256-iterative;66;64;64;64;65;66;68;64;64;64 19:43:24 INFO - PROCESS | 18210 | __end_tp_report 19:43:24 INFO - PROCESS | 18210 | __start_cc_report 19:43:24 INFO - PROCESS | 18210 | _x_x_mozilla_cycle_collect,1691 19:43:24 INFO - PROCESS | 18210 | __end_cc_report 19:43:24 INFO - PROCESS | 18210 | __startTimestamp1472611404502__endTimestamp 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | ------- Summary: start ------- 19:43:24 INFO - PROCESS | 18210 | Number of tests: 14 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#0] ai-astar Cycles:10 Average:114.50 Median:113.00 stddev:5.89 (5.2%) stddev-sans-first:6.25 19:43:24 INFO - PROCESS | 18210 | Values: 114.0 114.0 131.0 111.0 113.0 113.0 111.0 113.0 112.0 113.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:144.00 stddev:22.12 (15.4%) stddev-sans-first:23.47 19:43:24 INFO - PROCESS | 18210 | Values: 144.0 123.0 144.0 179.0 125.0 145.0 142.0 123.0 186.0 131.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.60 19:43:24 INFO - PROCESS | 18210 | Values: 160.0 162.0 161.0 162.0 162.0 162.0 162.0 162.0 161.0 163.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:41.55 (54.7%) stddev-sans-first:43.46 19:43:24 INFO - PROCESS | 18210 | Values: 76.0 75.0 76.0 174.0 78.0 78.0 74.0 75.0 175.0 76.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:82.00 stddev:30.19 (36.8%) stddev-sans-first:31.75 19:43:24 INFO - PROCESS | 18210 | Values: 91.0 82.0 150.0 82.0 83.0 83.0 146.0 82.0 82.0 141.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:43:24 INFO - PROCESS | 18210 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:43:24 INFO - PROCESS | 18210 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:43:24 INFO - PROCESS | 18210 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 96.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.06 (2.0%) stddev-sans-first:1.12 19:43:24 INFO - PROCESS | 18210 | Values: 52.0 51.0 52.0 52.0 52.0 55.0 52.0 52.0 52.0 53.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:1.06 (1.7%) stddev-sans-first:1.01 19:43:24 INFO - PROCESS | 18210 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 64.0 61.0 61.0 62.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.50 stddev:3.50 (4.4%) stddev-sans-first:3.71 19:43:24 INFO - PROCESS | 18210 | Values: 80.0 78.0 78.0 79.0 78.0 87.0 81.0 79.0 87.0 79.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:132.00 stddev:13.09 (9.9%) stddev-sans-first:13.85 19:43:24 INFO - PROCESS | 18210 | Values: 136.0 123.0 126.0 122.0 124.0 140.0 140.0 128.0 165.0 127.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 19:43:24 INFO - PROCESS | 18210 | Values: 163.0 163.0 161.0 164.0 161.0 163.0 163.0 160.0 165.0 162.0 19:43:24 INFO - PROCESS | 18210 | 19:43:24 INFO - PROCESS | 18210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:1.37 (2.1%) stddev-sans-first:1.39 19:43:24 INFO - PROCESS | 18210 | Values: 66.0 64.0 64.0 64.0 65.0 66.0 68.0 64.0 64.0 64.0 19:43:24 INFO - PROCESS | 18210 | -------- Summary: end -------- 19:43:24 INFO - PROCESS | 18210 | 19:43:25 INFO - TEST-INFO | 18210: exit 0 19:43:25 INFO - TEST-OK | kraken | took 61835ms 19:43:25 INFO - SUITE-END | took 1178s 19:43:26 INFO - Completed test suite (00:19:38) 19:43:26 INFO - javascript benchmark 19:43:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3004.4591973444785, 3018.200176953108, 3023.4860073787454, 3045.7563394928407, 3078.353545755391, 5214.895702085956, 5280.419153893069, 5290.920636190451, 5333.546648534874, 5349.866253343664, 5359.785608575652, 5391.622586418952, 5429.945700542993, 5453.263809385731, 5471.671699698021, 4844.733539655317, 4882.072406242803, 4930.7534623268875, 4942.703437793726, 5059.620528460362, 5000.624953128512, 5040.1179793535985, 5042.546170844624, 5059.747012649371, 5059.7723102460295, 4753.073150735625, 4813.109574728686, 4874.610031197496, 4875.366202393666, 4952.405711314629, 4832.806687732486, 4842.41890973082, 4849.5635392814465, 4864.464908860023, 4946.530079642428, 4844.176489996674, 4858.684185527929, 4873.195922672755, 4876.21980483121, 4928.802847886081, 5206.947930520684, 5270.130428479296, 5371.248025276464, 5404.486573775485, 5406.08096623575, 5628.352739434977, 5635.830925072254, 5646.2942132233475, 5650.943490565083, 5661.179129026309, 5707.600467967244, 5715.599908006441, 5716.085426331809, 5722.713864306768, 5728.398518155617, 5186.7147306898105, 5300.2314664373835, 5347.2781174541715, 5350.91973620396, 5427.728613569306, 5824.621399609096, 5827.59206855516, 5828.562857785683, 5828.6794226317115, 5832.679202643895, 5602.803901863415, 5609.551235901118, 5610.579206559442, 5613.158026296088, 5613.494785469327, 5517.889642207214, 5683.943160568424, 5715.9142612860005, 5733.741981610838, 5821.912671309934, 5731.455511726379, 5736.483716465538, 5736.770529178786, 5737.8565535861935, 5796.536277097822, 5693.601447898607, 5735.8852822944145, 5746.827595172152, 5748.856278592985, 5750.0, 4338.631216346583, 4379.167958088017, 4381.802818873159, 4418.33724941255, 4424.845130420485, 3970.06703424695, 3987.641112299907, 3987.900302492461, 3988.0827409695353, 3989.7805620691142, 5383.569314454834, 5391.946080539223, 5392.0, 5394.973025134927, 5394.974954758583, 5702.401247868997, 5707.0, 5748.166515855178, 5794.072948328248, 5803.158542011384, 5433.809816656398, 5493.917591236134, 5498.037843377473, 5507.256520369779, 5534.861628459321, 4996.825111121093, 5002.824901128443, 5003.72479513623, 5003.724795136302, 5060.645754797202, 5794.275715535558, 5951.345352011275, 6019.759209631653, 6026.54800889935, 6044.304904935901, 5783.103618939072, 5784.681842498703, 5788.986927287624, 5830.0, 5843.620164689281, 5961.910571341346, 5969.134475501115, 5976.133460648269, 5978.103284507359, 5981.9401805983125, 5416.918746218731, 5634.85912852182, 5673.06394444912, 5678.2050512929045, 5680.11958146488, 5801.535877129735, 5808.651480910989, 5809.2738407699035, 5862.501687356623, 5869.970650146722, 5671.177679236405, 5680.403557626555, 5683.232763576864, 5684.744186511534, 5690.004249256281, 5380.11228147367, 5610.382857885547, 5638.182463542681, 5655.660660360391, 5667.20659107717, 5624.3250809903075, 5665.461781130786, 5688.232088667977, 5692.260006199168, 5694.943050569607, 5659.39978478331, 5722.313322401338, 5739.569532285179, 5744.339400968942, 5748.48263656273, 5397.433269506802, 5555.444455554412, 5600.047991841316, 5630.577706671934, 5632.831015069554], "value": 5303.533706315867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.5073784331945, 604.2084868821844, 611.1596554737235, 615.3477314047108, 622.2905887288495, 43528.0, 45065.098698026064, 45069.09861802762, 45116.54883451165, 48650.27024594634, 45348.319775203396, 45726.0, 45802.41975802418, 45828.31257531131, 45861.31208031882, 8996.460212387261, 9174.724758257264, 9179.173874351307, 9182.449053056838, 9185.173334399902, 8988.056254093324, 9073.59168837404, 9082.727518174466, 9084.591193396313, 9088.091190880892, 9088.0, 9118.361714679975, 9123.315751318645, 9125.908740912606, 9128.132827381389, 9086.04596517366, 9112.908870911273, 9118.452892826452, 9119.908800911971, 9124.726258212264, 9007.774805629911, 9073.773155671095, 9081.091890810932, 9085.954570227173, 9088.863667045, 42034.78982605068, 42072.789636051624, 42225.57774422247, 42498.575014250084, 42563.0, 3496.4411930665196, 3665.486831843544, 3669.284489524544, 3678.70570354371, 3707.5921648618632, 31538.4769218462, 31547.0, 31727.681438664116, 31906.521402178987, 32049.679503205134, 3662.61542538035, 3665.6151104133946, 3693.9865682267136, 3696.5933747287777, 3735.7384983051197, 317133.9999999977, 317511.1982082879, 317544.0, 317567.1216439192, 318557.0, 57697.711511442176, 57953.0, 57976.13035804466, 58006.7099664499, 58030.41969580334, 52340.47659523356, 58059.0, 59517.881960066894, 60944.695276523336, 61027.694861526295, 16917.49247522576, 17277.308907643805, 17388.3044678214, 17443.0, 17448.0, 13666.658333541542, 13757.0, 13781.655458613413, 13783.241921694202, 13797.310134493235, 15152.393904243927, 16715.414960476326, 16850.157492125345, 17101.947766268127, 17246.396376126777, 5897.823065308047, 6014.278286605635, 6058.666773327509, 6172.567920245539, 6266.436020758154, 963.325672029582, 1051.4546945265813, 1091.8034753744244, 1102.2559772153763, 1140.0960396138469, 30936.69063309338, 31033.844830776154, 31217.219569510944, 31782.2054448636, 31829.20426989344, 1077.0629552289558, 1084.6637542361893, 1117.2291119127938, 1127.2447460201683, 1133.3143448213877, 15976.440824571084, 16613.50159495217, 16657.666846663, 16669.0, 16830.15849207535, 518979.0, 525752.0, 526161.0, 526672.0, 526897.0, 56513.71743141258, 56617.0, 56781.0, 56815.431845681844, 56882.14676779851, 1319.1755153029358, 1334.499562664001, 1357.7895426208756, 1358.2936872826076, 1358.436248956672, 29570.556441653822, 30260.24349391283, 30825.229369265948, 31198.844005779825, 31227.84386078055, 50213.0, 50752.0, 50873.23690144725, 50889.23666145085, 50919.74540127424, 399997.0, 401080.0, 402800.0, 404169.0, 405471.0, 34659.0, 39874.0, 40774.59225407708, 40866.89163854518, 41720.20217674885, 45690.77154614338, 46118.0, 46361.30458043199, 46926.0, 47399.289010665554, 37646.62353376431, 38781.0, 40418.79790601146, 40562.39156412715, 41443.37834932539, 39069.0, 39350.40974385444, 39923.0, 40156.0, 41798.58201417947, 39257.0, 39409.211815764094, 40218.3639699458, 40297.597024030554, 40491.79754101211, 32478.0, 35890.28219435649, 36178.8191059043, 36890.262194755414, 37204.627953721196, 27331.59002615002, 27452.313692157855, 27571.448571028064, 27680.723192767815, 27733.168004959884], "value": 19968.66172708585, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.4620761971341, 398.8903051660791, 407.6799712225902, 407.70645135502446, 425.2706608166993, 13281.468741250339, 18209.271629134837, 19014.14436350364, 20170.0, 20205.696914546294, 14765.18791466469, 15157.393704251845, 18223.817761822378, 18461.44615661529, 18542.72185917209, 5574.5506168396205, 5755.597108202427, 5755.683437410961, 5758.798442054529, 5764.481196692297, 5657.462541058593, 5711.257536520267, 5746.913796293059, 5759.107338362561, 5759.827205183851, 5583.888322233553, 5692.174634677969, 5725.656460612356, 5731.885362292752, 5757.510611598019, 5637.408072152447, 5671.319441667027, 5709.086546152616, 5709.400512946143, 5710.486056254937, 5016.724080175625, 5136.04983078128, 5145.819896303648, 5154.974225128888, 5158.974205128988, 16199.271032803552, 20588.27941022072, 21058.052387642594, 21262.787372126237, 23087.0, 2345.3901985483726, 2351.0948284910432, 2436.8903399347073, 2462.5936720441105, 2779.63864697588, 9721.0, 10184.592616295413, 10298.433586152758, 10383.740406489822, 13760.724785504233, 1848.7134494153427, 1874.9156287967073, 1917.319351630165, 1918.4340619517277, 1948.912298946551, 75957.0, 78222.0, 78434.0, 79766.60116699379, 85773.0, 11028.393438360967, 11079.446027698583, 11435.656930292105, 11481.483333250024, 11930.284182949052, 15528.84471155274, 15538.922305388627, 15540.611484712746, 15559.922200388926, 15571.454999074978, 8171.142030086755, 8202.302804261586, 8342.499450033018, 8393.160683931681, 8534.103919088406, 7929.960350198327, 7953.642086106023, 8026.919730802734, 8307.501549906903, 8347.582620868932, 4386.649068074546, 4545.931811022837, 4571.268597024527, 4783.306420569068, 4829.9275510867365, 1919.9232030718895, 2001.1695146514035, 2028.4016215216252, 2048.4673984764067, 2061.309461330441, 835.3359079531787, 897.9955100224457, 932.38462614674, 978.217426059164, 983.7589790501373, 18081.819181808278, 18670.159842807105, 18822.435326940213, 18872.339468118826, 18966.0, 943.4716558727134, 968.7093871838421, 973.3964941736169, 975.6048800235774, 1007.9445630490393, 9910.405375677483, 10567.682969510926, 10579.94710026445, 10646.680599582025, 10647.201459890539, 367909.0, 370736.0, 371284.0, 480967.0, 500491.9458859523, 95657.52171239238, 96106.51946740222, 100791.49604252078, 101610.0, 102679.0, 989.8267803134567, 1006.3659894266711, 1044.1646682653998, 1050.81610718124, 1056.8256237720843, 16172.838271617133, 16938.322467101178, 17580.648387032445, 17995.190216440555, 18115.81884181141, 39751.40372894351, 42940.78529607332, 44079.559204408826, 44617.0, 45947.77026114848, 52665.47334526606, 57357.71321143368, 58641.4135858653, 59084.704576478565, 59504.10743838759, 8037.517748935083, 8112.797180070545, 8202.958985205036, 8352.707655232038, 8382.119877412784, 12402.627921162379, 12503.812442813547, 12669.683257918257, 13218.140820846615, 13275.933620331836, 11490.82763758561, 11643.12676549279, 11707.121965852424, 11727.47226374798, 12069.27584344942, 6825.726970921108, 11360.659180224606, 11490.425478726198, 11651.0, 11691.707707307045, 11055.336679799238, 11420.885791141982, 11485.19603627738, 11693.356865372147, 11793.764124717629, 8136.796580085545, 8148.185181481805, 8228.465149765247, 8300.675810772993, 8534.146585341665, 10796.730081748019, 11421.657350279505, 11491.597794077166, 11555.653330400102, 11961.162718609961], "value": 9070.24618690543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.4554178328674, 1482.4811316039388, 1500.7223663622228, 1630.1278815833523, 1823.507652933708, 8526.616302266397, 8925.330600204987, 8980.550972451376, 9156.90843091569, 9273.258139348853, 8949.731508054769, 9160.496172710515, 9177.724668259963, 9185.311101667368, 9198.126178013095, 2116.608427440921, 2375.5605213035556, 2414.311921102482, 2442.3649851038767, 2443.1815341860497, 2453.288546321565, 2479.0, 2479.0827393864297, 2483.801295896333, 2486.5648511510503, 2387.7134743830766, 2399.2202534176463, 2405.927822165338, 2408.1089996701157, 2410.8553486790847, 2348.4598542335357, 2380.5119950410212, 2388.379021454417, 2437.573424650679, 2441.609342505191, 2408.337707130536, 2441.1944058460667, 2453.031052734178, 2458.1027924807495, 2460.90156393744, 9190.21883139934, 9254.768630784218, 9258.814823703555, 9267.3976191548, 9277.489738064403, 5236.554892834076, 5403.918941215885, 5453.318335208099, 5463.071277882769, 5467.808626698086, 3408.6761757632985, 3418.6581341865863, 3493.650634936486, 3502.509648649191, 3602.171500554887, 1101.944902754859, 1136.6476392318325, 1152.8501294831701, 1158.3455347728507, 1188.875168107345, 11469.0, 11569.826452603302, 11610.825837612443, 11648.475818588184, 11651.825222621668, 4169.353750168729, 4441.289393696993, 4543.750093744809, 4556.339330797082, 4580.496145424001, 9158.633654653739, 9178.586963586522, 9181.632734690671, 9194.080591940752, 9195.954020229856, 5040.168372218616, 5061.240813877874, 5061.974690126526, 5062.645614807002, 5062.873428164326, 4302.3546468030045, 4783.234682450791, 4854.0, 4913.287573301851, 4975.676581022222, 3822.5412950446125, 3873.8063096845044, 3965.940510892339, 4005.5193376794973, 4123.0310876943895, 1242.589945318043, 1254.861965183829, 1255.8430196225472, 1266.1516783754905, 1276.8340115784888, 977.2084611464736, 1002.7793885345212, 1003.934744241622, 1020.5713600287897, 1025.466757286207, 6014.699265036731, 6179.598326108789, 6309.179806625109, 6390.648514331757, 6420.967895160495, 469.1086934823862, 476.4711170600631, 478.30645563931745, 492.0896341767701, 507.92888995540653, 4224.17711970667, 4336.761478118734, 4455.598996090367, 4468.9106217876115, 4526.524714904954, 10799.568017279378, 11126.777464450666, 11220.66338009861, 11285.887141128647, 11287.322760634388, 10916.290441121302, 11094.278871873303, 11240.437978101227, 11261.943690281496, 11272.154588405903, 8133.633986470505, 8205.630746616416, 8210.343172546181, 8235.176482351717, 8246.340292776564, 6140.662263575547, 6176.752929882754, 6227.0, 6242.906356404566, 6304.905426418516, 10056.0, 10354.275200735876, 10369.118624916664, 10407.47962601882, 10410.73973150647, 9908.900910990798, 10040.64857729976, 10175.542100605639, 10269.794604108025, 10576.629817956335, 7159.319864612853, 7841.686332546634, 7975.7607271781935, 8004.279614834692, 8264.380171487042, 8961.283097352065, 9031.909680903107, 9034.45793252407, 9037.864432033393, 9045.638174472948, 7667.616619168908, 7912.881306780518, 7932.524048557105, 7986.560739159402, 8213.0, 7838.0, 7868.409869259714, 7921.603919804102, 7923.762287131395, 7952.721654742057, 7203.891941620985, 7231.602261875647, 7298.197198308288, 7304.598247096461, 7308.415326773739, 5418.566514678895, 5452.890942181055, 5502.147167189092, 5541.445855414427, 5635.211070450058, 5331.466853314638, 5424.511793938565, 5496.890062198813, 5586.720663966867, 5592.860178495407], "value": 4648.453012126206, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.4792108665592, 332.09172912085455, 332.31543021375967, 335.7968429100394, 337.7973216070358, 5218.947810521893, 5234.068921404017, 5267.499587539187, 5280.940433231043, 5332.760025798839, 5188.325517682696, 5254.264402983576, 5259.8422047338545, 5274.103402421598, 5277.70972596508, 4021.698372622065, 4154.688398370126, 4169.166166766644, 4177.436046133764, 4181.498220213563, 4136.841684328393, 4171.186618609372, 4187.916241675165, 4189.685773566979, 4202.138561594881, 4115.641838193389, 4118.979405102985, 4122.587741225869, 4137.710360274782, 4148.792560371984, 3928.135810121769, 3967.940480892789, 4108.849522133807, 4135.304525144691, 4141.068259641572, 3659.670629643318, 3665.7250706196874, 3672.8347224374966, 3679.2641471705497, 3691.7231207659534, 5110.2590124431745, 5129.410117836422, 5132.538071573539, 5134.8202812901745, 5141.460146684619, 4338.956610433886, 4433.512313645497, 4533.342665313544, 4734.19518681825, 4771.8091276348905, 5334.146536554172, 5364.839054828361, 5371.248025276464, 5386.542143917772, 5407.891842163174, 4009.659178969791, 4017.5178978522763, 4034.616711412411, 4037.555868854424, 4041.9191616167805, 5557.3886872444, 5558.86102847428, 5591.580631452657, 5625.803096891589, 5698.1452782083015, 4105.4252404662775, 4119.92881850721, 4130.339145736728, 4136.772477513766, 4137.937930931039, 4194.3289073748665, 4195.5315639525925, 4200.529814564878, 4215.178040282116, 4218.620324170839, 4403.3174857897075, 4640.721556706609, 4720.905581888343, 4721.622270218374, 4732.077244937204, 5418.729063546807, 5442.564594832404, 5442.945570544323, 5444.972775136099, 5447.210154527571, 1400.8093120847197, 1418.3971811979868, 1419.5812235390586, 1424.5583869000436, 1426.486464872645, 921.0634980009661, 945.7682867697321, 948.7153853843819, 953.1612181280428, 965.3773316211004, 4672.0, 4680.4149481314835, 4708.79925618965, 4712.151812673752, 4755.500672429345, 4847.394075740533, 4861.829835955725, 4886.29148773433, 4917.197197597407, 4925.827596034122, 4721.0, 4721.95278047222, 4723.811047558128, 4734.55021772931, 4978.377702787152, 2865.6131422258145, 2891.103757835078, 2962.8370439625596, 2969.8515074246634, 2973.836438995876, 5732.942670573324, 5774.0, 5775.133729940542, 5776.364599894008, 5784.652920824764, 5545.7781688732, 5658.575606829504, 5709.885802283931, 5716.114002329646, 5727.398623144593, 5659.745311461076, 5727.541796656257, 5762.654240745569, 5764.193012978187, 5777.19119323295, 5502.871911258102, 5558.527525160245, 5563.58273129525, 5638.154276858504, 5647.491725744702, 5336.573074153981, 5455.427180146027, 5492.52836223693, 5508.283923090133, 5594.776208951596, 5736.42635736423, 5739.0, 5740.598158128891, 5752.654840709571, 5810.389909059657, 3984.681225501895, 3987.900302492461, 4007.89782809718, 4011.338129208648, 4012.7191096622955, 5425.83722488326, 5505.366882808528, 5528.226048353315, 5544.168374743659, 5549.722513874371, 5392.51467367923, 5393.164059570773, 5398.730063496888, 5407.486288802557, 5412.972935135299, 5285.814996475105, 5410.7284788073985, 5430.67415955044, 5470.206820010996, 5477.507024367826, 5304.58641318207, 5330.680159190461, 5334.253204551288, 5347.385050719217, 5353.97323013398, 5391.838244852661, 5394.622376433612, 5447.836564903059, 5482.369527504388, 5486.286782718221, 5152.793888244429, 5315.893682126413, 5343.248227162936, 5384.300040994645, 5387.568994480511], "value": 4147.353996897274, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.9281321122118, 793.5040599625235, 804.5735760047173, 834.9863226470253, 846.5767116441777, 15486.92256538717, 16920.83079169208, 17018.574535636617, 17021.65956680867, 17024.404145854896, 14846.480373186942, 15137.772933406008, 15288.159151246677, 15380.230988450561, 15393.461228856992, 797.1789057271005, 823.8022874510134, 824.8680211166214, 825.6614787936948, 826.2563692676579, 666.4002397841957, 811.0470197517923, 821.7452589697183, 822.8765685147216, 823.5840900345318, 823.3660081737058, 837.9287760540361, 846.6571038729325, 849.4733265375476, 849.6389034660244, 827.4869580859905, 832.6045128563944, 833.1626715151234, 833.3458235285302, 834.0658462521953, 502.1012387825787, 609.5002098279368, 609.893268677984, 610.7770663707759, 611.4588589098636, 14177.220252886087, 14554.272286385638, 14658.706825863423, 15082.622934426727, 15138.0, 14194.0, 15375.308111134915, 15482.22588870552, 15589.610259743484, 15638.609034774108, 12320.938395307967, 12353.876461235452, 12392.194507356993, 12496.187747796364, 13260.138091024053, 3904.219156168749, 3970.007498125469, 3978.781167035812, 4005.7396269242404, 4090.8159132839096, 78889.60555197245, 79417.20582794157, 82093.0, 82680.0, 82822.0, 11779.293242405483, 11816.409179540988, 11931.761364772656, 12015.699607509881, 12160.817587736192, 21347.46631334229, 21481.140754369964, 21867.890660546913, 21899.562008759734, 21924.780752192593, 8492.333518188316, 8641.265492433087, 8836.91163088361, 8961.059088795713, 9002.774930626656, 4713.622910167179, 4840.733759643183, 4927.310176575283, 4969.254611808257, 5078.7460626968505, 3562.3765840977726, 3702.777833330009, 3724.944125838115, 3727.7576957497677, 3729.776213427203, 638.0588631768105, 646.5118835279428, 651.0884761334075, 653.4706887421204, 661.0183876942737, 738.7525179065074, 741.280957471252, 756.8486302739474, 760.8636347854535, 774.3727580659684, 9277.443353398818, 10250.436226007641, 10809.0, 10911.34531928071, 10964.276494767486, 659.3274859643137, 679.6126208061357, 719.0544434069183, 770.6416516319827, 787.173467858746, 4813.4945830687975, 4873.31773551703, 5006.849794506171, 5019.272205530177, 5035.093683136997, 103592.48203758933, 103748.0, 104186.0, 104363.0, 108714.0, 94954.0, 95465.52267238758, 95723.52138239403, 95979.0, 96562.51718741361, 85521.14478855132, 88175.0, 89441.55279223563, 89597.55201223952, 89835.0, 9460.526973651427, 9646.710598682052, 9732.75668108303, 9735.756606084904, 9740.512974351395, 49369.753151234014, 49515.0, 49627.50372496373, 50641.493585063676, 51050.0, 71749.0, 71952.64023679848, 74066.62966685132, 74410.62794685992, 77105.6630939047, 11954.701132471759, 12231.204971676812, 12411.193272437262, 12512.061595380565, 12964.286964217059, 13852.93073534626, 13970.091944023607, 14065.296735163405, 14109.717805643624, 14178.0, 12976.545820896223, 13023.0, 13605.659858503617, 13715.245661488714, 14141.080829746033, 12075.57735479254, 13145.60563183106, 13408.865911341152, 13914.86085139176, 14735.92632036833, 13868.93065534666, 14113.717725645225, 14413.711725765635, 14486.927565362106, 14507.637309067357, 11003.390944535018, 11268.492917818554, 11293.548258069914, 11959.521619135137, 12043.0, 11689.998413705422, 12081.214721043105, 12085.335306558223, 12148.167353919645, 12227.388630568614], "value": 7683.933646168331, "unit": "score"}], "name": "dromaeo_css", "value": 7225.596032606224, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 131.0, 111.0, 113.0, 113.0, 111.0, 113.0, 112.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 144.0, 179.0, 125.0, 145.0, 142.0, 123.0, 186.0, 131.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 174.0, 78.0, 78.0, 74.0, 75.0, 175.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 82.0, 150.0, 82.0, 83.0, 83.0, 146.0, 82.0, 82.0, 141.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 52.0, 55.0, 52.0, 52.0, 52.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 64.0, 61.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 79.0, 78.0, 87.0, 81.0, 79.0, 87.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 123.0, 126.0, 122.0, 124.0, 140.0, 140.0, 128.0, 165.0, 127.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 164.0, 161.0, 163.0, 163.0, 160.0, 165.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 64.0, 65.0, 66.0, 68.0, 64.0, 64.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1530.8999999999999, "alertThreshold": 2.0}]} 19:43:26 INFO - Return code: 0 19:43:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:43:26 INFO - # TBPL SUCCESS # 19:43:26 INFO - Running post-action listener: _resource_record_post_action 19:43:26 INFO - [mozharness: 2016-08-31 02:43:26.345261Z] Finished run-tests step (success) 19:43:26 INFO - Running post-run listener: _resource_record_post_run 19:43:26 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 406466560; Read time: 0; Write time: 382352 19:43:26 INFO - TinderboxPrint: CPU usage
13.1% 19:43:26 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:43:26 INFO - TinderboxPrint: I/O write bytes / time
406,466,560 / 382,352 19:43:26 INFO - TinderboxPrint: CPU idle
8,294.0 (86.9%) 19:43:26 INFO - TinderboxPrint: CPU user
1,199.0 (12.6%) 19:43:26 INFO - TinderboxPrint: Swap in / out
0 / 0 19:43:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118034432; Read time: 0; Write time: 139012 19:43:26 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288079872; Read time: 0; Write time: 243340 19:43:26 INFO - Running post-run listener: _upload_blobber_files 19:43:26 INFO - Blob upload gear active. 19:43:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:43:26 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 19:43:26 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:43:26 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:43:27 INFO - (blobuploader) - INFO - Open directory for files ... 19:43:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:31 INFO - (blobuploader) - INFO - Done attempting. 19:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:43:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:32 INFO - (blobuploader) - INFO - Done attempting. 19:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:43:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:32 INFO - (blobuploader) - INFO - Done attempting. 19:43:32 INFO - (blobuploader) - INFO - Iteration through files over. 19:43:32 INFO - Return code: 0 19:43:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:43:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:43:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/60a40edc4cb5b94ca9f7d228298ad08063fc8f698f63552aaf82bd35ea9726cb38cc11a58804f8b22ddf7b7bdf5501cf16d0323128742c87c57a30419a4f86de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03946fb62777d4b81128ad1289526722b90dd795565249aae4515d390d651f3e016490e576fc976d29bc40725432d72d383062cfda018453c93e0485092e42a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8fbc7ee5e505d7c7e39aecc18b8cbc6ca4e1f8c6b0e188b3016386122d40d94acb734cce30bfc01837396e4a5dcd635f84df65dc189338fb634e1522195510c4"} 19:43:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:43:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:43:32 INFO - Contents: 19:43:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/60a40edc4cb5b94ca9f7d228298ad08063fc8f698f63552aaf82bd35ea9726cb38cc11a58804f8b22ddf7b7bdf5501cf16d0323128742c87c57a30419a4f86de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03946fb62777d4b81128ad1289526722b90dd795565249aae4515d390d651f3e016490e576fc976d29bc40725432d72d383062cfda018453c93e0485092e42a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8fbc7ee5e505d7c7e39aecc18b8cbc6ca4e1f8c6b0e188b3016386122d40d94acb734cce30bfc01837396e4a5dcd635f84df65dc189338fb634e1522195510c4"} 19:43:32 INFO - Running post-run listener: copy_logs_to_upload_dir 19:43:32 INFO - Copying logs to upload dir... 19:43:32 INFO - mkdir: /builds/slave/test/build/upload/logs 19:43:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.384287 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-30 19:43:32.807154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 19:43:32.810457) ========= 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=db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739 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-Inbound/sha512/60a40edc4cb5b94ca9f7d228298ad08063fc8f698f63552aaf82bd35ea9726cb38cc11a58804f8b22ddf7b7bdf5501cf16d0323128742c87c57a30419a4f86de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03946fb62777d4b81128ad1289526722b90dd795565249aae4515d390d651f3e016490e576fc976d29bc40725432d72d383062cfda018453c93e0485092e42a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8fbc7ee5e505d7c7e39aecc18b8cbc6ca4e1f8c6b0e188b3016386122d40d94acb734cce30bfc01837396e4a5dcd635f84df65dc189338fb634e1522195510c4"} build_url:https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/YtLK7lMjRNqao0KXquarBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/60a40edc4cb5b94ca9f7d228298ad08063fc8f698f63552aaf82bd35ea9726cb38cc11a58804f8b22ddf7b7bdf5501cf16d0323128742c87c57a30419a4f86de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03946fb62777d4b81128ad1289526722b90dd795565249aae4515d390d651f3e016490e576fc976d29bc40725432d72d383062cfda018453c93e0485092e42a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8fbc7ee5e505d7c7e39aecc18b8cbc6ca4e1f8c6b0e188b3016386122d40d94acb734cce30bfc01837396e4a5dcd635f84df65dc189338fb634e1522195510c4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 19:43:32.836103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:43:32.836439) ========= 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=db0483c52d987ecb441a263b000001ad-1472610171.851909-1180766739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:43:32.919025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 19:43:32.919380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 19:43:32.919671) ========= ========= Total master_lag: 0.17 =========