builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1474517415.7 results: success (0) buildid: 20160921183008 builduid: 54d186cc963d4212b2931680552354f8 revision: 69a451ac94605fe68efa3780fd20a66ccdcb0b35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:15.701610) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:15.702028) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:15.702338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:15.720643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:15.721002) ========= 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=836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 21:10: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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.9M=0s 2016-09-21 21:10:15 (89.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130097 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:15.864890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:15.865222) ========= 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=836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017089 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:15.915845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 21:10:15.916400) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 69a451ac94605fe68efa3780fd20a66ccdcb0b35 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 69a451ac94605fe68efa3780fd20a66ccdcb0b35 --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=836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 21:10:16,083 truncating revision to first 12 chars 2016-09-21 21:10:16,083 Setting DEBUG logging. 2016-09-21 21:10:16,083 attempt 1/10 2016-09-21 21:10:16,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/69a451ac9460?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 21:10:16,929 unpacking tar archive at: fx-team-69a451ac9460/testing/mozharness/ program finished with exit code 0 elapsedTime=1.232576 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 21:10:17.164169) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:17.164610) ========= script_repo_revision: 69a451ac94605fe68efa3780fd20a66ccdcb0b35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:17.165061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:17.165342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 21:10:17.176166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-21 21:10:17.176577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:10:17 INFO - MultiFileLogger online at 20160921 21:10:17 in /builds/slave/test 21:10:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:10:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:10:17 INFO - {'append_to_log': False, 21:10:17 INFO - 'base_work_dir': '/builds/slave/test', 21:10:17 INFO - 'blob_upload_branch': 'Fx-Team', 21:10:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:10:17 INFO - 'branch': 'Fx-Team', 21:10:17 INFO - 'buildbot_json_path': 'buildprops.json', 21:10:17 INFO - 'config_files': ('talos/linux_config.py',), 21:10:17 INFO - 'default_actions': ('clobber', 21:10:17 INFO - 'read-buildbot-config', 21:10:17 INFO - 'download-and-extract', 21:10:17 INFO - 'populate-webroot', 21:10:17 INFO - 'create-virtualenv', 21:10:17 INFO - 'install', 21:10:17 INFO - 'run-tests'), 21:10:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:10:17 INFO - 'download_minidump_stackwalk': True, 21:10:17 INFO - 'download_symbols': 'ondemand', 21:10:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:10:17 INFO - 'tooltool.py': '/tools/tooltool.py', 21:10:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:10:17 INFO - '/tools/misc-python/virtualenv.py')}, 21:10:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:10:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:10:17 INFO - 'installer_path': 'installer.exe', 21:10:17 INFO - 'log_level': 'info', 21:10:17 INFO - 'log_name': 'talos', 21:10:17 INFO - 'log_to_console': True, 21:10:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:10:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:10:17 INFO - 'opt_config_files': (), 21:10:17 INFO - 'pip_index': False, 21:10:17 INFO - 'sps_profile': False, 21:10:17 INFO - 'sps_profile_interval': 0, 21:10:17 INFO - 'suite': 'dromaeojs', 21:10:17 INFO - 'system_bits': '32', 21:10:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:10:17 INFO - 'title': 'talos-linux64-ix-028', 21:10:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:10:17 INFO - 'use_talos_json': True, 21:10:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:10:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:10:17 INFO - 'work_dir': 'build'} 21:10:17 INFO - [mozharness: 2016-09-22 04:10:17.437229Z] Running clobber step. 21:10:17 INFO - Running pre-action listener: _resource_record_pre_action 21:10:17 INFO - Running main action method: clobber 21:10:17 INFO - rmtree: /builds/slave/test/build 21:10:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:10:17 INFO - Running post-action listener: _resource_record_post_action 21:10:17 INFO - [mozharness: 2016-09-22 04:10:17.896909Z] Finished clobber step (success) 21:10:17 INFO - [mozharness: 2016-09-22 04:10:17.897010Z] Running read-buildbot-config step. 21:10:17 INFO - Running pre-action listener: _resource_record_pre_action 21:10:17 INFO - Running main action method: read_buildbot_config 21:10:17 INFO - Using buildbot properties: 21:10:17 INFO - { 21:10:17 INFO - "project": "", 21:10:17 INFO - "product": "firefox", 21:10:17 INFO - "script_repo_revision": "production", 21:10:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:10:17 INFO - "repository": "", 21:10:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:10:17 INFO - "buildid": "20160921183008", 21:10:17 INFO - "pgo_build": "True", 21:10:17 INFO - "basedir": "/builds/slave/test", 21:10:17 INFO - "buildnumber": 1080, 21:10:17 INFO - "slavename": "talos-linux64-ix-028", 21:10:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:10:17 INFO - "platform": "ubuntu64_hw", 21:10:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:10:17 INFO - "branch": "fx-team", 21:10:17 INFO - "repo_path": "integration/fx-team", 21:10:17 INFO - "revision": "69a451ac94605fe68efa3780fd20a66ccdcb0b35", 21:10:17 INFO - "stage_platform": "linux64-pgo", 21:10:17 INFO - "builduid": "54d186cc963d4212b2931680552354f8", 21:10:17 INFO - "slavebuilddir": "test" 21:10:17 INFO - } 21:10:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:10:17 INFO - Running post-action listener: _resource_record_post_action 21:10:17 INFO - [mozharness: 2016-09-22 04:10:17.899480Z] Finished read-buildbot-config step (success) 21:10:17 INFO - [mozharness: 2016-09-22 04:10:17.899570Z] Running download-and-extract step. 21:10:17 INFO - Running pre-action listener: _resource_record_pre_action 21:10:17 INFO - Running main action method: download_and_extract 21:10:17 INFO - mkdir: /builds/slave/test/build/tests 21:10: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')]} 21:10:17 INFO - trying https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:10:17 INFO - Downloading https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:10:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:10:18 INFO - Downloaded 1361 bytes. 21:10:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:10:18 INFO - Using the following test package requirements: 21:10:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:10:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:10:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:10:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:18 INFO - u'jsshell-linux-x86_64.zip'], 21:10:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:10:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:10:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:10:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:10:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:10:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:10:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:10:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:10:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:10:18 INFO - Fetch https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:10:19 INFO - Expected file size: 21941887 21:10:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:10:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:10:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:10:23 INFO - Fetch https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:10:23 INFO - Expected file size: 21941887 21:10:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:10:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:10:28 INFO - Fetch https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:10:29 INFO - Expected file size: 14414059 21:10: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')]} 21:10:29 INFO - trying https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:10:29 INFO - Downloading https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:10:30 INFO - Downloaded 59555219 bytes. 21:10:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:10:30 INFO - mkdir: /builds/slave/test/properties 21:10:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:10:30 INFO - Writing to file /builds/slave/test/properties/build_url 21:10:30 INFO - Contents: 21:10:30 INFO - build_url:https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:10:31 INFO - Running post-action listener: _resource_record_post_action 21:10:31 INFO - Running post-action listener: set_extra_try_arguments 21:10:31 INFO - [mozharness: 2016-09-22 04:10:31.626241Z] Finished download-and-extract step (success) 21:10:31 INFO - [mozharness: 2016-09-22 04:10:31.626471Z] Running populate-webroot step. 21:10:31 INFO - Running pre-action listener: _resource_record_pre_action 21:10:31 INFO - Running main action method: populate_webroot 21:10:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:10:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:10:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:10:31 INFO - '--tppagecycles', 21:10:31 INFO - '7'], 21:10:31 INFO - 'tests': ['tsvgm']}}, 21:10:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:10:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:10:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:10:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:10:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:31 INFO - 'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:31 INFO - 'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['damp', 'tps']}, 21:10:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:31 INFO - 'tests': ['damp', 'tps']}, 21:10:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['dromaeo_dom']}, 21:10:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:10:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['basic_compositor_video']}, 21:10:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:10:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['a11yr', 21:10:31 INFO - 'ts_paint', 21:10:31 INFO - 'tpaint', 21:10:31 INFO - 'sessionrestore', 21:10:31 INFO - 'sessionrestore_no_auto_restore', 21:10:31 INFO - 'tabpaint']}, 21:10:31 INFO - 'other-e10s': {'tests': ['a11yr', 21:10:31 INFO - 'ts_paint', 21:10:31 INFO - 'tpaint', 21:10:31 INFO - 'sessionrestore', 21:10:31 INFO - 'sessionrestore_no_auto_restore', 21:10:31 INFO - 'tabpaint']}, 21:10:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:10:31 INFO - 'ts_paint', 21:10:31 INFO - 'tpaint', 21:10:31 INFO - 'sessionrestore', 21:10:31 INFO - 'sessionrestore_no_auto_restore', 21:10:31 INFO - 'tabpaint']}, 21:10:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:10:31 INFO - 'ts_paint', 21:10:31 INFO - 'tpaint', 21:10:31 INFO - 'sessionrestore', 21:10:31 INFO - 'sessionrestore_no_auto_restore', 21:10:31 INFO - 'tabpaint']}, 21:10:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['a11yr', 21:10:31 INFO - 'ts_paint', 21:10:31 INFO - 'tpaint', 21:10:31 INFO - 'sessionrestore', 21:10:31 INFO - 'sessionrestore_no_auto_restore', 21:10:31 INFO - 'tabpaint']}, 21:10:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['a11yr', 21:10:31 INFO - 'ts_paint', 21:10:31 INFO - 'tpaint', 21:10:31 INFO - 'sessionrestore', 21:10:31 INFO - 'sessionrestore_no_auto_restore', 21:10:31 INFO - 'tabpaint']}, 21:10:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['tsvgx', 21:10:31 INFO - 'tsvgr_opacity', 21:10:31 INFO - 'tart', 21:10:31 INFO - 'tscrollx', 21:10:31 INFO - 'cart']}, 21:10:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:10:31 INFO - 'tsvgr_opacity', 21:10:31 INFO - 'tart', 21:10:31 INFO - 'tscrollx', 21:10:31 INFO - 'cart']}, 21:10:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:31 INFO - 'talos_options': ['--disable-e10s'], 21:10:31 INFO - 'tests': ['tp5o']}, 21:10:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:31 INFO - 'tests': ['tp5o']}, 21:10:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:31 INFO - 'talos_options': ['--disable-e10s', 21:10:31 INFO - '--xperf_path', 21:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:31 INFO - 'tests': ['tp5n']}, 21:10:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:31 INFO - 'talos_options': ['--xperf_path', 21:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:31 INFO - 'tests': ['tp5n']}}, 21:10:31 INFO - 'talos.zip': {'path': '', 21:10:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:10:31 INFO - Running post-action listener: _resource_record_post_action 21:10:31 INFO - [mozharness: 2016-09-22 04:10:31.646862Z] Finished populate-webroot step (success) 21:10:31 INFO - [mozharness: 2016-09-22 04:10:31.646951Z] Running create-virtualenv step. 21:10:31 INFO - Running pre-action listener: _resource_record_pre_action 21:10:31 INFO - Running main action method: create_virtualenv 21:10:31 INFO - Creating virtualenv /builds/slave/test/build/venv 21:10: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 21:10:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:10:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:10:31 INFO - Using real prefix '/usr' 21:10:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:10:32 INFO - Installing distribute.............................................................................................................................................................................................done. 21:10:34 INFO - Installing pip.................done. 21:10:34 INFO - Return code: 0 21:10:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10: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', 'pip>=1.5'] in /builds/slave/test/build 21:10: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 pip>=1.5 21:10:34 INFO - Using env: {'DISPLAY': ':0', 21:10:34 INFO - 'HOME': '/home/cltbld', 21:10:34 INFO - 'LANG': 'en_US.UTF-8', 21:10:34 INFO - 'LANGUAGE': 'en_US:en', 21:10:34 INFO - 'LOGNAME': 'cltbld', 21:10:34 INFO - 'MAIL': '/var/mail/cltbld', 21:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:34 INFO - 'MOZ_NO_REMOTE': '1', 21:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:34 INFO - 'NO_EM_RESTART': '1', 21:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:34 INFO - 'PWD': '/builds/slave/test', 21:10:34 INFO - 'SHELL': '/bin/bash', 21:10:34 INFO - 'SHLVL': '1', 21:10:34 INFO - 'TERM': 'linux', 21:10:34 INFO - 'TMOUT': '86400', 21:10:34 INFO - 'USER': 'cltbld', 21:10:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:34 INFO - '_': '/tools/buildbot/bin/python'} 21:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10: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 21:10:34 INFO - Cleaning up... 21:10:34 INFO - Return code: 0 21:10:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10: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 21:10: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 21:10:34 INFO - Using env: {'DISPLAY': ':0', 21:10:34 INFO - 'HOME': '/home/cltbld', 21:10:34 INFO - 'LANG': 'en_US.UTF-8', 21:10:34 INFO - 'LANGUAGE': 'en_US:en', 21:10:34 INFO - 'LOGNAME': 'cltbld', 21:10:34 INFO - 'MAIL': '/var/mail/cltbld', 21:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:34 INFO - 'MOZ_NO_REMOTE': '1', 21:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:34 INFO - 'NO_EM_RESTART': '1', 21:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:34 INFO - 'PWD': '/builds/slave/test', 21:10:34 INFO - 'SHELL': '/bin/bash', 21:10:34 INFO - 'SHLVL': '1', 21:10:34 INFO - 'TERM': 'linux', 21:10:34 INFO - 'TMOUT': '86400', 21:10:34 INFO - 'USER': 'cltbld', 21:10:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:34 INFO - '_': '/tools/buildbot/bin/python'} 21:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:34 INFO - Downloading/unpacking psutil>=3.1.1 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:36 INFO - Installing collected packages: psutil 21:10:36 INFO - Running setup.py install for psutil 21:10:36 INFO - building 'psutil._psutil_linux' extension 21:10: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 21:10: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 21:10:36 INFO - building 'psutil._psutil_posix' extension 21:10: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 21:10:37 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 21:10:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:37 INFO - Successfully installed psutil 21:10:37 INFO - Cleaning up... 21:10:37 INFO - Return code: 0 21:10:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10: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 21:10: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 21:10:37 INFO - Using env: {'DISPLAY': ':0', 21:10:37 INFO - 'HOME': '/home/cltbld', 21:10:37 INFO - 'LANG': 'en_US.UTF-8', 21:10:37 INFO - 'LANGUAGE': 'en_US:en', 21:10:37 INFO - 'LOGNAME': 'cltbld', 21:10:37 INFO - 'MAIL': '/var/mail/cltbld', 21:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:37 INFO - 'MOZ_NO_REMOTE': '1', 21:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:37 INFO - 'NO_EM_RESTART': '1', 21:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:37 INFO - 'PWD': '/builds/slave/test', 21:10:37 INFO - 'SHELL': '/bin/bash', 21:10:37 INFO - 'SHLVL': '1', 21:10:37 INFO - 'TERM': 'linux', 21:10:37 INFO - 'TMOUT': '86400', 21:10:37 INFO - 'USER': 'cltbld', 21:10:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:37 INFO - '_': '/tools/buildbot/bin/python'} 21:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:10:39 INFO - Installing collected packages: mozsystemmonitor 21:10:39 INFO - Running setup.py install for mozsystemmonitor 21:10:39 INFO - Successfully installed mozsystemmonitor 21:10:39 INFO - Cleaning up... 21:10:39 INFO - Return code: 0 21:10:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10: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 21:10: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 21:10:39 INFO - Using env: {'DISPLAY': ':0', 21:10:39 INFO - 'HOME': '/home/cltbld', 21:10:39 INFO - 'LANG': 'en_US.UTF-8', 21:10:39 INFO - 'LANGUAGE': 'en_US:en', 21:10:39 INFO - 'LOGNAME': 'cltbld', 21:10:39 INFO - 'MAIL': '/var/mail/cltbld', 21:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:39 INFO - 'MOZ_NO_REMOTE': '1', 21:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:39 INFO - 'NO_EM_RESTART': '1', 21:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:39 INFO - 'PWD': '/builds/slave/test', 21:10:39 INFO - 'SHELL': '/bin/bash', 21:10:39 INFO - 'SHLVL': '1', 21:10:39 INFO - 'TERM': 'linux', 21:10:39 INFO - 'TMOUT': '86400', 21:10:39 INFO - 'USER': 'cltbld', 21:10:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:39 INFO - '_': '/tools/buildbot/bin/python'} 21:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:39 INFO - Downloading/unpacking jsonschema==2.5.1 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:10:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:41 INFO - Downloading functools32-3.2.3-2.tar.gz 21:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:10:41 INFO - warning: no files found matching '*.txt' 21:10:41 INFO - no previously-included directories found matching 'build' 21:10:41 INFO - no previously-included directories found matching 'dist' 21:10:41 INFO - no previously-included directories found matching '.git*' 21:10:41 INFO - Installing collected packages: jsonschema, functools32 21:10:41 INFO - Running setup.py install for functools32 21:10:41 INFO - warning: no files found matching '*.txt' 21:10:41 INFO - no previously-included directories found matching 'build' 21:10:41 INFO - no previously-included directories found matching 'dist' 21:10:41 INFO - no previously-included directories found matching '.git*' 21:10:42 INFO - Successfully installed jsonschema functools32 21:10:42 INFO - Cleaning up... 21:10:42 INFO - Return code: 0 21:10:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10: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 21:10: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 21:10:42 INFO - Using env: {'DISPLAY': ':0', 21:10:42 INFO - 'HOME': '/home/cltbld', 21:10:42 INFO - 'LANG': 'en_US.UTF-8', 21:10:42 INFO - 'LANGUAGE': 'en_US:en', 21:10:42 INFO - 'LOGNAME': 'cltbld', 21:10:42 INFO - 'MAIL': '/var/mail/cltbld', 21:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:42 INFO - 'MOZ_NO_REMOTE': '1', 21:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:42 INFO - 'NO_EM_RESTART': '1', 21:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:42 INFO - 'PWD': '/builds/slave/test', 21:10:42 INFO - 'SHELL': '/bin/bash', 21:10:42 INFO - 'SHLVL': '1', 21:10:42 INFO - 'TERM': 'linux', 21:10:42 INFO - 'TMOUT': '86400', 21:10:42 INFO - 'USER': 'cltbld', 21:10:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:42 INFO - '_': '/tools/buildbot/bin/python'} 21:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:10:42 INFO - Cleaning up... 21:10:42 INFO - Return code: 0 21:10:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10: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 21:10: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 21:10:42 INFO - Using env: {'DISPLAY': ':0', 21:10:42 INFO - 'HOME': '/home/cltbld', 21:10:42 INFO - 'LANG': 'en_US.UTF-8', 21:10:42 INFO - 'LANGUAGE': 'en_US:en', 21:10:42 INFO - 'LOGNAME': 'cltbld', 21:10:42 INFO - 'MAIL': '/var/mail/cltbld', 21:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:42 INFO - 'MOZ_NO_REMOTE': '1', 21:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:42 INFO - 'NO_EM_RESTART': '1', 21:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:42 INFO - 'PWD': '/builds/slave/test', 21:10:42 INFO - 'SHELL': '/bin/bash', 21:10:42 INFO - 'SHLVL': '1', 21:10:42 INFO - 'TERM': 'linux', 21:10:42 INFO - 'TMOUT': '86400', 21:10:42 INFO - 'USER': 'cltbld', 21:10:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:42 INFO - '_': '/tools/buildbot/bin/python'} 21:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:42 INFO - Downloading/unpacking blobuploader==1.2.4 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:44 INFO - Downloading blobuploader-1.2.4.tar.gz 21:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:10:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:10:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:45 INFO - Downloading docopt-0.6.1.tar.gz 21:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:10:45 INFO - Installing collected packages: blobuploader, requests, docopt 21:10:45 INFO - Running setup.py install for blobuploader 21:10:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:10:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:10:45 INFO - Running setup.py install for requests 21:10:45 INFO - Running setup.py install for docopt 21:10:45 INFO - Successfully installed blobuploader requests docopt 21:10:45 INFO - Cleaning up... 21:10:45 INFO - Return code: 0 21:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10: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 21:10: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 21:10:45 INFO - Using env: {'DISPLAY': ':0', 21:10:45 INFO - 'HOME': '/home/cltbld', 21:10:45 INFO - 'LANG': 'en_US.UTF-8', 21:10:45 INFO - 'LANGUAGE': 'en_US:en', 21:10:45 INFO - 'LOGNAME': 'cltbld', 21:10:45 INFO - 'MAIL': '/var/mail/cltbld', 21:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:45 INFO - 'MOZ_NO_REMOTE': '1', 21:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:45 INFO - 'NO_EM_RESTART': '1', 21:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:45 INFO - 'PWD': '/builds/slave/test', 21:10:45 INFO - 'SHELL': '/bin/bash', 21:10:45 INFO - 'SHLVL': '1', 21:10:45 INFO - 'TERM': 'linux', 21:10:45 INFO - 'TMOUT': '86400', 21:10:45 INFO - 'USER': 'cltbld', 21:10:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:45 INFO - '_': '/tools/buildbot/bin/python'} 21:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:10:45 INFO - Running setup.py (path:/tmp/pip-WW3Ktm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:10:46 INFO - Running setup.py (path:/tmp/pip-s0eR7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:10:46 INFO - Running setup.py (path:/tmp/pip-aqGbJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:10:46 INFO - Running setup.py (path:/tmp/pip-9FI0hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:10:46 INFO - Running setup.py (path:/tmp/pip-MApeQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:10:46 INFO - Running setup.py (path:/tmp/pip-XueHyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:10:46 INFO - Running setup.py (path:/tmp/pip-aHSaCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:10:46 INFO - Running setup.py (path:/tmp/pip-q9gJX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:10:46 INFO - Running setup.py (path:/tmp/pip-MItcUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:10:46 INFO - Running setup.py (path:/tmp/pip-aSbzU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:10:46 INFO - Running setup.py (path:/tmp/pip-urK3lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:10:46 INFO - Running setup.py (path:/tmp/pip-5TwVqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:10:46 INFO - Running setup.py (path:/tmp/pip-lvSXPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:10:46 INFO - Running setup.py (path:/tmp/pip-12_DG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:46 INFO - Running setup.py (path:/tmp/pip-yIvYoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:10:47 INFO - Running setup.py (path:/tmp/pip-EHoV6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:10:47 INFO - Running setup.py (path:/tmp/pip-h0iUWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:10:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:10:47 INFO - Running setup.py install for manifestparser 21:10:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:10:47 INFO - Running setup.py install for mozcrash 21:10:47 INFO - Running setup.py install for mozdebug 21:10:47 INFO - Running setup.py install for mozdevice 21:10:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:10:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:10:47 INFO - Running setup.py install for mozfile 21:10:47 INFO - Running setup.py install for mozhttpd 21:10:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:10:47 INFO - Running setup.py install for mozinfo 21:10:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:10:47 INFO - Running setup.py install for mozInstall 21:10:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:10:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:10:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:10:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:10:48 INFO - Running setup.py install for mozleak 21:10:48 INFO - Running setup.py install for mozlog 21:10:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:10:48 INFO - Running setup.py install for moznetwork 21:10:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:10:48 INFO - Running setup.py install for mozprocess 21:10:48 INFO - Running setup.py install for mozprofile 21:10:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:10:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:10:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:10:48 INFO - Running setup.py install for mozrunner 21:10:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:10:48 INFO - Running setup.py install for mozscreenshot 21:10:48 INFO - Running setup.py install for moztest 21:10:48 INFO - Running setup.py install for mozversion 21:10:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:10:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:10:48 INFO - Cleaning up... 21:10:49 INFO - Return code: 0 21:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10: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 21:10: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 21:10:49 INFO - Using env: {'DISPLAY': ':0', 21:10:49 INFO - 'HOME': '/home/cltbld', 21:10:49 INFO - 'LANG': 'en_US.UTF-8', 21:10:49 INFO - 'LANGUAGE': 'en_US:en', 21:10:49 INFO - 'LOGNAME': 'cltbld', 21:10:49 INFO - 'MAIL': '/var/mail/cltbld', 21:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:49 INFO - 'MOZ_NO_REMOTE': '1', 21:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:49 INFO - 'NO_EM_RESTART': '1', 21:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:49 INFO - 'PWD': '/builds/slave/test', 21:10:49 INFO - 'SHELL': '/bin/bash', 21:10:49 INFO - 'SHLVL': '1', 21:10:49 INFO - 'TERM': 'linux', 21:10:49 INFO - 'TMOUT': '86400', 21:10:49 INFO - 'USER': 'cltbld', 21:10:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:49 INFO - '_': '/tools/buildbot/bin/python'} 21:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:10:49 INFO - Running setup.py (path:/tmp/pip-TXw6e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:10: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)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:10:49 INFO - Running setup.py (path:/tmp/pip-d0PaLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:10:49 INFO - Running setup.py (path:/tmp/pip-z9jBlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:10: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)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:10:49 INFO - Running setup.py (path:/tmp/pip-pDBAjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:10:49 INFO - Running setup.py (path:/tmp/pip-jXdvQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:10: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)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:10:49 INFO - Running setup.py (path:/tmp/pip-iFqRjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:10: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)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:10:49 INFO - Running setup.py (path:/tmp/pip-6pTsYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:10: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)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:10:49 INFO - Running setup.py (path:/tmp/pip-g3gk6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:10: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)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:10:49 INFO - Running setup.py (path:/tmp/pip-KjSt8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:10:49 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)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:10:49 INFO - Running setup.py (path:/tmp/pip-xF4VtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:10:49 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)) 21:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:10:49 INFO - Running setup.py (path:/tmp/pip-SFRiwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:10: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)) 21:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:10:50 INFO - Running setup.py (path:/tmp/pip-FAfXTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:10: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)) 21:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:10:50 INFO - Running setup.py (path:/tmp/pip-CLQfvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:10: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)) 21:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:10:50 INFO - Running setup.py (path:/tmp/pip-vZPlZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:50 INFO - Running setup.py (path:/tmp/pip-QYUf_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:10: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)) 21:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:10:50 INFO - Running setup.py (path:/tmp/pip-BaTsSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:10: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)) 21:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:10:50 INFO - Running setup.py (path:/tmp/pip-mKO23j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:10: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)) 21:10: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:10: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:10: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)) 21:10: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:10: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:10:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:52 INFO - Downloading blessings-1.6.tar.gz 21:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:10:52 INFO - Installing collected packages: blessings 21:10:52 INFO - Running setup.py install for blessings 21:10:52 INFO - Successfully installed blessings 21:10:52 INFO - Cleaning up... 21:10:52 INFO - Return code: 0 21:10:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:10:52 INFO - Reading from file tmpfile_stdout 21:10:52 INFO - Current package versions: 21:10:52 INFO - argparse == 1.2.1 21:10:52 INFO - blessings == 1.6 21:10:52 INFO - blobuploader == 1.2.4 21:10:52 INFO - docopt == 0.6.1 21:10:52 INFO - functools32 == 3.2.3-2 21:10:52 INFO - jsonschema == 2.5.1 21:10:52 INFO - manifestparser == 1.1 21:10:52 INFO - mozInstall == 1.12 21:10:52 INFO - mozcrash == 0.17 21:10:52 INFO - mozdebug == 0.1 21:10:52 INFO - mozdevice == 0.48 21:10:52 INFO - mozfile == 1.2 21:10:52 INFO - mozhttpd == 0.7 21:10:52 INFO - mozinfo == 0.9 21:10:52 INFO - mozleak == 0.1 21:10:52 INFO - mozlog == 3.4 21:10:52 INFO - moznetwork == 0.27 21:10:52 INFO - mozprocess == 0.23 21:10:52 INFO - mozprofile == 0.28 21:10:52 INFO - mozrunner == 6.12 21:10:52 INFO - mozscreenshot == 0.1 21:10:52 INFO - mozsystemmonitor == 0.3 21:10:52 INFO - moztest == 0.7 21:10:52 INFO - mozversion == 1.4 21:10:52 INFO - psutil == 3.1.1 21:10:52 INFO - requests == 1.2.3 21:10:52 INFO - wsgiref == 0.1.2 21:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:52 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 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10:52 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 21:10:52 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 21:10:52 INFO - Using env: {'DISPLAY': ':0', 21:10:52 INFO - 'HOME': '/home/cltbld', 21:10:52 INFO - 'LANG': 'en_US.UTF-8', 21:10:52 INFO - 'LANGUAGE': 'en_US:en', 21:10:52 INFO - 'LOGNAME': 'cltbld', 21:10:52 INFO - 'MAIL': '/var/mail/cltbld', 21:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:52 INFO - 'MOZ_NO_REMOTE': '1', 21:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:52 INFO - 'NO_EM_RESTART': '1', 21:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:52 INFO - 'PWD': '/builds/slave/test', 21:10:52 INFO - 'SHELL': '/bin/bash', 21:10:52 INFO - 'SHLVL': '1', 21:10:52 INFO - 'TERM': 'linux', 21:10:52 INFO - 'TMOUT': '86400', 21:10:52 INFO - 'USER': 'cltbld', 21:10:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:52 INFO - '_': '/tools/buildbot/bin/python'} 21:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10: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)) 21:10: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)) 21:10: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)) 21:10: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)) 21:10: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)) 21:10: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)) 21:10: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)) 21:10: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)) 21:10: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)) 21:10: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)) 21:10: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)) 21:10:53 INFO - Cleaning up... 21:10:53 INFO - Return code: 0 21:10:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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 0x7f18309c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, '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': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', '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 21:10: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 21:10: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 21:10:53 INFO - Using env: {'DISPLAY': ':0', 21:10:53 INFO - 'HOME': '/home/cltbld', 21:10:53 INFO - 'LANG': 'en_US.UTF-8', 21:10:53 INFO - 'LANGUAGE': 'en_US:en', 21:10:53 INFO - 'LOGNAME': 'cltbld', 21:10:53 INFO - 'MAIL': '/var/mail/cltbld', 21:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:53 INFO - 'MOZ_NO_REMOTE': '1', 21:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:53 INFO - 'NO_EM_RESTART': '1', 21:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:53 INFO - 'PWD': '/builds/slave/test', 21:10:53 INFO - 'SHELL': '/bin/bash', 21:10:53 INFO - 'SHLVL': '1', 21:10:53 INFO - 'TERM': 'linux', 21:10:53 INFO - 'TMOUT': '86400', 21:10:53 INFO - 'USER': 'cltbld', 21:10:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:53 INFO - '_': '/tools/buildbot/bin/python'} 21:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:10:53 INFO - Cleaning up... 21:10:53 INFO - Return code: 0 21:10:53 INFO - Running post-action listener: _resource_record_post_action 21:10:53 INFO - Running post-action listener: _start_resource_monitoring 21:10:53 INFO - Starting resource monitoring. 21:10:53 INFO - [mozharness: 2016-09-22 04:10:53.280397Z] Finished create-virtualenv step (success) 21:10:53 INFO - [mozharness: 2016-09-22 04:10:53.280908Z] Running install step. 21:10:53 INFO - Running pre-action listener: _resource_record_pre_action 21:10:53 INFO - Running main action method: install 21:10:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:10:53 INFO - Reading from file tmpfile_stdout 21:10:53 INFO - Detecting whether we're running mozinstall >=1.0... 21:10:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:10:53 INFO - Reading from file tmpfile_stdout 21:10:53 INFO - Output received: 21:10:53 INFO - Usage: mozinstall [options] installer 21:10:53 INFO - Options: 21:10:53 INFO - -h, --help show this help message and exit 21:10:53 INFO - -d DEST, --destination=DEST 21:10:53 INFO - Directory to install application into. [default: 21:10:53 INFO - "/builds/slave/test"] 21:10:53 INFO - --app=APP Application being installed. [default: firefox] 21:10:53 INFO - mkdir: /builds/slave/test/build/application 21:10:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:11:10 INFO - Reading from file tmpfile_stdout 21:11:10 INFO - Output received: 21:11:10 INFO - /builds/slave/test/build/application/firefox/firefox 21:11:10 INFO - Running post-action listener: _resource_record_post_action 21:11:10 INFO - [mozharness: 2016-09-22 04:11:10.544532Z] Finished install step (success) 21:11:10 INFO - [mozharness: 2016-09-22 04:11:10.544777Z] Running run-tests step. 21:11:10 INFO - Running pre-action listener: _resource_record_pre_action 21:11:10 INFO - Running main action method: run_tests 21:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:11:10 INFO - Python 2.7.3 21:11:10 INFO - Return code: 0 21:11:10 INFO - grabbing minidump binary from tooltool 21:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:10 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 0x2ca4930>, '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 0x2ca5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:11:10 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 21:11:10 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 21:11:10 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 21:11:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:11:10 INFO - Return code: 0 21:11:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:11:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:11:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:11:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:11:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 21:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 21:11:10 INFO - Using env: {'DISPLAY': ':0', 21:11:10 INFO - 'HOME': '/home/cltbld', 21:11:10 INFO - 'LANG': 'en_US.UTF-8', 21:11:10 INFO - 'LANGUAGE': 'en_US:en', 21:11:10 INFO - 'LOGNAME': 'cltbld', 21:11:10 INFO - 'MAIL': '/var/mail/cltbld', 21:11:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:11:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:10 INFO - 'MOZ_NO_REMOTE': '1', 21:11:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:10 INFO - 'NO_EM_RESTART': '1', 21:11:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:10 INFO - 'PWD': '/builds/slave/test', 21:11:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:11:10 INFO - 'SHELL': '/bin/bash', 21:11:10 INFO - 'SHLVL': '1', 21:11:10 INFO - 'TERM': 'linux', 21:11:10 INFO - 'TMOUT': '86400', 21:11:10 INFO - 'USER': 'cltbld', 21:11:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848', 21:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:10 INFO - '_': '/tools/buildbot/bin/python'} 21:11:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 21:11:10 INFO - mozversion application_buildid: 20160921183008 21:11:10 INFO - mozversion application_changeset: 69a451ac94605fe68efa3780fd20a66ccdcb0b35 21:11:10 INFO - mozversion application_display_name: Nightly 21:11:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:11:10 INFO - mozversion application_name: Firefox 21:11:10 INFO - mozversion application_remotingname: firefox 21:11:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:11:10 INFO - mozversion application_vendor: Mozilla 21:11:10 INFO - mozversion application_version: 52.0a1 21:11:10 INFO - mozversion platform_buildid: 20160921183008 21:11:10 INFO - mozversion platform_changeset: 69a451ac94605fe68efa3780fd20a66ccdcb0b35 21:11:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:11:10 INFO - mozversion platform_version: 52.0a1 21:11:10 INFO - using testdate: 1474517470 21:11:10 INFO - actual date: 1474517470 21:11:10 INFO - starting webserver on 'localhost:52504' 21:11:10 INFO - SUITE-START | Running 2 tests 21:11:10 INFO - TEST-START | dromaeo_css 21:11:10 INFO - operating with platform_type : linux_ 21:11:10 INFO - Initialising browser for dromaeo_css test... 21:11:10 INFO - TEST-INFO | started process 9769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEapiUV/profile http://localhost:52504/getInfo.html) 21:11:15 INFO - PROCESS | 9769 | __metrics Screen width/height:1600/1200 21:11:15 INFO - PROCESS | 9769 | colorDepth:24 21:11:15 INFO - PROCESS | 9769 | Browser inner width/height: 1024/697 21:11:15 INFO - PROCESS | 9769 | __metrics 21:11:15 INFO - PROCESS | 9769 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:11:15 INFO - PROCESS | 9769 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:11:16 INFO - PROCESS | 9769 | console.error: PushService: 21:11:16 INFO - PROCESS | 9769 | stateChangeProcessEnqueue: Error transitioning state 21:11:16 INFO - PROCESS | 9769 | UnknownError 21:11:17 INFO - TEST-INFO | 9769: exit 0 21:11:17 INFO - Browser initialized. 21:11:17 INFO - Running cycle 1/1 for dromaeo_css test... 21:11:17 INFO - TEST-INFO | started process 9851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEapiUV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:11:29 INFO - PROCESS | 9851 | RSS: Main: 177483776 21:11:29 INFO - PROCESS | 9851 | 21:12:20 INFO - PROCESS | 9851 | 1474517540453 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] 21:14:30 INFO - PROCESS | 9851 | Cycle 1(1): loaded http://localhost:52504/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52504/tests/dromaeo/cssquery-ext.html) 21:14:31 INFO - PROCESS | 9851 | RSS: Main: 284512256 21:14:31 INFO - PROCESS | 9851 | 21:17:33 INFO - PROCESS | 9851 | Cycle 1(1): loaded http://localhost:52504/tests/dromaeo/cssquery-ext.html (next: http://localhost:52504/tests/dromaeo/cssquery-jquery.html) 21:17:34 INFO - PROCESS | 9851 | RSS: Main: 280346624 21:17:34 INFO - PROCESS | 9851 | 21:20:36 INFO - PROCESS | 9851 | Cycle 1(1): loaded http://localhost:52504/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52504/tests/dromaeo/cssquery-mootools.html) 21:20:36 INFO - PROCESS | 9851 | RSS: Main: 278360064 21:20:36 INFO - PROCESS | 9851 | 21:23:38 INFO - PROCESS | 9851 | Cycle 1(1): loaded http://localhost:52504/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52504/tests/dromaeo/cssquery-prototype.html) 21:23:39 INFO - PROCESS | 9851 | RSS: Main: 263159808 21:23:39 INFO - PROCESS | 9851 | 21:26:41 INFO - PROCESS | 9851 | Cycle 1(1): loaded http://localhost:52504/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52504/tests/dromaeo/cssquery-yui.html) 21:26:42 INFO - PROCESS | 9851 | RSS: Main: 221904896 21:26:42 INFO - PROCESS | 9851 | 21:29:44 INFO - PROCESS | 9851 | Cycle 1(1): loaded http://localhost:52504/tests/dromaeo/cssquery-yui.html (next: http://localhost:52504/tests/dromaeo/cssquery-dojo.html) 21:29:45 INFO - PROCESS | 9851 | RSS: Main: 312209408 21:29:45 INFO - PROCESS | 9851 | 21:29:45 INFO - PROCESS | 9851 | __start_tp_report 21:29:45 INFO - PROCESS | 9851 | _x_x_mozilla_page_load 21:29:45 INFO - PROCESS | 9851 | _x_x_mozilla_page_load_details 21:29:45 INFO - PROCESS | 9851 | |i|pagename|runs| 21:29:45 INFO - PROCESS | 9851 | |0;dojo.html;2965.970340296597;3024.4102400031998;3030.939381212377;3052.9084127476185;3073.707997740214;5119.6672216305915;5223.138182199932;5230.555402790763;5323.041852466555;5344.22508736233;5240.34495688039;5295.179247216687;5343.038253114438;5358.624896257264;5400.621956463049;4694.741789201593;4829.541193586604;4842.273658951168;4851.902961940759;4942.87642808929;4899.730514821684;4913.385826771653;4941.752912354368;4955.578775804061;4970.130227210242;4723.244280915072;4774.976125119352;4775.474697783241;4833.10587541306;4929.038837426703;4847.103285892122;4925.950740492585;4927.605791536668;4971;4978.626603004789;4855.368802055746;4870.586000189988;4872.756362181912;4891.339669144655;4899.8040078396825;5348.1175606025345;5352.652077614982;5363.839084827422;5376;5380.784768609251;5564.916526252109;5614.101743720985;5615.859603509904;5669.121286200645;5673.290838645169;5709.74306156224;5734.741936612862;5800.0719884818645;5801.274840644919;5805.4194580542035;5335.466453354634;5337.973310133424;5342.2787923630585;5342.91985620216;5351.277577527023;5677.858053548612;5718.542516598662;5791.362950075489;5841.678707671119;5848.590598658053;5517.69652669107;5529.142982837667;5536.975659503005;5614.410486898817;5659.943400566024;5685.0335442973965;5689.402612725687;5689.971550142305;5692.345380281238;5692.829215123553;5380.569554435636;5666.178404131378;5669.234653321749;5671.6597004179885;5676.091825307931;5505.834824955257;5639.520640745501;5688.800891968844;5699;5797.971010144923;4431.911361772746;4439.9778001110435;4442.378067070613;4443.37792709021;4494;3930.7051971102283;3942.073612701013;3959.8416063357718;3996.020974861178;4010.438538604598;5216.426193118754;5241.73791310433;5248;5378.515933565998;5459.945400545944;5775.364709881909;5785.942140578624;5834.241548598655;5838.9124163137585;5849;5476;5487.314085739283;5490.835274941758;5494.450554944554;5499.120140777536;4820.421549414093;4869.780859861315;4960.305557221992;4999.825006124841;5071.442141364447;5822.7088645567555;5828.358880523224;5832.212651292021;5834.387389324144;5838.241028666246;5600.523955463668;5659;5713.428657134419;5821.592488525763;5827.533797296291;5938.2280303560265;5943.851403714942;5944.881102377842;5950.19672344228;5959.28488581373;5663.745131469176;5670.858228544319;5674.659520428622;5678.375378708256;5678.545716342765;5487.2317875496665;5537.363203231519;5658.349289831722;5661.264035675501;5750.25246717924;5614.803481878114;5618.044932361427;5619.719014049363;5671.858203544944;5687.3459552152035;5562.332520097614;5599.720013999366;5601.607887448003;5611.046122159161;5620.74706638194;5352.063388906848;5415.6479828811;5477.424870388551;5550.722463876871;5558.833235002957;5599.468050535193;5618.803341883015;5619.971900140473;5627.465390787868;5688.601797874109;5472.069748142746;5473.917891231715;5474.5894057945015;5476.945230547643;5479.75341109659 21:29:45 INFO - PROCESS | 9851 | |1;ext.html;611.8684482836189;617.6695467924659;624.2353117431147;633.8795628830521;635.6218050260094;42864.57135428645;45231.547684523146;45365;48463.51536484634;48539.271910921365;45362;45993;46031.769841150744;46056.76971615146;46100;8993.28053755698;9142.451452912814;9153.267738580898;9154.862677059817;9161.633534658606;8954.149355811187;9055.501947392891;9060.275177985779;9061.50161741104;9065.773355666128;9114.680986165486;9152.039035901234;9163.725088247364;9164.954175229148;9170.312226582999;9060.09399060092;9102.04428535001;9108.453492790453;9122.452652840851;9125.81748365029;8943.821123577558;8954.731358059269;8968.775780605472;9038.367314288002;9044.14080662336;42544;42694.78652606717;42810.35784463236;42816.57183428188;42874.571254287366;3160.1625569224175;3304.306095719902;3332.4334863073336;3479.982600087009;3844.192719528902;32680.836595817105;32983.83508082444;33229.83385083059;33452.163695907555;34706.65293347059;4438.267685831834;4443.466783985942;4463.620592249663;4493.123840851035;4685.953140468586;323593.9999999977;326103;326576;326730;327245;60319;60522.69738651279;60569;60599.69700151471;60612.39387606156;55043.72478137664;56176.71911640416;61480.69259653673;63200.36799632037;63202;13417.66455838612;14148.504802331869;14164.150150990974;14209.715805683829;14227.07524010936;10314.638987635397;10422.635207767691;10427.530761115768;10435.791284174275;10444.373337599769;15799.605009874846;16295.51113466598;18000.729989050174;18310.725339119923;18408.88297845765;6319.46284565817;6426.903596446057;6472.967635161888;6563.606183628997;6590.703418346186;883.1786438612153;921.2998121427763;925.6343744220995;963.9518024098767;1064.9882611519088;31144.885511449127;31685.841570792;31933.68066319307;31951.680483194872;32423;1022.882368527614;1033.4884232305058;1077.7090185649988;1086.0551320351187;1132.53000004997;15740.212989350486;16358.263878125514;16491.58771030734;16520;16540.75188872168;509706;513540;513577;513637;514178;58052.70973645105;58229.303630082235;58273.708631456575;58288.70855645695;58304.99999999915;1317.5915466205506;1343.7648411527944;1369.2469141971876;1369.9383527741275;1378.6622277542267;29314.7068529312;31059.53410698796;31117.377652447278;31236.531452027783;31332.216694582818;50761.23858142057;51154.23268651048;51183;51190;51212;446350;449089;449374;449376;449396;34630.65369346375;34847;35481.82259088688;35760.28479430345;42179.789101054295;41380.58619413767;47732;47915;48156.27765583589;48239;39562.010949726486;40680.186396272504;40941.59058409378;41495.58504414917;41997.79001104975;39552.40671389989;39878.80060599678;40212.59787402089;41912;42273.365899510914;39580.40629390504;40416.79791601023;40643.59356406398;41007.17985640211;41187.1762564753;32797.50803737898;34940.82529587336;36748.63251367452;38065.42901856419;38711.419328710654;27676;27814.721852781215;28172.577411338436;28397.290067748472;28519.857400712863 21:29:45 INFO - PROCESS | 9851 | |2;jquery.html;392.77611761296055;393.5513514593362;401.97186196966214;405.47086052701223;416.2798358839208;13694.870571570515;17988.28046878125;18382.63234735308;19709.211631534738;19717.408477745656;18434.907825460854;18567.535811604717;18779.906100469514;18790.812091879077;18792.624147517043;5594.49649531542;5680.630759000673;5692.516136128414;5745.138229265602;5747.856303592402;5739.655620662753;5742.28221472316;5797.3043234811885;5804.709764511778;5811.186433899257;5628.831135065954;5739.569532285095;5785.768569257225;5790.594658373915;5791.276090488689;5599;5644.491995720364;5751.1085781703905;5779.653220806744;5801.709914504279;5073.289739436482;5100.9489905100845;5101.438841727407;5101.642884998052;5104.668196567211;22493.662595061087;22745.54508909829;22891.313260602208;22949.311520654406;23049.617022978677;2293.908243670251;2314.756950520188;2854.700256473082;3026.228311780504;3079.322549039208;14205.289735513183;14215.502457414044;14335.211563364011;14641.19473428961;14737.336819843025;1853.573678054055;1861.6369807887468;1925.480120367507;1935.806419358067;1980.752126160524;81919.18080819235;82535;83918.58040709757;85793;87062;10312.071913527818;10374.481275936323;10465.215108866865;10522.842157367646;10940.288881222696;13054.608361749162;13767.518136865361;15155.166465844264;15192.392304307925;15202.847971520143;6857.759978400732;7200.603966781772;7294.598797066106;7341.70633174667;7390.007047145915;6549.312322206099;6688.765893193715;6697.464202863759;6873.931260687429;6874.862502749917;6352.301246862841;6453.450602168882;6495.805125846232;6546.443552298108;6560.081588577603;1835.7980622131554;1894.9431517054234;1913.7416448779516;1941.1852813420596;1985.4335029432248;943.7923656795494;960.9663661771945;962.9085236902483;1011.7116621762763;1016.9084782369622;18313.816861831478;18816.647919010124;19366.61266774685;19594.672264287907;19647.705284420746;899.3120262998812;960.7550074731039;974.668612671695;995.5370752599931;998.3610489286863;10657.413842238597;11174.832377514344;11197.552097916156;11210.43947802623;11217.887821121847;410886;434431;445092;445288;445333;51730.74134629303;83328.58335708283;85840;86544.56727716321;87997;998.6754304851098;1029.0943969306961;1036.8600238967642;1045.764702941832;1056.7358160459885;16260.617847482623;16576.845010149085;17174.828251717823;17311;17640.1179941005;39424.40863387109;39921;40229.597704022584;40386.1922761549;40472.79763601163;51764.74117629388;53042.20436693376;54506.454935450136;54694.726526367114;54960;7216.530925489827;8115.79710507242;8329.875051874105;8495.575221239036;8629.799401152666;10741.140708743125;12543.184692994926;12606.810897836724;12748;12911.354432278536;11028.613998510014;11072.335659860435;11078.501467433824;11153;11482.655520334403;5395;8445.902032735705;9937.850932235877;10730.89269107299;10848.240623156304;10854.891451085388;10910.181736369645;10967.42265567607;11189.272697274651;11233.640935403657;7439.51643143194;7523.473356865185;7588;7600.80997975055;7663.348615367756;10585.735356616146;11148.278647498051;11378.43107844621;11399.316041037564;11412.087033037504 21:29:45 INFO - PROCESS | 9851 | |3;mootools.html;1307.5750381126136;1460.1458146984014;1505.4053648808722;1598.1529789211716;1761.3923196497212;7994.240547148019;8860.778480537982;8949.194572488483;9085.909140908589;9405.294602904776;9141.77145571361;9198.770030749234;9227.538623068836;9227.815443691123;9256.25949924006;2397.520495900818;2409.325388891109;2420.419099416145;2437.597796363607;2440.8169387295934;2379.95240095198;2380.3811009137576;2434.2697190842764;2441.4994926040117;2441.7436169202156;2368.905243790255;2387.3315471667875;2400.8595916939403;2444.083468699238;2445.755424457549;2306.4810417656063;2333.9066437342485;2343.589871772433;2347.6947996760396;2359.315798418457;2301.6432452969816;2307;2312.306308107561;2317.1310758465575;2330.918417855367;9048.547572621343;9177.219936305422;9181.540922953825;9195.448273103635;9210.309226807949;5270.789168433258;5480.123180291134;5481.972590137064;5544.77820887168;5548.805791797308;3618.583862855779;3624.4563315502623;3676.4117741161285;3691.630836916314;3707.610700876423;1241.596481143632;1249.312877917142;1260.7226410189744;1287.7167023254963;1291.6706239908858;12755.36223188846;12797.744045119045;12839;12847.972162227094;12868;4276.144771045741;4510.458744950627;4593.402857628554;4646.744429056367;4652.813887444464;9980.45107519079;9995.750106247257;10002.499875006366;10010.099091081838;10022.799544009078;5227.947720522822;5283.630145889751;5290.603204759658;5290.9735451322495;5294.8941021180135;4284.507281662586;4290.4636920384955;4391.912161756747;4507.616852567503;4950.2822090796635;3648.5804132524568;3969.7221194516683;4002.0995276062654;4014.8394064237104;4026.174634199982;1187.1749134351714;1207.088648070701;1230.8215308780177;1230.870758570355;1234.4136535145913;912.8630705394111;917.1974522292994;928.4290161550733;932.7295084425576;942.1002942190192;5740.167675687002;5940.70296485174;5974.880502390015;6241.96879015602;6245.531585131133;442.77197243419664;450.79038247215203;460.10050351562614;460.42676867300423;461.4554825306171;3841.961580384216;3921.215756848642;3977.482927219443;3988.4216788565495;4071.0840060986043;11206.887931120747;11348.886511134948;11401.48693308803;11436.542538298374;11443.25618834773;10958.56165753361;11268.718282043015;11277.887221127849;11296.491657875415;11306.434678266218;8473.95763021181;8486.660533578712;8507;8508.872366914502;8537.658493660309;5794.159846822103;5858.619189752652;5891.882162356815;5952.404759524013;6048.879022419439;10468.110210631878;10510.527026283682;10623.468826558486;10643.680689579325;10686.946565267124;9619.951900240734;10744.83882741775;10973.670789876316;10994.450277486254;11008.559657613927;6943.958406239105;7305.561666300039;7491.101067871672;7577.393808495197;7766.417518686008;8580.75579041048;8615.396922215385;8654.524001179743;8844.55777211124;8909.821803564022;7960.920390796018;8041.879371809545;8090.271875531231;8174.182581741778;8275.54484503358;7887;7940.126586075412;7956.443048986515;7972.202779721982;8117.066537348281;7024.051753013277;7031.964840175767;7052.2242553318065;7071.575705457689;7076.610786406797;5059.924101138412;5078.441371449064;5158.613104017289;5204.98502791952;5234.267202591716;5042.294078828893;5213.661112027706;5286.259923610774;5289.47105289468;5296.41739408657 21:29:45 INFO - PROCESS | 9851 | |4;prototype.html;330.3788876911406;334.29130243882963;336.2988169666246;342.24022669673326;342.42814499785356;5000.7749651265685;5099.266249475178;5134.9743251283735;5176.249443830647;5216.895662086756;5010.72441015744;5104.545204616685;5138.177891537355;5141.177411614133;5145.176771716526;4092.877213683579;4100.7334523255895;4104.42538044674;4121.216968775923;4123.814378379456;3908.355121404965;4037.4953130858644;4100.462326627515;4106.815193316293;4131.834726610932;4006.1186538961383;4011.277969965405;4028.5769994150633;4033.9394909076386;4036.838526458953;4013.6387725104883;4017.6384125428704;4021.879343619696;4023.4568333275074;4063.309237429644;3459.8616055357757;3589.3898037333456;3593.1556084320164;3593.5446144311595;3624.3838547447;5056.241563765428;5067.5185857343495;5070.518300761421;5073.77168027436;5075.974620126913;4638.9072218555775;4645.698029628097;4657.301404789275;4658.557437043475;4669.463011753658;5301.204819277101;5341.359036915556;5371.301730775013;5378.520906750675;5450.863728406782;3898.161895192547;3903.980480097581;3907.628775266345;3912.295786758411;3924.6271604197555;5576.525995290405;5591.524720398771;5606.318104568654;5611.775528978836;5620.5503559715125;3897.61023897608;3939.2712348215673;3950.58518855516;4016.979915100406;4025.879223623296;4000.1999600079516;4002.959970400317;4008.9599104008585;4010.8796736097966;4024.3359845625146;4588.151192029485;4593.150267200579;4605.930911036337;4608.953910460919;4611.239145540948;5272.261883336336;5438.211459338374;5440.700761458079;5464.426235245322;5474.260974768435;1348.7928304167715;1384.3562743324403;1388.9027668142055;1410.5063227870369;1411.4142630808306;868.5092922498768;896.3949334199519;898.6360523987795;909.7680091576606;913.584319134792;4687.95312046882;4706;4716.103940251342;4717.551832575899;4722.7874745635845;4835.500994691657;4850.369451971292;4877.488093631782;4899.902001960012;4904.950950490521;4460.821567137343;4611.400517932714;4617.699849509839;4646.3495110684535;4660.883477913011;2591.883365248568;2595.832479879284;2604.7785938195466;2614.81026133109;2618.7904967602544;4987.17967941706;5055.241713742895;5060.418051924003;5062.367204099488;5087.97456012725;4769.783705155232;4928.926066109011;4982.302477653131;4991.5258050485145;5001.674556242599;5056.443791182894;5064.797408103635;5080.77136528857;5082.2122571001555;5111.182210846247;4818.482178113883;4827.034593081327;4837.419509658864;4852.902941941071;4904.6321525886415;4549.363089167453;4796.472388037383;4847.442544107473;4848.684835485682;4874.439439464507;4975.776090075883;4987.625928055338;4988.201887697951;5003.199488081889;5033.874153146201;3587.264610754841;3748.100455890621;3873.767573945572;3899.8050097494443;3979.1842672252697;5458.099413596871;5474.726263686879;5485.50630443262;5490.835274941758;5490.929268792547;5323.8287576733055;5324.946750532445;5325.840224793263;5332.293666026834;5352.895320714055;5194.818181363634;5298.97350513245;5343.7862485500145;5350.6254562180275;5350.866228344167;5289.338832645919;5293.332600230915;5295.338082739658;5301.416844147064;5304.7347632618985;5189.844304670866;5377.677339359651;5386.48828361305;5389.649672771257;5399.244105825109;5239.799284300527;5247.317848679647;5250.711210883438;5255.947440525546;5276.5251127398715 21:29:45 INFO - PROCESS | 9851 | |5;yui.html;666.3037126203117;704.4153352717245;706.4913262451037;740.5445650924676;744.8808190689489;13273.867261327383;14042.719145617082;14055;14110.3650335735;14120.576382708523;13200.273984930825;13361.33193340334;13375.933120334385;13390.866091339083;13404.396802143903;771.4484143837155;789.388224126301;789.455275859655;790.0992868130336;791.216695471482;793.1394437035823;797.5414136871293;799.580220384297;801.4429971170039;802.458340620082;842.5744998775609;844.1136806353335;845.3533047218882;845.4420082745389;846.9618867150962;833.729038062629;836.7489753074053;837.0165056059107;837.8701301298339;838.9119142490042;623.0529595015596;625.3933684326241;625.5464788028688;625.809128215894;625.8435391152212;13030.674233144153;13044.41300141496;13105.86894131056;13156.934215328958;13177.736445271137;13455.461781528727;14058.156510609293;14145.151290922578;14185.148891066568;14205.36075876588;11241.494132764044;11475.885241147565;11639.883601164049;11656.184067115306;11815.94092029543;3714.164313029574;3725.143217060064;3737.719671024684;3805.334066538345;3814.694824414068;84175.57912210461;84578.57710711469;85347.57326213391;86103.99999999937;87573.56213218893;10631;10660.413677247825;10689.893101069045;10846.511906964206;10907.18196135293;20828.062737176864;20940.895295523424;21021.159153633682;21026.369208923756;21116;8020;8119.188081191834;8224.8355032899;8257.710980115788;8309.8338033239;4596.10375976688;4598.333241679938;4711.623070154379;4868.537488938545;4874.147024270738;3417.709494692929;3559.1280136366754;3559.982200089035;3563.94654080189;3566.6076731559506;588.4556784973882;588.8822235552907;594.872102497965;598.512212546773;613.6747523812387;592.7066102279399;671.9462443004547;676.2223443040542;681.9454443644496;749.3143773447234;8850.380473366802;9338.48638324885;9344.66383404149;9417.340786144903;9485.193758530602;575.4044563876367;628.8710814283061;644.8387903024244;704.3660705365212;708.9645517724197;4423.181711383404;4455.777211139495;4491.124230774967;4655.627549796008;4726.692764970335;98075.50962245143;98788.50605746925;125306.37346813208;133472;133517.3324133373;65498;96599;103989;105048.47475762572;109057;56629;62302.37697623057;76616.61691691617;84289.57855210685;84879;9143.3599648024;9430.82114735658;9663.130318271109;9744.12302892743;9969;50618.24072638987;50768.49231507638;51501.48498514967;52948.20577691415;53089.734551327;59058.40941590529;71901.28098718946;72345.6382718083;72377.63811180911;72803.63598182188;12293.692657683629;12492.43784029739;12553.560625378068;12667.93666031664;12879.356032198166;13673;13736.65658358549;14015.439382424996;14116.858831411555;14365.13809171453;13572.728545429234;13642.795358069437;13741.175529468264;13759.587212383645;14894.925525372304;12935.61193164169;13649.522266720616;13782.65543361424;14271;14351.856481435052;11821.763564728486;13317.933410332886;13619.65950851197;14111.082779619292;14242.857571424567;9782.41305521671;9915.405075695482;10610.8938910613;10882.129429645767;11303.378314192469;10599.47002649849;11179.217454778087;11507.769844602893;11645.941770291094;11658.242214256046 21:29:45 INFO - PROCESS | 9851 | __end_tp_report 21:29:45 INFO - PROCESS | 9851 | __start_cc_report 21:29:45 INFO - PROCESS | 9851 | _x_x_mozilla_cycle_collect,922 21:29:45 INFO - PROCESS | 9851 | __end_cc_report 21:29:45 INFO - PROCESS | 9851 | __startTimestamp1474518585236__endTimestamp 21:29:45 INFO - PROCESS | 9851 | 21:29:45 INFO - PROCESS | 9851 | ------- Summary: start ------- 21:29:45 INFO - PROCESS | 9851 | Number of tests: 6 21:29:45 INFO - PROCESS | 9851 | 21:29:45 INFO - PROCESS | 9851 | [#0] dojo.html Cycles:165 Average:5303.04 Median:5490.84 stddev:595.03 (10.8%) stddev-sans-first:567.91 21:29:45 INFO - PROCESS | 9851 | Values: 2966.0 3024.4 3030.9 3052.9 3073.7 5119.7 5223.1 5230.6 5323.0 5344.2 5240.3 5295.2 5343.0 5358.6 5400.6 4694.7 4829.5 4842.3 4851.9 4942.9 4899.7 4913.4 4941.8 4955.6 4970.1 4723.2 4775.0 4775.5 4833.1 4929.0 4847.1 4926.0 4927.6 4971.0 4978.6 4855.4 4870.6 4872.8 4891.3 4899.8 5348.1 5352.7 5363.8 5376.0 5380.8 5564.9 5614.1 5615.9 5669.1 5673.3 5709.7 5734.7 5800.1 5801.3 5805.4 5335.5 5338.0 5342.3 5342.9 5351.3 5677.9 5718.5 5791.4 5841.7 5848.6 5517.7 5529.1 5537.0 5614.4 5659.9 5685.0 5689.4 5690.0 5692.3 5692.8 5380.6 5666.2 5669.2 5671.7 5676.1 5505.8 5639.5 5688.8 5699.0 5798.0 4431.9 4440.0 4442.4 4443.4 4494.0 3930.7 3942.1 3959.8 3996.0 4010.4 5216.4 5241.7 5248.0 5378.5 5459.9 5775.4 5785.9 5834.2 5838.9 5849.0 5476.0 5487.3 5490.8 5494.5 5499.1 4820.4 4869.8 4960.3 4999.8 5071.4 5822.7 5828.4 5832.2 5834.4 5838.2 5600.5 5659.0 5713.4 5821.6 5827.5 5938.2 5943.9 5944.9 5950.2 5959.3 5663.7 5670.9 5674.7 5678.4 5678.5 5487.2 5537.4 5658.3 5661.3 5750.3 5614.8 5618.0 5619.7 5671.9 5687.3 5562.3 5599.7 5601.6 5611.0 5620.7 5352.1 5415.6 5477.4 5550.7 5558.8 5599.5 5618.8 5620.0 5627.5 5688.6 5472.1 5473.9 5474.6 5476.9 5479.8 21:29:45 INFO - PROCESS | 9851 | 21:29:45 INFO - PROCESS | 9851 | [#1] ext.html Cycles:180 Average:59445.03 Median:42840.57 stddev:115542.87 (269.7%) stddev-sans-first:115782.56 21:29:45 INFO - PROCESS | 9851 | Values: 611.9 617.7 624.2 633.9 635.6 42864.6 45231.5 45365.0 48463.5 48539.3 45362.0 45993.0 46031.8 46056.8 46100.0 8993.3 9142.5 9153.3 9154.9 9161.6 8954.1 9055.5 9060.3 9061.5 9065.8 9114.7 9152.0 9163.7 9165.0 9170.3 9060.1 9102.0 9108.5 9122.5 9125.8 8943.8 8954.7 8968.8 9038.4 9044.1 42544.0 42694.8 42810.4 42816.6 42874.6 3160.2 3304.3 3332.4 3480.0 3844.2 32680.8 32983.8 33229.8 33452.2 34706.7 4438.3 4443.5 4463.6 4493.1 4686.0 323594.0 326103.0 326576.0 326730.0 327245.0 60319.0 60522.7 60569.0 60599.7 60612.4 55043.7 56176.7 61480.7 63200.4 63202.0 13417.7 14148.5 14164.2 14209.7 14227.1 10314.6 10422.6 10427.5 10435.8 10444.4 15799.6 16295.5 18000.7 18310.7 18408.9 6319.5 6426.9 6473.0 6563.6 6590.7 883.2 921.3 925.6 964.0 1065.0 31144.9 31685.8 31933.7 31951.7 32423.0 1022.9 1033.5 1077.7 1086.1 1132.5 15740.2 16358.3 16491.6 16520.0 16540.8 509706.0 513540.0 513577.0 513637.0 514178.0 58052.7 58229.3 58273.7 58288.7 58305.0 1317.6 1343.8 1369.2 1369.9 1378.7 29314.7 31059.5 31117.4 31236.5 31332.2 50761.2 51154.2 51183.0 51190.0 51212.0 446350.0 449089.0 449374.0 449376.0 449396.0 34630.7 34847.0 35481.8 35760.3 42179.8 41380.6 47732.0 47915.0 48156.3 48239.0 39562.0 40680.2 40941.6 41495.6 41997.8 39552.4 39878.8 40212.6 41912.0 42273.4 39580.4 40416.8 40643.6 41007.2 41187.2 32797.5 34940.8 36748.6 38065.4 38711.4 27676.0 27814.7 28172.6 28397.3 28519.9 21:29:45 INFO - PROCESS | 9851 | 21:29:45 INFO - PROCESS | 9851 | [#2] jquery.html Cycles:180 Average:26898.35 Median:39672.70 stddev:72081.34 (181.7%) stddev-sans-first:72256.08 21:29:45 INFO - PROCESS | 9851 | Values: 392.8 393.6 402.0 405.5 416.3 13694.9 17988.3 18382.6 19709.2 19717.4 18434.9 18567.5 18779.9 18790.8 18792.6 5594.5 5680.6 5692.5 5745.1 5747.9 5739.7 5742.3 5797.3 5804.7 5811.2 5628.8 5739.6 5785.8 5790.6 5791.3 5599.0 5644.5 5751.1 5779.7 5801.7 5073.3 5100.9 5101.4 5101.6 5104.7 22493.7 22745.5 22891.3 22949.3 23049.6 2293.9 2314.8 2854.7 3026.2 3079.3 14205.3 14215.5 14335.2 14641.2 14737.3 1853.6 1861.6 1925.5 1935.8 1980.8 81919.2 82535.0 83918.6 85793.0 87062.0 10312.1 10374.5 10465.2 10522.8 10940.3 13054.6 13767.5 15155.2 15192.4 15202.8 6857.8 7200.6 7294.6 7341.7 7390.0 6549.3 6688.8 6697.5 6873.9 6874.9 6352.3 6453.5 6495.8 6546.4 6560.1 1835.8 1894.9 1913.7 1941.2 1985.4 943.8 961.0 962.9 1011.7 1016.9 18313.8 18816.6 19366.6 19594.7 19647.7 899.3 960.8 974.7 995.5 998.4 10657.4 11174.8 11197.6 11210.4 11217.9 410886.0 434431.0 445092.0 445288.0 445333.0 51730.7 83328.6 85840.0 86544.6 87997.0 998.7 1029.1 1036.9 1045.8 1056.7 16260.6 16576.8 17174.8 17311.0 17640.1 39424.4 39921.0 40229.6 40386.2 40472.8 51764.7 53042.2 54506.5 54694.7 54960.0 7216.5 8115.8 8329.9 8495.6 8629.8 10741.1 12543.2 12606.8 12748.0 12911.4 11028.6 11072.3 11078.5 11153.0 11482.7 5395.0 8445.9 9937.9 10730.9 10848.2 10854.9 10910.2 10967.4 11189.3 11233.6 7439.5 7523.5 7588.0 7600.8 7663.3 10585.7 11148.3 11378.4 11399.3 11412.1 21:29:45 INFO - PROCESS | 9851 | 21:29:45 INFO - PROCESS | 9851 | [#3] mootools.html Cycles:180 Average:5905.45 Median:2526.75 stddev:3439.02 (136.1%) stddev-sans-first:3431.30 21:29:45 INFO - PROCESS | 9851 | Values: 1307.6 1460.1 1505.4 1598.2 1761.4 7994.2 8860.8 8949.2 9085.9 9405.3 9141.8 9198.8 9227.5 9227.8 9256.3 2397.5 2409.3 2420.4 2437.6 2440.8 2380.0 2380.4 2434.3 2441.5 2441.7 2368.9 2387.3 2400.9 2444.1 2445.8 2306.5 2333.9 2343.6 2347.7 2359.3 2301.6 2307.0 2312.3 2317.1 2330.9 9048.5 9177.2 9181.5 9195.4 9210.3 5270.8 5480.1 5482.0 5544.8 5548.8 3618.6 3624.5 3676.4 3691.6 3707.6 1241.6 1249.3 1260.7 1287.7 1291.7 12755.4 12797.7 12839.0 12848.0 12868.0 4276.1 4510.5 4593.4 4646.7 4652.8 9980.5 9995.8 10002.5 10010.1 10022.8 5227.9 5283.6 5290.6 5291.0 5294.9 4284.5 4290.5 4391.9 4507.6 4950.3 3648.6 3969.7 4002.1 4014.8 4026.2 1187.2 1207.1 1230.8 1230.9 1234.4 912.9 917.2 928.4 932.7 942.1 5740.2 5940.7 5974.9 6242.0 6245.5 442.8 450.8 460.1 460.4 461.5 3842.0 3921.2 3977.5 3988.4 4071.1 11206.9 11348.9 11401.5 11436.5 11443.3 10958.6 11268.7 11277.9 11296.5 11306.4 8474.0 8486.7 8507.0 8508.9 8537.7 5794.2 5858.6 5891.9 5952.4 6048.9 10468.1 10510.5 10623.5 10643.7 10686.9 9620.0 10744.8 10973.7 10994.5 11008.6 6944.0 7305.6 7491.1 7577.4 7766.4 8580.8 8615.4 8654.5 8844.6 8909.8 7960.9 8041.9 8090.3 8174.2 8275.5 7887.0 7940.1 7956.4 7972.2 8117.1 7024.1 7032.0 7052.2 7071.6 7076.6 5059.9 5078.4 5158.6 5205.0 5234.3 5042.3 5213.7 5286.3 5289.5 5296.4 21:29:45 INFO - PROCESS | 9851 | 21:29:45 INFO - PROCESS | 9851 | [#4] prototype.html Cycles:180 Average:4376.72 Median:4863.67 stddev:1247.90 (25.7%) stddev-sans-first:1213.88 21:29:45 INFO - PROCESS | 9851 | Values: 330.4 334.3 336.3 342.2 342.4 5000.8 5099.3 5135.0 5176.2 5216.9 5010.7 5104.5 5138.2 5141.2 5145.2 4092.9 4100.7 4104.4 4121.2 4123.8 3908.4 4037.5 4100.5 4106.8 4131.8 4006.1 4011.3 4028.6 4033.9 4036.8 4013.6 4017.6 4021.9 4023.5 4063.3 3459.9 3589.4 3593.2 3593.5 3624.4 5056.2 5067.5 5070.5 5073.8 5076.0 4638.9 4645.7 4657.3 4658.6 4669.5 5301.2 5341.4 5371.3 5378.5 5450.9 3898.2 3904.0 3907.6 3912.3 3924.6 5576.5 5591.5 5606.3 5611.8 5620.6 3897.6 3939.3 3950.6 4017.0 4025.9 4000.2 4003.0 4009.0 4010.9 4024.3 4588.2 4593.2 4605.9 4609.0 4611.2 5272.3 5438.2 5440.7 5464.4 5474.3 1348.8 1384.4 1388.9 1410.5 1411.4 868.5 896.4 898.6 909.8 913.6 4688.0 4706.0 4716.1 4717.6 4722.8 4835.5 4850.4 4877.5 4899.9 4905.0 4460.8 4611.4 4617.7 4646.3 4660.9 2591.9 2595.8 2604.8 2614.8 2618.8 4987.2 5055.2 5060.4 5062.4 5088.0 4769.8 4928.9 4982.3 4991.5 5001.7 5056.4 5064.8 5080.8 5082.2 5111.2 4818.5 4827.0 4837.4 4852.9 4904.6 4549.4 4796.5 4847.4 4848.7 4874.4 4975.8 4987.6 4988.2 5003.2 5033.9 3587.3 3748.1 3873.8 3899.8 3979.2 5458.1 5474.7 5485.5 5490.8 5490.9 5323.8 5324.9 5325.8 5332.3 5352.9 5194.8 5299.0 5343.8 5350.6 5350.9 5289.3 5293.3 5295.3 5301.4 5304.7 5189.8 5377.7 5386.5 5389.6 5399.2 5239.8 5247.3 5250.7 5255.9 5276.5 21:29:45 INFO - PROCESS | 9851 | 21:29:45 INFO - PROCESS | 9851 | [#5] yui.html Cycles:180 Average:20311.54 Median:4719.16 stddev:29905.15 (633.7%) stddev-sans-first:29952.66 21:29:45 INFO - PROCESS | 9851 | Values: 666.3 704.4 706.5 740.5 744.9 13273.9 14042.7 14055.0 14110.4 14120.6 13200.3 13361.3 13375.9 13390.9 13404.4 771.4 789.4 789.5 790.1 791.2 793.1 797.5 799.6 801.4 802.5 842.6 844.1 845.4 845.4 847.0 833.7 836.7 837.0 837.9 838.9 623.1 625.4 625.5 625.8 625.8 13030.7 13044.4 13105.9 13156.9 13177.7 13455.5 14058.2 14145.2 14185.1 14205.4 11241.5 11475.9 11639.9 11656.2 11815.9 3714.2 3725.1 3737.7 3805.3 3814.7 84175.6 84578.6 85347.6 86104.0 87573.6 10631.0 10660.4 10689.9 10846.5 10907.2 20828.1 20940.9 21021.2 21026.4 21116.0 8020.0 8119.2 8224.8 8257.7 8309.8 4596.1 4598.3 4711.6 4868.5 4874.1 3417.7 3559.1 3560.0 3563.9 3566.6 588.5 588.9 594.9 598.5 613.7 592.7 671.9 676.2 681.9 749.3 8850.4 9338.5 9344.7 9417.3 9485.2 575.4 628.9 644.8 704.4 709.0 4423.2 4455.8 4491.1 4655.6 4726.7 98075.5 98788.5 125306.4 133472.0 133517.3 65498.0 96599.0 103989.0 105048.5 109057.0 56629.0 62302.4 76616.6 84289.6 84879.0 9143.4 9430.8 9663.1 9744.1 9969.0 50618.2 50768.5 51501.5 52948.2 53089.7 59058.4 71901.3 72345.6 72377.6 72803.6 12293.7 12492.4 12553.6 12667.9 12879.4 13673.0 13736.7 14015.4 14116.9 14365.1 13572.7 13642.8 13741.2 13759.6 14894.9 12935.6 13649.5 13782.7 14271.0 14351.9 11821.8 13317.9 13619.7 14111.1 14242.9 9782.4 9915.4 10610.9 10882.1 11303.4 10599.5 11179.2 11507.8 11645.9 11658.2 21:29:45 INFO - PROCESS | 9851 | -------- Summary: end -------- 21:29:45 INFO - PROCESS | 9851 | 21:29:46 INFO - TEST-INFO | 9851: exit 0 21:29:46 INFO - TEST-OK | dromaeo_css | took 1115337ms 21:29:46 INFO - TEST-START | kraken 21:29:46 INFO - operating with platform_type : linux_ 21:29:46 INFO - Initialising browser for kraken test... 21:29:46 INFO - TEST-INFO | started process 10162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj8hhAo/profile http://localhost:52504/getInfo.html) 21:29:50 INFO - PROCESS | 10162 | __metrics Screen width/height:1600/1200 21:29:50 INFO - PROCESS | 10162 | colorDepth:24 21:29:50 INFO - PROCESS | 10162 | Browser inner width/height: 1024/697 21:29:50 INFO - PROCESS | 10162 | __metrics 21:29:51 INFO - PROCESS | 10162 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:29:51 INFO - PROCESS | 10162 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:29:51 INFO - PROCESS | 10162 | console.error: PushService: 21:29:51 INFO - PROCESS | 10162 | stateChangeProcessEnqueue: Error transitioning state 21:29:51 INFO - PROCESS | 10162 | UnknownError 21:29:52 INFO - TEST-INFO | 10162: exit 0 21:29:52 INFO - Browser initialized. 21:29:52 INFO - Running cycle 1/1 for kraken test... 21:29:52 INFO - TEST-INFO | started process 10244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj8hhAo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:04 INFO - PROCESS | 10244 | RSS: Main: 173727744 21:30:04 INFO - PROCESS | 10244 | 21:30:07 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52504/tests/kraken/driver.html?testName=audio-beat-detection) 21:30:07 INFO - PROCESS | 10244 | RSS: Main: 233205760 21:30:07 INFO - PROCESS | 10244 | 21:30:10 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52504/tests/kraken/driver.html?testName=audio-dft) 21:30:11 INFO - PROCESS | 10244 | RSS: Main: 217108480 21:30:11 INFO - PROCESS | 10244 | 21:30:14 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52504/tests/kraken/driver.html?testName=audio-fft) 21:30:14 INFO - PROCESS | 10244 | RSS: Main: 298856448 21:30:14 INFO - PROCESS | 10244 | 21:30:17 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52504/tests/kraken/driver.html?testName=audio-oscillator) 21:30:17 INFO - PROCESS | 10244 | RSS: Main: 208519168 21:30:17 INFO - PROCESS | 10244 | 21:30:19 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52504/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:30:20 INFO - PROCESS | 10244 | RSS: Main: 213110784 21:30:20 INFO - PROCESS | 10244 | 21:30:23 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52504/tests/kraken/driver.html?testName=imaging-darkroom) 21:30:23 INFO - PROCESS | 10244 | RSS: Main: 249393152 21:30:23 INFO - PROCESS | 10244 | 21:30:27 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52504/tests/kraken/driver.html?testName=imaging-desaturate) 21:30:27 INFO - PROCESS | 10244 | RSS: Main: 248913920 21:30:27 INFO - PROCESS | 10244 | 21:30:30 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52504/tests/kraken/driver.html?testName=json-parse-financial) 21:30:31 INFO - PROCESS | 10244 | RSS: Main: 248872960 21:30:31 INFO - PROCESS | 10244 | 21:30:32 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52504/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:30:33 INFO - PROCESS | 10244 | RSS: Main: 210300928 21:30:33 INFO - PROCESS | 10244 | 21:30:35 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52504/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:30:35 INFO - PROCESS | 10244 | RSS: Main: 217792512 21:30:35 INFO - PROCESS | 10244 | 21:30:37 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52504/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:30:38 INFO - PROCESS | 10244 | RSS: Main: 222330880 21:30:38 INFO - PROCESS | 10244 | 21:30:41 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:30:41 INFO - PROCESS | 10244 | RSS: Main: 222793728 21:30:41 INFO - PROCESS | 10244 | 21:30:44 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:30:45 INFO - PROCESS | 10244 | RSS: Main: 221261824 21:30:45 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | Cycle 1(1): loaded http://localhost:52504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52504/tests/kraken/driver.html?testName=ai-astar) 21:30:46 INFO - PROCESS | 10244 | RSS: Main: 273133568 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | __start_tp_report 21:30:46 INFO - PROCESS | 10244 | _x_x_mozilla_page_load 21:30:46 INFO - PROCESS | 10244 | _x_x_mozilla_page_load_details 21:30:46 INFO - PROCESS | 10244 | |i|pagename|runs| 21:30:46 INFO - PROCESS | 10244 | |0;ai-astar;110;111;111;111;111;111;112;111;112;112 21:30:46 INFO - PROCESS | 10244 | |1;audio-beat-detection;142;117;120;169;118;119;117;120;148;123 21:30:46 INFO - PROCESS | 10244 | |2;audio-dft;160;160;159;160;160;160;160;161;161;161 21:30:46 INFO - PROCESS | 10244 | |3;audio-fft;78;75;76;108;78;76;76;77;114;76 21:30:46 INFO - PROCESS | 10244 | |4;audio-oscillator;83;83;123;81;82;82;99;83;81;115 21:30:46 INFO - PROCESS | 10244 | |5;imaging-gaussian-blur;118;117;118;118;117;117;117;116;117;116 21:30:46 INFO - PROCESS | 10244 | |6;imaging-darkroom;148;146;146;147;147;147;147;147;147;146 21:30:46 INFO - PROCESS | 10244 | |7;imaging-desaturate;95;95;96;95;95;94;95;96;95;95 21:30:46 INFO - PROCESS | 10244 | |8;json-parse-financial;52;50;51;50;52;50;53;51;52;52 21:30:46 INFO - PROCESS | 10244 | |9;json-stringify-tinderbox;60;59;60;60;60;59;60;59;59;60 21:30:46 INFO - PROCESS | 10244 | |10;stanford-crypto-aes;79;79;80;86;81;79;79;80;80;79 21:30:46 INFO - PROCESS | 10244 | |11;stanford-crypto-ccm;129;135;123;124;124;133;133;123;168;123 21:30:46 INFO - PROCESS | 10244 | |12;stanford-crypto-pbkdf2;169;170;164;164;168;164;165;176;161;164 21:30:46 INFO - PROCESS | 10244 | |13;stanford-crypto-sha256-iterative;67;65;65;64;64;64;68;64;64;62 21:30:46 INFO - PROCESS | 10244 | __end_tp_report 21:30:46 INFO - PROCESS | 10244 | __start_cc_report 21:30:46 INFO - PROCESS | 10244 | _x_x_mozilla_cycle_collect,1610 21:30:46 INFO - PROCESS | 10244 | __end_cc_report 21:30:46 INFO - PROCESS | 10244 | __startTimestamp1474518646916__endTimestamp 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | ------- Summary: start ------- 21:30:46 INFO - PROCESS | 10244 | Number of tests: 14 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 21:30:46 INFO - PROCESS | 10244 | Values: 110.0 111.0 111.0 111.0 111.0 111.0 112.0 111.0 112.0 112.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:121.50 stddev:17.75 (14.6%) stddev-sans-first:18.22 21:30:46 INFO - PROCESS | 10244 | Values: 142.0 117.0 120.0 169.0 118.0 119.0 117.0 120.0 148.0 123.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 21:30:46 INFO - PROCESS | 10244 | Values: 160.0 160.0 159.0 160.0 160.0 160.0 160.0 161.0 161.0 161.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:14.65 (19.3%) stddev-sans-first:15.40 21:30:46 INFO - PROCESS | 10244 | Values: 78.0 75.0 76.0 108.0 78.0 76.0 76.0 77.0 114.0 76.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.50 stddev:15.70 (19.0%) stddev-sans-first:16.37 21:30:46 INFO - PROCESS | 10244 | Values: 83.0 83.0 123.0 81.0 82.0 82.0 99.0 83.0 81.0 115.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 21:30:46 INFO - PROCESS | 10244 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 117.0 116.0 117.0 116.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 21:30:46 INFO - PROCESS | 10244 | Values: 148.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:30:46 INFO - PROCESS | 10244 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:52.00 stddev:1.06 (2.0%) stddev-sans-first:1.09 21:30:46 INFO - PROCESS | 10244 | Values: 52.0 50.0 51.0 50.0 52.0 50.0 53.0 51.0 52.0 52.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 21:30:46 INFO - PROCESS | 10244 | Values: 60.0 59.0 60.0 60.0 60.0 59.0 60.0 59.0 59.0 60.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:2.15 (2.7%) stddev-sans-first:2.24 21:30:46 INFO - PROCESS | 10244 | Values: 79.0 79.0 80.0 86.0 81.0 79.0 79.0 80.0 80.0 79.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:131.00 stddev:13.68 (10.4%) stddev-sans-first:14.48 21:30:46 INFO - PROCESS | 10244 | Values: 129.0 135.0 123.0 124.0 124.0 133.0 133.0 123.0 168.0 123.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.50 stddev:4.33 (2.6%) stddev-sans-first:4.49 21:30:46 INFO - PROCESS | 10244 | Values: 169.0 170.0 164.0 164.0 168.0 164.0 165.0 176.0 161.0 164.0 21:30:46 INFO - PROCESS | 10244 | 21:30:46 INFO - PROCESS | 10244 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.50 stddev:1.70 (2.6%) stddev-sans-first:1.59 21:30:46 INFO - PROCESS | 10244 | Values: 67.0 65.0 65.0 64.0 64.0 64.0 68.0 64.0 64.0 62.0 21:30:46 INFO - PROCESS | 10244 | -------- Summary: end -------- 21:30:46 INFO - PROCESS | 10244 | 21:30:48 INFO - TEST-INFO | 10244: exit 0 21:30:48 INFO - TEST-OK | kraken | took 61978ms 21:30:48 INFO - SUITE-END | took 1177s 21:30:48 INFO - Completed test suite (00:19:37) 21:30:48 INFO - javascript benchmark 21:30:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2965.970340296597, 3024.4102400031998, 3030.939381212377, 3052.9084127476185, 3073.707997740214, 5119.6672216305915, 5223.138182199932, 5230.555402790763, 5323.041852466555, 5344.22508736233, 5240.34495688039, 5295.179247216687, 5343.038253114438, 5358.624896257264, 5400.621956463049, 4694.741789201593, 4829.541193586604, 4842.273658951168, 4851.902961940759, 4942.87642808929, 4899.730514821684, 4913.385826771653, 4941.752912354368, 4955.578775804061, 4970.130227210242, 4723.244280915072, 4774.976125119352, 4775.474697783241, 4833.10587541306, 4929.038837426703, 4847.103285892122, 4925.950740492585, 4927.605791536668, 4971.0, 4978.626603004789, 4855.368802055746, 4870.586000189988, 4872.756362181912, 4891.339669144655, 4899.8040078396825, 5348.1175606025345, 5352.652077614982, 5363.839084827422, 5376.0, 5380.784768609251, 5564.916526252109, 5614.101743720985, 5615.859603509904, 5669.121286200645, 5673.290838645169, 5709.74306156224, 5734.741936612862, 5800.0719884818645, 5801.274840644919, 5805.4194580542035, 5335.466453354634, 5337.973310133424, 5342.2787923630585, 5342.91985620216, 5351.277577527023, 5677.858053548612, 5718.542516598662, 5791.362950075489, 5841.678707671119, 5848.590598658053, 5517.69652669107, 5529.142982837667, 5536.975659503005, 5614.410486898817, 5659.943400566024, 5685.0335442973965, 5689.402612725687, 5689.971550142305, 5692.345380281238, 5692.829215123553, 5380.569554435636, 5666.178404131378, 5669.234653321749, 5671.6597004179885, 5676.091825307931, 5505.834824955257, 5639.520640745501, 5688.800891968844, 5699.0, 5797.971010144923, 4431.911361772746, 4439.9778001110435, 4442.378067070613, 4443.37792709021, 4494.0, 3930.7051971102283, 3942.073612701013, 3959.8416063357718, 3996.020974861178, 4010.438538604598, 5216.426193118754, 5241.73791310433, 5248.0, 5378.515933565998, 5459.945400545944, 5775.364709881909, 5785.942140578624, 5834.241548598655, 5838.9124163137585, 5849.0, 5476.0, 5487.314085739283, 5490.835274941758, 5494.450554944554, 5499.120140777536, 4820.421549414093, 4869.780859861315, 4960.305557221992, 4999.825006124841, 5071.442141364447, 5822.7088645567555, 5828.358880523224, 5832.212651292021, 5834.387389324144, 5838.241028666246, 5600.523955463668, 5659.0, 5713.428657134419, 5821.592488525763, 5827.533797296291, 5938.2280303560265, 5943.851403714942, 5944.881102377842, 5950.19672344228, 5959.28488581373, 5663.745131469176, 5670.858228544319, 5674.659520428622, 5678.375378708256, 5678.545716342765, 5487.2317875496665, 5537.363203231519, 5658.349289831722, 5661.264035675501, 5750.25246717924, 5614.803481878114, 5618.044932361427, 5619.719014049363, 5671.858203544944, 5687.3459552152035, 5562.332520097614, 5599.720013999366, 5601.607887448003, 5611.046122159161, 5620.74706638194, 5352.063388906848, 5415.6479828811, 5477.424870388551, 5550.722463876871, 5558.833235002957, 5599.468050535193, 5618.803341883015, 5619.971900140473, 5627.465390787868, 5688.601797874109, 5472.069748142746, 5473.917891231715, 5474.5894057945015, 5476.945230547643, 5479.75341109659], "value": 5262.937297198954, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.8684482836189, 617.6695467924659, 624.2353117431147, 633.8795628830521, 635.6218050260094, 42864.57135428645, 45231.547684523146, 45365.0, 48463.51536484634, 48539.271910921365, 45362.0, 45993.0, 46031.769841150744, 46056.76971615146, 46100.0, 8993.28053755698, 9142.451452912814, 9153.267738580898, 9154.862677059817, 9161.633534658606, 8954.149355811187, 9055.501947392891, 9060.275177985779, 9061.50161741104, 9065.773355666128, 9114.680986165486, 9152.039035901234, 9163.725088247364, 9164.954175229148, 9170.312226582999, 9060.09399060092, 9102.04428535001, 9108.453492790453, 9122.452652840851, 9125.81748365029, 8943.821123577558, 8954.731358059269, 8968.775780605472, 9038.367314288002, 9044.14080662336, 42544.0, 42694.78652606717, 42810.35784463236, 42816.57183428188, 42874.571254287366, 3160.1625569224175, 3304.306095719902, 3332.4334863073336, 3479.982600087009, 3844.192719528902, 32680.836595817105, 32983.83508082444, 33229.83385083059, 33452.163695907555, 34706.65293347059, 4438.267685831834, 4443.466783985942, 4463.620592249663, 4493.123840851035, 4685.953140468586, 323593.9999999977, 326103.0, 326576.0, 326730.0, 327245.0, 60319.0, 60522.69738651279, 60569.0, 60599.69700151471, 60612.39387606156, 55043.72478137664, 56176.71911640416, 61480.69259653673, 63200.36799632037, 63202.0, 13417.66455838612, 14148.504802331869, 14164.150150990974, 14209.715805683829, 14227.07524010936, 10314.638987635397, 10422.635207767691, 10427.530761115768, 10435.791284174275, 10444.373337599769, 15799.605009874846, 16295.51113466598, 18000.729989050174, 18310.725339119923, 18408.88297845765, 6319.46284565817, 6426.903596446057, 6472.967635161888, 6563.606183628997, 6590.703418346186, 883.1786438612153, 921.2998121427763, 925.6343744220995, 963.9518024098767, 1064.9882611519088, 31144.885511449127, 31685.841570792, 31933.68066319307, 31951.680483194872, 32423.0, 1022.882368527614, 1033.4884232305058, 1077.7090185649988, 1086.0551320351187, 1132.53000004997, 15740.212989350486, 16358.263878125514, 16491.58771030734, 16520.0, 16540.75188872168, 509706.0, 513540.0, 513577.0, 513637.0, 514178.0, 58052.70973645105, 58229.303630082235, 58273.708631456575, 58288.70855645695, 58304.99999999915, 1317.5915466205506, 1343.7648411527944, 1369.2469141971876, 1369.9383527741275, 1378.6622277542267, 29314.7068529312, 31059.53410698796, 31117.377652447278, 31236.531452027783, 31332.216694582818, 50761.23858142057, 51154.23268651048, 51183.0, 51190.0, 51212.0, 446350.0, 449089.0, 449374.0, 449376.0, 449396.0, 34630.65369346375, 34847.0, 35481.82259088688, 35760.28479430345, 42179.789101054295, 41380.58619413767, 47732.0, 47915.0, 48156.27765583589, 48239.0, 39562.010949726486, 40680.186396272504, 40941.59058409378, 41495.58504414917, 41997.79001104975, 39552.40671389989, 39878.80060599678, 40212.59787402089, 41912.0, 42273.365899510914, 39580.40629390504, 40416.79791601023, 40643.59356406398, 41007.17985640211, 41187.1762564753, 32797.50803737898, 34940.82529587336, 36748.63251367452, 38065.42901856419, 38711.419328710654, 27676.0, 27814.721852781215, 28172.577411338436, 28397.290067748472, 28519.857400712863], "value": 19947.679562257636, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.77611761296055, 393.5513514593362, 401.97186196966214, 405.47086052701223, 416.2798358839208, 13694.870571570515, 17988.28046878125, 18382.63234735308, 19709.211631534738, 19717.408477745656, 18434.907825460854, 18567.535811604717, 18779.906100469514, 18790.812091879077, 18792.624147517043, 5594.49649531542, 5680.630759000673, 5692.516136128414, 5745.138229265602, 5747.856303592402, 5739.655620662753, 5742.28221472316, 5797.3043234811885, 5804.709764511778, 5811.186433899257, 5628.831135065954, 5739.569532285095, 5785.768569257225, 5790.594658373915, 5791.276090488689, 5599.0, 5644.491995720364, 5751.1085781703905, 5779.653220806744, 5801.709914504279, 5073.289739436482, 5100.9489905100845, 5101.438841727407, 5101.642884998052, 5104.668196567211, 22493.662595061087, 22745.54508909829, 22891.313260602208, 22949.311520654406, 23049.617022978677, 2293.908243670251, 2314.756950520188, 2854.700256473082, 3026.228311780504, 3079.322549039208, 14205.289735513183, 14215.502457414044, 14335.211563364011, 14641.19473428961, 14737.336819843025, 1853.573678054055, 1861.6369807887468, 1925.480120367507, 1935.806419358067, 1980.752126160524, 81919.18080819235, 82535.0, 83918.58040709757, 85793.0, 87062.0, 10312.071913527818, 10374.481275936323, 10465.215108866865, 10522.842157367646, 10940.288881222696, 13054.608361749162, 13767.518136865361, 15155.166465844264, 15192.392304307925, 15202.847971520143, 6857.759978400732, 7200.603966781772, 7294.598797066106, 7341.70633174667, 7390.007047145915, 6549.312322206099, 6688.765893193715, 6697.464202863759, 6873.931260687429, 6874.862502749917, 6352.301246862841, 6453.450602168882, 6495.805125846232, 6546.443552298108, 6560.081588577603, 1835.7980622131554, 1894.9431517054234, 1913.7416448779516, 1941.1852813420596, 1985.4335029432248, 943.7923656795494, 960.9663661771945, 962.9085236902483, 1011.7116621762763, 1016.9084782369622, 18313.816861831478, 18816.647919010124, 19366.61266774685, 19594.672264287907, 19647.705284420746, 899.3120262998812, 960.7550074731039, 974.668612671695, 995.5370752599931, 998.3610489286863, 10657.413842238597, 11174.832377514344, 11197.552097916156, 11210.43947802623, 11217.887821121847, 410886.0, 434431.0, 445092.0, 445288.0, 445333.0, 51730.74134629303, 83328.58335708283, 85840.0, 86544.56727716321, 87997.0, 998.6754304851098, 1029.0943969306961, 1036.8600238967642, 1045.764702941832, 1056.7358160459885, 16260.617847482623, 16576.845010149085, 17174.828251717823, 17311.0, 17640.1179941005, 39424.40863387109, 39921.0, 40229.597704022584, 40386.1922761549, 40472.79763601163, 51764.74117629388, 53042.20436693376, 54506.454935450136, 54694.726526367114, 54960.0, 7216.530925489827, 8115.79710507242, 8329.875051874105, 8495.575221239036, 8629.799401152666, 10741.140708743125, 12543.184692994926, 12606.810897836724, 12748.0, 12911.354432278536, 11028.613998510014, 11072.335659860435, 11078.501467433824, 11153.0, 11482.655520334403, 5395.0, 8445.902032735705, 9937.850932235877, 10730.89269107299, 10848.240623156304, 10854.891451085388, 10910.181736369645, 10967.42265567607, 11189.272697274651, 11233.640935403657, 7439.51643143194, 7523.473356865185, 7588.0, 7600.80997975055, 7663.348615367756, 10585.735356616146, 11148.278647498051, 11378.43107844621, 11399.316041037564, 11412.087033037504], "value": 9020.95124513722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.5750381126136, 1460.1458146984014, 1505.4053648808722, 1598.1529789211716, 1761.3923196497212, 7994.240547148019, 8860.778480537982, 8949.194572488483, 9085.909140908589, 9405.294602904776, 9141.77145571361, 9198.770030749234, 9227.538623068836, 9227.815443691123, 9256.25949924006, 2397.520495900818, 2409.325388891109, 2420.419099416145, 2437.597796363607, 2440.8169387295934, 2379.95240095198, 2380.3811009137576, 2434.2697190842764, 2441.4994926040117, 2441.7436169202156, 2368.905243790255, 2387.3315471667875, 2400.8595916939403, 2444.083468699238, 2445.755424457549, 2306.4810417656063, 2333.9066437342485, 2343.589871772433, 2347.6947996760396, 2359.315798418457, 2301.6432452969816, 2307.0, 2312.306308107561, 2317.1310758465575, 2330.918417855367, 9048.547572621343, 9177.219936305422, 9181.540922953825, 9195.448273103635, 9210.309226807949, 5270.789168433258, 5480.123180291134, 5481.972590137064, 5544.77820887168, 5548.805791797308, 3618.583862855779, 3624.4563315502623, 3676.4117741161285, 3691.630836916314, 3707.610700876423, 1241.596481143632, 1249.312877917142, 1260.7226410189744, 1287.7167023254963, 1291.6706239908858, 12755.36223188846, 12797.744045119045, 12839.0, 12847.972162227094, 12868.0, 4276.144771045741, 4510.458744950627, 4593.402857628554, 4646.744429056367, 4652.813887444464, 9980.45107519079, 9995.750106247257, 10002.499875006366, 10010.099091081838, 10022.799544009078, 5227.947720522822, 5283.630145889751, 5290.603204759658, 5290.9735451322495, 5294.8941021180135, 4284.507281662586, 4290.4636920384955, 4391.912161756747, 4507.616852567503, 4950.2822090796635, 3648.5804132524568, 3969.7221194516683, 4002.0995276062654, 4014.8394064237104, 4026.174634199982, 1187.1749134351714, 1207.088648070701, 1230.8215308780177, 1230.870758570355, 1234.4136535145913, 912.8630705394111, 917.1974522292994, 928.4290161550733, 932.7295084425576, 942.1002942190192, 5740.167675687002, 5940.70296485174, 5974.880502390015, 6241.96879015602, 6245.531585131133, 442.77197243419664, 450.79038247215203, 460.10050351562614, 460.42676867300423, 461.4554825306171, 3841.961580384216, 3921.215756848642, 3977.482927219443, 3988.4216788565495, 4071.0840060986043, 11206.887931120747, 11348.886511134948, 11401.48693308803, 11436.542538298374, 11443.25618834773, 10958.56165753361, 11268.718282043015, 11277.887221127849, 11296.491657875415, 11306.434678266218, 8473.95763021181, 8486.660533578712, 8507.0, 8508.872366914502, 8537.658493660309, 5794.159846822103, 5858.619189752652, 5891.882162356815, 5952.404759524013, 6048.879022419439, 10468.110210631878, 10510.527026283682, 10623.468826558486, 10643.680689579325, 10686.946565267124, 9619.951900240734, 10744.83882741775, 10973.670789876316, 10994.450277486254, 11008.559657613927, 6943.958406239105, 7305.561666300039, 7491.101067871672, 7577.393808495197, 7766.417518686008, 8580.75579041048, 8615.396922215385, 8654.524001179743, 8844.55777211124, 8909.821803564022, 7960.920390796018, 8041.879371809545, 8090.271875531231, 8174.182581741778, 8275.54484503358, 7887.0, 7940.126586075412, 7956.443048986515, 7972.202779721982, 8117.066537348281, 7024.051753013277, 7031.964840175767, 7052.2242553318065, 7071.575705457689, 7076.610786406797, 5059.924101138412, 5078.441371449064, 5158.613104017289, 5204.98502791952, 5234.267202591716, 5042.294078828893, 5213.661112027706, 5286.259923610774, 5289.47105289468, 5296.41739408657], "value": 4619.817645298462, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.3788876911406, 334.29130243882963, 336.2988169666246, 342.24022669673326, 342.42814499785356, 5000.7749651265685, 5099.266249475178, 5134.9743251283735, 5176.249443830647, 5216.895662086756, 5010.72441015744, 5104.545204616685, 5138.177891537355, 5141.177411614133, 5145.176771716526, 4092.877213683579, 4100.7334523255895, 4104.42538044674, 4121.216968775923, 4123.814378379456, 3908.355121404965, 4037.4953130858644, 4100.462326627515, 4106.815193316293, 4131.834726610932, 4006.1186538961383, 4011.277969965405, 4028.5769994150633, 4033.9394909076386, 4036.838526458953, 4013.6387725104883, 4017.6384125428704, 4021.879343619696, 4023.4568333275074, 4063.309237429644, 3459.8616055357757, 3589.3898037333456, 3593.1556084320164, 3593.5446144311595, 3624.3838547447, 5056.241563765428, 5067.5185857343495, 5070.518300761421, 5073.77168027436, 5075.974620126913, 4638.9072218555775, 4645.698029628097, 4657.301404789275, 4658.557437043475, 4669.463011753658, 5301.204819277101, 5341.359036915556, 5371.301730775013, 5378.520906750675, 5450.863728406782, 3898.161895192547, 3903.980480097581, 3907.628775266345, 3912.295786758411, 3924.6271604197555, 5576.525995290405, 5591.524720398771, 5606.318104568654, 5611.775528978836, 5620.5503559715125, 3897.61023897608, 3939.2712348215673, 3950.58518855516, 4016.979915100406, 4025.879223623296, 4000.1999600079516, 4002.959970400317, 4008.9599104008585, 4010.8796736097966, 4024.3359845625146, 4588.151192029485, 4593.150267200579, 4605.930911036337, 4608.953910460919, 4611.239145540948, 5272.261883336336, 5438.211459338374, 5440.700761458079, 5464.426235245322, 5474.260974768435, 1348.7928304167715, 1384.3562743324403, 1388.9027668142055, 1410.5063227870369, 1411.4142630808306, 868.5092922498768, 896.3949334199519, 898.6360523987795, 909.7680091576606, 913.584319134792, 4687.95312046882, 4706.0, 4716.103940251342, 4717.551832575899, 4722.7874745635845, 4835.500994691657, 4850.369451971292, 4877.488093631782, 4899.902001960012, 4904.950950490521, 4460.821567137343, 4611.400517932714, 4617.699849509839, 4646.3495110684535, 4660.883477913011, 2591.883365248568, 2595.832479879284, 2604.7785938195466, 2614.81026133109, 2618.7904967602544, 4987.17967941706, 5055.241713742895, 5060.418051924003, 5062.367204099488, 5087.97456012725, 4769.783705155232, 4928.926066109011, 4982.302477653131, 4991.5258050485145, 5001.674556242599, 5056.443791182894, 5064.797408103635, 5080.77136528857, 5082.2122571001555, 5111.182210846247, 4818.482178113883, 4827.034593081327, 4837.419509658864, 4852.902941941071, 4904.6321525886415, 4549.363089167453, 4796.472388037383, 4847.442544107473, 4848.684835485682, 4874.439439464507, 4975.776090075883, 4987.625928055338, 4988.201887697951, 5003.199488081889, 5033.874153146201, 3587.264610754841, 3748.100455890621, 3873.767573945572, 3899.8050097494443, 3979.1842672252697, 5458.099413596871, 5474.726263686879, 5485.50630443262, 5490.835274941758, 5490.929268792547, 5323.8287576733055, 5324.946750532445, 5325.840224793263, 5332.293666026834, 5352.895320714055, 5194.818181363634, 5298.97350513245, 5343.7862485500145, 5350.6254562180275, 5350.866228344167, 5289.338832645919, 5293.332600230915, 5295.338082739658, 5301.416844147064, 5304.7347632618985, 5189.844304670866, 5377.677339359651, 5386.48828361305, 5389.649672771257, 5399.244105825109, 5239.799284300527, 5247.317848679647, 5250.711210883438, 5255.947440525546, 5276.5251127398715], "value": 3986.0133096356412, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.3037126203117, 704.4153352717245, 706.4913262451037, 740.5445650924676, 744.8808190689489, 13273.867261327383, 14042.719145617082, 14055.0, 14110.3650335735, 14120.576382708523, 13200.273984930825, 13361.33193340334, 13375.933120334385, 13390.866091339083, 13404.396802143903, 771.4484143837155, 789.388224126301, 789.455275859655, 790.0992868130336, 791.216695471482, 793.1394437035823, 797.5414136871293, 799.580220384297, 801.4429971170039, 802.458340620082, 842.5744998775609, 844.1136806353335, 845.3533047218882, 845.4420082745389, 846.9618867150962, 833.729038062629, 836.7489753074053, 837.0165056059107, 837.8701301298339, 838.9119142490042, 623.0529595015596, 625.3933684326241, 625.5464788028688, 625.809128215894, 625.8435391152212, 13030.674233144153, 13044.41300141496, 13105.86894131056, 13156.934215328958, 13177.736445271137, 13455.461781528727, 14058.156510609293, 14145.151290922578, 14185.148891066568, 14205.36075876588, 11241.494132764044, 11475.885241147565, 11639.883601164049, 11656.184067115306, 11815.94092029543, 3714.164313029574, 3725.143217060064, 3737.719671024684, 3805.334066538345, 3814.694824414068, 84175.57912210461, 84578.57710711469, 85347.57326213391, 86103.99999999937, 87573.56213218893, 10631.0, 10660.413677247825, 10689.893101069045, 10846.511906964206, 10907.18196135293, 20828.062737176864, 20940.895295523424, 21021.159153633682, 21026.369208923756, 21116.0, 8020.0, 8119.188081191834, 8224.8355032899, 8257.710980115788, 8309.8338033239, 4596.10375976688, 4598.333241679938, 4711.623070154379, 4868.537488938545, 4874.147024270738, 3417.709494692929, 3559.1280136366754, 3559.982200089035, 3563.94654080189, 3566.6076731559506, 588.4556784973882, 588.8822235552907, 594.872102497965, 598.512212546773, 613.6747523812387, 592.7066102279399, 671.9462443004547, 676.2223443040542, 681.9454443644496, 749.3143773447234, 8850.380473366802, 9338.48638324885, 9344.66383404149, 9417.340786144903, 9485.193758530602, 575.4044563876367, 628.8710814283061, 644.8387903024244, 704.3660705365212, 708.9645517724197, 4423.181711383404, 4455.777211139495, 4491.124230774967, 4655.627549796008, 4726.692764970335, 98075.50962245143, 98788.50605746925, 125306.37346813208, 133472.0, 133517.3324133373, 65498.0, 96599.0, 103989.0, 105048.47475762572, 109057.0, 56629.0, 62302.37697623057, 76616.61691691617, 84289.57855210685, 84879.0, 9143.3599648024, 9430.82114735658, 9663.130318271109, 9744.12302892743, 9969.0, 50618.24072638987, 50768.49231507638, 51501.48498514967, 52948.20577691415, 53089.734551327, 59058.40941590529, 71901.28098718946, 72345.6382718083, 72377.63811180911, 72803.63598182188, 12293.692657683629, 12492.43784029739, 12553.560625378068, 12667.93666031664, 12879.356032198166, 13673.0, 13736.65658358549, 14015.439382424996, 14116.858831411555, 14365.13809171453, 13572.728545429234, 13642.795358069437, 13741.175529468264, 13759.587212383645, 14894.925525372304, 12935.61193164169, 13649.522266720616, 13782.65543361424, 14271.0, 14351.856481435052, 11821.763564728486, 13317.933410332886, 13619.65950851197, 14111.082779619292, 14242.857571424567, 9782.41305521671, 9915.405075695482, 10610.8938910613, 10882.129429645767, 11303.378314192469, 10599.47002649849, 11179.217454778087, 11507.769844602893, 11645.941770291094, 11658.242214256046], "value": 7321.741263450365, "unit": "score"}], "name": "dromaeo_css", "value": 7096.317878002958, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 112.0, 111.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 120.0, 169.0, 118.0, 119.0, 117.0, 120.0, 148.0, 123.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 76.0, 108.0, 78.0, 76.0, 76.0, 77.0, 114.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 123.0, 81.0, 82.0, 82.0, 99.0, 83.0, 81.0, 115.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 50.0, 52.0, 50.0, 53.0, 51.0, 52.0, 52.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 86.0, 81.0, 79.0, 79.0, 80.0, 80.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 135.0, 123.0, 124.0, 124.0, 133.0, 133.0, 123.0, 168.0, 123.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 164.0, 164.0, 168.0, 164.0, 165.0, 176.0, 161.0, 164.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 64.0, 64.0, 64.0, 68.0, 64.0, 64.0, 62.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1488.1000000000001, "alertThreshold": 2.0}]} 21:30:48 INFO - Return code: 0 21:30:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:30:48 INFO - # TBPL SUCCESS # 21:30:48 INFO - Running post-action listener: _resource_record_post_action 21:30:48 INFO - [mozharness: 2016-09-22 04:30:48.746181Z] Finished run-tests step (success) 21:30:48 INFO - Running post-run listener: _resource_record_post_run 21:30:48 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 403406848; Read time: 188; Write time: 289932 21:30:48 INFO - TinderboxPrint: CPU usage
13.1% 21:30:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 188 21:30:48 INFO - TinderboxPrint: I/O write bytes / time
403,406,848 / 289,932 21:30:48 INFO - TinderboxPrint: CPU idle
8,286.1 (86.9%) 21:30:48 INFO - TinderboxPrint: CPU user
1,196.1 (12.5%) 21:30:48 INFO - TinderboxPrint: Swap in / out
0 / 0 21:30:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114294784; Read time: 0; Write time: 68932 21:30:48 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287801344; Read time: 180; Write time: 220976 21:30:49 INFO - Running post-run listener: _upload_blobber_files 21:30:49 INFO - Blob upload gear active. 21:30:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:30:49 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 21:30:49 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:30:49 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:30:49 INFO - (blobuploader) - INFO - Open directory for files ... 21:30:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:30:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:30:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:30:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:30:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:30:50 INFO - (blobuploader) - INFO - Done attempting. 21:30:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:30:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:30:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:30:57 INFO - (blobuploader) - INFO - Done attempting. 21:30:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:30:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:30:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:30:58 INFO - (blobuploader) - INFO - Done attempting. 21:30:58 INFO - (blobuploader) - INFO - Iteration through files over. 21:30:58 INFO - Return code: 0 21:30:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:30:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:30:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c02052615b6bb32516685800762daee29e51360ac09e84187a70e2526eefbafa5bb2dbeac5a4a15e8d2069f7bf80f014380a1d99f24a907772116947c409ace7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9732d0605085e2f0c72422f38d543be2721b0829a98c7c77c033ef7a711b2101a61ff6136132aac9838cccb5d29f15bf8d0a10fa3ec71355ac704a2b657c89c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5959f4dec42bcf22ea773fd4277189f922ebda9f8e74131f0bec0ba849f22e45f8879c1c74363f4a8b19391477fe9680b96e5e27c8b81298f607ac2debbddb19"} 21:30:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:30:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:30:58 INFO - Contents: 21:30:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c02052615b6bb32516685800762daee29e51360ac09e84187a70e2526eefbafa5bb2dbeac5a4a15e8d2069f7bf80f014380a1d99f24a907772116947c409ace7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9732d0605085e2f0c72422f38d543be2721b0829a98c7c77c033ef7a711b2101a61ff6136132aac9838cccb5d29f15bf8d0a10fa3ec71355ac704a2b657c89c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5959f4dec42bcf22ea773fd4277189f922ebda9f8e74131f0bec0ba849f22e45f8879c1c74363f4a8b19391477fe9680b96e5e27c8b81298f607ac2debbddb19"} 21:30:58 INFO - Running post-run listener: copy_logs_to_upload_dir 21:30:58 INFO - Copying logs to upload dir... 21:30:58 INFO - mkdir: /builds/slave/test/build/upload/logs 21:30:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.815175 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-21 21:30:58.186785) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 21:30:58.190206) ========= 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=836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c02052615b6bb32516685800762daee29e51360ac09e84187a70e2526eefbafa5bb2dbeac5a4a15e8d2069f7bf80f014380a1d99f24a907772116947c409ace7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9732d0605085e2f0c72422f38d543be2721b0829a98c7c77c033ef7a711b2101a61ff6136132aac9838cccb5d29f15bf8d0a10fa3ec71355ac704a2b657c89c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5959f4dec42bcf22ea773fd4277189f922ebda9f8e74131f0bec0ba849f22e45f8879c1c74363f4a8b19391477fe9680b96e5e27c8b81298f607ac2debbddb19"} build_url:https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/VoxqX5HLQGmlXYTHS-SfKg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c02052615b6bb32516685800762daee29e51360ac09e84187a70e2526eefbafa5bb2dbeac5a4a15e8d2069f7bf80f014380a1d99f24a907772116947c409ace7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9732d0605085e2f0c72422f38d543be2721b0829a98c7c77c033ef7a711b2101a61ff6136132aac9838cccb5d29f15bf8d0a10fa3ec71355ac704a2b657c89c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5959f4dec42bcf22ea773fd4277189f922ebda9f8e74131f0bec0ba849f22e45f8879c1c74363f4a8b19391477fe9680b96e5e27c8b81298f607ac2debbddb19"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 21:30:58.215488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 21:30:58.215831) ========= 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=836cfdc75598d54cb747368e000001a9-1474517222.21655-1405392848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 21:30:58.265765) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 21:30:58.266075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 21:30:58.266383) ========= ========= Total master_lag: 0.32 =========