builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1482463259.55 results: success (0) buildid: 20161222182453 builduid: 335f367e40164d33934720f884c1448b revision: 82574d098a94527588b6be7d800785ccb11df961 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 19:20:59.547566) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 19:20:59.547967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 19:20:59.548246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 19:20:59.562566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:20:59.562833) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-22 19:21:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-12-22 19:21:00 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:20:59.727178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:20:59.727466) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019095 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:20:59.777041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:20:59.777381) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 82574d098a94527588b6be7d800785ccb11df961 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 82574d098a94527588b6be7d800785ccb11df961 --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=9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-22 19:21:00,309 truncating revision to first 12 chars 2016-12-22 19:21:00,309 Setting DEBUG logging. 2016-12-22 19:21:00,309 attempt 1/10 2016-12-22 19:21:00,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/82574d098a94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 19:21:00,625 unpacking tar archive at: mozilla-central-82574d098a94/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:21:00.422591) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 19:21:00.422904) ========= script_repo_revision: 82574d098a94527588b6be7d800785ccb11df961 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 19:21:00.423736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 19:21:00.424137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 19:21:00.433693) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-22 19:21:00.433974) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:21:01 INFO - MultiFileLogger online at 20161222 19:21:01 in /builds/slave/test 19:21:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:21:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:21:01 INFO - {'append_to_log': False, 19:21:01 INFO - 'base_work_dir': '/builds/slave/test', 19:21:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:21:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:21:01 INFO - 'branch': 'Firefox-Non-PGO', 19:21:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:21:01 INFO - 'config_files': ('talos/linux_config.py',), 19:21:01 INFO - 'default_actions': ('clobber', 19:21:01 INFO - 'read-buildbot-config', 19:21:01 INFO - 'download-and-extract', 19:21:01 INFO - 'populate-webroot', 19:21:01 INFO - 'create-virtualenv', 19:21:01 INFO - 'install', 19:21:01 INFO - 'run-tests'), 19:21:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:21:01 INFO - 'download_minidump_stackwalk': True, 19:21:01 INFO - 'download_symbols': 'ondemand', 19:21:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:21:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:21:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:21:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:21:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:21:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:21:01 INFO - 'installer_path': 'installer.exe', 19:21:01 INFO - 'log_level': 'info', 19:21:01 INFO - 'log_name': 'talos', 19:21:01 INFO - 'log_to_console': True, 19:21:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:21:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:21:01 INFO - 'opt_config_files': (), 19:21:01 INFO - 'pip_index': False, 19:21:01 INFO - 'sps_profile': False, 19:21:01 INFO - 'sps_profile_interval': 0, 19:21:01 INFO - 'suite': 'dromaeojs', 19:21:01 INFO - 'system_bits': '32', 19:21:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:21:01 INFO - 'title': 'talos-linux64-ix-013', 19:21:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:21:01 INFO - 'use_talos_json': True, 19:21:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:21:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:21:01 INFO - 'work_dir': 'build'} 19:21:01 INFO - [mozharness: 2016-12-23 03:21:01.061587Z] Running clobber step. 19:21:01 INFO - Running pre-action listener: _resource_record_pre_action 19:21:01 INFO - Running main action method: clobber 19:21:01 INFO - rmtree: /builds/slave/test/build 19:21:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:21:01 INFO - Running post-action listener: _resource_record_post_action 19:21:01 INFO - [mozharness: 2016-12-23 03:21:01.533507Z] Finished clobber step (success) 19:21:01 INFO - [mozharness: 2016-12-23 03:21:01.533607Z] Running read-buildbot-config step. 19:21:01 INFO - Running pre-action listener: _resource_record_pre_action 19:21:01 INFO - Running main action method: read_buildbot_config 19:21:01 INFO - Using buildbot properties: 19:21:01 INFO - { 19:21:01 INFO - "project": "", 19:21:01 INFO - "product": "firefox", 19:21:01 INFO - "script_repo_revision": "production", 19:21:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:21:01 INFO - "repository": "", 19:21:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 19:21:01 INFO - "buildid": "20161222182453", 19:21:01 INFO - "pgo_build": "False", 19:21:01 INFO - "basedir": "/builds/slave/test", 19:21:01 INFO - "buildnumber": 353, 19:21:01 INFO - "slavename": "talos-linux64-ix-013", 19:21:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:21:01 INFO - "platform": "ubuntu64_hw", 19:21:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:21:01 INFO - "branch": "mozilla-central", 19:21:01 INFO - "repo_path": "mozilla-central", 19:21:01 INFO - "revision": "82574d098a94527588b6be7d800785ccb11df961", 19:21:01 INFO - "stage_platform": "linux64", 19:21:01 INFO - "builduid": "335f367e40164d33934720f884c1448b", 19:21:01 INFO - "slavebuilddir": "test" 19:21:01 INFO - } 19:21:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 19:21:01 INFO - Running post-action listener: _resource_record_post_action 19:21:01 INFO - [mozharness: 2016-12-23 03:21:01.536064Z] Finished read-buildbot-config step (success) 19:21:01 INFO - [mozharness: 2016-12-23 03:21:01.536266Z] Running download-and-extract step. 19:21:01 INFO - Running pre-action listener: _resource_record_pre_action 19:21:01 INFO - Running main action method: download_and_extract 19:21:01 INFO - mkdir: /builds/slave/test/build/tests 19:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:01 INFO - trying https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:21:01 INFO - Downloading https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:21:02 INFO - Downloaded 1361 bytes. 19:21:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:21:02 INFO - Using the following test package requirements: 19:21:02 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:21:02 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:21:02 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:21:02 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:02 INFO - u'jsshell-linux-x86_64.zip'], 19:21:02 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:21:02 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:21:02 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:21:02 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:21:02 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:21:02 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:21:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:21:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:21:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:21:02 INFO - Fetch https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:21:02 INFO - Expected file size: 20272629 19:21:02 INFO - Obtained file size: 20272629 19:21:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:21:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:21:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:21:06 INFO - Fetch https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:21:07 INFO - Expected file size: 20272629 19:21:07 INFO - Obtained file size: 20272629 19:21:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 19:21:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:21:12 INFO - Fetch https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:21:12 INFO - Expected file size: 14409776 19:21:12 INFO - Obtained file size: 14409776 19:21: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:21:13 INFO - trying https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:21:13 INFO - Downloading https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:21:15 INFO - Downloaded 55743952 bytes. 19:21:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:21:15 INFO - mkdir: /builds/slave/test/properties 19:21:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:21:15 INFO - Writing to file /builds/slave/test/properties/build_url 19:21:15 INFO - Contents: 19:21:15 INFO - build_url:https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:21:15 INFO - Running post-action listener: _resource_record_post_action 19:21:15 INFO - Running post-action listener: set_extra_try_arguments 19:21:15 INFO - [mozharness: 2016-12-23 03:21:15.812300Z] Finished download-and-extract step (success) 19:21:15 INFO - [mozharness: 2016-12-23 03:21:15.812528Z] Running populate-webroot step. 19:21:15 INFO - Running pre-action listener: _resource_record_pre_action 19:21:15 INFO - Running main action method: populate_webroot 19:21:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:21:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:21:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:21:15 INFO - '--tppagecycles', 19:21:15 INFO - '7'], 19:21:15 INFO - 'tests': ['tsvgm']}}, 19:21:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:21:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:21:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:21:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:21:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:21:15 INFO - 'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:21:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:21:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:21:15 INFO - 'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['damp', 'tps']}, 19:21:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:21:15 INFO - 'tests': ['damp', 'tps']}, 19:21:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['dromaeo_dom']}, 19:21:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:21:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['basic_compositor_video']}, 19:21:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:21:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['a11yr', 19:21:15 INFO - 'ts_paint', 19:21:15 INFO - 'tpaint', 19:21:15 INFO - 'sessionrestore', 19:21:15 INFO - 'sessionrestore_no_auto_restore', 19:21:15 INFO - 'tabpaint']}, 19:21:15 INFO - 'other-e10s': {'tests': ['a11yr', 19:21:15 INFO - 'ts_paint', 19:21:15 INFO - 'tpaint', 19:21:15 INFO - 'sessionrestore', 19:21:15 INFO - 'sessionrestore_no_auto_restore', 19:21:15 INFO - 'tabpaint']}, 19:21:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:21:15 INFO - 'ts_paint', 19:21:15 INFO - 'tpaint', 19:21:15 INFO - 'sessionrestore', 19:21:15 INFO - 'sessionrestore_no_auto_restore', 19:21:15 INFO - 'tabpaint']}, 19:21:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:21:15 INFO - 'ts_paint', 19:21:15 INFO - 'tpaint', 19:21:15 INFO - 'sessionrestore', 19:21:15 INFO - 'sessionrestore_no_auto_restore', 19:21:15 INFO - 'tabpaint']}, 19:21:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['a11yr', 19:21:15 INFO - 'ts_paint', 19:21:15 INFO - 'tpaint', 19:21:15 INFO - 'sessionrestore', 19:21:15 INFO - 'sessionrestore_no_auto_restore', 19:21:15 INFO - 'tabpaint']}, 19:21:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['a11yr', 19:21:15 INFO - 'ts_paint', 19:21:15 INFO - 'tpaint', 19:21:15 INFO - 'sessionrestore', 19:21:15 INFO - 'sessionrestore_no_auto_restore', 19:21:15 INFO - 'tabpaint']}, 19:21:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['tsvgx', 19:21:15 INFO - 'tsvgr_opacity', 19:21:15 INFO - 'tart', 19:21:15 INFO - 'tscrollx', 19:21:15 INFO - 'cart', 19:21:15 INFO - 'tsvg_static']}, 19:21:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:21:15 INFO - 'tsvgr_opacity', 19:21:15 INFO - 'tart', 19:21:15 INFO - 'tscrollx', 19:21:15 INFO - 'cart', 19:21:15 INFO - 'tsvg_static']}, 19:21:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:21:15 INFO - 'talos_options': ['--disable-e10s'], 19:21:15 INFO - 'tests': ['tp5o']}, 19:21:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:21:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:21:15 INFO - 'talos_options': ['--disable-e10s', 19:21:15 INFO - '--xperf_path', 19:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:21:15 INFO - 'tests': ['tp5n']}, 19:21:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:21:15 INFO - 'talos_options': ['--xperf_path', 19:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:21:15 INFO - 'tests': ['tp5n']}}, 19:21:15 INFO - 'talos.zip': {'path': '', 19:21:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:21:15 INFO - Running post-action listener: _resource_record_post_action 19:21:15 INFO - [mozharness: 2016-12-23 03:21:15.827548Z] Finished populate-webroot step (success) 19:21:15 INFO - [mozharness: 2016-12-23 03:21:15.827661Z] Running create-virtualenv step. 19:21:15 INFO - Running pre-action listener: _resource_record_pre_action 19:21:15 INFO - Running main action method: create_virtualenv 19:21:15 INFO - Creating virtualenv /builds/slave/test/build/venv 19:21:15 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:21:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:21:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:21:15 INFO - Using real prefix '/usr' 19:21:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:21:16 INFO - Installing distribute.............................................................................................................................................................................................done. 19:21:18 INFO - Installing pip.................done. 19:21:18 INFO - Return code: 0 19:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:21:18 INFO - Reading from file tmpfile_stdout 19:21:18 INFO - Output received: 19:21:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:21:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:21: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:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21: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:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21: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', 'pip>=1.5'] in /builds/slave/test/build 19:21: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 pip>=1.5 19:21:18 INFO - Using env: {'DISPLAY': ':0', 19:21:18 INFO - 'HOME': '/home/cltbld', 19:21:18 INFO - 'LANG': 'en_US.UTF-8', 19:21:18 INFO - 'LANGUAGE': 'en_US:en', 19:21:18 INFO - 'LOGNAME': 'cltbld', 19:21:18 INFO - 'MAIL': '/var/mail/cltbld', 19:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:18 INFO - 'MOZ_NO_REMOTE': '1', 19:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:18 INFO - 'NO_EM_RESTART': '1', 19:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:18 INFO - 'PWD': '/builds/slave/test', 19:21:18 INFO - 'SHELL': '/bin/bash', 19:21:18 INFO - 'SHLVL': '1', 19:21:18 INFO - 'TERM': 'linux', 19:21:18 INFO - 'TMOUT': '86400', 19:21:18 INFO - 'USER': 'cltbld', 19:21:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:18 INFO - '_': '/tools/buildbot/bin/python'} 19:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:18 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:21:18 INFO - Cleaning up... 19:21:18 INFO - Return code: 0 19:21:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:21: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:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21: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:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21: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', '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 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:21: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 psutil>=3.1.1 19:21:18 INFO - Using env: {'DISPLAY': ':0', 19:21:18 INFO - 'HOME': '/home/cltbld', 19:21:18 INFO - 'LANG': 'en_US.UTF-8', 19:21:18 INFO - 'LANGUAGE': 'en_US:en', 19:21:18 INFO - 'LOGNAME': 'cltbld', 19:21:18 INFO - 'MAIL': '/var/mail/cltbld', 19:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:18 INFO - 'MOZ_NO_REMOTE': '1', 19:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:18 INFO - 'NO_EM_RESTART': '1', 19:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:18 INFO - 'PWD': '/builds/slave/test', 19:21:18 INFO - 'SHELL': '/bin/bash', 19:21:18 INFO - 'SHLVL': '1', 19:21:18 INFO - 'TERM': 'linux', 19:21:18 INFO - 'TMOUT': '86400', 19:21:18 INFO - 'USER': 'cltbld', 19:21:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:18 INFO - '_': '/tools/buildbot/bin/python'} 19:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:19 INFO - Downloading/unpacking psutil>=3.1.1 19:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:21:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:21:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:21:21 INFO - Installing collected packages: psutil 19:21:21 INFO - Running setup.py install for psutil 19:21:21 INFO - building 'psutil._psutil_linux' extension 19:21:21 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:21:21 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:21:21 INFO - building 'psutil._psutil_posix' extension 19:21:21 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:21:21 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:21:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:21:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:21:21 INFO - Successfully installed psutil 19:21:21 INFO - Cleaning up... 19:21:21 INFO - Return code: 0 19:21:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:21:21 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:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:21 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:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:21 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 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21:21 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:21:21 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:21:21 INFO - Using env: {'DISPLAY': ':0', 19:21:21 INFO - 'HOME': '/home/cltbld', 19:21:21 INFO - 'LANG': 'en_US.UTF-8', 19:21:21 INFO - 'LANGUAGE': 'en_US:en', 19:21:21 INFO - 'LOGNAME': 'cltbld', 19:21:21 INFO - 'MAIL': '/var/mail/cltbld', 19:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:21 INFO - 'MOZ_NO_REMOTE': '1', 19:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:21 INFO - 'NO_EM_RESTART': '1', 19:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:21 INFO - 'PWD': '/builds/slave/test', 19:21:21 INFO - 'SHELL': '/bin/bash', 19:21:21 INFO - 'SHLVL': '1', 19:21:21 INFO - 'TERM': 'linux', 19:21:21 INFO - 'TMOUT': '86400', 19:21:21 INFO - 'USER': 'cltbld', 19:21:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:21 INFO - '_': '/tools/buildbot/bin/python'} 19:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:21: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:21: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:21: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:21: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:21: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:21: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:21:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:21:23 INFO - Installing collected packages: mozsystemmonitor 19:21:23 INFO - Running setup.py install for mozsystemmonitor 19:21:24 INFO - Successfully installed mozsystemmonitor 19:21:24 INFO - Cleaning up... 19:21:24 INFO - Return code: 0 19:21:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:21:24 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:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:24 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:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:24 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 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21:24 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:21:24 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:21:24 INFO - Using env: {'DISPLAY': ':0', 19:21:24 INFO - 'HOME': '/home/cltbld', 19:21:24 INFO - 'LANG': 'en_US.UTF-8', 19:21:24 INFO - 'LANGUAGE': 'en_US:en', 19:21:24 INFO - 'LOGNAME': 'cltbld', 19:21:24 INFO - 'MAIL': '/var/mail/cltbld', 19:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:24 INFO - 'MOZ_NO_REMOTE': '1', 19:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:24 INFO - 'NO_EM_RESTART': '1', 19:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:24 INFO - 'PWD': '/builds/slave/test', 19:21:24 INFO - 'SHELL': '/bin/bash', 19:21:24 INFO - 'SHLVL': '1', 19:21:24 INFO - 'TERM': 'linux', 19:21:24 INFO - 'TMOUT': '86400', 19:21:24 INFO - 'USER': 'cltbld', 19:21:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:24 INFO - '_': '/tools/buildbot/bin/python'} 19:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:24 INFO - Downloading/unpacking jsonschema==2.5.1 19:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:21:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:21: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:21: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:21: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:21: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:21: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:21: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:21:26 INFO - Downloading functools32-3.2.3-2.tar.gz 19:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:21:26 INFO - warning: no files found matching '*.txt' 19:21:26 INFO - no previously-included directories found matching 'build' 19:21:26 INFO - no previously-included directories found matching 'dist' 19:21:26 INFO - no previously-included directories found matching '.git*' 19:21:26 INFO - Installing collected packages: jsonschema, functools32 19:21:26 INFO - Running setup.py install for functools32 19:21:26 INFO - warning: no files found matching '*.txt' 19:21:26 INFO - no previously-included directories found matching 'build' 19:21:26 INFO - no previously-included directories found matching 'dist' 19:21:26 INFO - no previously-included directories found matching '.git*' 19:21:26 INFO - Successfully installed jsonschema functools32 19:21:26 INFO - Cleaning up... 19:21:26 INFO - Return code: 0 19:21:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:21:26 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:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:26 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:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:26 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 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21:26 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:21:26 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:21:26 INFO - Using env: {'DISPLAY': ':0', 19:21:26 INFO - 'HOME': '/home/cltbld', 19:21:26 INFO - 'LANG': 'en_US.UTF-8', 19:21:26 INFO - 'LANGUAGE': 'en_US:en', 19:21:26 INFO - 'LOGNAME': 'cltbld', 19:21:26 INFO - 'MAIL': '/var/mail/cltbld', 19:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:26 INFO - 'MOZ_NO_REMOTE': '1', 19:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:26 INFO - 'NO_EM_RESTART': '1', 19:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:26 INFO - 'PWD': '/builds/slave/test', 19:21:26 INFO - 'SHELL': '/bin/bash', 19:21:26 INFO - 'SHLVL': '1', 19:21:26 INFO - 'TERM': 'linux', 19:21:26 INFO - 'TMOUT': '86400', 19:21:26 INFO - 'USER': 'cltbld', 19:21:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:26 INFO - '_': '/tools/buildbot/bin/python'} 19:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:21:27 INFO - Cleaning up... 19:21:27 INFO - Return code: 0 19:21:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:21:27 INFO - Using env: {'DISPLAY': ':0', 19:21:27 INFO - 'HOME': '/home/cltbld', 19:21:27 INFO - 'LANG': 'en_US.UTF-8', 19:21:27 INFO - 'LANGUAGE': 'en_US:en', 19:21:27 INFO - 'LOGNAME': 'cltbld', 19:21:27 INFO - 'MAIL': '/var/mail/cltbld', 19:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:27 INFO - 'MOZ_NO_REMOTE': '1', 19:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:27 INFO - 'NO_EM_RESTART': '1', 19:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:27 INFO - 'PWD': '/builds/slave/test', 19:21:27 INFO - 'SHELL': '/bin/bash', 19:21:27 INFO - 'SHLVL': '1', 19:21:27 INFO - 'TERM': 'linux', 19:21:27 INFO - 'TMOUT': '86400', 19:21:27 INFO - 'USER': 'cltbld', 19:21:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:27 INFO - '_': '/tools/buildbot/bin/python'} 19:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:27 INFO - Downloading/unpacking blobuploader==1.2.4 19:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:29 INFO - Downloading blobuploader-1.2.4.tar.gz 19:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:21:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:21:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:30 INFO - Downloading docopt-0.6.1.tar.gz 19:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:21:30 INFO - Installing collected packages: blobuploader, requests, docopt 19:21:30 INFO - Running setup.py install for blobuploader 19:21:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:21:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:21:30 INFO - Running setup.py install for requests 19:21:30 INFO - Running setup.py install for docopt 19:21:30 INFO - Successfully installed blobuploader requests docopt 19:21:30 INFO - Cleaning up... 19:21:30 INFO - Return code: 0 19:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:30 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 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21:30 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:21:30 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:21:30 INFO - Using env: {'DISPLAY': ':0', 19:21:30 INFO - 'HOME': '/home/cltbld', 19:21:30 INFO - 'LANG': 'en_US.UTF-8', 19:21:30 INFO - 'LANGUAGE': 'en_US:en', 19:21:30 INFO - 'LOGNAME': 'cltbld', 19:21:30 INFO - 'MAIL': '/var/mail/cltbld', 19:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:30 INFO - 'MOZ_NO_REMOTE': '1', 19:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:30 INFO - 'NO_EM_RESTART': '1', 19:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:30 INFO - 'PWD': '/builds/slave/test', 19:21:30 INFO - 'SHELL': '/bin/bash', 19:21:30 INFO - 'SHLVL': '1', 19:21:30 INFO - 'TERM': 'linux', 19:21:30 INFO - 'TMOUT': '86400', 19:21:30 INFO - 'USER': 'cltbld', 19:21:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:30 INFO - '_': '/tools/buildbot/bin/python'} 19:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:21:30 INFO - Running setup.py (path:/tmp/pip-g4p7ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:21:31 INFO - Running setup.py (path:/tmp/pip-6ZoTwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:21:31 INFO - Running setup.py (path:/tmp/pip-eVRGQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:21:31 INFO - Running setup.py (path:/tmp/pip-SVT85n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:21:31 INFO - Running setup.py (path:/tmp/pip-w8JBvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:21:31 INFO - Running setup.py (path:/tmp/pip-5w6H7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:21:31 INFO - Running setup.py (path:/tmp/pip-C_ZqEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:21:31 INFO - Running setup.py (path:/tmp/pip-Fwen20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:21:31 INFO - Running setup.py (path:/tmp/pip-XZQrQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:21:31 INFO - Running setup.py (path:/tmp/pip-XhP4fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:21:31 INFO - Running setup.py (path:/tmp/pip-i4qEo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:21:31 INFO - Running setup.py (path:/tmp/pip-aq1Det-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:21:31 INFO - Running setup.py (path:/tmp/pip-8h_aM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:21:31 INFO - Running setup.py (path:/tmp/pip-K0QiZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:31 INFO - Running setup.py (path:/tmp/pip-7Hegun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:21:32 INFO - Running setup.py (path:/tmp/pip-gf7PGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:21:32 INFO - Running setup.py (path:/tmp/pip-S8uXN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:21:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:21:32 INFO - Running setup.py install for manifestparser 19:21:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:21:32 INFO - Running setup.py install for mozcrash 19:21:32 INFO - Running setup.py install for mozdebug 19:21:32 INFO - Running setup.py install for mozdevice 19:21:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:21:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:21:32 INFO - Running setup.py install for mozfile 19:21:32 INFO - Running setup.py install for mozhttpd 19:21:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:21:32 INFO - Running setup.py install for mozinfo 19:21:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:21:32 INFO - Running setup.py install for mozInstall 19:21:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:21:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:21:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:21:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:21:32 INFO - Running setup.py install for mozleak 19:21:33 INFO - Running setup.py install for mozlog 19:21:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:21:33 INFO - Running setup.py install for moznetwork 19:21:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:21:33 INFO - Running setup.py install for mozprocess 19:21:33 INFO - Running setup.py install for mozprofile 19:21:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:21:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:21:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:21:33 INFO - Running setup.py install for mozrunner 19:21:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:21:33 INFO - Running setup.py install for mozscreenshot 19:21:33 INFO - Running setup.py install for moztest 19:21:33 INFO - Running setup.py install for mozversion 19:21:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:21:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:21:33 INFO - Cleaning up... 19:21:33 INFO - Return code: 0 19:21:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:21:33 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:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:33 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:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:33 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 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21:33 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:21:33 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:21:33 INFO - Using env: {'DISPLAY': ':0', 19:21:33 INFO - 'HOME': '/home/cltbld', 19:21:33 INFO - 'LANG': 'en_US.UTF-8', 19:21:33 INFO - 'LANGUAGE': 'en_US:en', 19:21:33 INFO - 'LOGNAME': 'cltbld', 19:21:33 INFO - 'MAIL': '/var/mail/cltbld', 19:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:33 INFO - 'MOZ_NO_REMOTE': '1', 19:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:33 INFO - 'NO_EM_RESTART': '1', 19:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:33 INFO - 'PWD': '/builds/slave/test', 19:21:33 INFO - 'SHELL': '/bin/bash', 19:21:33 INFO - 'SHLVL': '1', 19:21:33 INFO - 'TERM': 'linux', 19:21:33 INFO - 'TMOUT': '86400', 19:21:33 INFO - 'USER': 'cltbld', 19:21:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:33 INFO - '_': '/tools/buildbot/bin/python'} 19:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:21:34 INFO - Running setup.py (path:/tmp/pip-vmObqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:21:34 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:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:21:34 INFO - Running setup.py (path:/tmp/pip-5hCPx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:21:34 INFO - Running setup.py (path:/tmp/pip-_Drp44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:21:34 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:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:21:34 INFO - Running setup.py (path:/tmp/pip-ukpOno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:21:34 INFO - Running setup.py (path:/tmp/pip-B9BJE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:21:34 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:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:21:34 INFO - Running setup.py (path:/tmp/pip-_IRtAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:21:34 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:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:21:34 INFO - Running setup.py (path:/tmp/pip-HaEEMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:21:34 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:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:21:34 INFO - Running setup.py (path:/tmp/pip-Hjorii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:21:34 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:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:21:34 INFO - Running setup.py (path:/tmp/pip-QRcioQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:21:34 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:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:21:34 INFO - Running setup.py (path:/tmp/pip-R19tc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:21:34 INFO - Running setup.py (path:/tmp/pip-gXtymX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:21:34 INFO - Running setup.py (path:/tmp/pip-PYYofm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:21:35 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:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:21:35 INFO - Running setup.py (path:/tmp/pip-mo78_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:21:35 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:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:21:35 INFO - Running setup.py (path:/tmp/pip-TUXo2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:35 INFO - Running setup.py (path:/tmp/pip-Lq_Ppz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:35 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:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:21:35 INFO - Running setup.py (path:/tmp/pip-C7zMi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:21:35 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:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:21:35 INFO - Running setup.py (path:/tmp/pip-sLgL4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:21:35 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:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:21:35 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:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:21:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:21:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:37 INFO - Downloading blessings-1.6.tar.gz 19:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:21:37 INFO - Installing collected packages: blessings 19:21:37 INFO - Running setup.py install for blessings 19:21:37 INFO - Successfully installed blessings 19:21:37 INFO - Cleaning up... 19:21:37 INFO - Return code: 0 19:21:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:21:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:21:37 INFO - Reading from file tmpfile_stdout 19:21:37 INFO - Current package versions: 19:21:37 INFO - argparse == 1.2.1 19:21:37 INFO - blessings == 1.6 19:21:37 INFO - blobuploader == 1.2.4 19:21:37 INFO - docopt == 0.6.1 19:21:37 INFO - functools32 == 3.2.3-2 19:21:37 INFO - jsonschema == 2.5.1 19:21:37 INFO - manifestparser == 1.1 19:21:37 INFO - mozInstall == 1.12 19:21:37 INFO - mozcrash == 1.0 19:21:37 INFO - mozdebug == 0.1 19:21:37 INFO - mozdevice == 0.49 19:21:37 INFO - mozfile == 1.2 19:21:37 INFO - mozhttpd == 0.7 19:21:37 INFO - mozinfo == 0.9 19:21:37 INFO - mozleak == 0.1 19:21:37 INFO - mozlog == 3.4 19:21:37 INFO - moznetwork == 0.27 19:21:37 INFO - mozprocess == 0.23 19:21:37 INFO - mozprofile == 0.28 19:21:37 INFO - mozrunner == 6.13 19:21:37 INFO - mozscreenshot == 0.1 19:21:37 INFO - mozsystemmonitor == 0.3 19:21:37 INFO - moztest == 0.7 19:21:37 INFO - mozversion == 1.4 19:21:37 INFO - psutil == 3.1.1 19:21:37 INFO - requests == 1.2.3 19:21:37 INFO - wsgiref == 0.1.2 19:21:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:21:37 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:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:37 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:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:37 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 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21:37 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:21:37 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:21:37 INFO - Using env: {'DISPLAY': ':0', 19:21:37 INFO - 'HOME': '/home/cltbld', 19:21:37 INFO - 'LANG': 'en_US.UTF-8', 19:21:37 INFO - 'LANGUAGE': 'en_US:en', 19:21:37 INFO - 'LOGNAME': 'cltbld', 19:21:37 INFO - 'MAIL': '/var/mail/cltbld', 19:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:37 INFO - 'MOZ_NO_REMOTE': '1', 19:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:37 INFO - 'NO_EM_RESTART': '1', 19:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:37 INFO - 'PWD': '/builds/slave/test', 19:21:37 INFO - 'SHELL': '/bin/bash', 19:21:37 INFO - 'SHLVL': '1', 19:21:37 INFO - 'TERM': 'linux', 19:21:37 INFO - 'TMOUT': '86400', 19:21:37 INFO - 'USER': 'cltbld', 19:21:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:37 INFO - '_': '/tools/buildbot/bin/python'} 19:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 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:21:38 INFO - Cleaning up... 19:21:38 INFO - Return code: 0 19:21:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:38 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 0x13571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1467a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', '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:21:38 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:21:38 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:21:38 INFO - Using env: {'DISPLAY': ':0', 19:21:38 INFO - 'HOME': '/home/cltbld', 19:21:38 INFO - 'LANG': 'en_US.UTF-8', 19:21:38 INFO - 'LANGUAGE': 'en_US:en', 19:21:38 INFO - 'LOGNAME': 'cltbld', 19:21:38 INFO - 'MAIL': '/var/mail/cltbld', 19:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:38 INFO - 'MOZ_NO_REMOTE': '1', 19:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:38 INFO - 'NO_EM_RESTART': '1', 19:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:38 INFO - 'PWD': '/builds/slave/test', 19:21:38 INFO - 'SHELL': '/bin/bash', 19:21:38 INFO - 'SHLVL': '1', 19:21:38 INFO - 'TERM': 'linux', 19:21:38 INFO - 'TMOUT': '86400', 19:21:38 INFO - 'USER': 'cltbld', 19:21:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:38 INFO - '_': '/tools/buildbot/bin/python'} 19:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:21:38 INFO - Cleaning up... 19:21:38 INFO - Return code: 0 19:21:38 INFO - Running post-action listener: _resource_record_post_action 19:21:38 INFO - Running post-action listener: _start_resource_monitoring 19:21:38 INFO - Starting resource monitoring. 19:21:38 INFO - [mozharness: 2016-12-23 03:21:38.428141Z] Finished create-virtualenv step (success) 19:21:38 INFO - [mozharness: 2016-12-23 03:21:38.428675Z] Running install step. 19:21:38 INFO - Running pre-action listener: _resource_record_pre_action 19:21:38 INFO - Running main action method: install 19:21:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:21:38 INFO - Reading from file tmpfile_stdout 19:21:38 INFO - Detecting whether we're running mozinstall >=1.0... 19:21:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:21:38 INFO - Reading from file tmpfile_stdout 19:21:38 INFO - Output received: 19:21:38 INFO - Usage: mozinstall [options] installer 19:21:38 INFO - Options: 19:21:38 INFO - -h, --help show this help message and exit 19:21:38 INFO - -d DEST, --destination=DEST 19:21:38 INFO - Directory to install application into. [default: 19:21:38 INFO - "/builds/slave/test"] 19:21:38 INFO - --app=APP Application being installed. [default: firefox] 19:21:38 INFO - mkdir: /builds/slave/test/build/application 19:21:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:21:54 INFO - Reading from file tmpfile_stdout 19:21:54 INFO - Output received: 19:21:54 INFO - /builds/slave/test/build/application/firefox/firefox 19:21:54 INFO - Running post-action listener: _resource_record_post_action 19:21:54 INFO - [mozharness: 2016-12-23 03:21:54.809393Z] Finished install step (success) 19:21:54 INFO - [mozharness: 2016-12-23 03:21:54.809636Z] Running run-tests step. 19:21:54 INFO - Running pre-action listener: _resource_record_pre_action 19:21:54 INFO - Running main action method: run_tests 19:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:21:54 INFO - Python 2.7.3 19:21:54 INFO - Return code: 0 19:21:54 INFO - grabbing minidump binary from tooltool 19:21: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:21:54 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 0x1752850>, '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 0x16c76d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:21:54 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:21:54 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:21:54 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:21:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:21:54 INFO - Return code: 0 19:21:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:21:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:21:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:21:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:21:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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:21:54 INFO - Using env: {'DISPLAY': ':0', 19:21:54 INFO - 'HOME': '/home/cltbld', 19:21:54 INFO - 'LANG': 'en_US.UTF-8', 19:21:54 INFO - 'LANGUAGE': 'en_US:en', 19:21:54 INFO - 'LOGNAME': 'cltbld', 19:21:54 INFO - 'MAIL': '/var/mail/cltbld', 19:21:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:21:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:54 INFO - 'MOZ_NO_REMOTE': '1', 19:21:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:54 INFO - 'NO_EM_RESTART': '1', 19:21:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:54 INFO - 'PWD': '/builds/slave/test', 19:21:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:21:54 INFO - 'SHELL': '/bin/bash', 19:21:54 INFO - 'SHLVL': '1', 19:21:54 INFO - 'TERM': 'linux', 19:21:54 INFO - 'TMOUT': '86400', 19:21:54 INFO - 'USER': 'cltbld', 19:21:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564', 19:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:54 INFO - '_': '/tools/buildbot/bin/python'} 19:21:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:21:55 INFO - mozversion application_buildid: 20161222182453 19:21:55 INFO - mozversion application_changeset: 82574d098a94527588b6be7d800785ccb11df961 19:21:55 INFO - mozversion application_display_name: Nightly 19:21:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:21:55 INFO - mozversion application_name: Firefox 19:21:55 INFO - mozversion application_remotingname: firefox 19:21:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:21:55 INFO - mozversion application_vendor: Mozilla 19:21:55 INFO - mozversion application_version: 53.0a1 19:21:55 INFO - mozversion platform_buildid: 20161222182453 19:21:55 INFO - mozversion platform_changeset: 82574d098a94527588b6be7d800785ccb11df961 19:21:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:21:55 INFO - mozversion platform_version: 53.0a1 19:21:55 INFO - using testdate: 1482463315 19:21:55 INFO - actual date: 1482463315 19:21:55 INFO - starting webserver on 'localhost:36210' 19:21:55 INFO - SUITE-START | Running 2 tests 19:21:55 INFO - TEST-START | dromaeo_css 19:21:55 INFO - operating with platform_type : linux_ 19:21:55 INFO - Initialising browser for dromaeo_css test... 19:21:55 INFO - TEST-INFO | started process 3507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCAPBM3/profile http://localhost:36210/getInfo.html) 19:21:55 INFO - PROCESS | 3507 | 1482463315597 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 19:21:59 INFO - PROCESS | 3507 | __metrics Screen width/height:1600/1200 19:21:59 INFO - PROCESS | 3507 | colorDepth:24 19:21:59 INFO - PROCESS | 3507 | Browser inner width/height: 1024/697 19:21:59 INFO - PROCESS | 3507 | __metrics 19:21:59 INFO - PROCESS | 3507 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:21:59 INFO - PROCESS | 3507 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:22:00 INFO - PROCESS | 3507 | console.error: PushService: 19:22:00 INFO - PROCESS | 3507 | stateChangeProcessEnqueue: Error transitioning state 19:22:00 INFO - PROCESS | 3507 | UnknownError 19:22:01 INFO - TEST-INFO | 3507: exit 0 19:22:01 INFO - Browser initialized. 19:22:01 INFO - Running cycle 1/1 for dromaeo_css test... 19:22:01 INFO - TEST-INFO | started process 3589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCAPBM3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:13 INFO - PROCESS | 3589 | RSS: Main: 150884352 19:22:13 INFO - PROCESS | 3589 | 19:23:04 INFO - PROCESS | 3589 | 1482463384290 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:25:18 INFO - PROCESS | 3589 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36210/tests/dromaeo/cssquery-ext.html) 19:25:20 INFO - PROCESS | 3589 | RSS: Main: 275066880 19:25:20 INFO - PROCESS | 3589 | 19:27:02 INFO - PROCESS | 3589 | ************************* 19:27:02 INFO - PROCESS | 3589 | A coding exception was thrown and uncaught in a Task. 19:27:02 INFO - PROCESS | 3589 | 19:27:02 INFO - PROCESS | 3589 | Full message: ReferenceError: fetch is not defined 19:27:02 INFO - PROCESS | 3589 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 19:27:02 INFO - PROCESS | 3589 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 19:27:02 INFO - PROCESS | 3589 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 19:27:02 INFO - PROCESS | 3589 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:27:02 INFO - PROCESS | 3589 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:27:02 INFO - PROCESS | 3589 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:27:02 INFO - PROCESS | 3589 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 19:27:02 INFO - PROCESS | 3589 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:27:02 INFO - PROCESS | 3589 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:27:02 INFO - PROCESS | 3589 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:27:02 INFO - PROCESS | 3589 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 19:27:02 INFO - PROCESS | 3589 | 19:27:02 INFO - PROCESS | 3589 | ************************* 19:28:22 INFO - PROCESS | 3589 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-ext.html (next: http://localhost:36210/tests/dromaeo/cssquery-jquery.html) 19:28:23 INFO - PROCESS | 3589 | RSS: Main: 256589824 19:28:23 INFO - PROCESS | 3589 | 19:31:25 INFO - PROCESS | 3589 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36210/tests/dromaeo/cssquery-mootools.html) 19:31:26 INFO - PROCESS | 3589 | RSS: Main: 188866560 19:31:26 INFO - PROCESS | 3589 | 19:34:28 INFO - PROCESS | 3589 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36210/tests/dromaeo/cssquery-prototype.html) 19:34:29 INFO - PROCESS | 3589 | RSS: Main: 207831040 19:34:29 INFO - PROCESS | 3589 | 19:37:32 INFO - PROCESS | 3589 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36210/tests/dromaeo/cssquery-yui.html) 19:37:33 INFO - PROCESS | 3589 | RSS: Main: 187019264 19:37:33 INFO - PROCESS | 3589 | 19:40:36 INFO - PROCESS | 3589 | Cycle 1(1): loaded http://localhost:36210/tests/dromaeo/cssquery-yui.html (next: http://localhost:36210/tests/dromaeo/cssquery-dojo.html) 19:40:36 INFO - PROCESS | 3589 | RSS: Main: 282419200 19:40:36 INFO - PROCESS | 3589 | 19:40:36 INFO - PROCESS | 3589 | __start_tp_report 19:40:36 INFO - PROCESS | 3589 | _x_x_mozilla_page_load 19:40:36 INFO - PROCESS | 3589 | _x_x_mozilla_page_load_details 19:40:36 INFO - PROCESS | 3589 | |i|pagename|runs| 19:40:36 INFO - PROCESS | 3589 | |0;dojo.html;2619.3975385661297;2657.1629936569966;2674.4249986252953;2685.62401263823;2690.8789104490284;4580.816767329311;4628.051249493854;4753.928691069633;4824.300476430915;4857.902841943159;4675.368825208596;4787.904241915159;4816.325714399987;4856.951430485694;4894.461609222983;4295;4324.437823083011;4332.111917057012;4339.674524410666;4403.295472724365;4328.523862375137;4388.188185185735;4405.295152775557;4435.356873253377;4461.5092339842595;4371.34429835524;4423.690341676084;4434.933475997863;4446.888277930518;4476.619487343563;4205.642520385771;4230.302000169968;4237.533871274158;4305.50486694031;4315.223259813232;4326.848560300375;4347.7173983690955;4357.150355680644;4407.382966384709;4412.24991751403;4751.691140075884;4751.714897106184;4784.162771515006;4784.569388755029;4785.8564243072415;4875.561199492063;4937;5111.1566591512355;5120.155174396257;5153.201253805666;5080.644354895159;5100.132977393815;5136.255242989783;5142.588592912595;5202.97398513005;4802.8799280018275;4815.6388270879825;4816.831410900601;4853.854384368439;4865.172920603506;5221.242919776687;5221.765020574007;5224.60815438836;5234.92147617786;5256.106461901486;4868.561829435368;4923.975380123076;4924.778384972685;5021.397432308147;5045.268436076748;5134.512221338967;5212.296339994128;5213.843584692465;5216.843494695166;5217.7912883485;5069.746512674352;5078.898422031539;5106.208537676592;5122.1804511278015;5128.512551517422;5099.260607211933;5103.617228707862;5107.438181799999;5113.7698803553185;5147.485251474823;4126.319157339006;4153.418521407006;4154.605312495308;4260.424842646203;4279.657627389864;3738.420544815558;3778.905527361838;3788.791616461066;3791.450239715226;3799.164183879542;4441.133978874153;4445.488768791631;4446.866594002185;4453.910921781546;4479.753613551221;5071.644984851099;5077.26379674945;5085.160948443466;5086.949130508721;5155.510226528549;4248.87253382399;4280.850170244089;4318.352247162888;4328.134373125387;4353.651707863363;4547.795349209294;4559.430071241095;4580.519045500175;4598.954010459853;4602.332661764025;4752.833650822274;4788.348019933118;4791.712497250176;4804.159272127434;4828.613710903049;4955.82654607087;4993.251012348177;4999.625028122832;5104.540591346797;5117.974410128075;4718.693284936468;4767.6662633615315;4793.185158523129;4805.879853003563;4859.8299059534165;5073.7716802743225;5073.898522029613;5079.6698214615935;5123.615728820428;5123.692578445305;5136.0755064087325;5142.202958541432;5142.485751424828;5146.485351464824;5188.58491320701;4837.879053023562;4871.707697538159;4880.145974454385;4961;5017.648764586444;4916.188828843344;4938.777755000961;4946.802127914843;4991.575716064175;4995.000999799981;4853.708777473363;4905.190643543775;4905.3623029006;4911.214205727067;4951.1088004158155;4920.975395123001;4992.625553083606;5001.399832020181;5011.699298042129;5057.443681195139;4815.470298267118;4823;4862.149123903374;4867.123917694707;4873.171560834738 19:40:36 INFO - PROCESS | 3589 | |1;ext.html;519.2263527344257;520.2950002746279;525.6950968438306;535.9437259087796;536.6753114365808;27390.315242118933;37315.62684373155;38638.99999999996;38803.80598097012;42386;40019;40434.19131617366;40506.39240411389;40556.79721601388;40565;7117.323854233865;7553.395728341733;7720.112187098472;7725.034370703662;7730.381569474456;7249.021382113427;9749;9950.154236889874;9956.452395118265;10299;10037.648682296121;10088.192944564416;10089.394636321807;10092.142167915736;10139.695809125702;10028.197744180448;10062.597496100147;10077.54651040705;10086.949565252164;10091.596336146618;9874.210063194927;9938.850917236246;9943.80112397748;9949.75125621858;9950.552225149813;37879.62120378789;38224.235515289816;38252;38272;38301.23397532062;3097.2461744139227;3131.937361252785;3175.7935734177204;3190.489521676521;3403.23427228874;25237.49525009508;25598.488030239292;25803.225903222934;28401.289967750767;28661.28346791326;3191.5850939377965;3225.403300389412;3252.7235185009304;3258.9185270368193;3292.3909076820864;248290;250049;250426;250537.6827896513;251859.74070129715;46494;46751.25989920798;46878.76560617175;46879.1248350069;46910;48480.27279590809;48517.514824852005;48614.756926215145;48680;48748;13349.933250333686;13592;13633.250171240677;13634.181949083088;13635.795463068062;8365;8443.493390396596;10242.231832612435;10307.226957978182;10388.636397726043;13519.797203041962;13612.183269003892;13663.726725465434;15013.24933753308;15262.542123736306;6058.363871793398;6443.838904027437;6476.4495017924;6478.773242936474;6533.24867640218;778.622368151446;812.4069429316633;925.2644147902433;947.7583216279943;953.6423841059602;26652.73347266541;27679;28258.858705706753;28267.293317667223;28274.151775446768;883.4787475389551;978.1978777402604;1016.1515134862325;1043.8486419469134;1068.1454836131063;14625.707485850224;14705;14888.255587220596;15080.622984425258;15100.848991509944;116873;117166;117738;117789.41105294418;118042;48875.755621221666;49159.26261106086;49541.25688114681;49615;49652.75173624109;1148.896599306083;1200.4657927222302;1201.6575276046285;1201.7776711308436;1202.6392082375253;25872.611910820975;26935.73064269332;27459.588106178024;27485.595438307093;27773.86113069422;41825;42164.578354216064;42243.3663495054;42302.788486057376;42312.576874232094;288704;292120;292647;293792;293866;24737.50524989526;25018.749812501643;25334.49331013406;25351.873240634417;25447.10935117262;41553.79223103865;41659.58340416557;42182.228908135585;42319;42382.15235695207;34273.485897711056;35207;35374;35534.46698299579;35695;34028.65971340255;34307.14232144116;34683.82658086693;34716.652833471344;35053;34239.31521369509;34740.826295868355;35490;35563.64436355707;35604.109897252776;30188.547171792;32060.51909221317;32327.51508727324;32342.19144521406;32496;24125.51748964976;24659;24788.876055620327;24975.500489989736;25157.87421062883 19:40:36 INFO - PROCESS | 3589 | |2;jquery.html;338.4753631870603;358.04045158973975;361.65461983805466;366.4173963398196;378.8445242011863;12119.878801211986;15246.313915873785;15266;15590.298436570352;16227.83772162278;15153.469628563002;15578.766318505202;15685.29416176272;15714.135722535257;15981.84018159818;3762.3039737648487;4531.116432295704;4679.508651591585;4684.203685373478;5045.419776725668;4989.950100499003;5035.370578677665;5054.696718196901;5055.620828437864;5068.72122033288;5024.497550244964;5025.246213068032;5025.924611130836;5031.069252188338;5033.597312215014;5163.974180129094;5316.654417462872;5319.28189694394;5324.7071411072375;5326.147816349404;5035.370578677665;5154.38147422308;5160.380754309507;5164.380274367062;5200.609954253446;12046.879531204664;12061.457234424472;12224.511019559208;12240.387980601023;12240.81638775419;1845.372573325076;1848.5378655336167;1851.1484717030182;1859.2098358197711;2038.2458490358663;9135.40619859707;9465.195458386046;9477.099675530813;9678.370905891095;12289.631311060682;1650.4553497345967;1725.3961113610137;1747.0827815396892;1751.9299228030864;1788.1148831328576;62349.746415878;65682.67158664225;66122.3387766121;66831.66584167047;67764.32235677679;9500.809983800285;9554.474503902353;9643;9809.656662016796;9920.603175873028;13450.730985380238;13467.191968481922;13486.595402137755;13499.527516536875;13500;6785.219699734495;7005.7547985821275;7035.542689725152;7241.746538871114;7248.60132692707;6679.933200668028;6724.293949135368;6899.48253880961;6901.551399159039;6943.270956549591;4188.539260681323;4197.538270790211;4203.726757760735;4248.426462427595;4271.444712187395;1702.2595171100363;1754.9034803085697;1760.313477743681;1775.4229875290323;1812.3113216977465;806.8547661421001;825.533573530953;837.7779888329597;851.0255757158019;876.3077169036517;14736.926315368355;15567.221638918008;15788.447404340794;15806.288717007763;15857.444989425314;808.9595520223966;827.5200383777394;840.932725381968;845.1928408370114;850.8340873529726;8696.652133914698;8722.495566822425;9036.548172591343;9191.126842949909;9309.95345023284;179711;179969;180876;181382;181399.0930045368;57238;66802;67846;69431;75967;918.5728636184207;946.9479178645103;960.4573416019927;963.7060696487639;969.7381706939087;14716.55850324492;14761.261936902896;15079.095254284777;15287.159206243763;15518.275014488012;35259.47110793392;36259;36719;36817.815910921345;36930;50509.242361365345;50672.49327506825;51064;51189.74405128099;51449;7436.888446673196;7515.661795219119;7612.581308028111;10468.790624187626;10567.89432105669;11156.44217789091;11692.479977602858;11983.64049078529;12276.877231227574;12526.373681315716;10208.234382421497;10323.32898361604;10452.895471045193;10797.082248009006;10935.726606834893;9389.342746007715;10298.124659404035;10373.429461379697;10678.679639610824;10769.192310576582;10856.13150947938;10887.673369798918;10949.726256843642;10969.945150274516;11048.904415680106;10624.84062739075;10852.89877843787;10927.45362731876;11002.009819116318;11185.105191584817;10792.730181745519;10811.69572076334;10941.781164376509;11000.962896072107;11099.112071034137 19:40:36 INFO - PROCESS | 3589 | |3;mootools.html;1197.1679682620581;1349.0286993364778;1368.0492058019674;1452.5206681795003;1660.5682522544134;5792.304923409191;6943.958406239067;7201.963990180055;7213.3507984281405;7384.520006199593;7229.060222171123;7294.088238970129;7297.635118244093;7304.488685791996;7309.890351644716;1781.9376321828738;1839.9724004139948;2042.1627132875524;2071.989640051798;2079.511314841011;2035.1452389996164;2112.5986062648126;2115.947101322464;2132.3922682035623;2139.5827813576357;2065.989670051648;2067.8138967492923;2069.596428696405;2072.046858445117;2074.097767471155;2026.8682535635137;2045.2841505473114;2070.3167954575106;2078.7609424916177;2079.9168033278725;1987.7614686237744;2010.45717656232;2011.3965810256864;2029.9797002029939;2034.9796502035085;7052.541584796972;7176.390006849424;7185.137783466018;7202.603856787875;7214.67533960973;4308.224519586473;4439.733615983051;4443.977780111079;4450.46594408673;4451.955480445219;2641.77544908683;2757.4347258811895;2781.276868014311;2788.3029242689327;2811.9578206326923;850.3962186847345;887.573964497045;894.2130924786212;900.7072701372081;907.4963395315597;9505;9534.570944307523;9575.281853860919;9576.186024187882;9584.329096963216;3887.5140607423505;4030.717849750548;4076.8165432555606;4153.231652144363;4158.584141585818;8192.426530142833;8206.343492520584;8209.466384684976;8210;8229.711960081368;4448.043670610834;4473.776311184428;4474.574915383034;4476.485204201494;4477.350784136347;3544.5392099027476;3783.3379158647126;4099.282625540519;4105.3020986432375;4107.753534787863;3348.41402754517;3426.4130581411373;3470.531478250404;3471.8437670304393;3499.230169362736;1097.1935627313917;1106.7343837478948;1118.8377685235596;1123.8763735989035;1124.9325040497433;797.5254723439544;812.4191203289677;815.3436483630734;825.2613910550024;826.3802148388709;4682.548409992914;4713.599344055725;4750;4895.7062576245535;5086.643934924594;401.08752587862847;407.6697874721485;412.44526112378804;418.3160532529276;424.22367068265004;3383.8477268522975;3388.6272510023878;3400.6769356911054;3401.9829900850336;3519.3137338219312;8389.874151887727;8801.075887031897;8822.77943051416;8832.823343533093;8839;8770.51762153075;8773.605187766565;8774.29805615562;8776.429532080394;8783.429077109968;6551.672416379162;6782.389584937379;6836.487263455261;6847.931520684829;6856.485763567753;4690.577847993697;4694.178518759271;4752.88117797044;4786.545278198566;4897.314375987294;7657.961710191414;7747.30274275318;7849.097353804157;7891.921080789349;7969;7815.29662330393;7904.367650587824;8012.118666946748;8111.675532978851;8201.466904651179;5885.61743486672;6051.062085376773;6793.966030169818;6928.549644273106;6931.584104953719;6624.403803657694;6838.897416538656;6861.55399899005;7029.9648501757165;7037.507374483737;6050.394960503914;6054.3340232575265;6242.5942313749465;6265.843353916189;6362.9681851592295;5850.912236316373;5899.646021238739;6147.323794382703;6187.288461826947;6217.751289948533;5700.971495142498;5789.247397838254;5832.096025116114;5833.883322333445;5838.2702162229725;4291;4345.478542574911;4347.6304514116655;4391.3193455014525;4465.620422264144;4282.571742825692;4288.849890253826;4315.223259813264;4468.79890404939;4560.133574620944 19:40:36 INFO - PROCESS | 3589 | |4;prototype.html;334.4665258912036;347.82608695652175;348.7001178986073;349.38159457759764;352.6913950293495;4825.541573550516;4862.2220444728855;4870.65905386623;4896.869861610202;4910.901781964359;4606.124836281104;4665.580097791198;4707.05858828234;4756.857294281169;4859.9831070105865;3862.2275544890995;3865.5697391965014;3867.7292589518606;3877.689784817215;3884.5139110969003;3859.459675645412;3861.903452413684;3865.6327648873453;3871.9545722654866;3886.961130388688;3640.5995340512522;3740.129935032484;3756.1548651553317;3806.638369354907;3848.749831260959;3804;3812.2566099610585;3829.885103446901;3838.7696738195796;3845.673242731253;3433.484977253432;3434.8969530914114;3440.3291358185165;3443.9483407748903;3452.2922800826022;4538.410006699141;4735.12400205963;4753.191957367256;4756.6432517561325;4771.188897887368;4334.891627709332;4363.716358436692;4365.672574556921;4370.868873933755;4374.956250437487;5068.619853511002;5096.79612815487;5098.541131298164;5105.009046471879;5119.513646203604;3793.2223894101644;3795.221979494197;3805.733598648068;3818.274527839729;3821.5032045833864;5105.668131571436;5224.346956630421;5230.372355317349;5235.9004609032145;5270.710110943896;3811.5997820228476;3828.693704503633;3831.7700937943814;3839.2897313997;3841.846326146923;3887.669548088444;3889.2999260133447;3899.512560929884;3912.139329347539;3923.293807114747;4002.6597739192493;4200.306949353322;4374.431323927933;4389.385486031958;4393.538678438782;5007.4491805901325;5010.774515146827;5014.5737612303365;5050.949490505048;5060.2156665716875;1225.6078055022308;1232.4577186038114;1234.6481252843075;1235.32057368447;1235.8393408856791;791.5765065689828;804.8611215130642;828.7596596986806;843.7300063979591;849.7323343146888;4240.685387529876;4263.552327005682;4273.290683726472;4278.358246263086;4278.55075217104;4975.487378873646;4990.451050384455;4996.90006199874;5025.271335656309;5037.69773813565;4044.9214867819637;4256.723312984646;4267.67992400565;4277.091577727113;4295.162443323585;2637.723039080869;2647.483740670589;2667.906623268176;2685.44948285601;2690.3543149643942;4680.227762419163;4685.625149987993;4687.5781179693995;4699.130660827758;4735.739534325645;5069.5944324454695;5105.617078719111;5108.438071812097;5123.436421993578;5354.330708661418;4852.757362131879;4892.315075889307;4895.363602731622;4924.3105965164905;4938.456769755324;5241.768184476721;5244.265802787537;5282.81510147143;5287.286216360742;5296.814611488579;4871.87820304481;5105.285260063668;5122.871928201825;5164.406093299319;5164.870878228075;4895.559399654048;4901.3383193268455;4905.852824415273;4909.312696222603;4916.0905232532095;3566.341651132236;3572.3386077372525;3600.3699352612666;3600.765950213228;3613.1870329176777;5092;5177.637565370388;5212.784566559273;5218.634695571273;5233.947660523346;5027.321311622884;5069.188929771219;5081.161608334732;5081.491850815037;5088.618353623567;5046.974765126298;5066.4680208577565;5074.82238121664;5077.466865979019;5083.229639846219;4797.7601119943165;4956.256561515802;4990.525900039491;5026.723530205873;5039.3448851649055;4846.442659094108;4967.677100988424;4993.525615066563;5105.591552675852;5120.84924331789;4945.876353091202;4952.653314268111;4956.653034287565;4959.752012399438;4986.775595098156 19:40:36 INFO - PROCESS | 3589 | |5;yui.html;656.4387448731335;664.8138521214062;669.2938949408373;729.9920760697303;747.4058123791585;12354.691132721686;13395.129316594415;13416.798748018775;13420.865791342083;13438.260895650748;12400.937995310034;12469.314187719672;12472.501099956013;12505.312207828565;12574.05694572906;607.696151924038;629.295189387884;746.7461063238497;759.760675387254;769.9461037727361;785.6229010075167;788.42051092447;789.0728394136895;789.1280135450331;789.6999140326668;830.3979614779267;831.55096248026;833.2625626320689;835.6991483066091;836.60679480644;635.920509936258;658.6509150150428;662.8342914271432;665.500874344237;829.8008477965275;489.3589397888777;582.0570675505666;601.1553766957431;602.2261394108549;603.1224568253225;12786.296753678544;12811.231326120462;12823.74352512954;12852.871471285262;12878.80681789774;12058.69853253667;12160.939195304056;12262.570810021696;12350.691232719164;12416.875831241663;11236.269642473295;11329.603463878808;11360.48877800501;11579.710507237301;11706.180567360288;3897.259520691088;3899.454076429302;3947.9013024674327;3953.031507280735;4031.07285324377;64143.67928160376;64584;65557.3444265556;65981.67009164924;66714.99999999952;9555.140037396668;9697.321187516805;9738;9779.902200977898;9858.556364963593;17931.641367172582;17934.19296131677;17954.102294885204;17955.192016359295;17982.730259046126;6536.509761767791;6540.70566824494;6570.178727659043;6735.158105236846;7016.824579385556;3525.347810655037;3580;3587.497750314958;3610.1335679436747;3654.3056819204267;2700.1629494856656;2751.614773931611;2773.5839624056553;2788.2889863084783;2797.2447439191305;482;506.1471420656206;507.2948601443996;517.319724562207;524.6170295684095;487.98012154597063;547.2529996554674;552.2020680117192;556.5630979680931;589.7699897040158;8261.752147435587;8339.166083391612;8545.851050058289;8750.86873696895;8888.291088793303;549.3353042818235;561.332014902265;584.6346033728919;601.0533409879457;606.5269090109722;3878.3212937735784;3969.126792105732;4005.078831868628;4049.0687141957515;4134.607212314825;69938.3006169942;70263;70279;72769;73537.26462735412;58787.41212587905;59831.401685982586;60238;60664.090038649454;65146.348536514975;55496.72251638716;56049;56259;56361;56460.43539564634;7364.116306043309;7490;7786.532808031537;7809.882851757115;7940.880886786587;38313.808430957666;38711.2257754849;39366.60633393744;40423;40490;46565.3015204779;50919;51592.48407516027;52590.474095258556;55189;9557.378770379903;9590.42457452555;9775.315727898978;9788.021197880154;9833.16418104469;11305.660830175108;11339.829902551302;11601.883981160081;11602.593909213138;11811;10323.741906452398;10601.310914790514;10618.681439556825;10864.185186110915;10882.40146791934;10569.682909512727;10652.89347106519;10809.783804323712;11223.71940701489;11225.60710375133;10396.428196448966;10579.31234469757;10901.400422976496;11404.315741055563;11410.258333208647;8898.154675305836;9038.231750301298;9117.36178467501;9221.631134754534;9528.85706714386;8475.576221188792;8733.606987685442;9098.363114581916;9118.863217051618;9200.769980750534 19:40:36 INFO - PROCESS | 3589 | __end_tp_report 19:40:36 INFO - PROCESS | 3589 | __start_cc_report 19:40:36 INFO - PROCESS | 3589 | _x_x_mozilla_cycle_collect,1429 19:40:36 INFO - PROCESS | 3589 | __end_cc_report 19:40:36 INFO - PROCESS | 3589 | __startTimestamp1482464436630__endTimestamp 19:40:36 INFO - PROCESS | 3589 | 19:40:36 INFO - PROCESS | 3589 | ------- Summary: start ------- 19:40:36 INFO - PROCESS | 3589 | Number of tests: 6 19:40:36 INFO - PROCESS | 3589 | 19:40:36 INFO - PROCESS | 3589 | [#0] dojo.html Cycles:165 Average:4705.20 Median:4853.71 stddev:503.41 (10.4%) stddev-sans-first:477.62 19:40:36 INFO - PROCESS | 3589 | Values: 2619.4 2657.2 2674.4 2685.6 2690.9 4580.8 4628.1 4753.9 4824.3 4857.9 4675.4 4787.9 4816.3 4857.0 4894.5 4295.0 4324.4 4332.1 4339.7 4403.3 4328.5 4388.2 4405.3 4435.4 4461.5 4371.3 4423.7 4434.9 4446.9 4476.6 4205.6 4230.3 4237.5 4305.5 4315.2 4326.8 4347.7 4357.2 4407.4 4412.2 4751.7 4751.7 4784.2 4784.6 4785.9 4875.6 4937.0 5111.2 5120.2 5153.2 5080.6 5100.1 5136.3 5142.6 5203.0 4802.9 4815.6 4816.8 4853.9 4865.2 5221.2 5221.8 5224.6 5234.9 5256.1 4868.6 4924.0 4924.8 5021.4 5045.3 5134.5 5212.3 5213.8 5216.8 5217.8 5069.7 5078.9 5106.2 5122.2 5128.5 5099.3 5103.6 5107.4 5113.8 5147.5 4126.3 4153.4 4154.6 4260.4 4279.7 3738.4 3778.9 3788.8 3791.5 3799.2 4441.1 4445.5 4446.9 4453.9 4479.8 5071.6 5077.3 5085.2 5086.9 5155.5 4248.9 4280.9 4318.4 4328.1 4353.7 4547.8 4559.4 4580.5 4599.0 4602.3 4752.8 4788.3 4791.7 4804.2 4828.6 4955.8 4993.3 4999.6 5104.5 5118.0 4718.7 4767.7 4793.2 4805.9 4859.8 5073.8 5073.9 5079.7 5123.6 5123.7 5136.1 5142.2 5142.5 5146.5 5188.6 4837.9 4871.7 4880.1 4961.0 5017.6 4916.2 4938.8 4946.8 4991.6 4995.0 4853.7 4905.2 4905.4 4911.2 4951.1 4921.0 4992.6 5001.4 5011.7 5057.4 4815.5 4823.0 4862.1 4867.1 4873.2 19:40:36 INFO - PROCESS | 3589 | 19:40:36 INFO - PROCESS | 3589 | [#1] ext.html Cycles:180 Average:38571.37 Median:3275.65 stddev:60872.71 (1858.3%) stddev-sans-first:60976.42 19:40:36 INFO - PROCESS | 3589 | Values: 519.2 520.3 525.7 535.9 536.7 27390.3 37315.6 38639.0 38803.8 42386.0 40019.0 40434.2 40506.4 40556.8 40565.0 7117.3 7553.4 7720.1 7725.0 7730.4 7249.0 9749.0 9950.2 9956.5 10299.0 10037.6 10088.2 10089.4 10092.1 10139.7 10028.2 10062.6 10077.5 10086.9 10091.6 9874.2 9938.9 9943.8 9949.8 9950.6 37879.6 38224.2 38252.0 38272.0 38301.2 3097.2 3131.9 3175.8 3190.5 3403.2 25237.5 25598.5 25803.2 28401.3 28661.3 3191.6 3225.4 3252.7 3258.9 3292.4 248290.0 250049.0 250426.0 250537.7 251859.7 46494.0 46751.3 46878.8 46879.1 46910.0 48480.3 48517.5 48614.8 48680.0 48748.0 13349.9 13592.0 13633.3 13634.2 13635.8 8365.0 8443.5 10242.2 10307.2 10388.6 13519.8 13612.2 13663.7 15013.2 15262.5 6058.4 6443.8 6476.4 6478.8 6533.2 778.6 812.4 925.3 947.8 953.6 26652.7 27679.0 28258.9 28267.3 28274.2 883.5 978.2 1016.2 1043.8 1068.1 14625.7 14705.0 14888.3 15080.6 15100.8 116873.0 117166.0 117738.0 117789.4 118042.0 48875.8 49159.3 49541.3 49615.0 49652.8 1148.9 1200.5 1201.7 1201.8 1202.6 25872.6 26935.7 27459.6 27485.6 27773.9 41825.0 42164.6 42243.4 42302.8 42312.6 288704.0 292120.0 292647.0 293792.0 293866.0 24737.5 25018.7 25334.5 25351.9 25447.1 41553.8 41659.6 42182.2 42319.0 42382.2 34273.5 35207.0 35374.0 35534.5 35695.0 34028.7 34307.1 34683.8 34716.7 35053.0 34239.3 34740.8 35490.0 35563.6 35604.1 30188.5 32060.5 32327.5 32342.2 32496.0 24125.5 24659.0 24788.9 24975.5 25157.9 19:40:36 INFO - PROCESS | 3589 | 19:40:36 INFO - PROCESS | 3589 | [#2] jquery.html Cycles:180 Average:17847.89 Median:20346.15 stddev:31975.41 (157.2%) stddev-sans-first:32038.08 19:40:36 INFO - PROCESS | 3589 | Values: 338.5 358.0 361.7 366.4 378.8 12119.9 15246.3 15266.0 15590.3 16227.8 15153.5 15578.8 15685.3 15714.1 15981.8 3762.3 4531.1 4679.5 4684.2 5045.4 4990.0 5035.4 5054.7 5055.6 5068.7 5024.5 5025.2 5025.9 5031.1 5033.6 5164.0 5316.7 5319.3 5324.7 5326.1 5035.4 5154.4 5160.4 5164.4 5200.6 12046.9 12061.5 12224.5 12240.4 12240.8 1845.4 1848.5 1851.1 1859.2 2038.2 9135.4 9465.2 9477.1 9678.4 12289.6 1650.5 1725.4 1747.1 1751.9 1788.1 62349.7 65682.7 66122.3 66831.7 67764.3 9500.8 9554.5 9643.0 9809.7 9920.6 13450.7 13467.2 13486.6 13499.5 13500.0 6785.2 7005.8 7035.5 7241.7 7248.6 6679.9 6724.3 6899.5 6901.6 6943.3 4188.5 4197.5 4203.7 4248.4 4271.4 1702.3 1754.9 1760.3 1775.4 1812.3 806.9 825.5 837.8 851.0 876.3 14736.9 15567.2 15788.4 15806.3 15857.4 809.0 827.5 840.9 845.2 850.8 8696.7 8722.5 9036.5 9191.1 9310.0 179711.0 179969.0 180876.0 181382.0 181399.1 57238.0 66802.0 67846.0 69431.0 75967.0 918.6 946.9 960.5 963.7 969.7 14716.6 14761.3 15079.1 15287.2 15518.3 35259.5 36259.0 36719.0 36817.8 36930.0 50509.2 50672.5 51064.0 51189.7 51449.0 7436.9 7515.7 7612.6 10468.8 10567.9 11156.4 11692.5 11983.6 12276.9 12526.4 10208.2 10323.3 10452.9 10797.1 10935.7 9389.3 10298.1 10373.4 10678.7 10769.2 10856.1 10887.7 10949.7 10969.9 11048.9 10624.8 10852.9 10927.5 11002.0 11185.1 10792.7 10811.7 10941.8 11001.0 11099.1 19:40:36 INFO - PROCESS | 3589 | 19:40:36 INFO - PROCESS | 3589 | [#3] mootools.html Cycles:180 Average:4732.93 Median:4769.71 stddev:2594.52 (54.4%) stddev-sans-first:2588.19 19:40:36 INFO - PROCESS | 3589 | Values: 1197.2 1349.0 1368.0 1452.5 1660.6 5792.3 6944.0 7202.0 7213.4 7384.5 7229.1 7294.1 7297.6 7304.5 7309.9 1781.9 1840.0 2042.2 2072.0 2079.5 2035.1 2112.6 2115.9 2132.4 2139.6 2066.0 2067.8 2069.6 2072.0 2074.1 2026.9 2045.3 2070.3 2078.8 2079.9 1987.8 2010.5 2011.4 2030.0 2035.0 7052.5 7176.4 7185.1 7202.6 7214.7 4308.2 4439.7 4444.0 4450.5 4452.0 2641.8 2757.4 2781.3 2788.3 2812.0 850.4 887.6 894.2 900.7 907.5 9505.0 9534.6 9575.3 9576.2 9584.3 3887.5 4030.7 4076.8 4153.2 4158.6 8192.4 8206.3 8209.5 8210.0 8229.7 4448.0 4473.8 4474.6 4476.5 4477.4 3544.5 3783.3 4099.3 4105.3 4107.8 3348.4 3426.4 3470.5 3471.8 3499.2 1097.2 1106.7 1118.8 1123.9 1124.9 797.5 812.4 815.3 825.3 826.4 4682.5 4713.6 4750.0 4895.7 5086.6 401.1 407.7 412.4 418.3 424.2 3383.8 3388.6 3400.7 3402.0 3519.3 8389.9 8801.1 8822.8 8832.8 8839.0 8770.5 8773.6 8774.3 8776.4 8783.4 6551.7 6782.4 6836.5 6847.9 6856.5 4690.6 4694.2 4752.9 4786.5 4897.3 7658.0 7747.3 7849.1 7891.9 7969.0 7815.3 7904.4 8012.1 8111.7 8201.5 5885.6 6051.1 6794.0 6928.5 6931.6 6624.4 6838.9 6861.6 7030.0 7037.5 6050.4 6054.3 6242.6 6265.8 6363.0 5850.9 5899.6 6147.3 6187.3 6217.8 5701.0 5789.2 5832.1 5833.9 5838.3 4291.0 4345.5 4347.6 4391.3 4465.6 4282.6 4288.8 4315.2 4468.8 4560.1 19:40:36 INFO - PROCESS | 3589 | 19:40:36 INFO - PROCESS | 3589 | [#4] prototype.html Cycles:180 Average:4194.76 Median:4754.92 stddev:1204.61 (25.3%) stddev-sans-first:1172.63 19:40:36 INFO - PROCESS | 3589 | Values: 334.5 347.8 348.7 349.4 352.7 4825.5 4862.2 4870.7 4896.9 4910.9 4606.1 4665.6 4707.1 4756.9 4860.0 3862.2 3865.6 3867.7 3877.7 3884.5 3859.5 3861.9 3865.6 3872.0 3887.0 3640.6 3740.1 3756.2 3806.6 3848.7 3804.0 3812.3 3829.9 3838.8 3845.7 3433.5 3434.9 3440.3 3443.9 3452.3 4538.4 4735.1 4753.2 4756.6 4771.2 4334.9 4363.7 4365.7 4370.9 4375.0 5068.6 5096.8 5098.5 5105.0 5119.5 3793.2 3795.2 3805.7 3818.3 3821.5 5105.7 5224.3 5230.4 5235.9 5270.7 3811.6 3828.7 3831.8 3839.3 3841.8 3887.7 3889.3 3899.5 3912.1 3923.3 4002.7 4200.3 4374.4 4389.4 4393.5 5007.4 5010.8 5014.6 5050.9 5060.2 1225.6 1232.5 1234.6 1235.3 1235.8 791.6 804.9 828.8 843.7 849.7 4240.7 4263.6 4273.3 4278.4 4278.6 4975.5 4990.5 4996.9 5025.3 5037.7 4044.9 4256.7 4267.7 4277.1 4295.2 2637.7 2647.5 2667.9 2685.4 2690.4 4680.2 4685.6 4687.6 4699.1 4735.7 5069.6 5105.6 5108.4 5123.4 5354.3 4852.8 4892.3 4895.4 4924.3 4938.5 5241.8 5244.3 5282.8 5287.3 5296.8 4871.9 5105.3 5122.9 5164.4 5164.9 4895.6 4901.3 4905.9 4909.3 4916.1 3566.3 3572.3 3600.4 3600.8 3613.2 5092.0 5177.6 5212.8 5218.6 5233.9 5027.3 5069.2 5081.2 5081.5 5088.6 5047.0 5066.5 5074.8 5077.5 5083.2 4797.8 4956.3 4990.5 5026.7 5039.3 4846.4 4967.7 4993.5 5105.6 5120.8 4945.9 4952.7 4956.7 4959.8 4986.8 19:40:36 INFO - PROCESS | 3589 | 19:40:36 INFO - PROCESS | 3589 | [#5] yui.html Cycles:180 Average:15263.77 Median:28026.64 stddev:19934.45 (71.1%) stddev-sans-first:19960.20 19:40:36 INFO - PROCESS | 3589 | Values: 656.4 664.8 669.3 730.0 747.4 12354.7 13395.1 13416.8 13420.9 13438.3 12400.9 12469.3 12472.5 12505.3 12574.1 607.7 629.3 746.7 759.8 769.9 785.6 788.4 789.1 789.1 789.7 830.4 831.6 833.3 835.7 836.6 635.9 658.7 662.8 665.5 829.8 489.4 582.1 601.2 602.2 603.1 12786.3 12811.2 12823.7 12852.9 12878.8 12058.7 12160.9 12262.6 12350.7 12416.9 11236.3 11329.6 11360.5 11579.7 11706.2 3897.3 3899.5 3947.9 3953.0 4031.1 64143.7 64584.0 65557.3 65981.7 66715.0 9555.1 9697.3 9738.0 9779.9 9858.6 17931.6 17934.2 17954.1 17955.2 17982.7 6536.5 6540.7 6570.2 6735.2 7016.8 3525.3 3580.0 3587.5 3610.1 3654.3 2700.2 2751.6 2773.6 2788.3 2797.2 482.0 506.1 507.3 517.3 524.6 488.0 547.3 552.2 556.6 589.8 8261.8 8339.2 8545.9 8750.9 8888.3 549.3 561.3 584.6 601.1 606.5 3878.3 3969.1 4005.1 4049.1 4134.6 69938.3 70263.0 70279.0 72769.0 73537.3 58787.4 59831.4 60238.0 60664.1 65146.3 55496.7 56049.0 56259.0 56361.0 56460.4 7364.1 7490.0 7786.5 7809.9 7940.9 38313.8 38711.2 39366.6 40423.0 40490.0 46565.3 50919.0 51592.5 52590.5 55189.0 9557.4 9590.4 9775.3 9788.0 9833.2 11305.7 11339.8 11601.9 11602.6 11811.0 10323.7 10601.3 10618.7 10864.2 10882.4 10569.7 10652.9 10809.8 11223.7 11225.6 10396.4 10579.3 10901.4 11404.3 11410.3 8898.2 9038.2 9117.4 9221.6 9528.9 8475.6 8733.6 9098.4 9118.9 9200.8 19:40:36 INFO - PROCESS | 3589 | -------- Summary: end -------- 19:40:36 INFO - PROCESS | 3589 | 19:40:37 INFO - TEST-INFO | 3589: exit 0 19:40:37 INFO - TEST-OK | dromaeo_css | took 1122325ms 19:40:37 INFO - TEST-START | kraken 19:40:37 INFO - operating with platform_type : linux_ 19:40:37 INFO - Initialising browser for kraken test... 19:40:37 INFO - TEST-INFO | started process 3887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCjnEki/profile http://localhost:36210/getInfo.html) 19:40:37 INFO - PROCESS | 3887 | 1482464437890 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 19:40:41 INFO - PROCESS | 3887 | __metrics Screen width/height:1600/1200 19:40:41 INFO - PROCESS | 3887 | colorDepth:24 19:40:41 INFO - PROCESS | 3887 | Browser inner width/height: 1024/697 19:40:41 INFO - PROCESS | 3887 | __metrics 19:40:42 INFO - PROCESS | 3887 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:40:42 INFO - PROCESS | 3887 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:40:43 INFO - TEST-INFO | 3887: exit 0 19:40:43 INFO - Browser initialized. 19:40:43 INFO - Running cycle 1/1 for kraken test... 19:40:43 INFO - TEST-INFO | started process 3969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCjnEki/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:40:55 INFO - PROCESS | 3969 | RSS: Main: 150994944 19:40:55 INFO - PROCESS | 3969 | 19:40:58 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36210/tests/kraken/driver.html?testName=audio-beat-detection) 19:40:59 INFO - PROCESS | 3969 | RSS: Main: 205123584 19:40:59 INFO - PROCESS | 3969 | 19:41:01 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36210/tests/kraken/driver.html?testName=audio-dft) 19:41:02 INFO - PROCESS | 3969 | RSS: Main: 183939072 19:41:02 INFO - PROCESS | 3969 | 19:41:05 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36210/tests/kraken/driver.html?testName=audio-fft) 19:41:06 INFO - PROCESS | 3969 | RSS: Main: 266883072 19:41:06 INFO - PROCESS | 3969 | 19:41:08 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36210/tests/kraken/driver.html?testName=audio-oscillator) 19:41:08 INFO - PROCESS | 3969 | RSS: Main: 177909760 19:41:08 INFO - PROCESS | 3969 | 19:41:11 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:41:11 INFO - PROCESS | 3969 | RSS: Main: 181714944 19:41:11 INFO - PROCESS | 3969 | 19:41:14 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36210/tests/kraken/driver.html?testName=imaging-darkroom) 19:41:15 INFO - PROCESS | 3969 | RSS: Main: 220340224 19:41:15 INFO - PROCESS | 3969 | 19:41:18 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36210/tests/kraken/driver.html?testName=imaging-desaturate) 19:41:19 INFO - PROCESS | 3969 | RSS: Main: 220954624 19:41:19 INFO - PROCESS | 3969 | 19:41:22 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36210/tests/kraken/driver.html?testName=json-parse-financial) 19:41:22 INFO - PROCESS | 3969 | RSS: Main: 219389952 19:41:22 INFO - PROCESS | 3969 | 19:41:24 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:41:25 INFO - PROCESS | 3969 | RSS: Main: 181829632 19:41:25 INFO - PROCESS | 3969 | 19:41:27 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:41:27 INFO - PROCESS | 3969 | RSS: Main: 188788736 19:41:27 INFO - PROCESS | 3969 | 19:41:29 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:41:30 INFO - PROCESS | 3969 | RSS: Main: 197079040 19:41:30 INFO - PROCESS | 3969 | 19:41:33 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:41:34 INFO - PROCESS | 3969 | RSS: Main: 205762560 19:41:34 INFO - PROCESS | 3969 | 19:41:37 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:41:37 INFO - PROCESS | 3969 | RSS: Main: 203739136 19:41:37 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | Cycle 1(1): loaded http://localhost:36210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36210/tests/kraken/driver.html?testName=ai-astar) 19:41:39 INFO - PROCESS | 3969 | RSS: Main: 254386176 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | __start_tp_report 19:41:39 INFO - PROCESS | 3969 | _x_x_mozilla_page_load 19:41:39 INFO - PROCESS | 3969 | _x_x_mozilla_page_load_details 19:41:39 INFO - PROCESS | 3969 | |i|pagename|runs| 19:41:39 INFO - PROCESS | 3969 | |0;ai-astar;113;115;115;116;116;116;115;116;115;117 19:41:39 INFO - PROCESS | 3969 | |1;audio-beat-detection;160;128;131;178;128;135;124;127;145;127 19:41:39 INFO - PROCESS | 3969 | |2;audio-dft;161;160;160;163;162;162;161;161;161;160 19:41:39 INFO - PROCESS | 3969 | |3;audio-fft;76;76;77;103;76;77;77;77;96;75 19:41:39 INFO - PROCESS | 3969 | |4;audio-oscillator;84;84;118;85;83;84;103;84;83;118 19:41:39 INFO - PROCESS | 3969 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 19:41:39 INFO - PROCESS | 3969 | |6;imaging-darkroom;147;147;147;148;147;147;147;147;147;146 19:41:39 INFO - PROCESS | 3969 | |7;imaging-desaturate;95;96;95;95;95;95;95;96;95;95 19:41:39 INFO - PROCESS | 3969 | |8;json-parse-financial;65;62;63;64;64;65;65;64;66;65 19:41:39 INFO - PROCESS | 3969 | |9;json-stringify-tinderbox;65;65;66;66;66;65;66;70;67;67 19:41:39 INFO - PROCESS | 3969 | |10;stanford-crypto-aes;83;83;84;83;83;83;84;83;83;82 19:41:39 INFO - PROCESS | 3969 | |11;stanford-crypto-ccm;134;135;133;134;132;133;142;135;187;135 19:41:39 INFO - PROCESS | 3969 | |12;stanford-crypto-pbkdf2;177;172;181;179;177;175;176;173;175;176 19:41:39 INFO - PROCESS | 3969 | |13;stanford-crypto-sha256-iterative;67;68;66;67;76;67;66;67;66;66 19:41:39 INFO - PROCESS | 3969 | __end_tp_report 19:41:39 INFO - PROCESS | 3969 | __start_cc_report 19:41:39 INFO - PROCESS | 3969 | _x_x_mozilla_cycle_collect,1939 19:41:39 INFO - PROCESS | 3969 | __end_cc_report 19:41:39 INFO - PROCESS | 3969 | __startTimestamp1482464499796__endTimestamp 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | ------- Summary: start ------- 19:41:39 INFO - PROCESS | 3969 | Number of tests: 14 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:1.07 (0.9%) stddev-sans-first:0.71 19:41:39 INFO - PROCESS | 3969 | Values: 113.0 115.0 115.0 116.0 116.0 116.0 115.0 116.0 115.0 117.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:133.00 stddev:17.73 (13.3%) stddev-sans-first:16.97 19:41:39 INFO - PROCESS | 3969 | Values: 160.0 128.0 131.0 178.0 128.0 135.0 124.0 127.0 145.0 127.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 19:41:39 INFO - PROCESS | 3969 | Values: 161.0 160.0 160.0 163.0 162.0 162.0 161.0 161.0 161.0 160.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#3] audio-fft Cycles:10 Average:81.00 Median:77.00 stddev:9.91 (12.9%) stddev-sans-first:10.35 19:41:39 INFO - PROCESS | 3969 | Values: 76.0 76.0 77.0 103.0 76.0 77.0 77.0 77.0 96.0 75.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:84.00 stddev:14.67 (17.5%) stddev-sans-first:15.22 19:41:39 INFO - PROCESS | 3969 | Values: 84.0 84.0 118.0 85.0 83.0 84.0 103.0 84.0 83.0 118.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 19:41:39 INFO - PROCESS | 3969 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 19:41:39 INFO - PROCESS | 3969 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 146.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:41:39 INFO - PROCESS | 3969 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 19:41:39 INFO - PROCESS | 3969 | Values: 65.0 62.0 63.0 64.0 64.0 65.0 65.0 64.0 66.0 65.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.49 (2.3%) stddev-sans-first:1.51 19:41:39 INFO - PROCESS | 3969 | Values: 65.0 65.0 66.0 66.0 66.0 65.0 66.0 70.0 67.0 67.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 19:41:39 INFO - PROCESS | 3969 | Values: 83.0 83.0 84.0 83.0 83.0 83.0 84.0 83.0 83.0 82.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:135.00 stddev:16.74 (12.4%) stddev-sans-first:17.61 19:41:39 INFO - PROCESS | 3969 | Values: 134.0 135.0 133.0 134.0 132.0 133.0 142.0 135.0 187.0 135.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:176.50 stddev:2.64 (1.5%) stddev-sans-first:2.78 19:41:39 INFO - PROCESS | 3969 | Values: 177.0 172.0 181.0 179.0 177.0 175.0 176.0 173.0 175.0 176.0 19:41:39 INFO - PROCESS | 3969 | 19:41:39 INFO - PROCESS | 3969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:3.03 (4.5%) stddev-sans-first:3.20 19:41:39 INFO - PROCESS | 3969 | Values: 67.0 68.0 66.0 67.0 76.0 67.0 66.0 67.0 66.0 66.0 19:41:39 INFO - PROCESS | 3969 | -------- Summary: end -------- 19:41:39 INFO - PROCESS | 3969 | 19:41:40 INFO - TEST-INFO | 3969: exit 0 19:41:40 INFO - TEST-OK | kraken | took 63572ms 19:41:40 INFO - SUITE-END | took 1185s 19:41:41 INFO - Completed test suite (00:19:46) 19:41:41 INFO - javascript benchmark 19:41:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.3975385661297, 2657.1629936569966, 2674.4249986252953, 2685.62401263823, 2690.8789104490284, 4580.816767329311, 4628.051249493854, 4753.928691069633, 4824.300476430915, 4857.902841943159, 4675.368825208596, 4787.904241915159, 4816.325714399987, 4856.951430485694, 4894.461609222983, 4295.0, 4324.437823083011, 4332.111917057012, 4339.674524410666, 4403.295472724365, 4328.523862375137, 4388.188185185735, 4405.295152775557, 4435.356873253377, 4461.5092339842595, 4371.34429835524, 4423.690341676084, 4434.933475997863, 4446.888277930518, 4476.619487343563, 4205.642520385771, 4230.302000169968, 4237.533871274158, 4305.50486694031, 4315.223259813232, 4326.848560300375, 4347.7173983690955, 4357.150355680644, 4407.382966384709, 4412.24991751403, 4751.691140075884, 4751.714897106184, 4784.162771515006, 4784.569388755029, 4785.8564243072415, 4875.561199492063, 4937.0, 5111.1566591512355, 5120.155174396257, 5153.201253805666, 5080.644354895159, 5100.132977393815, 5136.255242989783, 5142.588592912595, 5202.97398513005, 4802.8799280018275, 4815.6388270879825, 4816.831410900601, 4853.854384368439, 4865.172920603506, 5221.242919776687, 5221.765020574007, 5224.60815438836, 5234.92147617786, 5256.106461901486, 4868.561829435368, 4923.975380123076, 4924.778384972685, 5021.397432308147, 5045.268436076748, 5134.512221338967, 5212.296339994128, 5213.843584692465, 5216.843494695166, 5217.7912883485, 5069.746512674352, 5078.898422031539, 5106.208537676592, 5122.1804511278015, 5128.512551517422, 5099.260607211933, 5103.617228707862, 5107.438181799999, 5113.7698803553185, 5147.485251474823, 4126.319157339006, 4153.418521407006, 4154.605312495308, 4260.424842646203, 4279.657627389864, 3738.420544815558, 3778.905527361838, 3788.791616461066, 3791.450239715226, 3799.164183879542, 4441.133978874153, 4445.488768791631, 4446.866594002185, 4453.910921781546, 4479.753613551221, 5071.644984851099, 5077.26379674945, 5085.160948443466, 5086.949130508721, 5155.510226528549, 4248.87253382399, 4280.850170244089, 4318.352247162888, 4328.134373125387, 4353.651707863363, 4547.795349209294, 4559.430071241095, 4580.519045500175, 4598.954010459853, 4602.332661764025, 4752.833650822274, 4788.348019933118, 4791.712497250176, 4804.159272127434, 4828.613710903049, 4955.82654607087, 4993.251012348177, 4999.625028122832, 5104.540591346797, 5117.974410128075, 4718.693284936468, 4767.6662633615315, 4793.185158523129, 4805.879853003563, 4859.8299059534165, 5073.7716802743225, 5073.898522029613, 5079.6698214615935, 5123.615728820428, 5123.692578445305, 5136.0755064087325, 5142.202958541432, 5142.485751424828, 5146.485351464824, 5188.58491320701, 4837.879053023562, 4871.707697538159, 4880.145974454385, 4961.0, 5017.648764586444, 4916.188828843344, 4938.777755000961, 4946.802127914843, 4991.575716064175, 4995.000999799981, 4853.708777473363, 4905.190643543775, 4905.3623029006, 4911.214205727067, 4951.1088004158155, 4920.975395123001, 4992.625553083606, 5001.399832020181, 5011.699298042129, 5057.443681195139, 4815.470298267118, 4823.0, 4862.149123903374, 4867.123917694707, 4873.171560834738], "value": 4672.679832669846, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.2263527344257, 520.2950002746279, 525.6950968438306, 535.9437259087796, 536.6753114365808, 27390.315242118933, 37315.62684373155, 38638.99999999996, 38803.80598097012, 42386.0, 40019.0, 40434.19131617366, 40506.39240411389, 40556.79721601388, 40565.0, 7117.323854233865, 7553.395728341733, 7720.112187098472, 7725.034370703662, 7730.381569474456, 7249.021382113427, 9749.0, 9950.154236889874, 9956.452395118265, 10299.0, 10037.648682296121, 10088.192944564416, 10089.394636321807, 10092.142167915736, 10139.695809125702, 10028.197744180448, 10062.597496100147, 10077.54651040705, 10086.949565252164, 10091.596336146618, 9874.210063194927, 9938.850917236246, 9943.80112397748, 9949.75125621858, 9950.552225149813, 37879.62120378789, 38224.235515289816, 38252.0, 38272.0, 38301.23397532062, 3097.2461744139227, 3131.937361252785, 3175.7935734177204, 3190.489521676521, 3403.23427228874, 25237.49525009508, 25598.488030239292, 25803.225903222934, 28401.289967750767, 28661.28346791326, 3191.5850939377965, 3225.403300389412, 3252.7235185009304, 3258.9185270368193, 3292.3909076820864, 248290.0, 250049.0, 250426.0, 250537.6827896513, 251859.74070129715, 46494.0, 46751.25989920798, 46878.76560617175, 46879.1248350069, 46910.0, 48480.27279590809, 48517.514824852005, 48614.756926215145, 48680.0, 48748.0, 13349.933250333686, 13592.0, 13633.250171240677, 13634.181949083088, 13635.795463068062, 8365.0, 8443.493390396596, 10242.231832612435, 10307.226957978182, 10388.636397726043, 13519.797203041962, 13612.183269003892, 13663.726725465434, 15013.24933753308, 15262.542123736306, 6058.363871793398, 6443.838904027437, 6476.4495017924, 6478.773242936474, 6533.24867640218, 778.622368151446, 812.4069429316633, 925.2644147902433, 947.7583216279943, 953.6423841059602, 26652.73347266541, 27679.0, 28258.858705706753, 28267.293317667223, 28274.151775446768, 883.4787475389551, 978.1978777402604, 1016.1515134862325, 1043.8486419469134, 1068.1454836131063, 14625.707485850224, 14705.0, 14888.255587220596, 15080.622984425258, 15100.848991509944, 116873.0, 117166.0, 117738.0, 117789.41105294418, 118042.0, 48875.755621221666, 49159.26261106086, 49541.25688114681, 49615.0, 49652.75173624109, 1148.896599306083, 1200.4657927222302, 1201.6575276046285, 1201.7776711308436, 1202.6392082375253, 25872.611910820975, 26935.73064269332, 27459.588106178024, 27485.595438307093, 27773.86113069422, 41825.0, 42164.578354216064, 42243.3663495054, 42302.788486057376, 42312.576874232094, 288704.0, 292120.0, 292647.0, 293792.0, 293866.0, 24737.50524989526, 25018.749812501643, 25334.49331013406, 25351.873240634417, 25447.10935117262, 41553.79223103865, 41659.58340416557, 42182.228908135585, 42319.0, 42382.15235695207, 34273.485897711056, 35207.0, 35374.0, 35534.46698299579, 35695.0, 34028.65971340255, 34307.14232144116, 34683.82658086693, 34716.652833471344, 35053.0, 34239.31521369509, 34740.826295868355, 35490.0, 35563.64436355707, 35604.109897252776, 30188.547171792, 32060.51909221317, 32327.51508727324, 32342.19144521406, 32496.0, 24125.51748964976, 24659.0, 24788.876055620327, 24975.500489989736, 25157.87421062883], "value": 16772.811189857217, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4753631870603, 358.04045158973975, 361.65461983805466, 366.4173963398196, 378.8445242011863, 12119.878801211986, 15246.313915873785, 15266.0, 15590.298436570352, 16227.83772162278, 15153.469628563002, 15578.766318505202, 15685.29416176272, 15714.135722535257, 15981.84018159818, 3762.3039737648487, 4531.116432295704, 4679.508651591585, 4684.203685373478, 5045.419776725668, 4989.950100499003, 5035.370578677665, 5054.696718196901, 5055.620828437864, 5068.72122033288, 5024.497550244964, 5025.246213068032, 5025.924611130836, 5031.069252188338, 5033.597312215014, 5163.974180129094, 5316.654417462872, 5319.28189694394, 5324.7071411072375, 5326.147816349404, 5035.370578677665, 5154.38147422308, 5160.380754309507, 5164.380274367062, 5200.609954253446, 12046.879531204664, 12061.457234424472, 12224.511019559208, 12240.387980601023, 12240.81638775419, 1845.372573325076, 1848.5378655336167, 1851.1484717030182, 1859.2098358197711, 2038.2458490358663, 9135.40619859707, 9465.195458386046, 9477.099675530813, 9678.370905891095, 12289.631311060682, 1650.4553497345967, 1725.3961113610137, 1747.0827815396892, 1751.9299228030864, 1788.1148831328576, 62349.746415878, 65682.67158664225, 66122.3387766121, 66831.66584167047, 67764.32235677679, 9500.809983800285, 9554.474503902353, 9643.0, 9809.656662016796, 9920.603175873028, 13450.730985380238, 13467.191968481922, 13486.595402137755, 13499.527516536875, 13500.0, 6785.219699734495, 7005.7547985821275, 7035.542689725152, 7241.746538871114, 7248.60132692707, 6679.933200668028, 6724.293949135368, 6899.48253880961, 6901.551399159039, 6943.270956549591, 4188.539260681323, 4197.538270790211, 4203.726757760735, 4248.426462427595, 4271.444712187395, 1702.2595171100363, 1754.9034803085697, 1760.313477743681, 1775.4229875290323, 1812.3113216977465, 806.8547661421001, 825.533573530953, 837.7779888329597, 851.0255757158019, 876.3077169036517, 14736.926315368355, 15567.221638918008, 15788.447404340794, 15806.288717007763, 15857.444989425314, 808.9595520223966, 827.5200383777394, 840.932725381968, 845.1928408370114, 850.8340873529726, 8696.652133914698, 8722.495566822425, 9036.548172591343, 9191.126842949909, 9309.95345023284, 179711.0, 179969.0, 180876.0, 181382.0, 181399.0930045368, 57238.0, 66802.0, 67846.0, 69431.0, 75967.0, 918.5728636184207, 946.9479178645103, 960.4573416019927, 963.7060696487639, 969.7381706939087, 14716.55850324492, 14761.261936902896, 15079.095254284777, 15287.159206243763, 15518.275014488012, 35259.47110793392, 36259.0, 36719.0, 36817.815910921345, 36930.0, 50509.242361365345, 50672.49327506825, 51064.0, 51189.74405128099, 51449.0, 7436.888446673196, 7515.661795219119, 7612.581308028111, 10468.790624187626, 10567.89432105669, 11156.44217789091, 11692.479977602858, 11983.64049078529, 12276.877231227574, 12526.373681315716, 10208.234382421497, 10323.32898361604, 10452.895471045193, 10797.082248009006, 10935.726606834893, 9389.342746007715, 10298.124659404035, 10373.429461379697, 10678.679639610824, 10769.192310576582, 10856.13150947938, 10887.673369798918, 10949.726256843642, 10969.945150274516, 11048.904415680106, 10624.84062739075, 10852.89877843787, 10927.45362731876, 11002.009819116318, 11185.105191584817, 10792.730181745519, 10811.69572076334, 10941.781164376509, 11000.962896072107, 11099.112071034137], "value": 7833.284878079187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.1679682620581, 1349.0286993364778, 1368.0492058019674, 1452.5206681795003, 1660.5682522544134, 5792.304923409191, 6943.958406239067, 7201.963990180055, 7213.3507984281405, 7384.520006199593, 7229.060222171123, 7294.088238970129, 7297.635118244093, 7304.488685791996, 7309.890351644716, 1781.9376321828738, 1839.9724004139948, 2042.1627132875524, 2071.989640051798, 2079.511314841011, 2035.1452389996164, 2112.5986062648126, 2115.947101322464, 2132.3922682035623, 2139.5827813576357, 2065.989670051648, 2067.8138967492923, 2069.596428696405, 2072.046858445117, 2074.097767471155, 2026.8682535635137, 2045.2841505473114, 2070.3167954575106, 2078.7609424916177, 2079.9168033278725, 1987.7614686237744, 2010.45717656232, 2011.3965810256864, 2029.9797002029939, 2034.9796502035085, 7052.541584796972, 7176.390006849424, 7185.137783466018, 7202.603856787875, 7214.67533960973, 4308.224519586473, 4439.733615983051, 4443.977780111079, 4450.46594408673, 4451.955480445219, 2641.77544908683, 2757.4347258811895, 2781.276868014311, 2788.3029242689327, 2811.9578206326923, 850.3962186847345, 887.573964497045, 894.2130924786212, 900.7072701372081, 907.4963395315597, 9505.0, 9534.570944307523, 9575.281853860919, 9576.186024187882, 9584.329096963216, 3887.5140607423505, 4030.717849750548, 4076.8165432555606, 4153.231652144363, 4158.584141585818, 8192.426530142833, 8206.343492520584, 8209.466384684976, 8210.0, 8229.711960081368, 4448.043670610834, 4473.776311184428, 4474.574915383034, 4476.485204201494, 4477.350784136347, 3544.5392099027476, 3783.3379158647126, 4099.282625540519, 4105.3020986432375, 4107.753534787863, 3348.41402754517, 3426.4130581411373, 3470.531478250404, 3471.8437670304393, 3499.230169362736, 1097.1935627313917, 1106.7343837478948, 1118.8377685235596, 1123.8763735989035, 1124.9325040497433, 797.5254723439544, 812.4191203289677, 815.3436483630734, 825.2613910550024, 826.3802148388709, 4682.548409992914, 4713.599344055725, 4750.0, 4895.7062576245535, 5086.643934924594, 401.08752587862847, 407.6697874721485, 412.44526112378804, 418.3160532529276, 424.22367068265004, 3383.8477268522975, 3388.6272510023878, 3400.6769356911054, 3401.9829900850336, 3519.3137338219312, 8389.874151887727, 8801.075887031897, 8822.77943051416, 8832.823343533093, 8839.0, 8770.51762153075, 8773.605187766565, 8774.29805615562, 8776.429532080394, 8783.429077109968, 6551.672416379162, 6782.389584937379, 6836.487263455261, 6847.931520684829, 6856.485763567753, 4690.577847993697, 4694.178518759271, 4752.88117797044, 4786.545278198566, 4897.314375987294, 7657.961710191414, 7747.30274275318, 7849.097353804157, 7891.921080789349, 7969.0, 7815.29662330393, 7904.367650587824, 8012.118666946748, 8111.675532978851, 8201.466904651179, 5885.61743486672, 6051.062085376773, 6793.966030169818, 6928.549644273106, 6931.584104953719, 6624.403803657694, 6838.897416538656, 6861.55399899005, 7029.9648501757165, 7037.507374483737, 6050.394960503914, 6054.3340232575265, 6242.5942313749465, 6265.843353916189, 6362.9681851592295, 5850.912236316373, 5899.646021238739, 6147.323794382703, 6187.288461826947, 6217.751289948533, 5700.971495142498, 5789.247397838254, 5832.096025116114, 5833.883322333445, 5838.2702162229725, 4291.0, 4345.478542574911, 4347.6304514116655, 4391.3193455014525, 4465.620422264144, 4282.571742825692, 4288.849890253826, 4315.223259813264, 4468.79890404939, 4560.133574620944], "value": 3789.7371589840677, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.4665258912036, 347.82608695652175, 348.7001178986073, 349.38159457759764, 352.6913950293495, 4825.541573550516, 4862.2220444728855, 4870.65905386623, 4896.869861610202, 4910.901781964359, 4606.124836281104, 4665.580097791198, 4707.05858828234, 4756.857294281169, 4859.9831070105865, 3862.2275544890995, 3865.5697391965014, 3867.7292589518606, 3877.689784817215, 3884.5139110969003, 3859.459675645412, 3861.903452413684, 3865.6327648873453, 3871.9545722654866, 3886.961130388688, 3640.5995340512522, 3740.129935032484, 3756.1548651553317, 3806.638369354907, 3848.749831260959, 3804.0, 3812.2566099610585, 3829.885103446901, 3838.7696738195796, 3845.673242731253, 3433.484977253432, 3434.8969530914114, 3440.3291358185165, 3443.9483407748903, 3452.2922800826022, 4538.410006699141, 4735.12400205963, 4753.191957367256, 4756.6432517561325, 4771.188897887368, 4334.891627709332, 4363.716358436692, 4365.672574556921, 4370.868873933755, 4374.956250437487, 5068.619853511002, 5096.79612815487, 5098.541131298164, 5105.009046471879, 5119.513646203604, 3793.2223894101644, 3795.221979494197, 3805.733598648068, 3818.274527839729, 3821.5032045833864, 5105.668131571436, 5224.346956630421, 5230.372355317349, 5235.9004609032145, 5270.710110943896, 3811.5997820228476, 3828.693704503633, 3831.7700937943814, 3839.2897313997, 3841.846326146923, 3887.669548088444, 3889.2999260133447, 3899.512560929884, 3912.139329347539, 3923.293807114747, 4002.6597739192493, 4200.306949353322, 4374.431323927933, 4389.385486031958, 4393.538678438782, 5007.4491805901325, 5010.774515146827, 5014.5737612303365, 5050.949490505048, 5060.2156665716875, 1225.6078055022308, 1232.4577186038114, 1234.6481252843075, 1235.32057368447, 1235.8393408856791, 791.5765065689828, 804.8611215130642, 828.7596596986806, 843.7300063979591, 849.7323343146888, 4240.685387529876, 4263.552327005682, 4273.290683726472, 4278.358246263086, 4278.55075217104, 4975.487378873646, 4990.451050384455, 4996.90006199874, 5025.271335656309, 5037.69773813565, 4044.9214867819637, 4256.723312984646, 4267.67992400565, 4277.091577727113, 4295.162443323585, 2637.723039080869, 2647.483740670589, 2667.906623268176, 2685.44948285601, 2690.3543149643942, 4680.227762419163, 4685.625149987993, 4687.5781179693995, 4699.130660827758, 4735.739534325645, 5069.5944324454695, 5105.617078719111, 5108.438071812097, 5123.436421993578, 5354.330708661418, 4852.757362131879, 4892.315075889307, 4895.363602731622, 4924.3105965164905, 4938.456769755324, 5241.768184476721, 5244.265802787537, 5282.81510147143, 5287.286216360742, 5296.814611488579, 4871.87820304481, 5105.285260063668, 5122.871928201825, 5164.406093299319, 5164.870878228075, 4895.559399654048, 4901.3383193268455, 4905.852824415273, 4909.312696222603, 4916.0905232532095, 3566.341651132236, 3572.3386077372525, 3600.3699352612666, 3600.765950213228, 3613.1870329176777, 5092.0, 5177.637565370388, 5212.784566559273, 5218.634695571273, 5233.947660523346, 5027.321311622884, 5069.188929771219, 5081.161608334732, 5081.491850815037, 5088.618353623567, 5046.974765126298, 5066.4680208577565, 5074.82238121664, 5077.466865979019, 5083.229639846219, 4797.7601119943165, 4956.256561515802, 4990.525900039491, 5026.723530205873, 5039.3448851649055, 4846.442659094108, 4967.677100988424, 4993.525615066563, 5105.591552675852, 5120.84924331789, 4945.876353091202, 4952.653314268111, 4956.653034287565, 4959.752012399438, 4986.775595098156], "value": 3818.7963957925454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.4387448731335, 664.8138521214062, 669.2938949408373, 729.9920760697303, 747.4058123791585, 12354.691132721686, 13395.129316594415, 13416.798748018775, 13420.865791342083, 13438.260895650748, 12400.937995310034, 12469.314187719672, 12472.501099956013, 12505.312207828565, 12574.05694572906, 607.696151924038, 629.295189387884, 746.7461063238497, 759.760675387254, 769.9461037727361, 785.6229010075167, 788.42051092447, 789.0728394136895, 789.1280135450331, 789.6999140326668, 830.3979614779267, 831.55096248026, 833.2625626320689, 835.6991483066091, 836.60679480644, 635.920509936258, 658.6509150150428, 662.8342914271432, 665.500874344237, 829.8008477965275, 489.3589397888777, 582.0570675505666, 601.1553766957431, 602.2261394108549, 603.1224568253225, 12786.296753678544, 12811.231326120462, 12823.74352512954, 12852.871471285262, 12878.80681789774, 12058.69853253667, 12160.939195304056, 12262.570810021696, 12350.691232719164, 12416.875831241663, 11236.269642473295, 11329.603463878808, 11360.48877800501, 11579.710507237301, 11706.180567360288, 3897.259520691088, 3899.454076429302, 3947.9013024674327, 3953.031507280735, 4031.07285324377, 64143.67928160376, 64584.0, 65557.3444265556, 65981.67009164924, 66714.99999999952, 9555.140037396668, 9697.321187516805, 9738.0, 9779.902200977898, 9858.556364963593, 17931.641367172582, 17934.19296131677, 17954.102294885204, 17955.192016359295, 17982.730259046126, 6536.509761767791, 6540.70566824494, 6570.178727659043, 6735.158105236846, 7016.824579385556, 3525.347810655037, 3580.0, 3587.497750314958, 3610.1335679436747, 3654.3056819204267, 2700.1629494856656, 2751.614773931611, 2773.5839624056553, 2788.2889863084783, 2797.2447439191305, 482.0, 506.1471420656206, 507.2948601443996, 517.319724562207, 524.6170295684095, 487.98012154597063, 547.2529996554674, 552.2020680117192, 556.5630979680931, 589.7699897040158, 8261.752147435587, 8339.166083391612, 8545.851050058289, 8750.86873696895, 8888.291088793303, 549.3353042818235, 561.332014902265, 584.6346033728919, 601.0533409879457, 606.5269090109722, 3878.3212937735784, 3969.126792105732, 4005.078831868628, 4049.0687141957515, 4134.607212314825, 69938.3006169942, 70263.0, 70279.0, 72769.0, 73537.26462735412, 58787.41212587905, 59831.401685982586, 60238.0, 60664.090038649454, 65146.348536514975, 55496.72251638716, 56049.0, 56259.0, 56361.0, 56460.43539564634, 7364.116306043309, 7490.0, 7786.532808031537, 7809.882851757115, 7940.880886786587, 38313.808430957666, 38711.2257754849, 39366.60633393744, 40423.0, 40490.0, 46565.3015204779, 50919.0, 51592.48407516027, 52590.474095258556, 55189.0, 9557.378770379903, 9590.42457452555, 9775.315727898978, 9788.021197880154, 9833.16418104469, 11305.660830175108, 11339.829902551302, 11601.883981160081, 11602.593909213138, 11811.0, 10323.741906452398, 10601.310914790514, 10618.681439556825, 10864.185186110915, 10882.40146791934, 10569.682909512727, 10652.89347106519, 10809.783804323712, 11223.71940701489, 11225.60710375133, 10396.428196448966, 10579.31234469757, 10901.400422976496, 11404.315741055563, 11410.258333208647, 8898.154675305836, 9038.231750301298, 9117.36178467501, 9221.631134754534, 9528.85706714386, 8475.576221188792, 8733.606987685442, 9098.363114581916, 9118.863217051618, 9200.769980750534], "value": 6167.544587629899, "unit": "score"}], "name": "dromaeo_css", "value": 6163.144021840138, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 116.0, 116.0, 116.0, 115.0, 116.0, 115.0, 117.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 131.0, 178.0, 128.0, 135.0, 124.0, 127.0, 145.0, 127.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 163.0, 162.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 103.0, 76.0, 77.0, 77.0, 77.0, 96.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 85.0, 83.0, 84.0, 103.0, 84.0, 83.0, 118.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 64.0, 64.0, 65.0, 65.0, 64.0, 66.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 70.0, 67.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 83.0, 83.0, 83.0, 84.0, 83.0, 83.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 133.0, 134.0, 132.0, 133.0, 142.0, 135.0, 187.0, 135.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 172.0, 181.0, 179.0, 177.0, 175.0, 176.0, 173.0, 175.0, 176.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 67.0, 76.0, 67.0, 66.0, 67.0, 66.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1545.0999999999997, "alertThreshold": 2.0}]} 19:41:41 INFO - Return code: 0 19:41:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:41:41 INFO - # TBPL SUCCESS # 19:41:41 INFO - Running post-action listener: _resource_record_post_action 19:41:41 INFO - [mozharness: 2016-12-23 03:41:41.595760Z] Finished run-tests step (success) 19:41:41 INFO - Running post-run listener: _resource_record_post_run 19:41:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 389373952; Read time: 204; Write time: 289916 19:41:41 INFO - TinderboxPrint: CPU usage
13.1% 19:41:41 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 204 19:41:41 INFO - TinderboxPrint: I/O write bytes / time
389,373,952 / 289,916 19:41:41 INFO - TinderboxPrint: CPU idle
8,344.7 (86.9%) 19:41:41 INFO - TinderboxPrint: CPU user
1,212.1 (12.6%) 19:41:41 INFO - TinderboxPrint: Swap in / out
0 / 0 19:41:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107016192; Read time: 0; Write time: 64168 19:41:41 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282357760; Read time: 192; Write time: 225748 19:41:42 INFO - Running post-run listener: _upload_blobber_files 19:41:42 INFO - Blob upload gear active. 19:41:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:41:42 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:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:41:42 INFO - (blobuploader) - INFO - Open directory for files ... 19:41:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:41:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:41:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:41:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:41:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:41:43 INFO - (blobuploader) - INFO - Done attempting. 19:41:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:41:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:41:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:41:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:41:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:41:46 INFO - (blobuploader) - INFO - Done attempting. 19:41:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:41:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:41:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:41:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:41:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:41:47 INFO - (blobuploader) - INFO - Done attempting. 19:41:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:41:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:41:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:41:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:41:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:41:48 INFO - (blobuploader) - INFO - Done attempting. 19:41:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:41:48 INFO - Return code: 0 19:41:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:41:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:41:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c4f9231554cb78e520cec942179319c2f0b65e3b0b018e4b885811db1bb58a701fe4313855fe0e4dcbbbed3632df6baef6eb5c6ffc5c4522f34e32574524e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecf66743ee5da66bcbab4aeaf4b2e8577cc99295a923f1186f0615071c5c67c3437173e428d6c7bd78441b83d365e963b4ba65de57a0333d8dd232adfe5e3802", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/709521146a507a66ab07d47e4a271532bc3b7515367618a3867e3cdb41dee10d77b5a7fa3d2492ed2d33bb4083307ea06a3a5dddebfb6d0d90e0bd2f2d7d1abe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b6b0fb308c5de79acf4ff4cc3ae9b483ec05f1a9abe1edec6a730d691842c3af4fae2146ebcc5b740e78704bd4bfa361df656448db3a62d22f1e351de6353bd"} 19:41:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:41:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:41:48 INFO - Contents: 19:41:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c4f9231554cb78e520cec942179319c2f0b65e3b0b018e4b885811db1bb58a701fe4313855fe0e4dcbbbed3632df6baef6eb5c6ffc5c4522f34e32574524e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecf66743ee5da66bcbab4aeaf4b2e8577cc99295a923f1186f0615071c5c67c3437173e428d6c7bd78441b83d365e963b4ba65de57a0333d8dd232adfe5e3802", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/709521146a507a66ab07d47e4a271532bc3b7515367618a3867e3cdb41dee10d77b5a7fa3d2492ed2d33bb4083307ea06a3a5dddebfb6d0d90e0bd2f2d7d1abe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b6b0fb308c5de79acf4ff4cc3ae9b483ec05f1a9abe1edec6a730d691842c3af4fae2146ebcc5b740e78704bd4bfa361df656448db3a62d22f1e351de6353bd"} 19:41:48 INFO - Running post-run listener: copy_logs_to_upload_dir 19:41:48 INFO - Copying logs to upload dir... 19:41:48 INFO - mkdir: /builds/slave/test/build/upload/logs 19:41:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.517274 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-22 19:41:47.969475) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 19:41:47.973121) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c4f9231554cb78e520cec942179319c2f0b65e3b0b018e4b885811db1bb58a701fe4313855fe0e4dcbbbed3632df6baef6eb5c6ffc5c4522f34e32574524e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecf66743ee5da66bcbab4aeaf4b2e8577cc99295a923f1186f0615071c5c67c3437173e428d6c7bd78441b83d365e963b4ba65de57a0333d8dd232adfe5e3802", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/709521146a507a66ab07d47e4a271532bc3b7515367618a3867e3cdb41dee10d77b5a7fa3d2492ed2d33bb4083307ea06a3a5dddebfb6d0d90e0bd2f2d7d1abe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b6b0fb308c5de79acf4ff4cc3ae9b483ec05f1a9abe1edec6a730d691842c3af4fae2146ebcc5b740e78704bd4bfa361df656448db3a62d22f1e351de6353bd"} build_url:https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/flo7xAGvQiS0F18NzXl5Bg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c4f9231554cb78e520cec942179319c2f0b65e3b0b018e4b885811db1bb58a701fe4313855fe0e4dcbbbed3632df6baef6eb5c6ffc5c4522f34e32574524e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecf66743ee5da66bcbab4aeaf4b2e8577cc99295a923f1186f0615071c5c67c3437173e428d6c7bd78441b83d365e963b4ba65de57a0333d8dd232adfe5e3802", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/709521146a507a66ab07d47e4a271532bc3b7515367618a3867e3cdb41dee10d77b5a7fa3d2492ed2d33bb4083307ea06a3a5dddebfb6d0d90e0bd2f2d7d1abe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b6b0fb308c5de79acf4ff4cc3ae9b483ec05f1a9abe1edec6a730d691842c3af4fae2146ebcc5b740e78704bd4bfa361df656448db3a62d22f1e351de6353bd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 19:41:48.003022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:41:48.003386) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1482461677.738768-489305564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:41:48.085536) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 19:41:48.085845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 19:41:48.086163) ========= ========= Total master_lag: 0.18 =========