builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1481763675.34 results: success (0) buildid: 20161214160703 builduid: 292354d9e139468380726b26ea57d292 revision: b1ab720c6d3e412ede797b08dfe63dca170f6ee0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:15.344320) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:15.344824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:15.345109) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:15.360850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:15.361243) ========= 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=62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-14 17:01:15-- 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% 70.0M=0s 2016-12-14 17:01:15 (70.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144929 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:15.519981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:15.520300) ========= 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=62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018691 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:15.569335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 17:01:15.569705) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1ab720c6d3e412ede797b08dfe63dca170f6ee0 --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 b1ab720c6d3e412ede797b08dfe63dca170f6ee0 --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=62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-14 17:01:15,651 truncating revision to first 12 chars 2016-12-14 17:01:15,651 Setting DEBUG logging. 2016-12-14 17:01:15,651 attempt 1/10 2016-12-14 17:01:15,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1ab720c6d3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 17:01:16,641 unpacking tar archive at: mozilla-central-b1ab720c6d3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.363128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 17:01:16.946333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:16.946736) ========= script_repo_revision: b1ab720c6d3e412ede797b08dfe63dca170f6ee0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:16.947178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:16.947442) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 17:01:16.957478) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-14 17:01:16.957910) ========= /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=62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:01:17 INFO - MultiFileLogger online at 20161214 17:01:17 in /builds/slave/test 17:01:17 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 17:01:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:01:17 INFO - {'append_to_log': False, 17:01:17 INFO - 'base_work_dir': '/builds/slave/test', 17:01:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:01:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:01:17 INFO - 'branch': 'Firefox-Non-PGO', 17:01:17 INFO - 'buildbot_json_path': 'buildprops.json', 17:01:17 INFO - 'config_files': ('talos/linux_config.py',), 17:01:17 INFO - 'default_actions': ('clobber', 17:01:17 INFO - 'read-buildbot-config', 17:01:17 INFO - 'download-and-extract', 17:01:17 INFO - 'populate-webroot', 17:01:17 INFO - 'create-virtualenv', 17:01:17 INFO - 'install', 17:01:17 INFO - 'run-tests'), 17:01:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:01:17 INFO - 'download_minidump_stackwalk': True, 17:01:17 INFO - 'download_symbols': 'ondemand', 17:01:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:01:17 INFO - 'tooltool.py': '/tools/tooltool.py', 17:01:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:01:17 INFO - '/tools/misc-python/virtualenv.py')}, 17:01:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:01:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:01:17 INFO - 'installer_path': 'installer.exe', 17:01:17 INFO - 'log_level': 'info', 17:01:17 INFO - 'log_name': 'talos', 17:01:17 INFO - 'log_to_console': True, 17:01:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:01:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:01:17 INFO - 'opt_config_files': (), 17:01:17 INFO - 'pip_index': False, 17:01:17 INFO - 'sps_profile': False, 17:01:17 INFO - 'sps_profile_interval': 0, 17:01:17 INFO - 'suite': 'dromaeojs', 17:01:17 INFO - 'system_bits': '32', 17:01:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:01:17 INFO - 'title': 'talos-linux64-ix-018', 17:01:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:01:17 INFO - 'use_talos_json': True, 17:01:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:01:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:01:17 INFO - 'work_dir': 'build'} 17:01:17 INFO - [mozharness: 2016-12-15 01:01:17.142647Z] Running clobber step. 17:01:17 INFO - Running pre-action listener: _resource_record_pre_action 17:01:17 INFO - Running main action method: clobber 17:01:17 INFO - rmtree: /builds/slave/test/build 17:01:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:01:17 INFO - Running post-action listener: _resource_record_post_action 17:01:17 INFO - [mozharness: 2016-12-15 01:01:17.592832Z] Finished clobber step (success) 17:01:17 INFO - [mozharness: 2016-12-15 01:01:17.592931Z] Running read-buildbot-config step. 17:01:17 INFO - Running pre-action listener: _resource_record_pre_action 17:01:17 INFO - Running main action method: read_buildbot_config 17:01:17 INFO - Using buildbot properties: 17:01:17 INFO - { 17:01:17 INFO - "project": "", 17:01:17 INFO - "product": "firefox", 17:01:17 INFO - "script_repo_revision": "production", 17:01:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:01:17 INFO - "repository": "", 17:01:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:01:17 INFO - "buildid": "20161214160703", 17:01:17 INFO - "pgo_build": "False", 17:01:17 INFO - "basedir": "/builds/slave/test", 17:01:17 INFO - "buildnumber": 344, 17:01:17 INFO - "slavename": "talos-linux64-ix-018", 17:01:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:01:17 INFO - "platform": "ubuntu64_hw", 17:01:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:01:17 INFO - "branch": "mozilla-central", 17:01:17 INFO - "repo_path": "mozilla-central", 17:01:17 INFO - "revision": "b1ab720c6d3e412ede797b08dfe63dca170f6ee0", 17:01:17 INFO - "stage_platform": "linux64", 17:01:17 INFO - "builduid": "292354d9e139468380726b26ea57d292", 17:01:17 INFO - "slavebuilddir": "test" 17:01:17 INFO - } 17:01:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 17:01:17 INFO - Running post-action listener: _resource_record_post_action 17:01:17 INFO - [mozharness: 2016-12-15 01:01:17.595366Z] Finished read-buildbot-config step (success) 17:01:17 INFO - [mozharness: 2016-12-15 01:01:17.595455Z] Running download-and-extract step. 17:01:17 INFO - Running pre-action listener: _resource_record_pre_action 17:01:17 INFO - Running main action method: download_and_extract 17:01:17 INFO - mkdir: /builds/slave/test/build/tests 17:01:17 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')]} 17:01:17 INFO - trying https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:01:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/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 17:01:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/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 17:01:18 INFO - Downloaded 1361 bytes. 17:01:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:01:18 INFO - Using the following test package requirements: 17:01:18 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:01:18 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:01:18 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:01:18 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:18 INFO - u'jsshell-linux-x86_64.zip'], 17:01:18 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:01:18 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:01:18 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:01:18 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:01:18 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:01:18 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:01:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:01:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:01:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:01:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:01:18 INFO - Expected file size: 20212155 17:01:18 INFO - Obtained file size: 20212155 17:01:23 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 17:01:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:01:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:01:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:01:23 INFO - Expected file size: 20212155 17:01:23 INFO - Obtained file size: 20212155 17:01:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 17:01:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:01:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:01:29 INFO - Expected file size: 14409734 17:01:29 INFO - Obtained file size: 14409734 17:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:29 INFO - trying https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:01:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/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 17:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/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 17:01:30 INFO - Downloaded 55786099 bytes. 17:01:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:01:30 INFO - mkdir: /builds/slave/test/properties 17:01:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:01:30 INFO - Writing to file /builds/slave/test/properties/build_url 17:01:30 INFO - Contents: 17:01:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:01:31 INFO - Running post-action listener: _resource_record_post_action 17:01:31 INFO - Running post-action listener: set_extra_try_arguments 17:01:31 INFO - [mozharness: 2016-12-15 01:01:31.177566Z] Finished download-and-extract step (success) 17:01:31 INFO - [mozharness: 2016-12-15 01:01:31.177793Z] Running populate-webroot step. 17:01:31 INFO - Running pre-action listener: _resource_record_pre_action 17:01:31 INFO - Running main action method: populate_webroot 17:01:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:01:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:01:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:01:31 INFO - '--tppagecycles', 17:01:31 INFO - '7'], 17:01:31 INFO - 'tests': ['tsvgm']}}, 17:01:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:01:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:01:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:01:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:01:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:01:31 INFO - 'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:01:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:01:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:01:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:01:31 INFO - 'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['damp', 'tps']}, 17:01:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:01:31 INFO - 'tests': ['damp', 'tps']}, 17:01:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['dromaeo_dom']}, 17:01:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:01:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['basic_compositor_video']}, 17:01:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:01:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['a11yr', 17:01:31 INFO - 'ts_paint', 17:01:31 INFO - 'tpaint', 17:01:31 INFO - 'sessionrestore', 17:01:31 INFO - 'sessionrestore_no_auto_restore', 17:01:31 INFO - 'tabpaint']}, 17:01:31 INFO - 'other-e10s': {'tests': ['a11yr', 17:01:31 INFO - 'ts_paint', 17:01:31 INFO - 'tpaint', 17:01:31 INFO - 'sessionrestore', 17:01:31 INFO - 'sessionrestore_no_auto_restore', 17:01:31 INFO - 'tabpaint']}, 17:01:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:01:31 INFO - 'ts_paint', 17:01:31 INFO - 'tpaint', 17:01:31 INFO - 'sessionrestore', 17:01:31 INFO - 'sessionrestore_no_auto_restore', 17:01:31 INFO - 'tabpaint']}, 17:01:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:01:31 INFO - 'ts_paint', 17:01:31 INFO - 'tpaint', 17:01:31 INFO - 'sessionrestore', 17:01:31 INFO - 'sessionrestore_no_auto_restore', 17:01:31 INFO - 'tabpaint']}, 17:01:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['a11yr', 17:01:31 INFO - 'ts_paint', 17:01:31 INFO - 'tpaint', 17:01:31 INFO - 'sessionrestore', 17:01:31 INFO - 'sessionrestore_no_auto_restore', 17:01:31 INFO - 'tabpaint']}, 17:01:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['a11yr', 17:01:31 INFO - 'ts_paint', 17:01:31 INFO - 'tpaint', 17:01:31 INFO - 'sessionrestore', 17:01:31 INFO - 'sessionrestore_no_auto_restore', 17:01:31 INFO - 'tabpaint']}, 17:01:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['tsvgx', 17:01:31 INFO - 'tsvgr_opacity', 17:01:31 INFO - 'tart', 17:01:31 INFO - 'tscrollx', 17:01:31 INFO - 'cart', 17:01:31 INFO - 'tsvg_static']}, 17:01:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:01:31 INFO - 'tsvgr_opacity', 17:01:31 INFO - 'tart', 17:01:31 INFO - 'tscrollx', 17:01:31 INFO - 'cart', 17:01:31 INFO - 'tsvg_static']}, 17:01:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:01:31 INFO - 'talos_options': ['--disable-e10s'], 17:01:31 INFO - 'tests': ['tp5o']}, 17:01:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:01:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:01:31 INFO - 'talos_options': ['--disable-e10s', 17:01:31 INFO - '--xperf_path', 17:01:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:01:31 INFO - 'tests': ['tp5n']}, 17:01:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:01:31 INFO - 'talos_options': ['--xperf_path', 17:01:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:01:31 INFO - 'tests': ['tp5n']}}, 17:01:31 INFO - 'talos.zip': {'path': '', 17:01:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:01:31 INFO - Running post-action listener: _resource_record_post_action 17:01:31 INFO - [mozharness: 2016-12-15 01:01:31.199603Z] Finished populate-webroot step (success) 17:01:31 INFO - [mozharness: 2016-12-15 01:01:31.199691Z] Running create-virtualenv step. 17:01:31 INFO - Running pre-action listener: _resource_record_pre_action 17:01:31 INFO - Running main action method: create_virtualenv 17:01:31 INFO - Creating virtualenv /builds/slave/test/build/venv 17:01:31 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 17:01:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:01:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:01:31 INFO - Using real prefix '/usr' 17:01:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:01:31 INFO - Installing distribute.............................................................................................................................................................................................done. 17:01:33 INFO - Installing pip.................done. 17:01:33 INFO - Return code: 0 17:01:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:01:33 INFO - Reading from file tmpfile_stdout 17:01:33 INFO - Output received: 17:01:33 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) 17:01:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:01: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')]} 17:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01: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')]} 17:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:33 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 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:33 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 17:01:33 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 17:01:33 INFO - Using env: {'DISPLAY': ':0', 17:01:33 INFO - 'HOME': '/home/cltbld', 17:01:33 INFO - 'LANG': 'en_US.UTF-8', 17:01:33 INFO - 'LANGUAGE': 'en_US:en', 17:01:33 INFO - 'LOGNAME': 'cltbld', 17:01:33 INFO - 'MAIL': '/var/mail/cltbld', 17:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:33 INFO - 'MOZ_NO_REMOTE': '1', 17:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:33 INFO - 'NO_EM_RESTART': '1', 17:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:33 INFO - 'PWD': '/builds/slave/test', 17:01:33 INFO - 'SHELL': '/bin/bash', 17:01:33 INFO - 'SHLVL': '1', 17:01:33 INFO - 'TERM': 'linux', 17:01:33 INFO - 'TMOUT': '86400', 17:01:33 INFO - 'USER': 'cltbld', 17:01:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:33 INFO - '_': '/tools/buildbot/bin/python'} 17:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:34 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 17:01:34 INFO - Cleaning up... 17:01:34 INFO - Return code: 0 17:01:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:34 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 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:34 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 17:01:34 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 17:01:34 INFO - Using env: {'DISPLAY': ':0', 17:01:34 INFO - 'HOME': '/home/cltbld', 17:01:34 INFO - 'LANG': 'en_US.UTF-8', 17:01:34 INFO - 'LANGUAGE': 'en_US:en', 17:01:34 INFO - 'LOGNAME': 'cltbld', 17:01:34 INFO - 'MAIL': '/var/mail/cltbld', 17:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:34 INFO - 'MOZ_NO_REMOTE': '1', 17:01:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:34 INFO - 'NO_EM_RESTART': '1', 17:01:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:34 INFO - 'PWD': '/builds/slave/test', 17:01:34 INFO - 'SHELL': '/bin/bash', 17:01:34 INFO - 'SHLVL': '1', 17:01:34 INFO - 'TERM': 'linux', 17:01:34 INFO - 'TMOUT': '86400', 17:01:34 INFO - 'USER': 'cltbld', 17:01:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:34 INFO - '_': '/tools/buildbot/bin/python'} 17:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:34 INFO - Downloading/unpacking psutil>=3.1.1 17:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:01:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:01:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:01:36 INFO - Installing collected packages: psutil 17:01:36 INFO - Running setup.py install for psutil 17:01:36 INFO - building 'psutil._psutil_linux' extension 17:01:36 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 17:01:36 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 17:01:36 INFO - building 'psutil._psutil_posix' extension 17:01:36 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 17:01:36 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 17:01:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:01:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:01:36 INFO - Successfully installed psutil 17:01:36 INFO - Cleaning up... 17:01:37 INFO - Return code: 0 17:01:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:01: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')]} 17:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01: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')]} 17:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:37 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 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:37 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 17:01:37 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 17:01:37 INFO - Using env: {'DISPLAY': ':0', 17:01:37 INFO - 'HOME': '/home/cltbld', 17:01:37 INFO - 'LANG': 'en_US.UTF-8', 17:01:37 INFO - 'LANGUAGE': 'en_US:en', 17:01:37 INFO - 'LOGNAME': 'cltbld', 17:01:37 INFO - 'MAIL': '/var/mail/cltbld', 17:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:37 INFO - 'MOZ_NO_REMOTE': '1', 17:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:37 INFO - 'NO_EM_RESTART': '1', 17:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:37 INFO - 'PWD': '/builds/slave/test', 17:01:37 INFO - 'SHELL': '/bin/bash', 17:01:37 INFO - 'SHLVL': '1', 17:01:37 INFO - 'TERM': 'linux', 17:01:37 INFO - 'TMOUT': '86400', 17:01:37 INFO - 'USER': 'cltbld', 17:01:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:37 INFO - '_': '/tools/buildbot/bin/python'} 17:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:01:39 INFO - Installing collected packages: mozsystemmonitor 17:01:39 INFO - Running setup.py install for mozsystemmonitor 17:01:39 INFO - Successfully installed mozsystemmonitor 17:01:39 INFO - Cleaning up... 17:01:39 INFO - Return code: 0 17:01:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:01:39 INFO - Using env: {'DISPLAY': ':0', 17:01:39 INFO - 'HOME': '/home/cltbld', 17:01:39 INFO - 'LANG': 'en_US.UTF-8', 17:01:39 INFO - 'LANGUAGE': 'en_US:en', 17:01:39 INFO - 'LOGNAME': 'cltbld', 17:01:39 INFO - 'MAIL': '/var/mail/cltbld', 17:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:39 INFO - 'MOZ_NO_REMOTE': '1', 17:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:39 INFO - 'NO_EM_RESTART': '1', 17:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:39 INFO - 'PWD': '/builds/slave/test', 17:01:39 INFO - 'SHELL': '/bin/bash', 17:01:39 INFO - 'SHLVL': '1', 17:01:39 INFO - 'TERM': 'linux', 17:01:39 INFO - 'TMOUT': '86400', 17:01:39 INFO - 'USER': 'cltbld', 17:01:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:39 INFO - '_': '/tools/buildbot/bin/python'} 17:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:39 INFO - Downloading/unpacking jsonschema==2.5.1 17:01:39 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 17:01:39 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 17:01:39 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 17:01:39 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 17:01:39 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 17:01:39 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 17:01:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:01:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 INFO - Downloading functools32-3.2.3-2.tar.gz 17:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:01:41 INFO - warning: no files found matching '*.txt' 17:01:41 INFO - no previously-included directories found matching 'build' 17:01:41 INFO - no previously-included directories found matching 'dist' 17:01:41 INFO - no previously-included directories found matching '.git*' 17:01:41 INFO - Installing collected packages: jsonschema, functools32 17:01:41 INFO - Running setup.py install for functools32 17:01:42 INFO - warning: no files found matching '*.txt' 17:01:42 INFO - no previously-included directories found matching 'build' 17:01:42 INFO - no previously-included directories found matching 'dist' 17:01:42 INFO - no previously-included directories found matching '.git*' 17:01:42 INFO - Successfully installed jsonschema functools32 17:01:42 INFO - Cleaning up... 17:01:42 INFO - Return code: 0 17:01:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:42 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 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:42 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 17:01:42 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 17:01:42 INFO - Using env: {'DISPLAY': ':0', 17:01:42 INFO - 'HOME': '/home/cltbld', 17:01:42 INFO - 'LANG': 'en_US.UTF-8', 17:01:42 INFO - 'LANGUAGE': 'en_US:en', 17:01:42 INFO - 'LOGNAME': 'cltbld', 17:01:42 INFO - 'MAIL': '/var/mail/cltbld', 17:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:42 INFO - 'MOZ_NO_REMOTE': '1', 17:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:42 INFO - 'NO_EM_RESTART': '1', 17:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:42 INFO - 'PWD': '/builds/slave/test', 17:01:42 INFO - 'SHELL': '/bin/bash', 17:01:42 INFO - 'SHLVL': '1', 17:01:42 INFO - 'TERM': 'linux', 17:01:42 INFO - 'TMOUT': '86400', 17:01:42 INFO - 'USER': 'cltbld', 17:01:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:42 INFO - '_': '/tools/buildbot/bin/python'} 17:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:01:42 INFO - Cleaning up... 17:01:42 INFO - Return code: 0 17:01:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:42 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 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:42 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 17:01:42 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 17:01:42 INFO - Using env: {'DISPLAY': ':0', 17:01:42 INFO - 'HOME': '/home/cltbld', 17:01:42 INFO - 'LANG': 'en_US.UTF-8', 17:01:42 INFO - 'LANGUAGE': 'en_US:en', 17:01:42 INFO - 'LOGNAME': 'cltbld', 17:01:42 INFO - 'MAIL': '/var/mail/cltbld', 17:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:42 INFO - 'MOZ_NO_REMOTE': '1', 17:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:42 INFO - 'NO_EM_RESTART': '1', 17:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:42 INFO - 'PWD': '/builds/slave/test', 17:01:42 INFO - 'SHELL': '/bin/bash', 17:01:42 INFO - 'SHLVL': '1', 17:01:42 INFO - 'TERM': 'linux', 17:01:42 INFO - 'TMOUT': '86400', 17:01:42 INFO - 'USER': 'cltbld', 17:01:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:42 INFO - '_': '/tools/buildbot/bin/python'} 17:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:42 INFO - Downloading/unpacking blobuploader==1.2.4 17:01:42 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 17:01:42 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 17:01:42 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 17:01:42 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 17:01:42 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 17:01:42 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 17:01:44 INFO - Downloading blobuploader-1.2.4.tar.gz 17:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:01:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:01:44 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 17:01:44 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 17:01:44 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 17:01:44 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 17:01:44 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 17:01:44 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 17:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:01:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:01:45 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 17:01:45 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 17:01:45 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 17:01:45 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 17:01:45 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 17:01:45 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 17:01:45 INFO - Downloading docopt-0.6.1.tar.gz 17:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:01:45 INFO - Installing collected packages: blobuploader, requests, docopt 17:01:45 INFO - Running setup.py install for blobuploader 17:01:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:01:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:01:45 INFO - Running setup.py install for requests 17:01:45 INFO - Running setup.py install for docopt 17:01:45 INFO - Successfully installed blobuploader requests docopt 17:01:45 INFO - Cleaning up... 17:01:45 INFO - Return code: 0 17:01:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:45 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 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:45 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 17:01:45 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 17:01:45 INFO - Using env: {'DISPLAY': ':0', 17:01:45 INFO - 'HOME': '/home/cltbld', 17:01:45 INFO - 'LANG': 'en_US.UTF-8', 17:01:45 INFO - 'LANGUAGE': 'en_US:en', 17:01:45 INFO - 'LOGNAME': 'cltbld', 17:01:45 INFO - 'MAIL': '/var/mail/cltbld', 17:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:45 INFO - 'MOZ_NO_REMOTE': '1', 17:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:45 INFO - 'NO_EM_RESTART': '1', 17:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:45 INFO - 'PWD': '/builds/slave/test', 17:01:45 INFO - 'SHELL': '/bin/bash', 17:01:45 INFO - 'SHLVL': '1', 17:01:45 INFO - 'TERM': 'linux', 17:01:45 INFO - 'TMOUT': '86400', 17:01:45 INFO - 'USER': 'cltbld', 17:01:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:45 INFO - '_': '/tools/buildbot/bin/python'} 17:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:01:46 INFO - Running setup.py (path:/tmp/pip-WgDcZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:01:46 INFO - Running setup.py (path:/tmp/pip-K742LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:01:46 INFO - Running setup.py (path:/tmp/pip-Vy739s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:01:46 INFO - Running setup.py (path:/tmp/pip-M4hDsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:01:46 INFO - Running setup.py (path:/tmp/pip-0ZpMM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:01:46 INFO - Running setup.py (path:/tmp/pip-ROe4sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:01:46 INFO - Running setup.py (path:/tmp/pip-nxMYys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:01:46 INFO - Running setup.py (path:/tmp/pip-tea0GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:01:46 INFO - Running setup.py (path:/tmp/pip-Upf3eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:01:46 INFO - Running setup.py (path:/tmp/pip-0A16p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:01:46 INFO - Running setup.py (path:/tmp/pip-_pOLNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:01:46 INFO - Running setup.py (path:/tmp/pip-UJNv74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:01:47 INFO - Running setup.py (path:/tmp/pip-Nz5KZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:01:47 INFO - Running setup.py (path:/tmp/pip-OuM1Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:01:47 INFO - Running setup.py (path:/tmp/pip-WOdHOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:01:47 INFO - Running setup.py (path:/tmp/pip-fv3674-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:01:47 INFO - Running setup.py (path:/tmp/pip-HLsv0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:01:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:01:47 INFO - Running setup.py install for manifestparser 17:01:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:01:47 INFO - Running setup.py install for mozcrash 17:01:47 INFO - Running setup.py install for mozdebug 17:01:47 INFO - Running setup.py install for mozdevice 17:01:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:01:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:01:47 INFO - Running setup.py install for mozfile 17:01:47 INFO - Running setup.py install for mozhttpd 17:01:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:01:47 INFO - Running setup.py install for mozinfo 17:01:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Running setup.py install for mozInstall 17:01:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Running setup.py install for mozleak 17:01:48 INFO - Running setup.py install for mozlog 17:01:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Running setup.py install for moznetwork 17:01:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Running setup.py install for mozprocess 17:01:48 INFO - Running setup.py install for mozprofile 17:01:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Running setup.py install for mozrunner 17:01:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:01:48 INFO - Running setup.py install for mozscreenshot 17:01:48 INFO - Running setup.py install for moztest 17:01:49 INFO - Running setup.py install for mozversion 17:01:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:01:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:01:49 INFO - Cleaning up... 17:01:49 INFO - Return code: 0 17:01:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:49 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 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:49 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 17:01:49 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 17:01:49 INFO - Using env: {'DISPLAY': ':0', 17:01:49 INFO - 'HOME': '/home/cltbld', 17:01:49 INFO - 'LANG': 'en_US.UTF-8', 17:01:49 INFO - 'LANGUAGE': 'en_US:en', 17:01:49 INFO - 'LOGNAME': 'cltbld', 17:01:49 INFO - 'MAIL': '/var/mail/cltbld', 17:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:49 INFO - 'MOZ_NO_REMOTE': '1', 17:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:49 INFO - 'NO_EM_RESTART': '1', 17:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:49 INFO - 'PWD': '/builds/slave/test', 17:01:49 INFO - 'SHELL': '/bin/bash', 17:01:49 INFO - 'SHLVL': '1', 17:01:49 INFO - 'TERM': 'linux', 17:01:49 INFO - 'TMOUT': '86400', 17:01:49 INFO - 'USER': 'cltbld', 17:01:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:49 INFO - '_': '/tools/buildbot/bin/python'} 17:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:01:49 INFO - Running setup.py (path:/tmp/pip-C9_r36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:01:49 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)) 17:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:01:49 INFO - Running setup.py (path:/tmp/pip-FbHPtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:01:49 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)) 17:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:01:49 INFO - Running setup.py (path:/tmp/pip-hWDfZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:01:49 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)) 17:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:01:49 INFO - Running setup.py (path:/tmp/pip-UJmuh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:01:49 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)) 17:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:01:49 INFO - Running setup.py (path:/tmp/pip-JCiLoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:01:49 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)) 17:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:01:49 INFO - Running setup.py (path:/tmp/pip-rxII94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:01:49 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)) 17:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:01:49 INFO - Running setup.py (path:/tmp/pip-8yMLyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:01:49 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)) 17:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:01:49 INFO - Running setup.py (path:/tmp/pip-vw8Ew5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:01:49 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)) 17:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:01:49 INFO - Running setup.py (path:/tmp/pip-d5bZu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:01:50 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)) 17:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:01:50 INFO - Running setup.py (path:/tmp/pip-CqbT0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:01:50 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)) 17:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:01:50 INFO - Running setup.py (path:/tmp/pip-8tjKvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:01:50 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)) 17:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:01:50 INFO - Running setup.py (path:/tmp/pip-wFWBZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:01:50 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)) 17:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:01:50 INFO - Running setup.py (path:/tmp/pip-AXcqh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:01:50 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)) 17:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:01:50 INFO - Running setup.py (path:/tmp/pip-ZCoJBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:01:50 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)) 17:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:01:50 INFO - Running setup.py (path:/tmp/pip-I1TKrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:01:50 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)) 17:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:01:50 INFO - Running setup.py (path:/tmp/pip-uUqu9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:01:50 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)) 17:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:01:50 INFO - Running setup.py (path:/tmp/pip-Ix3GXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:01:50 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)) 17:01:50 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)) 17:01:50 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)) 17:01:50 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)) 17:01:50 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)) 17:01:50 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)) 17:01:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:52 INFO - Downloading blessings-1.6.tar.gz 17:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:01:52 INFO - Installing collected packages: blessings 17:01:52 INFO - Running setup.py install for blessings 17:01:52 INFO - Successfully installed blessings 17:01:52 INFO - Cleaning up... 17:01:52 INFO - Return code: 0 17:01:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:01:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:01:53 INFO - Reading from file tmpfile_stdout 17:01:53 INFO - Current package versions: 17:01:53 INFO - argparse == 1.2.1 17:01:53 INFO - blessings == 1.6 17:01:53 INFO - blobuploader == 1.2.4 17:01:53 INFO - docopt == 0.6.1 17:01:53 INFO - functools32 == 3.2.3-2 17:01:53 INFO - jsonschema == 2.5.1 17:01:53 INFO - manifestparser == 1.1 17:01:53 INFO - mozInstall == 1.12 17:01:53 INFO - mozcrash == 1.0 17:01:53 INFO - mozdebug == 0.1 17:01:53 INFO - mozdevice == 0.49 17:01:53 INFO - mozfile == 1.2 17:01:53 INFO - mozhttpd == 0.7 17:01:53 INFO - mozinfo == 0.9 17:01:53 INFO - mozleak == 0.1 17:01:53 INFO - mozlog == 3.4 17:01:53 INFO - moznetwork == 0.27 17:01:53 INFO - mozprocess == 0.23 17:01:53 INFO - mozprofile == 0.28 17:01:53 INFO - mozrunner == 6.13 17:01:53 INFO - mozscreenshot == 0.1 17:01:53 INFO - mozsystemmonitor == 0.3 17:01:53 INFO - moztest == 0.7 17:01:53 INFO - mozversion == 1.4 17:01:53 INFO - psutil == 3.1.1 17:01:53 INFO - requests == 1.2.3 17:01:53 INFO - wsgiref == 0.1.2 17:01:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:01:53 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')]} 17:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:53 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')]} 17:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:53 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 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:53 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 17:01:53 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 17:01:53 INFO - Using env: {'DISPLAY': ':0', 17:01:53 INFO - 'HOME': '/home/cltbld', 17:01:53 INFO - 'LANG': 'en_US.UTF-8', 17:01:53 INFO - 'LANGUAGE': 'en_US:en', 17:01:53 INFO - 'LOGNAME': 'cltbld', 17:01:53 INFO - 'MAIL': '/var/mail/cltbld', 17:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:53 INFO - 'MOZ_NO_REMOTE': '1', 17:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:53 INFO - 'NO_EM_RESTART': '1', 17:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:53 INFO - 'PWD': '/builds/slave/test', 17:01:53 INFO - 'SHELL': '/bin/bash', 17:01:53 INFO - 'SHLVL': '1', 17:01:53 INFO - 'TERM': 'linux', 17:01:53 INFO - 'TMOUT': '86400', 17:01:53 INFO - 'USER': 'cltbld', 17:01:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:53 INFO - '_': '/tools/buildbot/bin/python'} 17:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:53 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)) 17:01:53 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)) 17:01:53 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)) 17:01:53 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)) 17:01:53 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)) 17:01:53 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)) 17:01:53 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)) 17:01:53 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)) 17:01:53 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)) 17:01:53 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)) 17:01:53 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)) 17:01:53 INFO - Cleaning up... 17:01:53 INFO - Return code: 0 17:01:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:01:53 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')]} 17:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:53 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')]} 17:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:53 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 0x7f5cac020e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, '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': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', '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 17:01:53 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 17:01:53 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 17:01:53 INFO - Using env: {'DISPLAY': ':0', 17:01:53 INFO - 'HOME': '/home/cltbld', 17:01:53 INFO - 'LANG': 'en_US.UTF-8', 17:01:53 INFO - 'LANGUAGE': 'en_US:en', 17:01:53 INFO - 'LOGNAME': 'cltbld', 17:01:53 INFO - 'MAIL': '/var/mail/cltbld', 17:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:53 INFO - 'MOZ_NO_REMOTE': '1', 17:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:53 INFO - 'NO_EM_RESTART': '1', 17:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:53 INFO - 'PWD': '/builds/slave/test', 17:01:53 INFO - 'SHELL': '/bin/bash', 17:01:53 INFO - 'SHLVL': '1', 17:01:53 INFO - 'TERM': 'linux', 17:01:53 INFO - 'TMOUT': '86400', 17:01:53 INFO - 'USER': 'cltbld', 17:01:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:53 INFO - '_': '/tools/buildbot/bin/python'} 17:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:01:53 INFO - Cleaning up... 17:01:53 INFO - Return code: 0 17:01:53 INFO - Running post-action listener: _resource_record_post_action 17:01:53 INFO - Running post-action listener: _start_resource_monitoring 17:01:53 INFO - Starting resource monitoring. 17:01:53 INFO - [mozharness: 2016-12-15 01:01:53.569677Z] Finished create-virtualenv step (success) 17:01:53 INFO - [mozharness: 2016-12-15 01:01:53.570141Z] Running install step. 17:01:53 INFO - Running pre-action listener: _resource_record_pre_action 17:01:53 INFO - Running main action method: install 17:01:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:01:53 INFO - Reading from file tmpfile_stdout 17:01:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:01:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:01:53 INFO - Reading from file tmpfile_stdout 17:01:53 INFO - Output received: 17:01:53 INFO - Usage: mozinstall [options] installer 17:01:53 INFO - Options: 17:01:53 INFO - -h, --help show this help message and exit 17:01:53 INFO - -d DEST, --destination=DEST 17:01:53 INFO - Directory to install application into. [default: 17:01:53 INFO - "/builds/slave/test"] 17:01:53 INFO - --app=APP Application being installed. [default: firefox] 17:01:53 INFO - mkdir: /builds/slave/test/build/application 17:01:53 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'] 17:01:53 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 17:02:09 INFO - Reading from file tmpfile_stdout 17:02:09 INFO - Output received: 17:02:09 INFO - /builds/slave/test/build/application/firefox/firefox 17:02:09 INFO - Running post-action listener: _resource_record_post_action 17:02:09 INFO - [mozharness: 2016-12-15 01:02:09.901796Z] Finished install step (success) 17:02:09 INFO - [mozharness: 2016-12-15 01:02:09.902037Z] Running run-tests step. 17:02:09 INFO - Running pre-action listener: _resource_record_pre_action 17:02:09 INFO - Running main action method: run_tests 17:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:02:09 INFO - Python 2.7.3 17:02:09 INFO - Return code: 0 17:02:09 INFO - grabbing minidump binary from tooltool 17:02:09 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')]} 17:02:09 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 0x2038f20>, '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 0x1fa5c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:02:09 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 17:02:09 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 17:02:09 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 17:02:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:02:09 INFO - Return code: 0 17:02:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:02:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:02:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:02:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:02:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:02:09 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/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:02:09 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/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 17:02:09 INFO - Using env: {'DISPLAY': ':0', 17:02:09 INFO - 'HOME': '/home/cltbld', 17:02:09 INFO - 'LANG': 'en_US.UTF-8', 17:02:09 INFO - 'LANGUAGE': 'en_US:en', 17:02:09 INFO - 'LOGNAME': 'cltbld', 17:02:09 INFO - 'MAIL': '/var/mail/cltbld', 17:02:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:02:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:09 INFO - 'MOZ_NO_REMOTE': '1', 17:02:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:09 INFO - 'NO_EM_RESTART': '1', 17:02:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:09 INFO - 'PWD': '/builds/slave/test', 17:02:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:02:09 INFO - 'SHELL': '/bin/bash', 17:02:09 INFO - 'SHLVL': '1', 17:02:09 INFO - 'TERM': 'linux', 17:02:09 INFO - 'TMOUT': '86400', 17:02:09 INFO - 'USER': 'cltbld', 17:02:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662', 17:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:09 INFO - '_': '/tools/buildbot/bin/python'} 17:02:09 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/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:02:10 INFO - mozversion application_buildid: 20161214160703 17:02:10 INFO - mozversion application_changeset: b1ab720c6d3e412ede797b08dfe63dca170f6ee0 17:02:10 INFO - mozversion application_display_name: Nightly 17:02:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:02:10 INFO - mozversion application_name: Firefox 17:02:10 INFO - mozversion application_remotingname: firefox 17:02:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:02:10 INFO - mozversion application_vendor: Mozilla 17:02:10 INFO - mozversion application_version: 53.0a1 17:02:10 INFO - mozversion platform_buildid: 20161214160703 17:02:10 INFO - mozversion platform_changeset: b1ab720c6d3e412ede797b08dfe63dca170f6ee0 17:02:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:02:10 INFO - mozversion platform_version: 53.0a1 17:02:10 INFO - using testdate: 1481763730 17:02:10 INFO - actual date: 1481763730 17:02:10 INFO - starting webserver on 'localhost:60386' 17:02:10 INFO - SUITE-START | Running 2 tests 17:02:10 INFO - TEST-START | dromaeo_css 17:02:10 INFO - operating with platform_type : linux_ 17:02:10 INFO - Initialising browser for dromaeo_css test... 17:02:10 INFO - TEST-INFO | started process 16715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3FxjTW/profile http://localhost:60386/getInfo.html) 17:02:14 INFO - PROCESS | 16715 | __metrics Screen width/height:1600/1200 17:02:14 INFO - PROCESS | 16715 | colorDepth:24 17:02:14 INFO - PROCESS | 16715 | Browser inner width/height: 1024/697 17:02:14 INFO - PROCESS | 16715 | __metrics 17:02:15 INFO - PROCESS | 16715 | 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" 17:02:15 INFO - PROCESS | 16715 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:02:16 INFO - PROCESS | 16715 | console.error: PushService: 17:02:16 INFO - PROCESS | 16715 | stateChangeProcessEnqueue: Error transitioning state 17:02:16 INFO - PROCESS | 16715 | UnknownError 17:02:16 INFO - TEST-INFO | 16715: exit 0 17:02:16 INFO - Browser initialized. 17:02:16 INFO - Running cycle 1/1 for dromaeo_css test... 17:02:16 INFO - TEST-INFO | started process 16796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3FxjTW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:02:29 INFO - PROCESS | 16796 | RSS: Main: 174133248 17:02:29 INFO - PROCESS | 16796 | 17:03:20 INFO - PROCESS | 16796 | 1481763800030 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] 17:05:34 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:60386/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60386/tests/dromaeo/cssquery-ext.html) 17:05:36 INFO - PROCESS | 16796 | RSS: Main: 317816832 17:05:36 INFO - PROCESS | 16796 | 17:08:38 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:60386/tests/dromaeo/cssquery-ext.html (next: http://localhost:60386/tests/dromaeo/cssquery-jquery.html) 17:08:39 INFO - PROCESS | 16796 | RSS: Main: 279875584 17:08:39 INFO - PROCESS | 16796 | 17:11:41 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:60386/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60386/tests/dromaeo/cssquery-mootools.html) 17:11:42 INFO - PROCESS | 16796 | RSS: Main: 217190400 17:11:42 INFO - PROCESS | 16796 | 17:14:44 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:60386/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60386/tests/dromaeo/cssquery-prototype.html) 17:14:45 INFO - PROCESS | 16796 | RSS: Main: 218472448 17:14:45 INFO - PROCESS | 16796 | 17:17:48 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:60386/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60386/tests/dromaeo/cssquery-yui.html) 17:17:49 INFO - PROCESS | 16796 | RSS: Main: 221609984 17:17:49 INFO - PROCESS | 16796 | 17:20:52 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:60386/tests/dromaeo/cssquery-yui.html (next: http://localhost:60386/tests/dromaeo/cssquery-dojo.html) 17:20:52 INFO - PROCESS | 16796 | RSS: Main: 319279104 17:20:52 INFO - PROCESS | 16796 | 17:20:52 INFO - PROCESS | 16796 | __start_tp_report 17:20:52 INFO - PROCESS | 16796 | _x_x_mozilla_page_load 17:20:52 INFO - PROCESS | 16796 | _x_x_mozilla_page_load_details 17:20:52 INFO - PROCESS | 16796 | |i|pagename|runs| 17:20:52 INFO - PROCESS | 16796 | |0;dojo.html;2586.288770588088;2617.6989646190696;2633.262686447795;2648.4703059388125;2656.5483867742482;4564.748938808364;4641.883952901171;4732.479427263002;4751.572358487735;4769.99830035693;4660.184467718144;4712.198926182548;4737.786799594027;4742.976285118578;4759.1433541962515;4211.199872024321;4224.218519573873;4261.446012018433;4293.656507479394;4372.672049596277;4278.486581610211;4357.085012147453;4380.167768124063;4409.801558929856;4451.532589078149;4189.62293393593;4225.683073769449;4311.1593239318345;4353.434053573015;4390.143921935224;4277.764722940237;4278.700490965633;4283.1433713257165;4288.957110428887;4294.119705460374;4249.681273904439;4253.383259427396;4253.978730106361;4254.574542545752;4258.787060646986;4656;4701.459332176775;4708.8116475341285;4723.952760472385;4774.570288674036;5066.265391518246;5070.036693028313;5074.720890351029;5083.8983220335385;5121.28302037715;4869.269609558559;5100.132977393852;5106.540411362995;5115.309433226541;5115.948840511622;4608.953910460886;4643.071385722869;4654.325122857167;4668.626509879202;4751.667383283206;5078.08594453002;5132.820351287687;5146.356705411824;5149.562287205629;5165.9225111623355;4877.829275975324;4880.536349046835;4901.460839307673;4904.926426103611;4955.90088198234;4843.951560484421;4905.656604037755;4929.580985616263;4985.900281994413;5006.4743201964;4957.256411538226;5020.648554601143;5047.697138171721;5058.291839142523;5071.974640126776;5016.974915125401;5020.673656212334;5023.522765337287;5029.798808047711;5077.695338279715;4179.519355274182;4212.19968206046;4346.326319420495;4353.673474489426;4382.583654552813;3710;3719.814009299578;3763.360228761117;3764.642358975893;3820.7898565578603;4273.423087883159;4278.957210427918;4286.121345124242;4289.463817022872;4326.264535029052;5072.137736584789;5074.08666440037;5076.213186956028;5079.644424890223;5105.361829771278;4155.91688166235;4188.350805625133;4225.091605304874;4237.63980061692;4242.17277630859;4532.161550113239;4541.5231400703115;4548.5906268436;4562.749048802281;4586.564276393738;4677.11134884364;4681.040386720646;4684.578387945101;4700.005451292711;4739.075880203327;4884.194107972145;4894.314795928502;4929.556339929423;4934.037862616899;5015.3480047593575;4610.884727881829;4661.883452913568;4680.180968330596;4688.2733176357715;4723.45680246776;4885.389326334208;4893.143699852582;4928.802847886044;4936.950630493649;4974.104661161025;4868.41579010521;4952.925706114339;4968.4286307075145;4974.104661161025;5003.624728145476;4792.4249090108015;4802.73584952831;4835.032993401263;4844.757762111951;4854.708717476963;4856.125897338513;4867.902641947212;4889.877753056202;4896.2655601660035;4900.191468407673;4795.376601041842;4811.158047341772;4817;4818.349522814376;4822.662413631012;4772.212584923449;4779.30700048498;4817.0606731686985;4938.259261110862;4970;4757.286407038971;4771.809127634994;4772.045590881907;4782.497837726988;4783.593394561502 17:20:52 INFO - PROCESS | 16796 | |1;ext.html;501.2231041885078;507.1657124030969;519.4286285086403;521.1947541049078;521.4602886012977;26821.061262855805;29864;36405.635943640555;38168;38358;37071.4439283411;37350;37413.625863741356;37439.62560374395;37615.435768463496;7192.280771922792;7479.47643664945;7659.502132361406;7660.846783064336;7661.808454788619;7125.7149714011375;9487;9742.415455072683;9746.074122958307;10086.293959422843;9849.409035457895;9946.751331216741;9952.452615106165;9962;9963.601455941754;9627.518624068804;9691.515424228832;9697.515124243759;9699.612015519406;9705.417674939456;9684;9774.951125244399;9776.462294573796;9780.462074585896;9782.51087445625;35699.28601427957;36102;36134.638653613656;36154.63845361539;36207;2722.8774705138117;2752.7935404844716;2757.7380148885823;2838.8154769940093;3246.188452886778;26969.865150674123;27042.5943610846;27330.5900411494;27949.86025069882;28085.719142808513;3326.7172290355347;3365.5936005755757;3402.761806673534;3409.9659003409897;3437.7937323760652;245146;245564;247159;247868;248727;49813;50177.24734128991;50207.497925021016;50261.74869125704;50293;54075.45924540783;54196;54214.45785542173;54220;54247.186292205646;11935.880641193651;12089.57686480969;12109.636710898687;12111.939440302742;12113.757724845455;8859.468431894107;9172.770680733034;9694.563744631509;9776.31565790402;9796.706098817047;15190.240487975558;15768.76346854798;15850.543165809318;15908.204589770465;16032;5758.337791153987;5792.420757924174;5911.733971971272;5940.039786870322;5945.464908158287;769.5690413368419;804;933.4492649336923;950.3680052764972;967.8161149381594;25068.874655626605;26405.47189056208;26945.191644250703;27362.726372736415;27383.315417114332;908.2869947091501;952.6760901293593;971.5087340931777;982.8181786369545;1012.9290949633455;14558.272086395638;14683.265836708122;14727;14786.20798922622;14904.254787260594;341532;342833;343719;344735;344931;47731.761341193764;47895.28157077647;47945.28082078702;47945.28082078772;48082.519174808505;1053.3732429204765;1089.2810744908481;1127.2785417332914;1131.6718151735904;1182.6806762174165;24205.313191303292;27579.862100689366;28803.423931521673;29109;29312.26719332034;39737;39939.60060399359;39961.80019099886;40141;40166.799166003984;263800;264228;265572;266545;267229;21819.454513637287;22852.229382152425;22870.199543015915;23770.40573985664;23981;34489.65510344965;34580;34779.478307825906;34930;35221.47167792434;29653.258668532595;30114.698853012065;30254.697453025186;30628.234294142825;30711.539326909668;29257.268568285963;29446.852765736036;30456.84771576128;30511.847440762653;31157.376852463276;29704.851475742482;30185;30247.69752302537;30863;30964.535531966587;25101.623475647513;28767;29031.419371612872;29159.271018224714;29276.853615731787;22445.43886402853;22558.210462633728;22696.773032269466;22718.204862829723;22888.31335059951 17:20:52 INFO - PROCESS | 16796 | |2;jquery.html;333.24187473497807;344.51595508310834;364.4460420161355;366.1852378457931;379.6203796203796;12147.939260303698;12304.261744295338;13005.544805931771;13143.539976100838;15958.680826383465;15699.136547489883;15954.28205730742;16051.357945682188;16135.83864161358;16237.675246495062;4716.151092803286;4768.833090841821;4921.950780492203;4954.479779623141;4975.850724478253;4822.9035419291595;4904.36243288372;4911.508849115078;4919;4925.48282430345;3613.2050948791225;3812.5806161322234;5432.293801805759;5711.371749107595;5736.282964629421;5553.527950124244;5804.129380592903;5821.446962538552;5821.970890145522;5826.329972053226;4919.483454237289;4954.232094025432;4956.405231372222;4958.429780575244;4958.801647934079;18440.63118737631;19012.5246868828;19020.334288299844;19161.646711825375;19172.616547668968;1989.4827344890289;2006.9397918062482;2078.293380250707;2431.9756802431925;2451.178855083549;11443.942780286128;12469.75060498794;12593.244405335709;12872.742545149138;13021.479140834355;1697.5671203843065;1728.3950617283976;1754.5438186071585;1758.4732081207678;1759.5601099725068;39333.80333098345;54048.45951540513;54113.45886541124;59988.40011599872;62961;8503.532305723245;8538.274246689101;9132.086791320948;9207.493587852598;9363.425058108938;12537.93731031339;12555.93722031384;12559.623211303675;12563.057770667236;12569.87430125687;6546.9017964730565;6584.057702977633;6626.734930602722;6719.193696756322;6934.583924964519;6371.840703982438;6374.968125159345;6513.902291465632;6582.078509008743;6603.471722262208;5641.379448260688;5796.1595568642315;5879.500242479352;5902.291724993029;6001.189839371629;1624.7969003874516;1713.4431309824108;1736.461696873973;1770.4157627982736;1783.6878546254613;747.8205230744691;821.9630116644765;848.9363297752569;977.5210147027905;988.6045581767207;15639.374425022872;16673;16795.328186872634;16959.491215263562;17016.829831701772;836.381078002274;837.4347315561971;870.4429165334191;877.8507653698887;915.0712027292303;8851.69019084329;9609.423434593948;9621.759456013655;9627.663031793994;9773.706788796348;338453;342205;342783;343442;348738;64668.18627156973;64709.67645161744;65068.69684172969;65505;66121.66939165369;868.1665601023088;887.3744010472731;932.664240873285;933.4446004627372;933.9813203735887;14321.57035288943;14337.78493322622;14582.635434114232;14736.48422305214;15101.848981510044;33218.16954576155;33546.832265838515;33820.83089584536;34561;34732;43022.56977430185;43499.34750978675;43938.12123757571;43990.12019759523;44010.33984490171;7229.168645605612;7334.853302934018;7385.187629360658;7452.962735186289;7664.770056898302;11422.485988130387;11551.653450396501;11781.587644432404;11810.350430726392;12185.14703970749;6738.898916516158;8763.649454021768;9386.106223202774;9585.712428627152;10871.565137394417;10011.849822252818;10084.596616135272;10262.152812493823;10379.636712715019;10521.736956576147;10420.531076101443;10440.477976101316;10466.633667821894;10622.20333474977;10721.35671859691;6938.548994315353;7143.178534468395;7314.378277846443;7428.517146385468;7468.663910123949;6693.497987651043;9309.301802364715;10181;10425.426601536685;10438.53026613789 17:20:52 INFO - PROCESS | 16796 | |3;mootools.html;1313;1334.5529247702023;1397.5667543061645;1629.6822119686651;1647.8764092693052;6726.428253598444;7137.4646901482465;7150.356467917886;7160.856782864346;7172.426205903528;6255.874882502348;6381.968090159554;6426.871462570746;6549.148610680617;7065.682044308006;1812.474382429094;1975.2099160335908;2055.804698553635;2057.146284292017;2068.596623658387;2083.1875568528285;2092.905819238138;2094.1623350659706;2103.116690989788;2105.3262955854134;2020.5756791073818;2042.6527490326605;2087.217293514932;2089.0912453082883;2089.39407571804;1753;1817.5365281853176;1978.940631781049;2031.086011294923;2050.4771283322807;1959.931402400909;1975.7629084509952;1978.5251539630528;1979.6931475621302;1982.058522201957;6657.201135863679;6689.1972963244725;6696.5647232929705;6700.530962832555;6723.630200338979;4183.97908010461;4288.935665965013;4296.312589985619;4309.1381723655395;4321.395004699345;2605.622184783215;2658.2689760315875;2818.549032154866;2826.0250213676454;2830.080223927232;887.5296093070683;900.6712549919298;901.6168128545407;1695.6184858406882;1730.108993868159;9335.113164249386;9347.532623368805;9385.953070234606;9403.952980235123;9425.010373910709;3611.9277614447565;3788.45067465216;3828.1960788234783;3846.3076646203954;3853.189001169446;7519.736809211651;7523.435742319348;7526.32263096324;7528.134264559536;7572.432067594952;4337.414449049401;4350.825966961286;4351.06452112791;4351.956480435155;4352.499462561846;3860.613938606117;4054.716169868081;4055.9391609125887;4061.735987160825;4062.51249850014;2932.765378769736;3001.4897467430587;3007.789454738191;3036.878524859025;3125.6561778204377;931.8276118918022;948.800751842107;949.7815502434479;960.0543464687278;963.3882484622176;669.5647828911247;826.2274773087182;828.1718281718282;834.4117397234935;838.1157878438185;4685.156671799109;4765.404324459442;4858.1012512685265;4948.233023881304;5158.329417175743;387.63949526939655;390.34617016497253;396.2293339454733;399.7281848343097;409.1693861461238;3422.3668621305137;3486.8430920608635;3500.6149323574386;3508.736844736604;3621.2938476996733;8264.752057438287;8740.257078148301;8794.472331660121;8814.955925220333;8816.955915220382;8609.69866054685;8613.61238744258;8617.612207450555;8658.696945606873;8664.48013119215;6457.2896981332015;6633.900491492632;6696.330366963265;6783.152105986752;6809.319068093151;4827.42070951488;4876.561109500162;4891.315215869852;4933.531314525115;5096.311997880239;7741.264579864904;7843.215678432111;7873.488223265469;7938.56337901421;8001.359891208573;7975.282224599814;8031.759047228593;8080.9191908080165;8121.512709237465;8151.877721834058;5779.97110014464;5817.127430885401;5883.764649413975;5883.852903677443;5902.380250073852;6678.532502724957;6783.93216067833;6805.319468053155;6809.353111454404;6818.420434263143;5975.223220981245;6205.782797602063;6214.161088253209;6242.375762423721;6251.68741562911;5771.711414429178;5821.534277257724;5870.324912635102;6002.819915402545;6032.849178770566;5763.971180144073;5909.5863289569315;5918.437748413894;5939.109133629817;5943.791967281124;3452.7583069184916;4161.126163505576;4165.437665915063;4251.107267473742;4275.743455392686;4230.857668429445;4321.978390108029;4363.520012798653;4380.934285985649;4428.667849911205 17:20:52 INFO - PROCESS | 16796 | |4;prototype.html;329.1901921273667;338.6782556571258;343.16439469890827;361.95656521217455;363.2227034146926;4836.951630483694;4858.611311095113;4892.143874821905;4892.535209155129;4924.655274130812;4775.522447755223;4818.783154758035;4819.5180481951875;4826.831060912868;4828.348172996644;3343.492380714464;3644.4533320001947;3700.2044560419504;3739.289534988357;3765.3975363941777;3773.6792372648356;3862.4206369044587;3871.1870507193385;3879.7672139671567;3899.298126337258;3829.272438236726;3836.808159592023;3845.8653947111857;3852.3451013327804;3855.63371479709;3664.6885014773775;3837.501124853751;3858.9807050964846;3865.323568375523;3875.4380614810834;3366.646502117267;3383.847726852273;3440.776349537272;3453.671901169385;3470.444728843373;4620.422447194101;4682.742449165295;4684.554967278137;4688.929666055012;4704.270838020112;4409.691321607489;4413.514513403523;4420.115976804652;4424.035895949722;4429.645628349725;4862.82980095695;4987.675801072919;5040.470750571174;5046.423701809521;5077.466865979056;3774.9811250943844;3779.074126838942;3787.7159213058853;3801.543814742221;3803.752756070874;5023.924641130386;5080.54275115234;5208.453112423179;5281.207818827168;5314.149736042254;3842.538895332522;3863.9613603864163;3864.439656249828;3872.7289089763444;3876.9806150969066;3935.134270460494;3935.8819235422984;3937.291287568265;3948.2498325318097;3951.229510245532;4198.412222288882;4364.956350436455;4371.147626212922;4386.429764130643;4405.735655860659;4947.5794557462295;5013.273075404046;5015.749212539358;5032.194848824171;5050.84847454577;1309.8821106100497;1310.927898965547;1315.83552055993;1338.8795008449285;1347.6361382426885;908.9454632722058;943.9103285187896;953.0755167487526;955.4553904274636;970.815545046439;4238.618524332825;4256.638185754246;4269.402283680287;4307.978460107742;4312.762798046075;4990.72551009698;4991.450940396553;4994.200927851526;5027.723475208899;5057.974710126426;4258.787060646955;4283.365730076043;4288.24955632763;4327.415798867176;4350.912981740347;2572.6269690894715;2707.4043710383685;2711.359627425379;2715.592661100851;2718.4834881372476;4721.457032441244;4742.5731684148595;4758.738269395148;4774.641901857305;4776.832810851603;5050.267711181858;5197.58419326453;5218.217267409919;5250.894982100413;5256.1327380982475;4880.267505035732;4894.3147959285725;4900.803967841246;4916.188828843272;4927.87680307988;5238.76425560843;5241.951609678156;5246.6065045121;5256.264123022704;5267.315249017756;4901.50984901507;5085.821996230115;5182.507661772125;5192.636515443883;5195.610329225247;4654.93017604743;4735.83424580138;4784.712917224839;4853.126437241189;4865.781039853286;3626.165981824248;3641.945370819493;3643.433323670847;3646.2525182338086;3652.3243200008083;5165.870853228699;5172.327597412313;5178.792848286026;5179.922301165561;5185.196294574347;4879.438864530624;4992.850214493571;5015.874603134951;5017.949820501748;5022.422421421583;5010.824621138243;5020.272060551272;5020.527624888889;5020.87447813793;5023.397192336797;4925.975370123269;4931.7067563583105;4933.827316043921;4942.8764280893265;4967.552920237052;4905.2151655734915;4999.850004499871;5017.623678224075;5018.698878067327;5063;4935.309056732132;4936.185529387611;4939.666290101581;4945.381827271591;4952.678075925053 17:20:52 INFO - PROCESS | 16796 | |5;yui.html;624.8344188789969;664.9468042556596;672.7275453441358;733.9834329453709;747.9626018699065;12263.570775022876;12273.079519036064;12286;12791.48834046637;12957;12343.938280308608;12453.12828102031;12582.874171258285;12604.873951260484;12632.98936085111;766.5477368352671;788.4480863395618;788.8304014636852;793.9523628582275;794.3486341200218;787.6061969015492;790.6718711734624;791.2364568191693;792.1642666986356;793.0404210904812;825.8637324841424;828.7099515169702;832.142892820393;832.9125441828612;833.3666413525704;826.1325608111518;826.4338927834423;827.0282418158639;827.1108558299821;827.3009307135461;604.338249616669;604.7701873288166;604.7913469852894;604.8911195984721;605.3220393159689;10804.78390432187;10805.567777288978;10858.131349492021;11014.06380457662;11451;12044.939775301154;13007.414666339942;13285.800712989312;13456.663583410394;13574.932125339408;10279.588816447333;10329.483525823754;10502.317349372266;10646.680599582025;10714.303570267908;3220.0822765511953;3241.2221066944;3258.6252580953255;3264.069740124053;3266.216566091092;44913.55086449159;61533.69233153851;62063.37936620621;62757.37242627561;63245.36754632395;10649.733756656145;10653;10748.495210670513;10780.29928054674;10843.240973131806;20038.098285577184;20038.49903752418;20045.298414555422;20070.89964550168;20090.296839610837;6127.908081378783;6237.126802247689;6389.6805159741825;6512.511561632897;6712.463002959751;3424.092615456906;3487.1805125795418;3569.232614987738;3579.427291633326;3658.0854786303425;2767.778577713778;2842.0621195005597;2851.472477591652;2869.397426540408;2882.495563276418;465.0768225073227;467.04256274636856;467.18009892638884;473.22155054935126;474.40462219913786;497.8357142143084;555.7138073891949;570.3241658634531;592.1975722895414;612.791650838717;7914.24814642608;8324.798393111074;8512.957435212908;8634.222919937236;8742.86885696715;530.7156680832395;537.9993212624515;572.6764378126428;573.9942600574025;595.1727099331932;3623.655752703489;3785.6782173515007;3843.3466310727244;3894.279558281727;3899.512560929884;66272.33727662759;66906.33093669098;67409;67633.66183169052;68071.65964170247;57869.28901914751;58369;58986;59521;59985;54274.18588721172;54761.452385476434;54988;55568;55968.44031559632;7218.855622887618;7473.252674732484;7644.732434364771;7713;7968.800779980315;36818.631813682594;38003.239935201695;38254.23491530209;38592.42111368276;38628.841134766;44621.62148652073;49660.751696241285;50876;51418;51806;9857.983243211214;10351.792964140826;10648.8935110651;10649.9467502662;10799.56801727922;12191.207571507824;12482.56311029146;13244.47022119143;13463.528776493167;13700.314984250947;11808.692787292666;11913.702157446132;11929.28424294545;12242.816357754462;12293.692657683629;11975.221610595632;11994.700132496757;12021.879781202426;12392.62822115338;12463.813042804546;11562.94218528902;11680.299182049104;11742.479001021977;11800.468978895799;11861.822072668745;9624.951875240578;10015.799684006133;10301.587936482456;10564.577416903237;10734.141268698642;10247;10251.692449226535;10775.461226938465;10776.730581735519;11073.944630276797 17:20:52 INFO - PROCESS | 16796 | __end_tp_report 17:20:52 INFO - PROCESS | 16796 | __start_cc_report 17:20:52 INFO - PROCESS | 16796 | _x_x_mozilla_cycle_collect,1560 17:20:52 INFO - PROCESS | 16796 | __end_cc_report 17:20:52 INFO - PROCESS | 16796 | __startTimestamp1481764852253__endTimestamp 17:20:52 INFO - PROCESS | 16796 | 17:20:52 INFO - PROCESS | 16796 | ------- Summary: start ------- 17:20:52 INFO - PROCESS | 16796 | Number of tests: 6 17:20:52 INFO - PROCESS | 16796 | 17:20:52 INFO - PROCESS | 16796 | [#0] dojo.html Cycles:165 Average:4624.22 Median:4757.29 stddev:483.52 (10.2%) stddev-sans-first:457.81 17:20:52 INFO - PROCESS | 16796 | Values: 2586.3 2617.7 2633.3 2648.5 2656.5 4564.7 4641.9 4732.5 4751.6 4770.0 4660.2 4712.2 4737.8 4743.0 4759.1 4211.2 4224.2 4261.4 4293.7 4372.7 4278.5 4357.1 4380.2 4409.8 4451.5 4189.6 4225.7 4311.2 4353.4 4390.1 4277.8 4278.7 4283.1 4289.0 4294.1 4249.7 4253.4 4254.0 4254.6 4258.8 4656.0 4701.5 4708.8 4724.0 4774.6 5066.3 5070.0 5074.7 5083.9 5121.3 4869.3 5100.1 5106.5 5115.3 5115.9 4609.0 4643.1 4654.3 4668.6 4751.7 5078.1 5132.8 5146.4 5149.6 5165.9 4877.8 4880.5 4901.5 4904.9 4955.9 4844.0 4905.7 4929.6 4985.9 5006.5 4957.3 5020.6 5047.7 5058.3 5072.0 5017.0 5020.7 5023.5 5029.8 5077.7 4179.5 4212.2 4346.3 4353.7 4382.6 3710.0 3719.8 3763.4 3764.6 3820.8 4273.4 4279.0 4286.1 4289.5 4326.3 5072.1 5074.1 5076.2 5079.6 5105.4 4155.9 4188.4 4225.1 4237.6 4242.2 4532.2 4541.5 4548.6 4562.7 4586.6 4677.1 4681.0 4684.6 4700.0 4739.1 4884.2 4894.3 4929.6 4934.0 5015.3 4610.9 4661.9 4680.2 4688.3 4723.5 4885.4 4893.1 4928.8 4937.0 4974.1 4868.4 4952.9 4968.4 4974.1 5003.6 4792.4 4802.7 4835.0 4844.8 4854.7 4856.1 4867.9 4889.9 4896.3 4900.2 4795.4 4811.2 4817.0 4818.3 4822.7 4772.2 4779.3 4817.1 4938.3 4970.0 4757.3 4771.8 4772.0 4782.5 4783.6 17:20:52 INFO - PROCESS | 16796 | 17:20:52 INFO - PROCESS | 16796 | [#1] ext.html Cycles:180 Average:43078.42 Median:173578.40 stddev:75693.36 (43.6%) stddev-sans-first:75838.19 17:20:52 INFO - PROCESS | 16796 | Values: 501.2 507.2 519.4 521.2 521.5 26821.1 29864.0 36405.6 38168.0 38358.0 37071.4 37350.0 37413.6 37439.6 37615.4 7192.3 7479.5 7659.5 7660.8 7661.8 7125.7 9487.0 9742.4 9746.1 10086.3 9849.4 9946.8 9952.5 9962.0 9963.6 9627.5 9691.5 9697.5 9699.6 9705.4 9684.0 9775.0 9776.5 9780.5 9782.5 35699.3 36102.0 36134.6 36154.6 36207.0 2722.9 2752.8 2757.7 2838.8 3246.2 26969.9 27042.6 27330.6 27949.9 28085.7 3326.7 3365.6 3402.8 3410.0 3437.8 245146.0 245564.0 247159.0 247868.0 248727.0 49813.0 50177.2 50207.5 50261.7 50293.0 54075.5 54196.0 54214.5 54220.0 54247.2 11935.9 12089.6 12109.6 12111.9 12113.8 8859.5 9172.8 9694.6 9776.3 9796.7 15190.2 15768.8 15850.5 15908.2 16032.0 5758.3 5792.4 5911.7 5940.0 5945.5 769.6 804.0 933.4 950.4 967.8 25068.9 26405.5 26945.2 27362.7 27383.3 908.3 952.7 971.5 982.8 1012.9 14558.3 14683.3 14727.0 14786.2 14904.3 341532.0 342833.0 343719.0 344735.0 344931.0 47731.8 47895.3 47945.3 47945.3 48082.5 1053.4 1089.3 1127.3 1131.7 1182.7 24205.3 27579.9 28803.4 29109.0 29312.3 39737.0 39939.6 39961.8 40141.0 40166.8 263800.0 264228.0 265572.0 266545.0 267229.0 21819.5 22852.2 22870.2 23770.4 23981.0 34489.7 34580.0 34779.5 34930.0 35221.5 29653.3 30114.7 30254.7 30628.2 30711.5 29257.3 29446.9 30456.8 30511.8 31157.4 29704.9 30185.0 30247.7 30863.0 30964.5 25101.6 28767.0 29031.4 29159.3 29276.9 22445.4 22558.2 22696.8 22718.2 22888.3 17:20:52 INFO - PROCESS | 16796 | 17:20:52 INFO - PROCESS | 16796 | [#2] jquery.html Cycles:180 Average:21717.07 Median:44000.23 stddev:56367.16 (128.1%) stddev-sans-first:56502.42 17:20:52 INFO - PROCESS | 16796 | Values: 333.2 344.5 364.4 366.2 379.6 12147.9 12304.3 13005.5 13143.5 15958.7 15699.1 15954.3 16051.4 16135.8 16237.7 4716.2 4768.8 4922.0 4954.5 4975.9 4822.9 4904.4 4911.5 4919.0 4925.5 3613.2 3812.6 5432.3 5711.4 5736.3 5553.5 5804.1 5821.4 5822.0 5826.3 4919.5 4954.2 4956.4 4958.4 4958.8 18440.6 19012.5 19020.3 19161.6 19172.6 1989.5 2006.9 2078.3 2432.0 2451.2 11443.9 12469.8 12593.2 12872.7 13021.5 1697.6 1728.4 1754.5 1758.5 1759.6 39333.8 54048.5 54113.5 59988.4 62961.0 8503.5 8538.3 9132.1 9207.5 9363.4 12537.9 12555.9 12559.6 12563.1 12569.9 6546.9 6584.1 6626.7 6719.2 6934.6 6371.8 6375.0 6513.9 6582.1 6603.5 5641.4 5796.2 5879.5 5902.3 6001.2 1624.8 1713.4 1736.5 1770.4 1783.7 747.8 822.0 848.9 977.5 988.6 15639.4 16673.0 16795.3 16959.5 17016.8 836.4 837.4 870.4 877.9 915.1 8851.7 9609.4 9621.8 9627.7 9773.7 338453.0 342205.0 342783.0 343442.0 348738.0 64668.2 64709.7 65068.7 65505.0 66121.7 868.2 887.4 932.7 933.4 934.0 14321.6 14337.8 14582.6 14736.5 15101.8 33218.2 33546.8 33820.8 34561.0 34732.0 43022.6 43499.3 43938.1 43990.1 44010.3 7229.2 7334.9 7385.2 7453.0 7664.8 11422.5 11551.7 11781.6 11810.4 12185.1 6738.9 8763.6 9386.1 9585.7 10871.6 10011.8 10084.6 10262.2 10379.6 10521.7 10420.5 10440.5 10466.6 10622.2 10721.4 6938.5 7143.2 7314.4 7428.5 7468.7 6693.5 9309.3 10181.0 10425.4 10438.5 17:20:52 INFO - PROCESS | 16796 | 17:20:52 INFO - PROCESS | 16796 | [#3] mootools.html Cycles:180 Average:4627.23 Median:5127.32 stddev:2520.97 (49.2%) stddev-sans-first:2515.74 17:20:52 INFO - PROCESS | 16796 | Values: 1313.0 1334.6 1397.6 1629.7 1647.9 6726.4 7137.5 7150.4 7160.9 7172.4 6255.9 6382.0 6426.9 6549.1 7065.7 1812.5 1975.2 2055.8 2057.1 2068.6 2083.2 2092.9 2094.2 2103.1 2105.3 2020.6 2042.7 2087.2 2089.1 2089.4 1753.0 1817.5 1978.9 2031.1 2050.5 1959.9 1975.8 1978.5 1979.7 1982.1 6657.2 6689.2 6696.6 6700.5 6723.6 4184.0 4288.9 4296.3 4309.1 4321.4 2605.6 2658.3 2818.5 2826.0 2830.1 887.5 900.7 901.6 1695.6 1730.1 9335.1 9347.5 9386.0 9404.0 9425.0 3611.9 3788.5 3828.2 3846.3 3853.2 7519.7 7523.4 7526.3 7528.1 7572.4 4337.4 4350.8 4351.1 4352.0 4352.5 3860.6 4054.7 4055.9 4061.7 4062.5 2932.8 3001.5 3007.8 3036.9 3125.7 931.8 948.8 949.8 960.1 963.4 669.6 826.2 828.2 834.4 838.1 4685.2 4765.4 4858.1 4948.2 5158.3 387.6 390.3 396.2 399.7 409.2 3422.4 3486.8 3500.6 3508.7 3621.3 8264.8 8740.3 8794.5 8815.0 8817.0 8609.7 8613.6 8617.6 8658.7 8664.5 6457.3 6633.9 6696.3 6783.2 6809.3 4827.4 4876.6 4891.3 4933.5 5096.3 7741.3 7843.2 7873.5 7938.6 8001.4 7975.3 8031.8 8080.9 8121.5 8151.9 5780.0 5817.1 5883.8 5883.9 5902.4 6678.5 6783.9 6805.3 6809.4 6818.4 5975.2 6205.8 6214.2 6242.4 6251.7 5771.7 5821.5 5870.3 6002.8 6032.8 5764.0 5909.6 5918.4 5939.1 5943.8 3452.8 4161.1 4165.4 4251.1 4275.7 4230.9 4322.0 4363.5 4380.9 4428.7 17:20:52 INFO - PROCESS | 16796 | 17:20:52 INFO - PROCESS | 16796 | [#4] prototype.html Cycles:180 Average:4197.38 Median:4775.08 stddev:1183.94 (24.8%) stddev-sans-first:1151.11 17:20:52 INFO - PROCESS | 16796 | Values: 329.2 338.7 343.2 362.0 363.2 4837.0 4858.6 4892.1 4892.5 4924.7 4775.5 4818.8 4819.5 4826.8 4828.3 3343.5 3644.5 3700.2 3739.3 3765.4 3773.7 3862.4 3871.2 3879.8 3899.3 3829.3 3836.8 3845.9 3852.3 3855.6 3664.7 3837.5 3859.0 3865.3 3875.4 3366.6 3383.8 3440.8 3453.7 3470.4 4620.4 4682.7 4684.6 4688.9 4704.3 4409.7 4413.5 4420.1 4424.0 4429.6 4862.8 4987.7 5040.5 5046.4 5077.5 3775.0 3779.1 3787.7 3801.5 3803.8 5023.9 5080.5 5208.5 5281.2 5314.1 3842.5 3864.0 3864.4 3872.7 3877.0 3935.1 3935.9 3937.3 3948.2 3951.2 4198.4 4365.0 4371.1 4386.4 4405.7 4947.6 5013.3 5015.7 5032.2 5050.8 1309.9 1310.9 1315.8 1338.9 1347.6 908.9 943.9 953.1 955.5 970.8 4238.6 4256.6 4269.4 4308.0 4312.8 4990.7 4991.5 4994.2 5027.7 5058.0 4258.8 4283.4 4288.2 4327.4 4350.9 2572.6 2707.4 2711.4 2715.6 2718.5 4721.5 4742.6 4758.7 4774.6 4776.8 5050.3 5197.6 5218.2 5250.9 5256.1 4880.3 4894.3 4900.8 4916.2 4927.9 5238.8 5242.0 5246.6 5256.3 5267.3 4901.5 5085.8 5182.5 5192.6 5195.6 4654.9 4735.8 4784.7 4853.1 4865.8 3626.2 3641.9 3643.4 3646.3 3652.3 5165.9 5172.3 5178.8 5179.9 5185.2 4879.4 4992.9 5015.9 5017.9 5022.4 5010.8 5020.3 5020.5 5020.9 5023.4 4926.0 4931.7 4933.8 4942.9 4967.6 4905.2 4999.9 5017.6 5018.7 5063.0 4935.3 4936.2 4939.7 4945.4 4952.7 17:20:52 INFO - PROCESS | 16796 | 17:20:52 INFO - PROCESS | 16796 | [#5] yui.html Cycles:180 Average:15017.35 Median:21261.56 stddev:18865.91 (88.7%) stddev-sans-first:18887.88 17:20:52 INFO - PROCESS | 16796 | Values: 624.8 664.9 672.7 734.0 748.0 12263.6 12273.1 12286.0 12791.5 12957.0 12343.9 12453.1 12582.9 12604.9 12633.0 766.5 788.4 788.8 794.0 794.3 787.6 790.7 791.2 792.2 793.0 825.9 828.7 832.1 832.9 833.4 826.1 826.4 827.0 827.1 827.3 604.3 604.8 604.8 604.9 605.3 10804.8 10805.6 10858.1 11014.1 11451.0 12044.9 13007.4 13285.8 13456.7 13574.9 10279.6 10329.5 10502.3 10646.7 10714.3 3220.1 3241.2 3258.6 3264.1 3266.2 44913.6 61533.7 62063.4 62757.4 63245.4 10649.7 10653.0 10748.5 10780.3 10843.2 20038.1 20038.5 20045.3 20070.9 20090.3 6127.9 6237.1 6389.7 6512.5 6712.5 3424.1 3487.2 3569.2 3579.4 3658.1 2767.8 2842.1 2851.5 2869.4 2882.5 465.1 467.0 467.2 473.2 474.4 497.8 555.7 570.3 592.2 612.8 7914.2 8324.8 8513.0 8634.2 8742.9 530.7 538.0 572.7 574.0 595.2 3623.7 3785.7 3843.3 3894.3 3899.5 66272.3 66906.3 67409.0 67633.7 68071.7 57869.3 58369.0 58986.0 59521.0 59985.0 54274.2 54761.5 54988.0 55568.0 55968.4 7218.9 7473.3 7644.7 7713.0 7968.8 36818.6 38003.2 38254.2 38592.4 38628.8 44621.6 49660.8 50876.0 51418.0 51806.0 9858.0 10351.8 10648.9 10649.9 10799.6 12191.2 12482.6 13244.5 13463.5 13700.3 11808.7 11913.7 11929.3 12242.8 12293.7 11975.2 11994.7 12021.9 12392.6 12463.8 11562.9 11680.3 11742.5 11800.5 11861.8 9625.0 10015.8 10301.6 10564.6 10734.1 10247.0 10251.7 10775.5 10776.7 11073.9 17:20:52 INFO - PROCESS | 16796 | -------- Summary: end -------- 17:20:52 INFO - PROCESS | 16796 | 17:20:53 INFO - TEST-INFO | 16796: exit 0 17:20:53 INFO - TEST-OK | dromaeo_css | took 1123168ms 17:20:53 INFO - TEST-START | kraken 17:20:53 INFO - operating with platform_type : linux_ 17:20:53 INFO - Initialising browser for kraken test... 17:20:53 INFO - TEST-INFO | started process 17101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvyIHf_/profile http://localhost:60386/getInfo.html) 17:20:57 INFO - PROCESS | 17101 | __metrics Screen width/height:1600/1200 17:20:57 INFO - PROCESS | 17101 | colorDepth:24 17:20:57 INFO - PROCESS | 17101 | Browser inner width/height: 1024/697 17:20:57 INFO - PROCESS | 17101 | __metrics 17:20:58 INFO - PROCESS | 17101 | 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" 17:20:58 INFO - PROCESS | 17101 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:20:59 INFO - PROCESS | 17101 | console.error: PushService: 17:20:59 INFO - PROCESS | 17101 | stateChangeProcessEnqueue: Error transitioning state 17:20:59 INFO - PROCESS | 17101 | UnknownError 17:20:59 INFO - TEST-INFO | 17101: exit 0 17:20:59 INFO - Browser initialized. 17:20:59 INFO - Running cycle 1/1 for kraken test... 17:20:59 INFO - TEST-INFO | started process 17183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvyIHf_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:12 INFO - PROCESS | 17183 | RSS: Main: 173969408 17:21:12 INFO - PROCESS | 17183 | 17:21:14 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60386/tests/kraken/driver.html?testName=audio-beat-detection) 17:21:15 INFO - PROCESS | 17183 | RSS: Main: 240369664 17:21:15 INFO - PROCESS | 17183 | 17:21:18 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60386/tests/kraken/driver.html?testName=audio-dft) 17:21:19 INFO - PROCESS | 17183 | RSS: Main: 218345472 17:21:19 INFO - PROCESS | 17183 | 17:21:22 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60386/tests/kraken/driver.html?testName=audio-fft) 17:21:23 INFO - PROCESS | 17183 | RSS: Main: 300752896 17:21:23 INFO - PROCESS | 17183 | 17:21:25 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60386/tests/kraken/driver.html?testName=audio-oscillator) 17:21:25 INFO - PROCESS | 17183 | RSS: Main: 211968000 17:21:25 INFO - PROCESS | 17183 | 17:21:27 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60386/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:21:28 INFO - PROCESS | 17183 | RSS: Main: 214454272 17:21:28 INFO - PROCESS | 17183 | 17:21:31 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60386/tests/kraken/driver.html?testName=imaging-darkroom) 17:21:32 INFO - PROCESS | 17183 | RSS: Main: 254939136 17:21:32 INFO - PROCESS | 17183 | 17:21:36 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60386/tests/kraken/driver.html?testName=imaging-desaturate) 17:21:36 INFO - PROCESS | 17183 | RSS: Main: 248377344 17:21:36 INFO - PROCESS | 17183 | 17:21:39 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60386/tests/kraken/driver.html?testName=json-parse-financial) 17:21:40 INFO - PROCESS | 17183 | RSS: Main: 250609664 17:21:40 INFO - PROCESS | 17183 | 17:21:41 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60386/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:21:42 INFO - PROCESS | 17183 | RSS: Main: 213127168 17:21:42 INFO - PROCESS | 17183 | 17:21:44 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60386/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:21:45 INFO - PROCESS | 17183 | RSS: Main: 220721152 17:21:45 INFO - PROCESS | 17183 | 17:21:47 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60386/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:21:47 INFO - PROCESS | 17183 | RSS: Main: 230162432 17:21:47 INFO - PROCESS | 17183 | 17:21:50 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:21:51 INFO - PROCESS | 17183 | RSS: Main: 239345664 17:21:51 INFO - PROCESS | 17183 | 17:21:54 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:21:55 INFO - PROCESS | 17183 | RSS: Main: 235585536 17:21:55 INFO - PROCESS | 17183 | 17:21:56 INFO - PROCESS | 17183 | Cycle 1(1): loaded http://localhost:60386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60386/tests/kraken/driver.html?testName=ai-astar) 17:21:57 INFO - PROCESS | 17183 | RSS: Main: 287551488 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | __start_tp_report 17:21:57 INFO - PROCESS | 17183 | _x_x_mozilla_page_load 17:21:57 INFO - PROCESS | 17183 | _x_x_mozilla_page_load_details 17:21:57 INFO - PROCESS | 17183 | |i|pagename|runs| 17:21:57 INFO - PROCESS | 17183 | |0;ai-astar;114;116;116;116;116;117;116;117;115;115 17:21:57 INFO - PROCESS | 17183 | |1;audio-beat-detection;154;129;128;168;140;130;131;134;154;130 17:21:57 INFO - PROCESS | 17183 | |2;audio-dft;162;162;161;161;163;163;162;160;161;161 17:21:57 INFO - PROCESS | 17183 | |3;audio-fft;75;76;76;106;78;78;76;78;105;78 17:21:57 INFO - PROCESS | 17183 | |4;audio-oscillator;85;85;105;85;85;85;104;84;85;111 17:21:57 INFO - PROCESS | 17183 | |5;imaging-gaussian-blur;127;128;128;127;127;127;127;127;127;126 17:21:57 INFO - PROCESS | 17183 | |6;imaging-darkroom;148;148;147;147;149;147;147;148;148;147 17:21:57 INFO - PROCESS | 17183 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;95;95 17:21:57 INFO - PROCESS | 17183 | |8;json-parse-financial;65;65;65;65;67;65;66;66;65;64 17:21:57 INFO - PROCESS | 17183 | |9;json-stringify-tinderbox;66;66;65;65;66;67;69;66;66;67 17:21:57 INFO - PROCESS | 17183 | |10;stanford-crypto-aes;86;84;87;97;93;84;89;84;85;85 17:21:57 INFO - PROCESS | 17183 | |11;stanford-crypto-ccm;141;139;148;140;140;155;152;138;184;144 17:21:57 INFO - PROCESS | 17183 | |12;stanford-crypto-pbkdf2;178;185;178;175;176;175;178;178;177;177 17:21:57 INFO - PROCESS | 17183 | |13;stanford-crypto-sha256-iterative;72;68;70;68;70;67;69;68;69;68 17:21:57 INFO - PROCESS | 17183 | __end_tp_report 17:21:57 INFO - PROCESS | 17183 | __start_cc_report 17:21:57 INFO - PROCESS | 17183 | _x_x_mozilla_cycle_collect,1946 17:21:57 INFO - PROCESS | 17183 | __end_cc_report 17:21:57 INFO - PROCESS | 17183 | __startTimestamp1481764917218__endTimestamp 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | ------- Summary: start ------- 17:21:57 INFO - PROCESS | 17183 | Number of tests: 14 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:0.92 (0.8%) stddev-sans-first:0.71 17:21:57 INFO - PROCESS | 17183 | Values: 114.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 115.0 115.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:137.00 stddev:13.97 (10.2%) stddev-sans-first:13.85 17:21:57 INFO - PROCESS | 17183 | Values: 154.0 129.0 128.0 168.0 140.0 130.0 131.0 134.0 154.0 130.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 17:21:57 INFO - PROCESS | 17183 | Values: 162.0 162.0 161.0 161.0 163.0 163.0 162.0 160.0 161.0 161.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:12.12 (15.7%) stddev-sans-first:12.54 17:21:57 INFO - PROCESS | 17183 | Values: 75.0 76.0 76.0 106.0 78.0 78.0 76.0 78.0 105.0 78.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:85.00 stddev:10.69 (12.6%) stddev-sans-first:11.08 17:21:57 INFO - PROCESS | 17183 | Values: 85.0 85.0 105.0 85.0 85.0 85.0 104.0 84.0 85.0 111.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#5] imaging-gaussian-blur Cycles:10 Average:127.10 Median:127.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:21:57 INFO - PROCESS | 17183 | Values: 127.0 128.0 128.0 127.0 127.0 127.0 127.0 127.0 127.0 126.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:21:57 INFO - PROCESS | 17183 | Values: 148.0 148.0 147.0 147.0 149.0 147.0 147.0 148.0 148.0 147.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:21:57 INFO - PROCESS | 17183 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 17:21:57 INFO - PROCESS | 17183 | Values: 65.0 65.0 65.0 65.0 67.0 65.0 66.0 66.0 65.0 64.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 17:21:57 INFO - PROCESS | 17183 | Values: 66.0 66.0 65.0 65.0 66.0 67.0 69.0 66.0 66.0 67.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.50 stddev:4.40 (5.1%) stddev-sans-first:4.64 17:21:57 INFO - PROCESS | 17183 | Values: 86.0 84.0 87.0 97.0 93.0 84.0 89.0 84.0 85.0 85.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:146.00 stddev:13.88 (9.5%) stddev-sans-first:14.49 17:21:57 INFO - PROCESS | 17183 | Values: 141.0 139.0 148.0 140.0 140.0 155.0 152.0 138.0 184.0 144.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:178.00 stddev:2.83 (1.6%) stddev-sans-first:3.00 17:21:57 INFO - PROCESS | 17183 | Values: 178.0 185.0 178.0 175.0 176.0 175.0 178.0 178.0 177.0 177.0 17:21:57 INFO - PROCESS | 17183 | 17:21:57 INFO - PROCESS | 17183 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.01 17:21:57 INFO - PROCESS | 17183 | Values: 72.0 68.0 70.0 68.0 70.0 67.0 69.0 68.0 69.0 68.0 17:21:57 INFO - PROCESS | 17183 | -------- Summary: end -------- 17:21:57 INFO - PROCESS | 17183 | 17:21:58 INFO - TEST-INFO | 17183: exit 0 17:21:58 INFO - TEST-OK | kraken | took 65222ms 17:21:58 INFO - SUITE-END | took 1188s 17:21:58 INFO - Completed test suite (00:19:48) 17:21:58 INFO - javascript benchmark 17:21:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.288770588088, 2617.6989646190696, 2633.262686447795, 2648.4703059388125, 2656.5483867742482, 4564.748938808364, 4641.883952901171, 4732.479427263002, 4751.572358487735, 4769.99830035693, 4660.184467718144, 4712.198926182548, 4737.786799594027, 4742.976285118578, 4759.1433541962515, 4211.199872024321, 4224.218519573873, 4261.446012018433, 4293.656507479394, 4372.672049596277, 4278.486581610211, 4357.085012147453, 4380.167768124063, 4409.801558929856, 4451.532589078149, 4189.62293393593, 4225.683073769449, 4311.1593239318345, 4353.434053573015, 4390.143921935224, 4277.764722940237, 4278.700490965633, 4283.1433713257165, 4288.957110428887, 4294.119705460374, 4249.681273904439, 4253.383259427396, 4253.978730106361, 4254.574542545752, 4258.787060646986, 4656.0, 4701.459332176775, 4708.8116475341285, 4723.952760472385, 4774.570288674036, 5066.265391518246, 5070.036693028313, 5074.720890351029, 5083.8983220335385, 5121.28302037715, 4869.269609558559, 5100.132977393852, 5106.540411362995, 5115.309433226541, 5115.948840511622, 4608.953910460886, 4643.071385722869, 4654.325122857167, 4668.626509879202, 4751.667383283206, 5078.08594453002, 5132.820351287687, 5146.356705411824, 5149.562287205629, 5165.9225111623355, 4877.829275975324, 4880.536349046835, 4901.460839307673, 4904.926426103611, 4955.90088198234, 4843.951560484421, 4905.656604037755, 4929.580985616263, 4985.900281994413, 5006.4743201964, 4957.256411538226, 5020.648554601143, 5047.697138171721, 5058.291839142523, 5071.974640126776, 5016.974915125401, 5020.673656212334, 5023.522765337287, 5029.798808047711, 5077.695338279715, 4179.519355274182, 4212.19968206046, 4346.326319420495, 4353.673474489426, 4382.583654552813, 3710.0, 3719.814009299578, 3763.360228761117, 3764.642358975893, 3820.7898565578603, 4273.423087883159, 4278.957210427918, 4286.121345124242, 4289.463817022872, 4326.264535029052, 5072.137736584789, 5074.08666440037, 5076.213186956028, 5079.644424890223, 5105.361829771278, 4155.91688166235, 4188.350805625133, 4225.091605304874, 4237.63980061692, 4242.17277630859, 4532.161550113239, 4541.5231400703115, 4548.5906268436, 4562.749048802281, 4586.564276393738, 4677.11134884364, 4681.040386720646, 4684.578387945101, 4700.005451292711, 4739.075880203327, 4884.194107972145, 4894.314795928502, 4929.556339929423, 4934.037862616899, 5015.3480047593575, 4610.884727881829, 4661.883452913568, 4680.180968330596, 4688.2733176357715, 4723.45680246776, 4885.389326334208, 4893.143699852582, 4928.802847886044, 4936.950630493649, 4974.104661161025, 4868.41579010521, 4952.925706114339, 4968.4286307075145, 4974.104661161025, 5003.624728145476, 4792.4249090108015, 4802.73584952831, 4835.032993401263, 4844.757762111951, 4854.708717476963, 4856.125897338513, 4867.902641947212, 4889.877753056202, 4896.2655601660035, 4900.191468407673, 4795.376601041842, 4811.158047341772, 4817.0, 4818.349522814376, 4822.662413631012, 4772.212584923449, 4779.30700048498, 4817.0606731686985, 4938.259261110862, 4970.0, 4757.286407038971, 4771.809127634994, 4772.045590881907, 4782.497837726988, 4783.593394561502], "value": 4593.594673426601, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.2231041885078, 507.1657124030969, 519.4286285086403, 521.1947541049078, 521.4602886012977, 26821.061262855805, 29864.0, 36405.635943640555, 38168.0, 38358.0, 37071.4439283411, 37350.0, 37413.625863741356, 37439.62560374395, 37615.435768463496, 7192.280771922792, 7479.47643664945, 7659.502132361406, 7660.846783064336, 7661.808454788619, 7125.7149714011375, 9487.0, 9742.415455072683, 9746.074122958307, 10086.293959422843, 9849.409035457895, 9946.751331216741, 9952.452615106165, 9962.0, 9963.601455941754, 9627.518624068804, 9691.515424228832, 9697.515124243759, 9699.612015519406, 9705.417674939456, 9684.0, 9774.951125244399, 9776.462294573796, 9780.462074585896, 9782.51087445625, 35699.28601427957, 36102.0, 36134.638653613656, 36154.63845361539, 36207.0, 2722.8774705138117, 2752.7935404844716, 2757.7380148885823, 2838.8154769940093, 3246.188452886778, 26969.865150674123, 27042.5943610846, 27330.5900411494, 27949.86025069882, 28085.719142808513, 3326.7172290355347, 3365.5936005755757, 3402.761806673534, 3409.9659003409897, 3437.7937323760652, 245146.0, 245564.0, 247159.0, 247868.0, 248727.0, 49813.0, 50177.24734128991, 50207.497925021016, 50261.74869125704, 50293.0, 54075.45924540783, 54196.0, 54214.45785542173, 54220.0, 54247.186292205646, 11935.880641193651, 12089.57686480969, 12109.636710898687, 12111.939440302742, 12113.757724845455, 8859.468431894107, 9172.770680733034, 9694.563744631509, 9776.31565790402, 9796.706098817047, 15190.240487975558, 15768.76346854798, 15850.543165809318, 15908.204589770465, 16032.0, 5758.337791153987, 5792.420757924174, 5911.733971971272, 5940.039786870322, 5945.464908158287, 769.5690413368419, 804.0, 933.4492649336923, 950.3680052764972, 967.8161149381594, 25068.874655626605, 26405.47189056208, 26945.191644250703, 27362.726372736415, 27383.315417114332, 908.2869947091501, 952.6760901293593, 971.5087340931777, 982.8181786369545, 1012.9290949633455, 14558.272086395638, 14683.265836708122, 14727.0, 14786.20798922622, 14904.254787260594, 341532.0, 342833.0, 343719.0, 344735.0, 344931.0, 47731.761341193764, 47895.28157077647, 47945.28082078702, 47945.28082078772, 48082.519174808505, 1053.3732429204765, 1089.2810744908481, 1127.2785417332914, 1131.6718151735904, 1182.6806762174165, 24205.313191303292, 27579.862100689366, 28803.423931521673, 29109.0, 29312.26719332034, 39737.0, 39939.60060399359, 39961.80019099886, 40141.0, 40166.799166003984, 263800.0, 264228.0, 265572.0, 266545.0, 267229.0, 21819.454513637287, 22852.229382152425, 22870.199543015915, 23770.40573985664, 23981.0, 34489.65510344965, 34580.0, 34779.478307825906, 34930.0, 35221.47167792434, 29653.258668532595, 30114.698853012065, 30254.697453025186, 30628.234294142825, 30711.539326909668, 29257.268568285963, 29446.852765736036, 30456.84771576128, 30511.847440762653, 31157.376852463276, 29704.851475742482, 30185.0, 30247.69752302537, 30863.0, 30964.535531966587, 25101.623475647513, 28767.0, 29031.419371612872, 29159.271018224714, 29276.853615731787, 22445.43886402853, 22558.210462633728, 22696.773032269466, 22718.204862829723, 22888.31335059951], "value": 16552.320400007673, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.24187473497807, 344.51595508310834, 364.4460420161355, 366.1852378457931, 379.6203796203796, 12147.939260303698, 12304.261744295338, 13005.544805931771, 13143.539976100838, 15958.680826383465, 15699.136547489883, 15954.28205730742, 16051.357945682188, 16135.83864161358, 16237.675246495062, 4716.151092803286, 4768.833090841821, 4921.950780492203, 4954.479779623141, 4975.850724478253, 4822.9035419291595, 4904.36243288372, 4911.508849115078, 4919.0, 4925.48282430345, 3613.2050948791225, 3812.5806161322234, 5432.293801805759, 5711.371749107595, 5736.282964629421, 5553.527950124244, 5804.129380592903, 5821.446962538552, 5821.970890145522, 5826.329972053226, 4919.483454237289, 4954.232094025432, 4956.405231372222, 4958.429780575244, 4958.801647934079, 18440.63118737631, 19012.5246868828, 19020.334288299844, 19161.646711825375, 19172.616547668968, 1989.4827344890289, 2006.9397918062482, 2078.293380250707, 2431.9756802431925, 2451.178855083549, 11443.942780286128, 12469.75060498794, 12593.244405335709, 12872.742545149138, 13021.479140834355, 1697.5671203843065, 1728.3950617283976, 1754.5438186071585, 1758.4732081207678, 1759.5601099725068, 39333.80333098345, 54048.45951540513, 54113.45886541124, 59988.40011599872, 62961.0, 8503.532305723245, 8538.274246689101, 9132.086791320948, 9207.493587852598, 9363.425058108938, 12537.93731031339, 12555.93722031384, 12559.623211303675, 12563.057770667236, 12569.87430125687, 6546.9017964730565, 6584.057702977633, 6626.734930602722, 6719.193696756322, 6934.583924964519, 6371.840703982438, 6374.968125159345, 6513.902291465632, 6582.078509008743, 6603.471722262208, 5641.379448260688, 5796.1595568642315, 5879.500242479352, 5902.291724993029, 6001.189839371629, 1624.7969003874516, 1713.4431309824108, 1736.461696873973, 1770.4157627982736, 1783.6878546254613, 747.8205230744691, 821.9630116644765, 848.9363297752569, 977.5210147027905, 988.6045581767207, 15639.374425022872, 16673.0, 16795.328186872634, 16959.491215263562, 17016.829831701772, 836.381078002274, 837.4347315561971, 870.4429165334191, 877.8507653698887, 915.0712027292303, 8851.69019084329, 9609.423434593948, 9621.759456013655, 9627.663031793994, 9773.706788796348, 338453.0, 342205.0, 342783.0, 343442.0, 348738.0, 64668.18627156973, 64709.67645161744, 65068.69684172969, 65505.0, 66121.66939165369, 868.1665601023088, 887.3744010472731, 932.664240873285, 933.4446004627372, 933.9813203735887, 14321.57035288943, 14337.78493322622, 14582.635434114232, 14736.48422305214, 15101.848981510044, 33218.16954576155, 33546.832265838515, 33820.83089584536, 34561.0, 34732.0, 43022.56977430185, 43499.34750978675, 43938.12123757571, 43990.12019759523, 44010.33984490171, 7229.168645605612, 7334.853302934018, 7385.187629360658, 7452.962735186289, 7664.770056898302, 11422.485988130387, 11551.653450396501, 11781.587644432404, 11810.350430726392, 12185.14703970749, 6738.898916516158, 8763.649454021768, 9386.106223202774, 9585.712428627152, 10871.565137394417, 10011.849822252818, 10084.596616135272, 10262.152812493823, 10379.636712715019, 10521.736956576147, 10420.531076101443, 10440.477976101316, 10466.633667821894, 10622.20333474977, 10721.35671859691, 6938.548994315353, 7143.178534468395, 7314.378277846443, 7428.517146385468, 7468.663910123949, 6693.497987651043, 9309.301802364715, 10181.0, 10425.426601536685, 10438.53026613789], "value": 7879.9035920131055, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.0, 1334.5529247702023, 1397.5667543061645, 1629.6822119686651, 1647.8764092693052, 6726.428253598444, 7137.4646901482465, 7150.356467917886, 7160.856782864346, 7172.426205903528, 6255.874882502348, 6381.968090159554, 6426.871462570746, 6549.148610680617, 7065.682044308006, 1812.474382429094, 1975.2099160335908, 2055.804698553635, 2057.146284292017, 2068.596623658387, 2083.1875568528285, 2092.905819238138, 2094.1623350659706, 2103.116690989788, 2105.3262955854134, 2020.5756791073818, 2042.6527490326605, 2087.217293514932, 2089.0912453082883, 2089.39407571804, 1753.0, 1817.5365281853176, 1978.940631781049, 2031.086011294923, 2050.4771283322807, 1959.931402400909, 1975.7629084509952, 1978.5251539630528, 1979.6931475621302, 1982.058522201957, 6657.201135863679, 6689.1972963244725, 6696.5647232929705, 6700.530962832555, 6723.630200338979, 4183.97908010461, 4288.935665965013, 4296.312589985619, 4309.1381723655395, 4321.395004699345, 2605.622184783215, 2658.2689760315875, 2818.549032154866, 2826.0250213676454, 2830.080223927232, 887.5296093070683, 900.6712549919298, 901.6168128545407, 1695.6184858406882, 1730.108993868159, 9335.113164249386, 9347.532623368805, 9385.953070234606, 9403.952980235123, 9425.010373910709, 3611.9277614447565, 3788.45067465216, 3828.1960788234783, 3846.3076646203954, 3853.189001169446, 7519.736809211651, 7523.435742319348, 7526.32263096324, 7528.134264559536, 7572.432067594952, 4337.414449049401, 4350.825966961286, 4351.06452112791, 4351.956480435155, 4352.499462561846, 3860.613938606117, 4054.716169868081, 4055.9391609125887, 4061.735987160825, 4062.51249850014, 2932.765378769736, 3001.4897467430587, 3007.789454738191, 3036.878524859025, 3125.6561778204377, 931.8276118918022, 948.800751842107, 949.7815502434479, 960.0543464687278, 963.3882484622176, 669.5647828911247, 826.2274773087182, 828.1718281718282, 834.4117397234935, 838.1157878438185, 4685.156671799109, 4765.404324459442, 4858.1012512685265, 4948.233023881304, 5158.329417175743, 387.63949526939655, 390.34617016497253, 396.2293339454733, 399.7281848343097, 409.1693861461238, 3422.3668621305137, 3486.8430920608635, 3500.6149323574386, 3508.736844736604, 3621.2938476996733, 8264.752057438287, 8740.257078148301, 8794.472331660121, 8814.955925220333, 8816.955915220382, 8609.69866054685, 8613.61238744258, 8617.612207450555, 8658.696945606873, 8664.48013119215, 6457.2896981332015, 6633.900491492632, 6696.330366963265, 6783.152105986752, 6809.319068093151, 4827.42070951488, 4876.561109500162, 4891.315215869852, 4933.531314525115, 5096.311997880239, 7741.264579864904, 7843.215678432111, 7873.488223265469, 7938.56337901421, 8001.359891208573, 7975.282224599814, 8031.759047228593, 8080.9191908080165, 8121.512709237465, 8151.877721834058, 5779.97110014464, 5817.127430885401, 5883.764649413975, 5883.852903677443, 5902.380250073852, 6678.532502724957, 6783.93216067833, 6805.319468053155, 6809.353111454404, 6818.420434263143, 5975.223220981245, 6205.782797602063, 6214.161088253209, 6242.375762423721, 6251.68741562911, 5771.711414429178, 5821.534277257724, 5870.324912635102, 6002.819915402545, 6032.849178770566, 5763.971180144073, 5909.5863289569315, 5918.437748413894, 5939.109133629817, 5943.791967281124, 3452.7583069184916, 4161.126163505576, 4165.437665915063, 4251.107267473742, 4275.743455392686, 4230.857668429445, 4321.978390108029, 4363.520012798653, 4380.934285985649, 4428.667849911205], "value": 3726.738228532257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.1901921273667, 338.6782556571258, 343.16439469890827, 361.95656521217455, 363.2227034146926, 4836.951630483694, 4858.611311095113, 4892.143874821905, 4892.535209155129, 4924.655274130812, 4775.522447755223, 4818.783154758035, 4819.5180481951875, 4826.831060912868, 4828.348172996644, 3343.492380714464, 3644.4533320001947, 3700.2044560419504, 3739.289534988357, 3765.3975363941777, 3773.6792372648356, 3862.4206369044587, 3871.1870507193385, 3879.7672139671567, 3899.298126337258, 3829.272438236726, 3836.808159592023, 3845.8653947111857, 3852.3451013327804, 3855.63371479709, 3664.6885014773775, 3837.501124853751, 3858.9807050964846, 3865.323568375523, 3875.4380614810834, 3366.646502117267, 3383.847726852273, 3440.776349537272, 3453.671901169385, 3470.444728843373, 4620.422447194101, 4682.742449165295, 4684.554967278137, 4688.929666055012, 4704.270838020112, 4409.691321607489, 4413.514513403523, 4420.115976804652, 4424.035895949722, 4429.645628349725, 4862.82980095695, 4987.675801072919, 5040.470750571174, 5046.423701809521, 5077.466865979056, 3774.9811250943844, 3779.074126838942, 3787.7159213058853, 3801.543814742221, 3803.752756070874, 5023.924641130386, 5080.54275115234, 5208.453112423179, 5281.207818827168, 5314.149736042254, 3842.538895332522, 3863.9613603864163, 3864.439656249828, 3872.7289089763444, 3876.9806150969066, 3935.134270460494, 3935.8819235422984, 3937.291287568265, 3948.2498325318097, 3951.229510245532, 4198.412222288882, 4364.956350436455, 4371.147626212922, 4386.429764130643, 4405.735655860659, 4947.5794557462295, 5013.273075404046, 5015.749212539358, 5032.194848824171, 5050.84847454577, 1309.8821106100497, 1310.927898965547, 1315.83552055993, 1338.8795008449285, 1347.6361382426885, 908.9454632722058, 943.9103285187896, 953.0755167487526, 955.4553904274636, 970.815545046439, 4238.618524332825, 4256.638185754246, 4269.402283680287, 4307.978460107742, 4312.762798046075, 4990.72551009698, 4991.450940396553, 4994.200927851526, 5027.723475208899, 5057.974710126426, 4258.787060646955, 4283.365730076043, 4288.24955632763, 4327.415798867176, 4350.912981740347, 2572.6269690894715, 2707.4043710383685, 2711.359627425379, 2715.592661100851, 2718.4834881372476, 4721.457032441244, 4742.5731684148595, 4758.738269395148, 4774.641901857305, 4776.832810851603, 5050.267711181858, 5197.58419326453, 5218.217267409919, 5250.894982100413, 5256.1327380982475, 4880.267505035732, 4894.3147959285725, 4900.803967841246, 4916.188828843272, 4927.87680307988, 5238.76425560843, 5241.951609678156, 5246.6065045121, 5256.264123022704, 5267.315249017756, 4901.50984901507, 5085.821996230115, 5182.507661772125, 5192.636515443883, 5195.610329225247, 4654.93017604743, 4735.83424580138, 4784.712917224839, 4853.126437241189, 4865.781039853286, 3626.165981824248, 3641.945370819493, 3643.433323670847, 3646.2525182338086, 3652.3243200008083, 5165.870853228699, 5172.327597412313, 5178.792848286026, 5179.922301165561, 5185.196294574347, 4879.438864530624, 4992.850214493571, 5015.874603134951, 5017.949820501748, 5022.422421421583, 5010.824621138243, 5020.272060551272, 5020.527624888889, 5020.87447813793, 5023.397192336797, 4925.975370123269, 4931.7067563583105, 4933.827316043921, 4942.8764280893265, 4967.552920237052, 4905.2151655734915, 4999.850004499871, 5017.623678224075, 5018.698878067327, 5063.0, 4935.309056732132, 4936.185529387611, 4939.666290101581, 4945.381827271591, 4952.678075925053], "value": 3839.3669855485314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.8344188789969, 664.9468042556596, 672.7275453441358, 733.9834329453709, 747.9626018699065, 12263.570775022876, 12273.079519036064, 12286.0, 12791.48834046637, 12957.0, 12343.938280308608, 12453.12828102031, 12582.874171258285, 12604.873951260484, 12632.98936085111, 766.5477368352671, 788.4480863395618, 788.8304014636852, 793.9523628582275, 794.3486341200218, 787.6061969015492, 790.6718711734624, 791.2364568191693, 792.1642666986356, 793.0404210904812, 825.8637324841424, 828.7099515169702, 832.142892820393, 832.9125441828612, 833.3666413525704, 826.1325608111518, 826.4338927834423, 827.0282418158639, 827.1108558299821, 827.3009307135461, 604.338249616669, 604.7701873288166, 604.7913469852894, 604.8911195984721, 605.3220393159689, 10804.78390432187, 10805.567777288978, 10858.131349492021, 11014.06380457662, 11451.0, 12044.939775301154, 13007.414666339942, 13285.800712989312, 13456.663583410394, 13574.932125339408, 10279.588816447333, 10329.483525823754, 10502.317349372266, 10646.680599582025, 10714.303570267908, 3220.0822765511953, 3241.2221066944, 3258.6252580953255, 3264.069740124053, 3266.216566091092, 44913.55086449159, 61533.69233153851, 62063.37936620621, 62757.37242627561, 63245.36754632395, 10649.733756656145, 10653.0, 10748.495210670513, 10780.29928054674, 10843.240973131806, 20038.098285577184, 20038.49903752418, 20045.298414555422, 20070.89964550168, 20090.296839610837, 6127.908081378783, 6237.126802247689, 6389.6805159741825, 6512.511561632897, 6712.463002959751, 3424.092615456906, 3487.1805125795418, 3569.232614987738, 3579.427291633326, 3658.0854786303425, 2767.778577713778, 2842.0621195005597, 2851.472477591652, 2869.397426540408, 2882.495563276418, 465.0768225073227, 467.04256274636856, 467.18009892638884, 473.22155054935126, 474.40462219913786, 497.8357142143084, 555.7138073891949, 570.3241658634531, 592.1975722895414, 612.791650838717, 7914.24814642608, 8324.798393111074, 8512.957435212908, 8634.222919937236, 8742.86885696715, 530.7156680832395, 537.9993212624515, 572.6764378126428, 573.9942600574025, 595.1727099331932, 3623.655752703489, 3785.6782173515007, 3843.3466310727244, 3894.279558281727, 3899.512560929884, 66272.33727662759, 66906.33093669098, 67409.0, 67633.66183169052, 68071.65964170247, 57869.28901914751, 58369.0, 58986.0, 59521.0, 59985.0, 54274.18588721172, 54761.452385476434, 54988.0, 55568.0, 55968.44031559632, 7218.855622887618, 7473.252674732484, 7644.732434364771, 7713.0, 7968.800779980315, 36818.631813682594, 38003.239935201695, 38254.23491530209, 38592.42111368276, 38628.841134766, 44621.62148652073, 49660.751696241285, 50876.0, 51418.0, 51806.0, 9857.983243211214, 10351.792964140826, 10648.8935110651, 10649.9467502662, 10799.56801727922, 12191.207571507824, 12482.56311029146, 13244.47022119143, 13463.528776493167, 13700.314984250947, 11808.692787292666, 11913.702157446132, 11929.28424294545, 12242.816357754462, 12293.692657683629, 11975.221610595632, 11994.700132496757, 12021.879781202426, 12392.62822115338, 12463.813042804546, 11562.94218528902, 11680.299182049104, 11742.479001021977, 11800.468978895799, 11861.822072668745, 9624.951875240578, 10015.799684006133, 10301.587936482456, 10564.577416903237, 10734.141268698642, 10247.0, 10251.692449226535, 10775.461226938465, 10776.730581735519, 11073.944630276797], "value": 6243.862445530393, "unit": "score"}], "name": "dromaeo_css", "value": 6139.092192706395, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 115.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 128.0, 168.0, 140.0, 130.0, 131.0, 134.0, 154.0, 130.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 163.0, 163.0, 162.0, 160.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 78.0, 78.0, 76.0, 78.0, 105.0, 78.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 105.0, 85.0, 85.0, 85.0, 104.0, 84.0, 85.0, 111.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 128.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 126.0], "value": 127.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 149.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 66.0, 66.0, 65.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 67.0, 69.0, 66.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 97.0, 93.0, 84.0, 89.0, 84.0, 85.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 148.0, 140.0, 140.0, 155.0, 152.0, 138.0, 184.0, 144.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 185.0, 178.0, 175.0, 176.0, 175.0, 178.0, 178.0, 177.0, 177.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 70.0, 68.0, 70.0, 67.0, 69.0, 68.0, 69.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1574.4, "alertThreshold": 2.0}]} 17:21:58 INFO - Return code: 0 17:21:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:21:59 INFO - # TBPL SUCCESS # 17:21:59 INFO - Running post-action listener: _resource_record_post_action 17:21:59 INFO - [mozharness: 2016-12-15 01:21:59.038845Z] Finished run-tests step (success) 17:21:59 INFO - Running post-run listener: _resource_record_post_run 17:21:59 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 221184; Write bytes: 394305536; Read time: 52; Write time: 416860 17:21:59 INFO - TinderboxPrint: CPU usage
13.1% 17:21:59 INFO - TinderboxPrint: I/O read bytes / time
221,184 / 52 17:21:59 INFO - TinderboxPrint: I/O write bytes / time
394,305,536 / 416,860 17:21:59 INFO - TinderboxPrint: CPU idle
8,349.8 (86.8%) 17:21:59 INFO - TinderboxPrint: CPU user
1,213.8 (12.6%) 17:21:59 INFO - TinderboxPrint: Swap in / out
0 / 0 17:21:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 103907328; Read time: 0; Write time: 95760 17:21:59 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 217088; Write bytes: 289234944; Read time: 44; Write time: 321064 17:21:59 INFO - Running post-run listener: _upload_blobber_files 17:21:59 INFO - Blob upload gear active. 17:21:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:21:59 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 17:21:59 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'] 17:21:59 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 17:22:00 INFO - (blobuploader) - INFO - Open directory for files ... 17:22:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:22:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:22:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:00 INFO - (blobuploader) - INFO - Done attempting. 17:22:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:22:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:22:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:03 INFO - (blobuploader) - INFO - Done attempting. 17:22:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:22:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:22:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:06 INFO - (blobuploader) - INFO - Done attempting. 17:22:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:22:06 INFO - Return code: 0 17:22:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:22:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:22:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45a02209aa245ae668d640a933b98516732e00c3912e10253eaf48817291ee3727064f7a450b84a98cb91d93944b0ff000990a87f5f748fdd33a450dfd053a03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0eec119973ccbdb97cc4dc5e57ba500996c409a523078047d0afeb19cb820fb8ef5a76b3ac5f23de828bea164d381a5d4cb7ab5fce06b4015b7c5668a3d403a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00b56ab888a5e4a280f6e51adc1dc17af5b05bedaba270368c694434d13a60bdd17523ba87afbcde02d841679fad2d57f9c0bc8ef857a272dcd86f4054b475f4"} 17:22:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:22:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:22:06 INFO - Contents: 17:22:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45a02209aa245ae668d640a933b98516732e00c3912e10253eaf48817291ee3727064f7a450b84a98cb91d93944b0ff000990a87f5f748fdd33a450dfd053a03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0eec119973ccbdb97cc4dc5e57ba500996c409a523078047d0afeb19cb820fb8ef5a76b3ac5f23de828bea164d381a5d4cb7ab5fce06b4015b7c5668a3d403a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00b56ab888a5e4a280f6e51adc1dc17af5b05bedaba270368c694434d13a60bdd17523ba87afbcde02d841679fad2d57f9c0bc8ef857a272dcd86f4054b475f4"} 17:22:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:22:06 INFO - Copying logs to upload dir... 17:22:06 INFO - mkdir: /builds/slave/test/build/upload/logs 17:22:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.978849 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-14 17:22:06.953747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 17:22:06.956925) ========= 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=62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662 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/45a02209aa245ae668d640a933b98516732e00c3912e10253eaf48817291ee3727064f7a450b84a98cb91d93944b0ff000990a87f5f748fdd33a450dfd053a03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0eec119973ccbdb97cc4dc5e57ba500996c409a523078047d0afeb19cb820fb8ef5a76b3ac5f23de828bea164d381a5d4cb7ab5fce06b4015b7c5668a3d403a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00b56ab888a5e4a280f6e51adc1dc17af5b05bedaba270368c694434d13a60bdd17523ba87afbcde02d841679fad2d57f9c0bc8ef857a272dcd86f4054b475f4"} build_url:https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011930 build_url: 'https://queue.taskcluster.net/v1/task/Of-arjT3T9yGl9X9gWpM6A/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/45a02209aa245ae668d640a933b98516732e00c3912e10253eaf48817291ee3727064f7a450b84a98cb91d93944b0ff000990a87f5f748fdd33a450dfd053a03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0eec119973ccbdb97cc4dc5e57ba500996c409a523078047d0afeb19cb820fb8ef5a76b3ac5f23de828bea164d381a5d4cb7ab5fce06b4015b7c5668a3d403a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00b56ab888a5e4a280f6e51adc1dc17af5b05bedaba270368c694434d13a60bdd17523ba87afbcde02d841679fad2d57f9c0bc8ef857a272dcd86f4054b475f4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 17:22:06.982646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:22:06.982968) ========= 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=62c568580acbfdaac3eec7be000001dc-1481763674.715068-200418662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:22:07.067539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 17:22:07.067850) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 17:22:07.068137) ========= ========= Total master_lag: 0.17 =========