builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1481829844.18 results: success (0) buildid: 20161215103400 builduid: 7a8bac2f5e8b47058a6363a260d92020 revision: 74fa34df0a2531e47b997215b1699bf41ac47906 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:04.184662) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:04.185093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:04.185359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:04.218534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:04.218825) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 11:24:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2016-12-15 11:24:04 (43.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077967 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:04.310947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:04.311300) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013628 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:04.360437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:04.360753) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 74fa34df0a2531e47b997215b1699bf41ac47906 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 74fa34df0a2531e47b997215b1699bf41ac47906 --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=82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 11:24:04,720 truncating revision to first 12 chars 2016-12-15 11:24:04,720 Setting DEBUG logging. 2016-12-15 11:24:04,720 attempt 1/10 2016-12-15 11:24:04,720 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/74fa34df0a25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 11:24:05,075 unpacking tar archive at: graphics-74fa34df0a25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673181 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:05.046777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:05.047072) ========= script_repo_revision: 74fa34df0a2531e47b997215b1699bf41ac47906 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:05.047441) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:05.047705) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 11:24:05.057077) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-12-15 11:24:05.057445) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:05 INFO - MultiFileLogger online at 20161215 11:24:05 in /builds/slave/test 11:24:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 11:24:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:05 INFO - {'append_to_log': False, 11:24:05 INFO - 'base_work_dir': '/builds/slave/test', 11:24:05 INFO - 'blob_upload_branch': 'Graphics', 11:24:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:05 INFO - 'branch': 'Graphics', 11:24:05 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:05 INFO - 'config_files': ('talos/linux_config.py',), 11:24:05 INFO - 'default_actions': ('clobber', 11:24:05 INFO - 'read-buildbot-config', 11:24:05 INFO - 'download-and-extract', 11:24:05 INFO - 'populate-webroot', 11:24:05 INFO - 'create-virtualenv', 11:24:05 INFO - 'install', 11:24:05 INFO - 'run-tests'), 11:24:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:05 INFO - 'download_minidump_stackwalk': True, 11:24:05 INFO - 'download_symbols': 'ondemand', 11:24:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:05 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:05 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:05 INFO - 'installer_path': 'installer.exe', 11:24:05 INFO - 'log_level': 'info', 11:24:05 INFO - 'log_name': 'talos', 11:24:05 INFO - 'log_to_console': True, 11:24:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:05 INFO - 'opt_config_files': (), 11:24:05 INFO - 'pip_index': False, 11:24:05 INFO - 'sps_profile': False, 11:24:05 INFO - 'sps_profile_interval': 0, 11:24:05 INFO - 'suite': 'dromaeojs', 11:24:05 INFO - 'system_bits': '32', 11:24:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:05 INFO - 'title': 'talos-linux64-ix-066', 11:24:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:05 INFO - 'use_talos_json': True, 11:24:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:05 INFO - 'work_dir': 'build'} 11:24:05 INFO - [mozharness: 2016-12-15 19:24:05.517338Z] Running clobber step. 11:24:05 INFO - Running pre-action listener: _resource_record_pre_action 11:24:05 INFO - Running main action method: clobber 11:24:05 INFO - rmtree: /builds/slave/test/build 11:24:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:05 INFO - Running post-action listener: _resource_record_post_action 11:24:05 INFO - [mozharness: 2016-12-15 19:24:05.973570Z] Finished clobber step (success) 11:24:05 INFO - [mozharness: 2016-12-15 19:24:05.973670Z] Running read-buildbot-config step. 11:24:05 INFO - Running pre-action listener: _resource_record_pre_action 11:24:05 INFO - Running main action method: read_buildbot_config 11:24:05 INFO - Using buildbot properties: 11:24:05 INFO - { 11:24:05 INFO - "project": "", 11:24:05 INFO - "product": "firefox", 11:24:05 INFO - "script_repo_revision": "default", 11:24:05 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 11:24:05 INFO - "repository": "", 11:24:05 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 11:24:05 INFO - "buildid": "20161215103400", 11:24:05 INFO - "pgo_build": "False", 11:24:05 INFO - "basedir": "/builds/slave/test", 11:24:05 INFO - "buildnumber": 22, 11:24:05 INFO - "slavename": "talos-linux64-ix-066", 11:24:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:05 INFO - "platform": "ubuntu64_hw", 11:24:05 INFO - "scheduler": "tests-graphics-linux64-talos", 11:24:05 INFO - "branch": "graphics", 11:24:05 INFO - "repo_path": "projects/graphics", 11:24:05 INFO - "revision": "74fa34df0a2531e47b997215b1699bf41ac47906", 11:24:05 INFO - "stage_platform": "linux64", 11:24:05 INFO - "builduid": "7a8bac2f5e8b47058a6363a260d92020", 11:24:05 INFO - "slavebuilddir": "test" 11:24:05 INFO - } 11:24:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 11:24:05 INFO - Running post-action listener: _resource_record_post_action 11:24:05 INFO - [mozharness: 2016-12-15 19:24:05.976127Z] Finished read-buildbot-config step (success) 11:24:05 INFO - [mozharness: 2016-12-15 19:24:05.976216Z] Running download-and-extract step. 11:24:05 INFO - Running pre-action listener: _resource_record_pre_action 11:24:05 INFO - Running main action method: download_and_extract 11:24:05 INFO - mkdir: /builds/slave/test/build/tests 11:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:05 INFO - trying https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:24:05 INFO - Downloading https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:24:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:24:06 INFO - Downloaded 1361 bytes. 11:24:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:24:06 INFO - Using the following test package requirements: 11:24:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:24:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:24:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:24:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:06 INFO - u'jsshell-linux-x86_64.zip'], 11:24:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:24:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:24:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:24:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:24:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:24:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:24:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:24:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:24:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:06 INFO - Fetch https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:24:08 INFO - Expected file size: 20212885 11:24:08 INFO - Obtained file size: 20212885 11:24:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:24:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:24:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:12 INFO - Fetch https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:24:13 INFO - Expected file size: 20212885 11:24:13 INFO - Obtained file size: 20212885 11:24:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 11:24:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:24:17 INFO - Fetch https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:24:19 INFO - Expected file size: 14409734 11:24:19 INFO - Obtained file size: 14409734 11:24:19 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')]} 11:24:19 INFO - trying https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:24:19 INFO - Downloading https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:24:21 INFO - Downloaded 55635185 bytes. 11:24:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:24:21 INFO - mkdir: /builds/slave/test/properties 11:24:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:21 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:21 INFO - Contents: 11:24:21 INFO - build_url:https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:24:22 INFO - Running post-action listener: _resource_record_post_action 11:24:22 INFO - Running post-action listener: set_extra_try_arguments 11:24:22 INFO - [mozharness: 2016-12-15 19:24:22.733372Z] Finished download-and-extract step (success) 11:24:22 INFO - [mozharness: 2016-12-15 19:24:22.733598Z] Running populate-webroot step. 11:24:22 INFO - Running pre-action listener: _resource_record_pre_action 11:24:22 INFO - Running main action method: populate_webroot 11:24:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:22 INFO - '--tppagecycles', 11:24:22 INFO - '7'], 11:24:22 INFO - 'tests': ['tsvgm']}}, 11:24:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:24:22 INFO - 'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:24:22 INFO - 'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['damp', 'tps']}, 11:24:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:22 INFO - 'tests': ['damp', 'tps']}, 11:24:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['dromaeo_dom']}, 11:24:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['basic_compositor_video']}, 11:24:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:24:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['a11yr', 11:24:22 INFO - 'ts_paint', 11:24:22 INFO - 'tpaint', 11:24:22 INFO - 'sessionrestore', 11:24:22 INFO - 'sessionrestore_no_auto_restore', 11:24:22 INFO - 'tabpaint']}, 11:24:22 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:22 INFO - 'ts_paint', 11:24:22 INFO - 'tpaint', 11:24:22 INFO - 'sessionrestore', 11:24:22 INFO - 'sessionrestore_no_auto_restore', 11:24:22 INFO - 'tabpaint']}, 11:24:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:22 INFO - 'ts_paint', 11:24:22 INFO - 'tpaint', 11:24:22 INFO - 'sessionrestore', 11:24:22 INFO - 'sessionrestore_no_auto_restore', 11:24:22 INFO - 'tabpaint']}, 11:24:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:22 INFO - 'ts_paint', 11:24:22 INFO - 'tpaint', 11:24:22 INFO - 'sessionrestore', 11:24:22 INFO - 'sessionrestore_no_auto_restore', 11:24:22 INFO - 'tabpaint']}, 11:24:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['a11yr', 11:24:22 INFO - 'ts_paint', 11:24:22 INFO - 'tpaint', 11:24:22 INFO - 'sessionrestore', 11:24:22 INFO - 'sessionrestore_no_auto_restore', 11:24:22 INFO - 'tabpaint']}, 11:24:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['a11yr', 11:24:22 INFO - 'ts_paint', 11:24:22 INFO - 'tpaint', 11:24:22 INFO - 'sessionrestore', 11:24:22 INFO - 'sessionrestore_no_auto_restore', 11:24:22 INFO - 'tabpaint']}, 11:24:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['tsvgx', 11:24:22 INFO - 'tsvgr_opacity', 11:24:22 INFO - 'tart', 11:24:22 INFO - 'tscrollx', 11:24:22 INFO - 'cart', 11:24:22 INFO - 'tsvg_static']}, 11:24:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:22 INFO - 'tsvgr_opacity', 11:24:22 INFO - 'tart', 11:24:22 INFO - 'tscrollx', 11:24:22 INFO - 'cart', 11:24:22 INFO - 'tsvg_static']}, 11:24:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:24:22 INFO - 'talos_options': ['--disable-e10s'], 11:24:22 INFO - 'tests': ['tp5o']}, 11:24:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:24:22 INFO - 'talos_options': ['--disable-e10s', 11:24:22 INFO - '--xperf_path', 11:24:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:22 INFO - 'tests': ['tp5n']}, 11:24:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:22 INFO - 'talos_options': ['--xperf_path', 11:24:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:22 INFO - 'tests': ['tp5n']}}, 11:24:22 INFO - 'talos.zip': {'path': '', 11:24:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:22 INFO - Running post-action listener: _resource_record_post_action 11:24:22 INFO - [mozharness: 2016-12-15 19:24:22.754777Z] Finished populate-webroot step (success) 11:24:22 INFO - [mozharness: 2016-12-15 19:24:22.754866Z] Running create-virtualenv step. 11:24:22 INFO - Running pre-action listener: _resource_record_pre_action 11:24:22 INFO - Running main action method: create_virtualenv 11:24:22 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:22 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 11:24:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:22 INFO - Using real prefix '/usr' 11:24:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:23 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:25 INFO - Installing pip.................done. 11:24:25 INFO - Return code: 0 11:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:25 INFO - Reading from file tmpfile_stdout 11:24:25 INFO - Output received: 11:24:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:24:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:25 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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:25 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 11:24:25 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 11:24:25 INFO - Using env: {'DISPLAY': ':0', 11:24:25 INFO - 'HOME': '/home/cltbld', 11:24:25 INFO - 'LANG': 'en_US.UTF-8', 11:24:25 INFO - 'LANGUAGE': 'en_US:en', 11:24:25 INFO - 'LOGNAME': 'cltbld', 11:24:25 INFO - 'MAIL': '/var/mail/cltbld', 11:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:25 INFO - 'MOZ_NO_REMOTE': '1', 11:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:25 INFO - 'NO_EM_RESTART': '1', 11:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:25 INFO - 'PWD': '/builds/slave/test', 11:24:25 INFO - 'SHELL': '/bin/bash', 11:24:25 INFO - 'SHLVL': '1', 11:24:25 INFO - 'TERM': 'linux', 11:24:25 INFO - 'TMOUT': '86400', 11:24:25 INFO - 'USER': 'cltbld', 11:24:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:25 INFO - '_': '/tools/buildbot/bin/python'} 11:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:25 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 11:24:25 INFO - Cleaning up... 11:24:25 INFO - Return code: 0 11:24:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:25 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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:25 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 11:24:25 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 11:24:25 INFO - Using env: {'DISPLAY': ':0', 11:24:25 INFO - 'HOME': '/home/cltbld', 11:24:25 INFO - 'LANG': 'en_US.UTF-8', 11:24:25 INFO - 'LANGUAGE': 'en_US:en', 11:24:25 INFO - 'LOGNAME': 'cltbld', 11:24:25 INFO - 'MAIL': '/var/mail/cltbld', 11:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:25 INFO - 'MOZ_NO_REMOTE': '1', 11:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:25 INFO - 'NO_EM_RESTART': '1', 11:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:25 INFO - 'PWD': '/builds/slave/test', 11:24:25 INFO - 'SHELL': '/bin/bash', 11:24:25 INFO - 'SHLVL': '1', 11:24:25 INFO - 'TERM': 'linux', 11:24:25 INFO - 'TMOUT': '86400', 11:24:25 INFO - 'USER': 'cltbld', 11:24:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:25 INFO - '_': '/tools/buildbot/bin/python'} 11:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:26 INFO - Downloading/unpacking psutil>=3.1.1 11:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:28 INFO - Installing collected packages: psutil 11:24:28 INFO - Running setup.py install for psutil 11:24:28 INFO - building 'psutil._psutil_linux' extension 11:24:28 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 11:24:28 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 11:24:28 INFO - building 'psutil._psutil_posix' extension 11:24:28 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 11:24:28 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 11:24:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:28 INFO - Successfully installed psutil 11:24:28 INFO - Cleaning up... 11:24:28 INFO - Return code: 0 11:24:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:28 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')]} 11:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:28 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')]} 11:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:28 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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:28 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 11:24:28 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 11:24:28 INFO - Using env: {'DISPLAY': ':0', 11:24:28 INFO - 'HOME': '/home/cltbld', 11:24:28 INFO - 'LANG': 'en_US.UTF-8', 11:24:28 INFO - 'LANGUAGE': 'en_US:en', 11:24:28 INFO - 'LOGNAME': 'cltbld', 11:24:28 INFO - 'MAIL': '/var/mail/cltbld', 11:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:28 INFO - 'MOZ_NO_REMOTE': '1', 11:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:28 INFO - 'NO_EM_RESTART': '1', 11:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:28 INFO - 'PWD': '/builds/slave/test', 11:24:28 INFO - 'SHELL': '/bin/bash', 11:24:28 INFO - 'SHLVL': '1', 11:24:28 INFO - 'TERM': 'linux', 11:24:28 INFO - 'TMOUT': '86400', 11:24:28 INFO - 'USER': 'cltbld', 11:24:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:28 INFO - '_': '/tools/buildbot/bin/python'} 11:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:30 INFO - Installing collected packages: mozsystemmonitor 11:24:30 INFO - Running setup.py install for mozsystemmonitor 11:24:31 INFO - Successfully installed mozsystemmonitor 11:24:31 INFO - Cleaning up... 11:24:31 INFO - Return code: 0 11:24:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:31 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')]} 11:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:31 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')]} 11:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:31 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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:31 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 11:24:31 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 11:24:31 INFO - Using env: {'DISPLAY': ':0', 11:24:31 INFO - 'HOME': '/home/cltbld', 11:24:31 INFO - 'LANG': 'en_US.UTF-8', 11:24:31 INFO - 'LANGUAGE': 'en_US:en', 11:24:31 INFO - 'LOGNAME': 'cltbld', 11:24:31 INFO - 'MAIL': '/var/mail/cltbld', 11:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:31 INFO - 'MOZ_NO_REMOTE': '1', 11:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:31 INFO - 'NO_EM_RESTART': '1', 11:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:31 INFO - 'PWD': '/builds/slave/test', 11:24:31 INFO - 'SHELL': '/bin/bash', 11:24:31 INFO - 'SHLVL': '1', 11:24:31 INFO - 'TERM': 'linux', 11:24:31 INFO - 'TMOUT': '86400', 11:24:31 INFO - 'USER': 'cltbld', 11:24:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:31 INFO - '_': '/tools/buildbot/bin/python'} 11:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:31 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:31 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 11:24:31 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 11:24:31 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 11:24:31 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 11:24:31 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 11:24:31 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 11:24:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:33 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:33 INFO - warning: no files found matching '*.txt' 11:24:33 INFO - no previously-included directories found matching 'build' 11:24:33 INFO - no previously-included directories found matching 'dist' 11:24:33 INFO - no previously-included directories found matching '.git*' 11:24:33 INFO - Installing collected packages: jsonschema, functools32 11:24:33 INFO - Running setup.py install for functools32 11:24:33 INFO - warning: no files found matching '*.txt' 11:24:33 INFO - no previously-included directories found matching 'build' 11:24:33 INFO - no previously-included directories found matching 'dist' 11:24:33 INFO - no previously-included directories found matching '.git*' 11:24:33 INFO - Successfully installed jsonschema functools32 11:24:33 INFO - Cleaning up... 11:24:33 INFO - Return code: 0 11:24:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:24:33 INFO - Using env: {'DISPLAY': ':0', 11:24:33 INFO - 'HOME': '/home/cltbld', 11:24:33 INFO - 'LANG': 'en_US.UTF-8', 11:24:33 INFO - 'LANGUAGE': 'en_US:en', 11:24:33 INFO - 'LOGNAME': 'cltbld', 11:24:33 INFO - 'MAIL': '/var/mail/cltbld', 11:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:33 INFO - 'MOZ_NO_REMOTE': '1', 11:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:33 INFO - 'NO_EM_RESTART': '1', 11:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:33 INFO - 'PWD': '/builds/slave/test', 11:24:33 INFO - 'SHELL': '/bin/bash', 11:24:33 INFO - 'SHLVL': '1', 11:24:33 INFO - 'TERM': 'linux', 11:24:33 INFO - 'TMOUT': '86400', 11:24:33 INFO - 'USER': 'cltbld', 11:24:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:33 INFO - '_': '/tools/buildbot/bin/python'} 11:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:33 INFO - Cleaning up... 11:24:33 INFO - Return code: 0 11:24:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:24:33 INFO - Using env: {'DISPLAY': ':0', 11:24:33 INFO - 'HOME': '/home/cltbld', 11:24:33 INFO - 'LANG': 'en_US.UTF-8', 11:24:33 INFO - 'LANGUAGE': 'en_US:en', 11:24:33 INFO - 'LOGNAME': 'cltbld', 11:24:33 INFO - 'MAIL': '/var/mail/cltbld', 11:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:33 INFO - 'MOZ_NO_REMOTE': '1', 11:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:33 INFO - 'NO_EM_RESTART': '1', 11:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:33 INFO - 'PWD': '/builds/slave/test', 11:24:33 INFO - 'SHELL': '/bin/bash', 11:24:33 INFO - 'SHLVL': '1', 11:24:33 INFO - 'TERM': 'linux', 11:24:33 INFO - 'TMOUT': '86400', 11:24:33 INFO - 'USER': 'cltbld', 11:24:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:33 INFO - '_': '/tools/buildbot/bin/python'} 11:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:34 INFO - Downloading/unpacking blobuploader==1.2.4 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:36 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 11:24:36 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 11:24:36 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 11:24:36 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 11:24:36 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 11:24:36 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 11:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:36 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 11:24:36 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 11:24:36 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 11:24:36 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 11:24:36 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 11:24:36 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 11:24:36 INFO - Downloading docopt-0.6.1.tar.gz 11:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:36 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:36 INFO - Running setup.py install for blobuploader 11:24:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:37 INFO - Running setup.py install for requests 11:24:37 INFO - Running setup.py install for docopt 11:24:37 INFO - Successfully installed blobuploader requests docopt 11:24:37 INFO - Cleaning up... 11:24:37 INFO - Return code: 0 11:24:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:37 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 11:24:37 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 11:24:37 INFO - Using env: {'DISPLAY': ':0', 11:24:37 INFO - 'HOME': '/home/cltbld', 11:24:37 INFO - 'LANG': 'en_US.UTF-8', 11:24:37 INFO - 'LANGUAGE': 'en_US:en', 11:24:37 INFO - 'LOGNAME': 'cltbld', 11:24:37 INFO - 'MAIL': '/var/mail/cltbld', 11:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:37 INFO - 'MOZ_NO_REMOTE': '1', 11:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:37 INFO - 'NO_EM_RESTART': '1', 11:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:37 INFO - 'PWD': '/builds/slave/test', 11:24:37 INFO - 'SHELL': '/bin/bash', 11:24:37 INFO - 'SHLVL': '1', 11:24:37 INFO - 'TERM': 'linux', 11:24:37 INFO - 'TMOUT': '86400', 11:24:37 INFO - 'USER': 'cltbld', 11:24:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:37 INFO - '_': '/tools/buildbot/bin/python'} 11:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:37 INFO - Running setup.py (path:/tmp/pip-YzVMU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:37 INFO - Running setup.py (path:/tmp/pip-eBzRhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:37 INFO - Running setup.py (path:/tmp/pip-s1ehT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:37 INFO - Running setup.py (path:/tmp/pip-ZZHHO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:38 INFO - Running setup.py (path:/tmp/pip-rVskv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:38 INFO - Running setup.py (path:/tmp/pip-L4GFtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:38 INFO - Running setup.py (path:/tmp/pip-5LcbW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:38 INFO - Running setup.py (path:/tmp/pip-LuLneE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:38 INFO - Running setup.py (path:/tmp/pip-K8gAiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:38 INFO - Running setup.py (path:/tmp/pip-LoGgI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:38 INFO - Running setup.py (path:/tmp/pip-KAC51O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:38 INFO - Running setup.py (path:/tmp/pip-uNndlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:38 INFO - Running setup.py (path:/tmp/pip-OhFXoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:38 INFO - Running setup.py (path:/tmp/pip-ikkQDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:38 INFO - Running setup.py (path:/tmp/pip-6sQLVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:38 INFO - Running setup.py (path:/tmp/pip-G998id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:38 INFO - Running setup.py (path:/tmp/pip-XIiSTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:38 INFO - Running setup.py install for manifestparser 11:24:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Running setup.py install for mozcrash 11:24:39 INFO - Running setup.py install for mozdebug 11:24:39 INFO - Running setup.py install for mozdevice 11:24:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Running setup.py install for mozfile 11:24:39 INFO - Running setup.py install for mozhttpd 11:24:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Running setup.py install for mozinfo 11:24:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Running setup.py install for mozInstall 11:24:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Running setup.py install for mozleak 11:24:39 INFO - Running setup.py install for mozlog 11:24:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:39 INFO - Running setup.py install for moznetwork 11:24:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:40 INFO - Running setup.py install for mozprocess 11:24:40 INFO - Running setup.py install for mozprofile 11:24:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:40 INFO - Running setup.py install for mozrunner 11:24:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:40 INFO - Running setup.py install for mozscreenshot 11:24:40 INFO - Running setup.py install for moztest 11:24:40 INFO - Running setup.py install for mozversion 11:24:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:40 INFO - Cleaning up... 11:24:40 INFO - Return code: 0 11:24:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:40 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')]} 11:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:40 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')]} 11:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:40 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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:40 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 11:24:40 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 11:24:40 INFO - Using env: {'DISPLAY': ':0', 11:24:40 INFO - 'HOME': '/home/cltbld', 11:24:40 INFO - 'LANG': 'en_US.UTF-8', 11:24:40 INFO - 'LANGUAGE': 'en_US:en', 11:24:40 INFO - 'LOGNAME': 'cltbld', 11:24:40 INFO - 'MAIL': '/var/mail/cltbld', 11:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:40 INFO - 'MOZ_NO_REMOTE': '1', 11:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:40 INFO - 'NO_EM_RESTART': '1', 11:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:40 INFO - 'PWD': '/builds/slave/test', 11:24:40 INFO - 'SHELL': '/bin/bash', 11:24:40 INFO - 'SHLVL': '1', 11:24:40 INFO - 'TERM': 'linux', 11:24:40 INFO - 'TMOUT': '86400', 11:24:40 INFO - 'USER': 'cltbld', 11:24:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:40 INFO - '_': '/tools/buildbot/bin/python'} 11:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:41 INFO - Running setup.py (path:/tmp/pip-Ar7zvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:41 INFO - Running setup.py (path:/tmp/pip-AMwrtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:41 INFO - Running setup.py (path:/tmp/pip-0YnClS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:41 INFO - Running setup.py (path:/tmp/pip-zsNQ_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:41 INFO - Running setup.py (path:/tmp/pip-ZELkZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:41 INFO - Running setup.py (path:/tmp/pip-6OIyXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:41 INFO - Running setup.py (path:/tmp/pip-LfDz3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:41 INFO - Running setup.py (path:/tmp/pip-PETdnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:41 INFO - Running setup.py (path:/tmp/pip-IPMrv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:41 INFO - Running setup.py (path:/tmp/pip-dQslBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:41 INFO - Running setup.py (path:/tmp/pip-C7R25U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:41 INFO - Running setup.py (path:/tmp/pip-wUVaDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:41 INFO - Running setup.py (path:/tmp/pip-RB8q8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:41 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)) 11:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:41 INFO - Running setup.py (path:/tmp/pip-eMK3mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:42 INFO - Running setup.py (path:/tmp/pip-C3nXee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:42 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)) 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:42 INFO - Running setup.py (path:/tmp/pip-DMLJ3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:42 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)) 11:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:42 INFO - Running setup.py (path:/tmp/pip-jvsj9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:42 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)) 11:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:42 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)) 11:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:44 INFO - Downloading blessings-1.6.tar.gz 11:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:44 INFO - Installing collected packages: blessings 11:24:44 INFO - Running setup.py install for blessings 11:24:44 INFO - Successfully installed blessings 11:24:44 INFO - Cleaning up... 11:24:44 INFO - Return code: 0 11:24:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:44 INFO - Reading from file tmpfile_stdout 11:24:44 INFO - Current package versions: 11:24:44 INFO - argparse == 1.2.1 11:24:44 INFO - blessings == 1.6 11:24:44 INFO - blobuploader == 1.2.4 11:24:44 INFO - docopt == 0.6.1 11:24:44 INFO - functools32 == 3.2.3-2 11:24:44 INFO - jsonschema == 2.5.1 11:24:44 INFO - manifestparser == 1.1 11:24:44 INFO - mozInstall == 1.12 11:24:44 INFO - mozcrash == 1.0 11:24:44 INFO - mozdebug == 0.1 11:24:44 INFO - mozdevice == 0.49 11:24:44 INFO - mozfile == 1.2 11:24:44 INFO - mozhttpd == 0.7 11:24:44 INFO - mozinfo == 0.9 11:24:44 INFO - mozleak == 0.1 11:24:44 INFO - mozlog == 3.4 11:24:44 INFO - moznetwork == 0.27 11:24:44 INFO - mozprocess == 0.23 11:24:44 INFO - mozprofile == 0.28 11:24:44 INFO - mozrunner == 6.13 11:24:44 INFO - mozscreenshot == 0.1 11:24:44 INFO - mozsystemmonitor == 0.3 11:24:44 INFO - moztest == 0.7 11:24:44 INFO - mozversion == 1.4 11:24:44 INFO - psutil == 3.1.1 11:24:44 INFO - requests == 1.2.3 11:24:44 INFO - wsgiref == 0.1.2 11:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:44 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')]} 11:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:44 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')]} 11:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:44 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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:44 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 11:24:44 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 11:24:44 INFO - Using env: {'DISPLAY': ':0', 11:24:44 INFO - 'HOME': '/home/cltbld', 11:24:44 INFO - 'LANG': 'en_US.UTF-8', 11:24:44 INFO - 'LANGUAGE': 'en_US:en', 11:24:44 INFO - 'LOGNAME': 'cltbld', 11:24:44 INFO - 'MAIL': '/var/mail/cltbld', 11:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:44 INFO - 'MOZ_NO_REMOTE': '1', 11:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:44 INFO - 'NO_EM_RESTART': '1', 11:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:44 INFO - 'PWD': '/builds/slave/test', 11:24:44 INFO - 'SHELL': '/bin/bash', 11:24:44 INFO - 'SHLVL': '1', 11:24:44 INFO - 'TERM': 'linux', 11:24:44 INFO - 'TMOUT': '86400', 11:24:44 INFO - 'USER': 'cltbld', 11:24:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:44 INFO - '_': '/tools/buildbot/bin/python'} 11:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 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)) 11:24:45 INFO - Cleaning up... 11:24:45 INFO - Return code: 0 11:24:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:45 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 0x7f9641be4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', '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 11:24:45 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 11:24:45 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 11:24:45 INFO - Using env: {'DISPLAY': ':0', 11:24:45 INFO - 'HOME': '/home/cltbld', 11:24:45 INFO - 'LANG': 'en_US.UTF-8', 11:24:45 INFO - 'LANGUAGE': 'en_US:en', 11:24:45 INFO - 'LOGNAME': 'cltbld', 11:24:45 INFO - 'MAIL': '/var/mail/cltbld', 11:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:45 INFO - 'MOZ_NO_REMOTE': '1', 11:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:45 INFO - 'NO_EM_RESTART': '1', 11:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:45 INFO - 'PWD': '/builds/slave/test', 11:24:45 INFO - 'SHELL': '/bin/bash', 11:24:45 INFO - 'SHLVL': '1', 11:24:45 INFO - 'TERM': 'linux', 11:24:45 INFO - 'TMOUT': '86400', 11:24:45 INFO - 'USER': 'cltbld', 11:24:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:45 INFO - '_': '/tools/buildbot/bin/python'} 11:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:45 INFO - Cleaning up... 11:24:45 INFO - Return code: 0 11:24:45 INFO - Running post-action listener: _resource_record_post_action 11:24:45 INFO - Running post-action listener: _start_resource_monitoring 11:24:45 INFO - Starting resource monitoring. 11:24:45 INFO - [mozharness: 2016-12-15 19:24:45.323245Z] Finished create-virtualenv step (success) 11:24:45 INFO - [mozharness: 2016-12-15 19:24:45.323769Z] Running install step. 11:24:45 INFO - Running pre-action listener: _resource_record_pre_action 11:24:45 INFO - Running main action method: install 11:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:45 INFO - Reading from file tmpfile_stdout 11:24:45 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:45 INFO - Reading from file tmpfile_stdout 11:24:45 INFO - Output received: 11:24:45 INFO - Usage: mozinstall [options] installer 11:24:45 INFO - Options: 11:24:45 INFO - -h, --help show this help message and exit 11:24:45 INFO - -d DEST, --destination=DEST 11:24:45 INFO - Directory to install application into. [default: 11:24:45 INFO - "/builds/slave/test"] 11:24:45 INFO - --app=APP Application being installed. [default: firefox] 11:24:45 INFO - mkdir: /builds/slave/test/build/application 11:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:25:01 INFO - Reading from file tmpfile_stdout 11:25:01 INFO - Output received: 11:25:01 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:01 INFO - Running post-action listener: _resource_record_post_action 11:25:01 INFO - [mozharness: 2016-12-15 19:25:01.655867Z] Finished install step (success) 11:25:01 INFO - [mozharness: 2016-12-15 19:25:01.656108Z] Running run-tests step. 11:25:01 INFO - Running pre-action listener: _resource_record_pre_action 11:25:01 INFO - Running main action method: run_tests 11:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:01 INFO - Python 2.7.3 11:25:01 INFO - Return code: 0 11:25:01 INFO - grabbing minidump binary from tooltool 11:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:01 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 0x1914f20>, '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 0x1881c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:01 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 11:25:01 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 11:25:01 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 11:25:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:01 INFO - Return code: 0 11:25:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 11:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 11:25:01 INFO - Using env: {'DISPLAY': ':0', 11:25:01 INFO - 'HOME': '/home/cltbld', 11:25:01 INFO - 'LANG': 'en_US.UTF-8', 11:25:01 INFO - 'LANGUAGE': 'en_US:en', 11:25:01 INFO - 'LOGNAME': 'cltbld', 11:25:01 INFO - 'MAIL': '/var/mail/cltbld', 11:25:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:01 INFO - 'MOZ_NO_REMOTE': '1', 11:25:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:01 INFO - 'NO_EM_RESTART': '1', 11:25:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:01 INFO - 'PWD': '/builds/slave/test', 11:25:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:01 INFO - 'SHELL': '/bin/bash', 11:25:01 INFO - 'SHLVL': '1', 11:25:01 INFO - 'TERM': 'linux', 11:25:01 INFO - 'TMOUT': '86400', 11:25:01 INFO - 'USER': 'cltbld', 11:25:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320', 11:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:01 INFO - '_': '/tools/buildbot/bin/python'} 11:25:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 11:25:01 INFO - mozversion application_buildid: 20161215103400 11:25:01 INFO - mozversion application_changeset: 74fa34df0a2531e47b997215b1699bf41ac47906 11:25:01 INFO - mozversion application_display_name: Nightly 11:25:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:01 INFO - mozversion application_name: Firefox 11:25:01 INFO - mozversion application_remotingname: firefox 11:25:01 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 11:25:01 INFO - mozversion application_vendor: Mozilla 11:25:01 INFO - mozversion application_version: 53.0a1 11:25:01 INFO - mozversion platform_buildid: 20161215103400 11:25:01 INFO - mozversion platform_changeset: 74fa34df0a2531e47b997215b1699bf41ac47906 11:25:01 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 11:25:01 INFO - mozversion platform_version: 53.0a1 11:25:01 INFO - using testdate: 1481829901 11:25:01 INFO - actual date: 1481829901 11:25:01 INFO - starting webserver on 'localhost:47870' 11:25:01 INFO - SUITE-START | Running 2 tests 11:25:01 INFO - TEST-START | dromaeo_css 11:25:01 INFO - operating with platform_type : linux_ 11:25:01 INFO - Initialising browser for dromaeo_css test... 11:25:01 INFO - TEST-INFO | started process 21939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_msil7/profile http://localhost:47870/getInfo.html) 11:25:06 INFO - PROCESS | 21939 | __metrics Screen width/height:1600/1200 11:25:06 INFO - PROCESS | 21939 | colorDepth:24 11:25:06 INFO - PROCESS | 21939 | Browser inner width/height: 1024/697 11:25:06 INFO - PROCESS | 21939 | __metrics 11:25:07 INFO - PROCESS | 21939 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:07 INFO - PROCESS | 21939 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:07 INFO - PROCESS | 21939 | console.error: PushService: 11:25:07 INFO - PROCESS | 21939 | stateChangeProcessEnqueue: Error transitioning state 11:25:07 INFO - PROCESS | 21939 | UnknownError 11:25:08 INFO - TEST-INFO | 21939: exit 0 11:25:08 INFO - Browser initialized. 11:25:08 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:08 INFO - TEST-INFO | started process 22022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_msil7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:20 INFO - PROCESS | 22022 | RSS: Main: 174026752 11:25:20 INFO - PROCESS | 22022 | 11:26:12 INFO - PROCESS | 22022 | 1481829972639 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] 11:28:25 INFO - PROCESS | 22022 | Cycle 1(1): loaded http://localhost:47870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47870/tests/dromaeo/cssquery-ext.html) 11:28:27 INFO - PROCESS | 22022 | RSS: Main: 287399936 11:28:27 INFO - PROCESS | 22022 | 11:31:30 INFO - PROCESS | 22022 | Cycle 1(1): loaded http://localhost:47870/tests/dromaeo/cssquery-ext.html (next: http://localhost:47870/tests/dromaeo/cssquery-jquery.html) 11:31:30 INFO - PROCESS | 22022 | RSS: Main: 272359424 11:31:30 INFO - PROCESS | 22022 | 11:34:32 INFO - PROCESS | 22022 | Cycle 1(1): loaded http://localhost:47870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47870/tests/dromaeo/cssquery-mootools.html) 11:34:33 INFO - PROCESS | 22022 | RSS: Main: 252121088 11:34:33 INFO - PROCESS | 22022 | 11:37:35 INFO - PROCESS | 22022 | Cycle 1(1): loaded http://localhost:47870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47870/tests/dromaeo/cssquery-prototype.html) 11:37:36 INFO - PROCESS | 22022 | RSS: Main: 219611136 11:37:36 INFO - PROCESS | 22022 | 11:40:39 INFO - PROCESS | 22022 | Cycle 1(1): loaded http://localhost:47870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47870/tests/dromaeo/cssquery-yui.html) 11:40:40 INFO - PROCESS | 22022 | RSS: Main: 220127232 11:40:40 INFO - PROCESS | 22022 | 11:43:43 INFO - PROCESS | 22022 | Cycle 1(1): loaded http://localhost:47870/tests/dromaeo/cssquery-yui.html (next: http://localhost:47870/tests/dromaeo/cssquery-dojo.html) 11:43:43 INFO - PROCESS | 22022 | RSS: Main: 318386176 11:43:43 INFO - PROCESS | 22022 | 11:43:43 INFO - PROCESS | 22022 | __start_tp_report 11:43:43 INFO - PROCESS | 22022 | _x_x_mozilla_page_load 11:43:43 INFO - PROCESS | 22022 | _x_x_mozilla_page_load_details 11:43:43 INFO - PROCESS | 22022 | |i|pagename|runs| 11:43:43 INFO - PROCESS | 22022 | |0;dojo.html;2528.721840597534;2548.8470691758484;2572.7041390240124;2580.3162162027065;2580.9225723228296;4450.621697155746;4481.529439408864;4541.364209010737;4541.500434952157;4554.2940844169125;4509.368688383621;4547.18150732868;4555.20283950309;4572.039871626962;4615.1000554891725;4190.664746820263;4204;4247.638950689196;4267.786610669454;4322.610965013148;3927.8136884950013;4240.936385954213;4249.936250956238;4290.914181716364;4339.848105316315;4167.624913757746;4186.6859985500905;4284.271673815428;4327.502337231227;4372.956270437287;4150.169966006781;4239.1521695660995;4241.1941731071;4241.384999175102;4242.3212286034395;4172;4177.206330797169;4177.997280652652;4233.767142807144;4234.640055595278;4527.343535187412;4553.886152846172;4562.384078149441;4583.129205450954;4610.308453731934;4728.66899317048;4771.665983381165;4865.683730557538;4874.561289483963;4876.171050921352;4813.927791083137;4885.2427873679635;4925.630577706651;4930.4330002049865;4986.650934434591;4601.401817763669;4604.40142781443;4607.378003969488;4607.44710634726;4646.163690535736;5031.773570189277;5032.974835125874;5039.974800125976;5043.672161309503;5092.567131793839;4705.058988202305;4731.432228132646;4735.195016847144;4781.187198176319;4796.184648609745;4913.385826771653;4914.066327397854;4917.0903382874285;4951.579115775199;4955.479674634112;4834.685745426536;4863.392075990501;4865.32322426173;4888.755562221874;4915.606751459874;4722.598579120813;4757.643176761757;4759.643026773006;4854.150523658416;4864.805407783649;4187;4219.578042195756;4221.831126754957;4225.514065882463;4276.465441819772;3696.6857817085847;3697.352963231424;3697.9445308320396;3714.9628503715157;3732.0483276764253;4157.91684166321;4193.559676233952;4196.244675958295;4201.243776120266;4215.156968606291;4830.951690483121;4843.0313937212695;4850.078485087822;4880.048390563877;4912.803487860446;4232.619064284229;4236.5128010278595;4237.258479766028;4262.829486820555;4271.487421509377;4467;4472.79872405736;4475.082608065339;4477.597016268552;4521.79651915658;4425.933610995773;4442.711223770574;4443.422355093817;4542.318652202196;4631.421072365954;4873.634477414137;4912.459629440687;4916.06594746997;4960.751962401793;4967.528084831935;4550.7952142154345;4586.197415452216;4589.426321709786;4590.311453282035;4630.86107416778;4733.219018861849;4759.69062010982;4839.612830973584;4842.15262329098;4873.7806798694855;4872.6832755870755;4910.165271903714;4914.827981020647;4945.109880221595;4993.525615066563;4728.219843725747;4804.495527969652;4814.807407703653;4817.494163112823;4860.149473842134;4632.281996290446;4648.488666246642;4812.181929072136;4818.494058123846;4861.1006963711825;4691.249400095969;4712.128256272601;4739.573438390561;4747.2879068140055;4798.904021919612;4863.562279394871;4869.756512174448;4870.0746858096845;4875.7074575525585;4919.877003074952;4602.148602508547;4768.189407800752;4769.379980602499;4771.093492236464;4818.084563932842 11:43:43 INFO - PROCESS | 22022 | |1;ext.html;528.294726540069;538.4588488568987;538.6660270632209;540.8999335123005;555.3752028967411;28047.03670743049;38873.22253554927;40016.59983400169;40083.799581002124;43468.130637387316;40832.183356332855;41392;41397;41405.7929710351;41445.58554414455;7306.817329566777;7521.623918804052;7693.038370203724;7703.46075774696;7720.073591169067;7266.672999715025;9789.21686265097;10011.399316041025;10019.799604007916;10360.792784144312;9557.522123893812;9593.136617704406;9596.520173991308;9599.232061435103;9600.80798384032;9929.751756206117;10002.39985600859;10003.699889003341;10008.699739007841;10023.749406264866;9905.950470247675;9962.203023758082;9978.201743860547;9982.151517121054;9993;38036;38338.61661383379;38376;38432.61567384318;38445.80777096125;2997.8800847966054;3042.7717921156;3112.4708799504137;3183.458812001942;3356.5133055706788;27344;28083;28123.718762812314;28143.155705328874;28200.294992625142;3184.7292481746413;3259.0222933119967;3287.293231955141;3385.6952874241438;3395.1851555626718;241891;242235.99999999822;242392;243193;244339;51324;51539.74230128901;51546.22680659793;51575.226371604454;51652;49882.75058624684;49967.75016124896;49993.50084488993;50011;50049.49950500448;13841.653958651113;14060.789088163685;14064.929675351557;14072.085314454527;14078;9676.467794271242;9950.552225149886;10455.268131230741;10675.786484270271;10731.302465339728;16417.425390111526;17050.829491704924;17180.22688978999;17226.741598876026;17253.32573451117;5650.519705824969;5798.565107616945;5824.912626310609;5828;5859.355470898197;779.6491578789568;854.4061876995429;873.9694110706095;895.7312806158127;1031.5358088859894;24728;26344.209673709818;26504.204873853814;26675.733242667713;28396.290092747848;883.1212943121635;914.4696076275744;917.7934964632905;943.6649989253854;963.9710808675751;12924;13409;13433;13500.662483437993;13529.323533823466;338885;341510;341729;341926;342090;42474.36288455676;42655.36016959748;42717.78641106775;42718;42718.57281427208;1155.7457359380755;1177.087756988341;1188.0970462448602;1202.1644956755147;1203.4764877278412;23267;23805.64291535663;24210.15264465735;24397.63403548984;24747.50504989926;35395.64604353924;35868;35873.64126358703;35900;36271.27457450889;306496;308309;308728;308888;309369;20491;21072.15711371528;22477.887610561844;22706.205282815023;23252.53494930058;33560;35268.47097293594;35650.8217458911;35702.28595428129;36311.636883630825;30549.694503055573;30787;31118.533222001235;31958.68041319557;32274.515882261316;30408.5438718415;31220.68779312178;31590.684093159693;31590.842045789625;32274.35451291008;30585.694143058285;30671.693283066885;30780.692193077783;31710.365792683555;31804.204894877814;26543.805528750865;28074.157775266776;28184.29539261535;28419.43161136807;28773.42453150967;21744.846997185636;22212.222572209896;22895.084196632615;22943.311700649007;23141.76858231396 11:43:43 INFO - PROCESS | 22022 | |2;jquery.html;337.1369294605808;351.94192958161904;358.7237826873307;359.9388104022317;383.3942371053735;12301.876981230185;15372;15785.210739463038;16235.26941287642;17415.82584174158;13818.65453363664;14009.229492377915;14927.477538286163;16028;16175;4101.26177288088;4350.064736081742;4944.332515110459;5171.405288391846;5183.559397451221;4996.675216110959;5036.647434679574;5081.28861959326;5086.567641750456;5088.847334579968;4817.614590832725;5058.064258112243;5063.443021267658;5064.924026139611;5067.087924173666;4967.776450059756;5026.999999999982;5079.136546787018;5080.187170052811;5088.363954505687;4334.284843000901;4547.408836851221;4547.590716835468;4550.954490455119;4551.840685575989;19277.614447710966;19648.01759912013;19884.304049358347;20039.398818035483;20053.699194512094;1715.579682977666;1854.4436668999247;1915.3200613782046;1967.9311224107087;2540.16174662361;7937.761867143995;8284.130166332568;8667.17661822126;8741.868871966926;8829.779255518599;1685.241641261425;1698.8046374666949;1699.6600679863952;1715.9914200428918;1734.5316764473648;60925;63032;63077.36922630761;63395.6830215846;64666;9680.612775489042;9684.51577421126;9755.415374318944;9940.602375905028;9943.751406214758;13434.596962091153;13442;13511.391987360395;13533.66165845842;13544.86455135436;6912.377885990285;7035.366816986496;7197.748078817216;7272.854542909112;7281.417486601059;6759.662016899136;6809.148856392951;6921.688524016431;6956.165260168812;6986.650667466606;3964.980175099106;4050.3316952702476;4177.26897792885;4307.138572285556;4370.278903980808;1762.4712586224082;1765.6910040742819;1805.6840052990938;1856.935007274766;1877.1740434208905;825.1707034430359;835.0814104485017;839;842.4103127810557;895.3106108296575;15575.454859080104;16848.494545163663;17178.1410929453;17271.481855544353;17347.826521734874;801.8276070644723;812.6993012585381;870.525563567857;897.8249241397865;906.664534122379;9069.183773460289;9284.767880803034;9512.1439070484;9551.188149007274;9709.36889102206;340203;343318;344966;346376;357458;71345;75749;76782;78232.2176778225;78384.2161578377;840.6217202259008;870.090755160871;872.376250980552;873.6461732998146;873.785922449004;14734.926325368304;14801.777973330194;14903.552893413214;14909.254537272876;15554.455594054154;32842.17894552655;35341.469877951335;35480;35632.28735425329;35640.643593563735;45138.322925155495;48054.5194548064;48978;50621.493785063154;51169.744151279;7100.964495177491;7347.889781653173;7359.484836061424;7440.107187137578;7670.232976702285;10968.122550195805;11651.88348116508;11890.643280701594;12036.699082522657;12413.131080824256;9938.354006989523;10147.289689721649;10342.276040677081;10697.465126743788;10802.243842930919;10436.165106791286;10464.738381540523;10564.947175264075;10661.680149595524;10788.352698838095;10499.79000419972;10617.203709721956;10644.520996555328;10803.189760767817;11106.722331941766;7396.445266605134;7418.332350088518;7489.213632568501;7558.546487210785;7680.6543705534505;10193.337433066827;10526.157907367238;10586.8411973822;10827.296225745302;11209.327440353605 11:43:43 INFO - PROCESS | 22022 | |3;mootools.html;1225.779359715252;1306.1118439461166;1327.9800802987957;1381.841088274848;1644.457329081404;5784.421557844214;6277.089821975816;6550;6566.1464009678675;6728.629925354116;6563.212414510253;6617.073609694647;6620.6358650274215;6622.4370928471135;6633.734650613982;1773.9379121730742;1994.8204661580419;2023.3221870673342;2029.4317591074448;2031.2281333093404;1815.4553633909775;1833.3308342454975;1834.7889992650883;1835.5227640813418;1992.511834600525;2006.8193862552369;2018.7173795668618;2026.0983862181336;2026.9189232430685;2027.5032617008853;1939.0401751133209;1940.689489681644;1946.5717542140706;1946.902654867251;1949.093671442786;1935.6128774245208;1973.980260197394;1990.7013947907785;1991.332903477337;1993.362124120282;6474.935250647481;6516.57642253252;6530.183727034121;6534.93465065348;6535.313792051861;3935.7048221383225;4082.2447847148374;4082.6937979651643;4085.3259212229946;4087.8364865405347;2610.582306830917;2707.323169207698;2774.250952242883;2783.8886444542195;2788.7490125888767;793.9722109726132;818.2431251092715;845.9280961118312;870.7997160653085;871.7384784564669;8567.871481927776;8569.742907712778;8593.570321483901;8594.312455003585;8602.09677983809;3536.522569453091;3711.7216208783907;3717.70258379329;3756.38019726742;3765.378712512405;7308.123025237006;7318.048653675095;7318.707251709979;7322.707091716378;7324.597147156957;4063.065494936181;4101.118259574206;4139.2135494256;4149.294619914622;4149.958500415018;3679.466477360768;3811.9047023824073;3815.713821463346;3816.332141875216;3823.1971286030243;2901.4632293025857;2990.5065664165604;3013.9246518836767;3194.440972829792;3209.791363561361;990.1138481059412;1003.7841863999275;1009.7929924365487;1068.8076146293743;1112.67732357617;694.5277211496231;832.1553623072587;840.6511297811462;845.7758693946109;856.2379482260793;4553.408056952641;4568.680192386501;4600.5169457207185;4684.508126646721;4756.096341695067;793.8452001859697;794.7258195922398;800.543690096651;827.5986146718836;866.250693150433;3110.3623757130185;3236.110069730843;3296.538484612156;3308.8345582720767;3450.9827450863086;7418.740344087931;7786.1435242123325;7791.0650721913735;7796.610169491502;7826.1391246962785;6775.525713200029;7072.504924655224;7133.179684336264;7350.742724004741;7764.262395072459;5983.461488466059;6082.878342433215;6088.36072212429;6089.725962331706;6092.208012958287;4635.490096089495;4750.952490475051;4758.476567577494;4827.927581086216;4999.67502112376;6869.4543727660875;6918.965405173143;7020.719171233093;7025.402840758593;7051.365377116084;7141.571505709674;7141.607211603204;7146.142462904277;7150.392216661642;7168;5396.0556902542685;5459.808906688247;5459.836204913859;5465;5466.508014278734;6130.785422510191;6197.070439434121;6198.101275315144;6205.6586887721605;6205.81382558524;5632.098864181875;5688.3742788294085;5805.564582656402;5901.704914754159;5903.026000709835;5651.745671444877;5698.1737648041635;5709.3719690834805;5715.685637289989;5718.056520674042;5186.092433824141;5221.660592061504;5262.552683021833;5263.763130659053;5270.683758974474;3924.646781789653;3953.8418463262296;4010.899727506719;4022.175454031858;4113.25961326964;3953.6244056814558;4000.599940005976;4034.697397695126;4096.959030409657;4116.341385378325 11:43:43 INFO - PROCESS | 22022 | |4;prototype.html;310.91449851290895;323.6375259709125;326.9199046233673;328.3793630039225;334.3263324401331;4713.2694432363;4764.285357196422;4779.091972525218;4782.306565547998;4788.497207793183;4452.755098469591;4679.719216846992;4722.91372984213;4723.055388922212;4724.503927087658;3646.7629604075782;3652.8721494747624;3735;3753.887383378503;3762.51087358643;3737.7009839212797;3747.9625203747887;3754.9624503754885;3760.135168911152;3766.491523644314;3532.9116772080647;3723.292574410867;3727.589965103836;3729.4219395993664;3735.9626403736024;3602.0994751312173;3620.149264922741;3711.9443208351895;3717.847467285123;3732.533433320835;3340.4321265384942;3349.882754103619;3352.7485438592203;3362.7477939154414;3364.5626068610923;4567.680262381635;4575.4738205106505;4583;4597.678162528624;4615.492295847454;4152.8131234094535;4248.129133527619;4261.21167583998;4273.87178384649;4278.42241297424;4851.56335929768;4886.633502487328;4892.434420985286;4913.336699545587;4917.803287868481;3633.5276414066;3635.291118231946;3636.563612366533;3639.854405823764;3640.7269454791;4872.3909511311085;5128.871778205537;5134.743262836843;5134.871628209287;5144.4083930348115;3456.1532424556144;3494.4932984717075;3501.842417091237;3504.229069604683;3505.298940211968;3543.7696549724187;3546.982265088658;3554.8222588870453;3564.465330200491;3565.1265439966855;4087.894734211883;4105.311021281066;4123.9175216495505;4128.690348223895;4128.772917489567;4786.1863483207935;4802.447718512346;4860.635452341088;4944.777485013183;4967.726775027409;1176.3823992404057;1198.4007996002;1201.2192075151222;1202.3387137074574;1209.4859684633996;774.5855967057597;784.5880912520972;808.5189312359137;815.8368326334756;820.4011071917533;4199.769012704331;4201.327787553977;4221.78891055446;4256.638185754246;4266.146770645883;4819.421669399694;4845.830395936126;4850.102730994778;4869.488703686133;4884.95115048852;4085.7946905662902;4242.957570424318;4248.150369926027;4265.808038638269;4268.658507319407;2589.2361753282826;2591.6501272327996;2599.636050952868;2601.245638764775;2608.0480624571896;4557.794899229542;4570.65720070996;4619.330197121399;4620.491745907947;4636.86089417318;4758.310799666138;5007.324011258506;5029.346184995927;5035.874103147451;5040.521150490697;4554.931676024862;4606.216943119678;4608.654350923627;4616.746078965689;4636.44362676481;4900.387451568554;4908.092002979461;4918.2868484068895;4918.803247870188;4930;4540.343898819096;4797.928031079607;4806.759662016815;4821.228603423576;4834.6374021947795;4552.362669226245;4578.221702310549;4585.220512512814;4594.7702614869795;4604.907901841877;3375.3080618472663;3383.424817780934;3385.3398587275246;3396.3207358527898;3397.966020339765;4877.219644856806;4902.8774280643265;4920.040592084509;4932.423992605332;4932.704037757746;4643.326717625993;4726.235152435726;4939.75301234944;4958.975205123951;4977.581389304031;4904;4907.288443175791;4927.507249275044;4927.655064145475;4955.2567114933045;4865.318855360181;4870.392770385835;4886.804527818989;4889.706617602813;4891.1658128201925;4749.192637251745;4943.159662857251;4963.677360971526;4986.426560945538;5007.974960125176;4842.491538388418;4864.829730959399;4865.245886887538;4873.975630121969;4877.195262781744 11:43:43 INFO - PROCESS | 22022 | |5;yui.html;653.2911790707083;674.7098747538558;680.0683064202044;722.2019668266565;750.4146765522894;12048.939755301222;13334.13328133673;13423.530176443826;13483.325833708312;13504.864951350484;12082.637520874388;12156.817647735292;12324.198927069756;12354.258744475315;12379.319137447437;767.163791467302;777.9416543759212;784.5724080376209;784.5998540744233;785.1441928298154;783.4515838912755;783.7178615698344;784.2902173532933;785.9410544209179;787.6258777080898;827.983440331193;829.2909562324186;829.854775414303;830.0122853803985;830.5058490198322;822.3010441125056;822.7367242482408;822.9629666665014;823.1685997142869;823.3618945317367;607.7872744539376;607.8784243151388;607.8996965500687;607.9118527813487;608.0150156746056;11632.941835290854;11634.418279086096;11661.70845728855;12279.69300767479;12833.871661283454;12438.440270187863;12984.675383115404;12987.545435909793;13194.472221111144;13566.321683915863;10341;10349.327293725884;10632;10663.626773062982;10741.19441041925;3183.5383869338816;3218.6942240487115;3245.0913744151676;3265.591801024872;3337.566116404852;51368;54213;63336.68331658312;63856.36143638551;64972.350276497105;10107.7473063174;10179.898201018043;10267.9486602568;10372.688819335432;10427.113695335982;17946.577212076463;18141.183646735928;18169.7274540882;18330;18482.630347393246;6887.070245516891;7000.334968178015;7017.017617533549;7034;7214.891776623354;3681.7606855554304;3744.6255374462335;3753.6246375362794;3776.8300426480873;3783.7135373972433;2741.300968253083;2804.032608750019;2821.492131416324;2827.2083816531403;2851.5865199546365;470.962323014158;474.43779121740846;478.0272146182502;478.2849639788469;487.50518224002667;448.37004009366893;555;568.4878223924342;574.9827505174851;595.8500094816958;7916.633568988722;8046.678132874619;8356.749297521084;8466.619002144918;8879.156480134377;600.5165841497549;606.4148097086332;617.3579477343512;624.5971348480296;624.9031400132895;3779.7732136071922;3957.426173204869;3966.087799806003;4072.8370865165653;4121.793910304473;57943;58157.70921145367;60072.69963650241;62131.689341553;62163.689181554706;45348.319775203396;45823.541764582595;46060.5393946063;53798.462015379344;54712.17931731027;42105.36841947373;42579.14841703149;42938;48834.26748598774;49183.75408123008;8508.489490630582;8843.336749743667;8902.73291801247;9021.684241051531;9473.384230025027;30549.847250763603;32866;34363.65636343705;34741.65258347384;34931;45012;46801;47030.52969470398;47035.529644703114;47527;10419.843702344318;10886.891131088905;10914.890851091388;11235.213535052795;11674.76650467003;12493.562725304571;12723;12831.743365132832;12854.871451285368;12937.223766574036;11328.773424531628;11349.716257093638;11466;12150.513979440724;12423.875761242272;11862.347570883685;12137.271763694207;12162.513499460276;12854.357282136043;12912.548060817826;10614.73463163427;10728.678139655824;11051.28166669196;11090.667279981613;11152.944235278772;8990.460572365679;9172.678956236767;9252.398594091363;9577.185939195246;9751;9892;10345.534450949575;10360.533775979948;10373;10379.325343852626 11:43:43 INFO - PROCESS | 22022 | __end_tp_report 11:43:43 INFO - PROCESS | 22022 | __start_cc_report 11:43:43 INFO - PROCESS | 22022 | _x_x_mozilla_cycle_collect,1180 11:43:43 INFO - PROCESS | 22022 | __end_cc_report 11:43:43 INFO - PROCESS | 22022 | __startTimestamp1481831023692__endTimestamp 11:43:43 INFO - PROCESS | 22022 | 11:43:43 INFO - PROCESS | 22022 | ------- Summary: start ------- 11:43:43 INFO - PROCESS | 22022 | Number of tests: 6 11:43:43 INFO - PROCESS | 22022 | 11:43:43 INFO - PROCESS | 22022 | [#0] dojo.html Cycles:165 Average:4529.76 Median:4615.10 stddev:466.00 (10.1%) stddev-sans-first:440.20 11:43:43 INFO - PROCESS | 22022 | Values: 2528.7 2548.8 2572.7 2580.3 2580.9 4450.6 4481.5 4541.4 4541.5 4554.3 4509.4 4547.2 4555.2 4572.0 4615.1 4190.7 4204.0 4247.6 4267.8 4322.6 3927.8 4240.9 4249.9 4290.9 4339.8 4167.6 4186.7 4284.3 4327.5 4373.0 4150.2 4239.2 4241.2 4241.4 4242.3 4172.0 4177.2 4178.0 4233.8 4234.6 4527.3 4553.9 4562.4 4583.1 4610.3 4728.7 4771.7 4865.7 4874.6 4876.2 4813.9 4885.2 4925.6 4930.4 4986.7 4601.4 4604.4 4607.4 4607.4 4646.2 5031.8 5033.0 5040.0 5043.7 5092.6 4705.1 4731.4 4735.2 4781.2 4796.2 4913.4 4914.1 4917.1 4951.6 4955.5 4834.7 4863.4 4865.3 4888.8 4915.6 4722.6 4757.6 4759.6 4854.2 4864.8 4187.0 4219.6 4221.8 4225.5 4276.5 3696.7 3697.4 3697.9 3715.0 3732.0 4157.9 4193.6 4196.2 4201.2 4215.2 4831.0 4843.0 4850.1 4880.0 4912.8 4232.6 4236.5 4237.3 4262.8 4271.5 4467.0 4472.8 4475.1 4477.6 4521.8 4425.9 4442.7 4443.4 4542.3 4631.4 4873.6 4912.5 4916.1 4960.8 4967.5 4550.8 4586.2 4589.4 4590.3 4630.9 4733.2 4759.7 4839.6 4842.2 4873.8 4872.7 4910.2 4914.8 4945.1 4993.5 4728.2 4804.5 4814.8 4817.5 4860.1 4632.3 4648.5 4812.2 4818.5 4861.1 4691.2 4712.1 4739.6 4747.3 4798.9 4863.6 4869.8 4870.1 4875.7 4919.9 4602.1 4768.2 4769.4 4771.1 4818.1 11:43:43 INFO - PROCESS | 22022 | 11:43:43 INFO - PROCESS | 22022 | [#1] ext.html Cycles:180 Average:44099.68 Median:32274.44 stddev:78868.35 (244.4%) stddev-sans-first:79021.75 11:43:43 INFO - PROCESS | 22022 | Values: 528.3 538.5 538.7 540.9 555.4 28047.0 38873.2 40016.6 40083.8 43468.1 40832.2 41392.0 41397.0 41405.8 41445.6 7306.8 7521.6 7693.0 7703.5 7720.1 7266.7 9789.2 10011.4 10019.8 10360.8 9557.5 9593.1 9596.5 9599.2 9600.8 9929.8 10002.4 10003.7 10008.7 10023.7 9906.0 9962.2 9978.2 9982.2 9993.0 38036.0 38338.6 38376.0 38432.6 38445.8 2997.9 3042.8 3112.5 3183.5 3356.5 27344.0 28083.0 28123.7 28143.2 28200.3 3184.7 3259.0 3287.3 3385.7 3395.2 241891.0 242236.0 242392.0 243193.0 244339.0 51324.0 51539.7 51546.2 51575.2 51652.0 49882.8 49967.8 49993.5 50011.0 50049.5 13841.7 14060.8 14064.9 14072.1 14078.0 9676.5 9950.6 10455.3 10675.8 10731.3 16417.4 17050.8 17180.2 17226.7 17253.3 5650.5 5798.6 5824.9 5828.0 5859.4 779.6 854.4 874.0 895.7 1031.5 24728.0 26344.2 26504.2 26675.7 28396.3 883.1 914.5 917.8 943.7 964.0 12924.0 13409.0 13433.0 13500.7 13529.3 338885.0 341510.0 341729.0 341926.0 342090.0 42474.4 42655.4 42717.8 42718.0 42718.6 1155.7 1177.1 1188.1 1202.2 1203.5 23267.0 23805.6 24210.2 24397.6 24747.5 35395.6 35868.0 35873.6 35900.0 36271.3 306496.0 308309.0 308728.0 308888.0 309369.0 20491.0 21072.2 22477.9 22706.2 23252.5 33560.0 35268.5 35650.8 35702.3 36311.6 30549.7 30787.0 31118.5 31958.7 32274.5 30408.5 31220.7 31590.7 31590.8 32274.4 30585.7 30671.7 30780.7 31710.4 31804.2 26543.8 28074.2 28184.3 28419.4 28773.4 21744.8 22212.2 22895.1 22943.3 23141.8 11:43:43 INFO - PROCESS | 22022 | 11:43:43 INFO - PROCESS | 22022 | [#2] jquery.html Cycles:180 Average:22574.32 Median:4360.17 stddev:57377.57 (1315.9%) stddev-sans-first:57514.24 11:43:43 INFO - PROCESS | 22022 | Values: 337.1 351.9 358.7 359.9 383.4 12301.9 15372.0 15785.2 16235.3 17415.8 13818.7 14009.2 14927.5 16028.0 16175.0 4101.3 4350.1 4944.3 5171.4 5183.6 4996.7 5036.6 5081.3 5086.6 5088.8 4817.6 5058.1 5063.4 5064.9 5067.1 4967.8 5027.0 5079.1 5080.2 5088.4 4334.3 4547.4 4547.6 4551.0 4551.8 19277.6 19648.0 19884.3 20039.4 20053.7 1715.6 1854.4 1915.3 1967.9 2540.2 7937.8 8284.1 8667.2 8741.9 8829.8 1685.2 1698.8 1699.7 1716.0 1734.5 60925.0 63032.0 63077.4 63395.7 64666.0 9680.6 9684.5 9755.4 9940.6 9943.8 13434.6 13442.0 13511.4 13533.7 13544.9 6912.4 7035.4 7197.7 7272.9 7281.4 6759.7 6809.1 6921.7 6956.2 6986.7 3965.0 4050.3 4177.3 4307.1 4370.3 1762.5 1765.7 1805.7 1856.9 1877.2 825.2 835.1 839.0 842.4 895.3 15575.5 16848.5 17178.1 17271.5 17347.8 801.8 812.7 870.5 897.8 906.7 9069.2 9284.8 9512.1 9551.2 9709.4 340203.0 343318.0 344966.0 346376.0 357458.0 71345.0 75749.0 76782.0 78232.2 78384.2 840.6 870.1 872.4 873.6 873.8 14734.9 14801.8 14903.6 14909.3 15554.5 32842.2 35341.5 35480.0 35632.3 35640.6 45138.3 48054.5 48978.0 50621.5 51169.7 7101.0 7347.9 7359.5 7440.1 7670.2 10968.1 11651.9 11890.6 12036.7 12413.1 9938.4 10147.3 10342.3 10697.5 10802.2 10436.2 10464.7 10564.9 10661.7 10788.4 10499.8 10617.2 10644.5 10803.2 11106.7 7396.4 7418.3 7489.2 7558.5 7680.7 10193.3 10526.2 10586.8 10827.3 11209.3 11:43:43 INFO - PROCESS | 22022 | 11:43:43 INFO - PROCESS | 22022 | [#3] mootools.html Cycles:180 Average:4327.37 Median:5242.11 stddev:2243.69 (42.8%) stddev-sans-first:2237.87 11:43:43 INFO - PROCESS | 22022 | Values: 1225.8 1306.1 1328.0 1381.8 1644.5 5784.4 6277.1 6550.0 6566.1 6728.6 6563.2 6617.1 6620.6 6622.4 6633.7 1773.9 1994.8 2023.3 2029.4 2031.2 1815.5 1833.3 1834.8 1835.5 1992.5 2006.8 2018.7 2026.1 2026.9 2027.5 1939.0 1940.7 1946.6 1946.9 1949.1 1935.6 1974.0 1990.7 1991.3 1993.4 6474.9 6516.6 6530.2 6534.9 6535.3 3935.7 4082.2 4082.7 4085.3 4087.8 2610.6 2707.3 2774.3 2783.9 2788.7 794.0 818.2 845.9 870.8 871.7 8567.9 8569.7 8593.6 8594.3 8602.1 3536.5 3711.7 3717.7 3756.4 3765.4 7308.1 7318.0 7318.7 7322.7 7324.6 4063.1 4101.1 4139.2 4149.3 4150.0 3679.5 3811.9 3815.7 3816.3 3823.2 2901.5 2990.5 3013.9 3194.4 3209.8 990.1 1003.8 1009.8 1068.8 1112.7 694.5 832.2 840.7 845.8 856.2 4553.4 4568.7 4600.5 4684.5 4756.1 793.8 794.7 800.5 827.6 866.3 3110.4 3236.1 3296.5 3308.8 3451.0 7418.7 7786.1 7791.1 7796.6 7826.1 6775.5 7072.5 7133.2 7350.7 7764.3 5983.5 6082.9 6088.4 6089.7 6092.2 4635.5 4751.0 4758.5 4827.9 4999.7 6869.5 6919.0 7020.7 7025.4 7051.4 7141.6 7141.6 7146.1 7150.4 7168.0 5396.1 5459.8 5459.8 5465.0 5466.5 6130.8 6197.1 6198.1 6205.7 6205.8 5632.1 5688.4 5805.6 5901.7 5903.0 5651.7 5698.2 5709.4 5715.7 5718.1 5186.1 5221.7 5262.6 5263.8 5270.7 3924.6 3953.8 4010.9 4022.2 4113.3 3953.6 4000.6 4034.7 4097.0 4116.3 11:43:43 INFO - PROCESS | 22022 | 11:43:43 INFO - PROCESS | 22022 | [#4] prototype.html Cycles:180 Average:4041.76 Median:4590.00 stddev:1164.64 (25.4%) stddev-sans-first:1133.74 11:43:43 INFO - PROCESS | 22022 | Values: 310.9 323.6 326.9 328.4 334.3 4713.3 4764.3 4779.1 4782.3 4788.5 4452.8 4679.7 4722.9 4723.1 4724.5 3646.8 3652.9 3735.0 3753.9 3762.5 3737.7 3748.0 3755.0 3760.1 3766.5 3532.9 3723.3 3727.6 3729.4 3736.0 3602.1 3620.1 3711.9 3717.8 3732.5 3340.4 3349.9 3352.7 3362.7 3364.6 4567.7 4575.5 4583.0 4597.7 4615.5 4152.8 4248.1 4261.2 4273.9 4278.4 4851.6 4886.6 4892.4 4913.3 4917.8 3633.5 3635.3 3636.6 3639.9 3640.7 4872.4 5128.9 5134.7 5134.9 5144.4 3456.2 3494.5 3501.8 3504.2 3505.3 3543.8 3547.0 3554.8 3564.5 3565.1 4087.9 4105.3 4123.9 4128.7 4128.8 4786.2 4802.4 4860.6 4944.8 4967.7 1176.4 1198.4 1201.2 1202.3 1209.5 774.6 784.6 808.5 815.8 820.4 4199.8 4201.3 4221.8 4256.6 4266.1 4819.4 4845.8 4850.1 4869.5 4885.0 4085.8 4243.0 4248.2 4265.8 4268.7 2589.2 2591.7 2599.6 2601.2 2608.0 4557.8 4570.7 4619.3 4620.5 4636.9 4758.3 5007.3 5029.3 5035.9 5040.5 4554.9 4606.2 4608.7 4616.7 4636.4 4900.4 4908.1 4918.3 4918.8 4930.0 4540.3 4797.9 4806.8 4821.2 4834.6 4552.4 4578.2 4585.2 4594.8 4604.9 3375.3 3383.4 3385.3 3396.3 3398.0 4877.2 4902.9 4920.0 4932.4 4932.7 4643.3 4726.2 4939.8 4959.0 4977.6 4904.0 4907.3 4927.5 4927.7 4955.3 4865.3 4870.4 4886.8 4889.7 4891.2 4749.2 4943.2 4963.7 4986.4 5008.0 4842.5 4864.8 4865.2 4874.0 4877.2 11:43:43 INFO - PROCESS | 22022 | 11:43:43 INFO - PROCESS | 22022 | [#5] yui.html Cycles:180 Average:14064.36 Median:42758.57 stddev:16865.27 (39.4%) stddev-sans-first:16882.51 11:43:43 INFO - PROCESS | 22022 | Values: 653.3 674.7 680.1 722.2 750.4 12048.9 13334.1 13423.5 13483.3 13504.9 12082.6 12156.8 12324.2 12354.3 12379.3 767.2 777.9 784.6 784.6 785.1 783.5 783.7 784.3 785.9 787.6 828.0 829.3 829.9 830.0 830.5 822.3 822.7 823.0 823.2 823.4 607.8 607.9 607.9 607.9 608.0 11632.9 11634.4 11661.7 12279.7 12833.9 12438.4 12984.7 12987.5 13194.5 13566.3 10341.0 10349.3 10632.0 10663.6 10741.2 3183.5 3218.7 3245.1 3265.6 3337.6 51368.0 54213.0 63336.7 63856.4 64972.4 10107.7 10179.9 10267.9 10372.7 10427.1 17946.6 18141.2 18169.7 18330.0 18482.6 6887.1 7000.3 7017.0 7034.0 7214.9 3681.8 3744.6 3753.6 3776.8 3783.7 2741.3 2804.0 2821.5 2827.2 2851.6 471.0 474.4 478.0 478.3 487.5 448.4 555.0 568.5 575.0 595.9 7916.6 8046.7 8356.7 8466.6 8879.2 600.5 606.4 617.4 624.6 624.9 3779.8 3957.4 3966.1 4072.8 4121.8 57943.0 58157.7 60072.7 62131.7 62163.7 45348.3 45823.5 46060.5 53798.5 54712.2 42105.4 42579.1 42938.0 48834.3 49183.8 8508.5 8843.3 8902.7 9021.7 9473.4 30549.8 32866.0 34363.7 34741.7 34931.0 45012.0 46801.0 47030.5 47035.5 47527.0 10419.8 10886.9 10914.9 11235.2 11674.8 12493.6 12723.0 12831.7 12854.9 12937.2 11328.8 11349.7 11466.0 12150.5 12423.9 11862.3 12137.3 12162.5 12854.4 12912.5 10614.7 10728.7 11051.3 11090.7 11152.9 8990.5 9172.7 9252.4 9577.2 9751.0 9892.0 10345.5 10360.5 10373.0 10379.3 11:43:43 INFO - PROCESS | 22022 | -------- Summary: end -------- 11:43:43 INFO - PROCESS | 22022 | 11:43:44 INFO - TEST-INFO | 22022: exit 0 11:43:44 INFO - TEST-OK | dromaeo_css | took 1122819ms 11:43:44 INFO - TEST-START | kraken 11:43:44 INFO - operating with platform_type : linux_ 11:43:44 INFO - Initialising browser for kraken test... 11:43:44 INFO - TEST-INFO | started process 22325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGESV6M/profile http://localhost:47870/getInfo.html) 11:43:49 INFO - PROCESS | 22325 | __metrics Screen width/height:1600/1200 11:43:49 INFO - PROCESS | 22325 | colorDepth:24 11:43:49 INFO - PROCESS | 22325 | Browser inner width/height: 1024/697 11:43:49 INFO - PROCESS | 22325 | __metrics 11:43:49 INFO - PROCESS | 22325 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:43:49 INFO - PROCESS | 22325 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:43:50 INFO - PROCESS | 22325 | console.error: PushService: 11:43:50 INFO - PROCESS | 22325 | stateChangeProcessEnqueue: Error transitioning state 11:43:50 INFO - PROCESS | 22325 | UnknownError 11:43:51 INFO - TEST-INFO | 22325: exit 0 11:43:51 INFO - Browser initialized. 11:43:51 INFO - Running cycle 1/1 for kraken test... 11:43:51 INFO - TEST-INFO | started process 22409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGESV6M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:03 INFO - PROCESS | 22409 | RSS: Main: 173490176 11:44:03 INFO - PROCESS | 22409 | 11:44:06 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47870/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:07 INFO - PROCESS | 22409 | RSS: Main: 235737088 11:44:07 INFO - PROCESS | 22409 | 11:44:10 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47870/tests/kraken/driver.html?testName=audio-dft) 11:44:10 INFO - PROCESS | 22409 | RSS: Main: 218583040 11:44:10 INFO - PROCESS | 22409 | 11:44:13 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47870/tests/kraken/driver.html?testName=audio-fft) 11:44:14 INFO - PROCESS | 22409 | RSS: Main: 300359680 11:44:14 INFO - PROCESS | 22409 | 11:44:16 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47870/tests/kraken/driver.html?testName=audio-oscillator) 11:44:17 INFO - PROCESS | 22409 | RSS: Main: 211763200 11:44:17 INFO - PROCESS | 22409 | 11:44:19 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:20 INFO - PROCESS | 22409 | RSS: Main: 214867968 11:44:20 INFO - PROCESS | 22409 | 11:44:23 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47870/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:24 INFO - PROCESS | 22409 | RSS: Main: 253861888 11:44:24 INFO - PROCESS | 22409 | 11:44:27 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47870/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:28 INFO - PROCESS | 22409 | RSS: Main: 248311808 11:44:28 INFO - PROCESS | 22409 | 11:44:31 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47870/tests/kraken/driver.html?testName=json-parse-financial) 11:44:31 INFO - PROCESS | 22409 | RSS: Main: 250343424 11:44:31 INFO - PROCESS | 22409 | 11:44:33 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:33 INFO - PROCESS | 22409 | RSS: Main: 213676032 11:44:33 INFO - PROCESS | 22409 | 11:44:35 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47870/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:36 INFO - PROCESS | 22409 | RSS: Main: 220540928 11:44:36 INFO - PROCESS | 22409 | 11:44:38 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:39 INFO - PROCESS | 22409 | RSS: Main: 229588992 11:44:39 INFO - PROCESS | 22409 | 11:44:42 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:43 INFO - PROCESS | 22409 | RSS: Main: 234041344 11:44:43 INFO - PROCESS | 22409 | 11:44:46 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:46 INFO - PROCESS | 22409 | RSS: Main: 234610688 11:44:46 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | Cycle 1(1): loaded http://localhost:47870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47870/tests/kraken/driver.html?testName=ai-astar) 11:44:48 INFO - PROCESS | 22409 | RSS: Main: 287064064 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | __start_tp_report 11:44:48 INFO - PROCESS | 22409 | _x_x_mozilla_page_load 11:44:48 INFO - PROCESS | 22409 | _x_x_mozilla_page_load_details 11:44:48 INFO - PROCESS | 22409 | |i|pagename|runs| 11:44:48 INFO - PROCESS | 22409 | |0;ai-astar;109;118;118;118;117;116;115;117;119;117 11:44:48 INFO - PROCESS | 22409 | |1;audio-beat-detection;152;131;135;172;132;132;130;130;159;130 11:44:48 INFO - PROCESS | 22409 | |2;audio-dft;162;161;163;163;163;163;163;163;164;163 11:44:48 INFO - PROCESS | 22409 | |3;audio-fft;76;76;79;109;76;77;77;77;91;76 11:44:48 INFO - PROCESS | 22409 | |4;audio-oscillator;85;85;107;85;86;87;101;85;86;105 11:44:48 INFO - PROCESS | 22409 | |5;imaging-gaussian-blur;127;128;128;128;128;128;128;127;130;128 11:44:48 INFO - PROCESS | 22409 | |6;imaging-darkroom;146;147;148;148;146;146;147;147;148;150 11:44:48 INFO - PROCESS | 22409 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;95 11:44:48 INFO - PROCESS | 22409 | |8;json-parse-financial;65;63;65;63;66;66;65;65;66;66 11:44:48 INFO - PROCESS | 22409 | |9;json-stringify-tinderbox;66;66;65;66;68;68;66;66;67;66 11:44:48 INFO - PROCESS | 22409 | |10;stanford-crypto-aes;86;85;86;86;87;91;84;95;86;85 11:44:48 INFO - PROCESS | 22409 | |11;stanford-crypto-ccm;164;141;139;139;140;142;151;139;248;150 11:44:48 INFO - PROCESS | 22409 | |12;stanford-crypto-pbkdf2;176;176;174;176;174;174;177;176;173;174 11:44:48 INFO - PROCESS | 22409 | |13;stanford-crypto-sha256-iterative;69;72;67;69;69;68;68;69;68;68 11:44:48 INFO - PROCESS | 22409 | __end_tp_report 11:44:48 INFO - PROCESS | 22409 | __start_cc_report 11:44:48 INFO - PROCESS | 22409 | _x_x_mozilla_cycle_collect,1955 11:44:48 INFO - PROCESS | 22409 | __end_cc_report 11:44:48 INFO - PROCESS | 22409 | __startTimestamp1481831088748__endTimestamp 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | ------- Summary: start ------- 11:44:48 INFO - PROCESS | 22409 | Number of tests: 14 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#0] ai-astar Cycles:10 Average:116.40 Median:117.50 stddev:2.84 (2.4%) stddev-sans-first:1.20 11:44:48 INFO - PROCESS | 22409 | Values: 109.0 118.0 118.0 118.0 117.0 116.0 115.0 117.0 119.0 117.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:133.50 stddev:15.14 (11.3%) stddev-sans-first:15.45 11:44:48 INFO - PROCESS | 22409 | Values: 152.0 131.0 135.0 172.0 132.0 132.0 130.0 130.0 159.0 130.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 11:44:48 INFO - PROCESS | 22409 | Values: 162.0 161.0 163.0 163.0 163.0 163.0 163.0 163.0 164.0 163.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#3] audio-fft Cycles:10 Average:81.40 Median:77.00 stddev:10.72 (13.9%) stddev-sans-first:11.19 11:44:48 INFO - PROCESS | 22409 | Values: 76.0 76.0 79.0 109.0 76.0 77.0 77.0 77.0 91.0 76.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:85.00 stddev:9.20 (10.8%) stddev-sans-first:9.48 11:44:48 INFO - PROCESS | 22409 | Values: 85.0 85.0 107.0 85.0 86.0 87.0 101.0 85.0 86.0 105.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#5] imaging-gaussian-blur Cycles:10 Average:128.00 Median:128.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 11:44:48 INFO - PROCESS | 22409 | Values: 127.0 128.0 128.0 128.0 128.0 128.0 128.0 127.0 130.0 128.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:1.25 (0.8%) stddev-sans-first:1.24 11:44:48 INFO - PROCESS | 22409 | Values: 146.0 147.0 148.0 148.0 146.0 146.0 147.0 147.0 148.0 150.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:44:48 INFO - PROCESS | 22409 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.50 stddev:1.15 (1.8%) stddev-sans-first:1.22 11:44:48 INFO - PROCESS | 22409 | Values: 65.0 63.0 65.0 63.0 66.0 66.0 65.0 65.0 66.0 66.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 11:44:48 INFO - PROCESS | 22409 | Values: 66.0 66.0 65.0 66.0 68.0 68.0 66.0 66.0 67.0 66.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.00 stddev:3.35 (3.9%) stddev-sans-first:3.53 11:44:48 INFO - PROCESS | 22409 | Values: 86.0 85.0 86.0 86.0 87.0 91.0 84.0 95.0 86.0 85.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#11] stanford-crypto-ccm Cycles:10 Average:155.30 Median:146.00 stddev:33.55 (23.0%) stddev-sans-first:35.43 11:44:48 INFO - PROCESS | 22409 | Values: 164.0 141.0 139.0 139.0 140.0 142.0 151.0 139.0 248.0 150.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.00 stddev:1.33 (0.8%) stddev-sans-first:1.36 11:44:48 INFO - PROCESS | 22409 | Values: 176.0 176.0 174.0 176.0 174.0 174.0 177.0 176.0 173.0 174.0 11:44:48 INFO - PROCESS | 22409 | 11:44:48 INFO - PROCESS | 22409 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 11:44:48 INFO - PROCESS | 22409 | Values: 69.0 72.0 67.0 69.0 69.0 68.0 68.0 69.0 68.0 68.0 11:44:48 INFO - PROCESS | 22409 | -------- Summary: end -------- 11:44:48 INFO - PROCESS | 22409 | 11:44:49 INFO - TEST-INFO | 22409: exit 0 11:44:50 INFO - TEST-OK | kraken | took 65265ms 11:44:50 INFO - SUITE-END | took 1188s 11:44:50 INFO - Completed test suite (00:19:48) 11:44:50 INFO - javascript benchmark 11:44:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2528.721840597534, 2548.8470691758484, 2572.7041390240124, 2580.3162162027065, 2580.9225723228296, 4450.621697155746, 4481.529439408864, 4541.364209010737, 4541.500434952157, 4554.2940844169125, 4509.368688383621, 4547.18150732868, 4555.20283950309, 4572.039871626962, 4615.1000554891725, 4190.664746820263, 4204.0, 4247.638950689196, 4267.786610669454, 4322.610965013148, 3927.8136884950013, 4240.936385954213, 4249.936250956238, 4290.914181716364, 4339.848105316315, 4167.624913757746, 4186.6859985500905, 4284.271673815428, 4327.502337231227, 4372.956270437287, 4150.169966006781, 4239.1521695660995, 4241.1941731071, 4241.384999175102, 4242.3212286034395, 4172.0, 4177.206330797169, 4177.997280652652, 4233.767142807144, 4234.640055595278, 4527.343535187412, 4553.886152846172, 4562.384078149441, 4583.129205450954, 4610.308453731934, 4728.66899317048, 4771.665983381165, 4865.683730557538, 4874.561289483963, 4876.171050921352, 4813.927791083137, 4885.2427873679635, 4925.630577706651, 4930.4330002049865, 4986.650934434591, 4601.401817763669, 4604.40142781443, 4607.378003969488, 4607.44710634726, 4646.163690535736, 5031.773570189277, 5032.974835125874, 5039.974800125976, 5043.672161309503, 5092.567131793839, 4705.058988202305, 4731.432228132646, 4735.195016847144, 4781.187198176319, 4796.184648609745, 4913.385826771653, 4914.066327397854, 4917.0903382874285, 4951.579115775199, 4955.479674634112, 4834.685745426536, 4863.392075990501, 4865.32322426173, 4888.755562221874, 4915.606751459874, 4722.598579120813, 4757.643176761757, 4759.643026773006, 4854.150523658416, 4864.805407783649, 4187.0, 4219.578042195756, 4221.831126754957, 4225.514065882463, 4276.465441819772, 3696.6857817085847, 3697.352963231424, 3697.9445308320396, 3714.9628503715157, 3732.0483276764253, 4157.91684166321, 4193.559676233952, 4196.244675958295, 4201.243776120266, 4215.156968606291, 4830.951690483121, 4843.0313937212695, 4850.078485087822, 4880.048390563877, 4912.803487860446, 4232.619064284229, 4236.5128010278595, 4237.258479766028, 4262.829486820555, 4271.487421509377, 4467.0, 4472.79872405736, 4475.082608065339, 4477.597016268552, 4521.79651915658, 4425.933610995773, 4442.711223770574, 4443.422355093817, 4542.318652202196, 4631.421072365954, 4873.634477414137, 4912.459629440687, 4916.06594746997, 4960.751962401793, 4967.528084831935, 4550.7952142154345, 4586.197415452216, 4589.426321709786, 4590.311453282035, 4630.86107416778, 4733.219018861849, 4759.69062010982, 4839.612830973584, 4842.15262329098, 4873.7806798694855, 4872.6832755870755, 4910.165271903714, 4914.827981020647, 4945.109880221595, 4993.525615066563, 4728.219843725747, 4804.495527969652, 4814.807407703653, 4817.494163112823, 4860.149473842134, 4632.281996290446, 4648.488666246642, 4812.181929072136, 4818.494058123846, 4861.1006963711825, 4691.249400095969, 4712.128256272601, 4739.573438390561, 4747.2879068140055, 4798.904021919612, 4863.562279394871, 4869.756512174448, 4870.0746858096845, 4875.7074575525585, 4919.877003074952, 4602.148602508547, 4768.189407800752, 4769.379980602499, 4771.093492236464, 4818.084563932842], "value": 4500.529723795738, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.294726540069, 538.4588488568987, 538.6660270632209, 540.8999335123005, 555.3752028967411, 28047.03670743049, 38873.22253554927, 40016.59983400169, 40083.799581002124, 43468.130637387316, 40832.183356332855, 41392.0, 41397.0, 41405.7929710351, 41445.58554414455, 7306.817329566777, 7521.623918804052, 7693.038370203724, 7703.46075774696, 7720.073591169067, 7266.672999715025, 9789.21686265097, 10011.399316041025, 10019.799604007916, 10360.792784144312, 9557.522123893812, 9593.136617704406, 9596.520173991308, 9599.232061435103, 9600.80798384032, 9929.751756206117, 10002.39985600859, 10003.699889003341, 10008.699739007841, 10023.749406264866, 9905.950470247675, 9962.203023758082, 9978.201743860547, 9982.151517121054, 9993.0, 38036.0, 38338.61661383379, 38376.0, 38432.61567384318, 38445.80777096125, 2997.8800847966054, 3042.7717921156, 3112.4708799504137, 3183.458812001942, 3356.5133055706788, 27344.0, 28083.0, 28123.718762812314, 28143.155705328874, 28200.294992625142, 3184.7292481746413, 3259.0222933119967, 3287.293231955141, 3385.6952874241438, 3395.1851555626718, 241891.0, 242235.99999999822, 242392.0, 243193.0, 244339.0, 51324.0, 51539.74230128901, 51546.22680659793, 51575.226371604454, 51652.0, 49882.75058624684, 49967.75016124896, 49993.50084488993, 50011.0, 50049.49950500448, 13841.653958651113, 14060.789088163685, 14064.929675351557, 14072.085314454527, 14078.0, 9676.467794271242, 9950.552225149886, 10455.268131230741, 10675.786484270271, 10731.302465339728, 16417.425390111526, 17050.829491704924, 17180.22688978999, 17226.741598876026, 17253.32573451117, 5650.519705824969, 5798.565107616945, 5824.912626310609, 5828.0, 5859.355470898197, 779.6491578789568, 854.4061876995429, 873.9694110706095, 895.7312806158127, 1031.5358088859894, 24728.0, 26344.209673709818, 26504.204873853814, 26675.733242667713, 28396.290092747848, 883.1212943121635, 914.4696076275744, 917.7934964632905, 943.6649989253854, 963.9710808675751, 12924.0, 13409.0, 13433.0, 13500.662483437993, 13529.323533823466, 338885.0, 341510.0, 341729.0, 341926.0, 342090.0, 42474.36288455676, 42655.36016959748, 42717.78641106775, 42718.0, 42718.57281427208, 1155.7457359380755, 1177.087756988341, 1188.0970462448602, 1202.1644956755147, 1203.4764877278412, 23267.0, 23805.64291535663, 24210.15264465735, 24397.63403548984, 24747.50504989926, 35395.64604353924, 35868.0, 35873.64126358703, 35900.0, 36271.27457450889, 306496.0, 308309.0, 308728.0, 308888.0, 309369.0, 20491.0, 21072.15711371528, 22477.887610561844, 22706.205282815023, 23252.53494930058, 33560.0, 35268.47097293594, 35650.8217458911, 35702.28595428129, 36311.636883630825, 30549.694503055573, 30787.0, 31118.533222001235, 31958.68041319557, 32274.515882261316, 30408.5438718415, 31220.68779312178, 31590.684093159693, 31590.842045789625, 32274.35451291008, 30585.694143058285, 30671.693283066885, 30780.692193077783, 31710.365792683555, 31804.204894877814, 26543.805528750865, 28074.157775266776, 28184.29539261535, 28419.43161136807, 28773.42453150967, 21744.846997185636, 22212.222572209896, 22895.084196632615, 22943.311700649007, 23141.76858231396], "value": 16753.297094255617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.1369294605808, 351.94192958161904, 358.7237826873307, 359.9388104022317, 383.3942371053735, 12301.876981230185, 15372.0, 15785.210739463038, 16235.26941287642, 17415.82584174158, 13818.65453363664, 14009.229492377915, 14927.477538286163, 16028.0, 16175.0, 4101.26177288088, 4350.064736081742, 4944.332515110459, 5171.405288391846, 5183.559397451221, 4996.675216110959, 5036.647434679574, 5081.28861959326, 5086.567641750456, 5088.847334579968, 4817.614590832725, 5058.064258112243, 5063.443021267658, 5064.924026139611, 5067.087924173666, 4967.776450059756, 5026.999999999982, 5079.136546787018, 5080.187170052811, 5088.363954505687, 4334.284843000901, 4547.408836851221, 4547.590716835468, 4550.954490455119, 4551.840685575989, 19277.614447710966, 19648.01759912013, 19884.304049358347, 20039.398818035483, 20053.699194512094, 1715.579682977666, 1854.4436668999247, 1915.3200613782046, 1967.9311224107087, 2540.16174662361, 7937.761867143995, 8284.130166332568, 8667.17661822126, 8741.868871966926, 8829.779255518599, 1685.241641261425, 1698.8046374666949, 1699.6600679863952, 1715.9914200428918, 1734.5316764473648, 60925.0, 63032.0, 63077.36922630761, 63395.6830215846, 64666.0, 9680.612775489042, 9684.51577421126, 9755.415374318944, 9940.602375905028, 9943.751406214758, 13434.596962091153, 13442.0, 13511.391987360395, 13533.66165845842, 13544.86455135436, 6912.377885990285, 7035.366816986496, 7197.748078817216, 7272.854542909112, 7281.417486601059, 6759.662016899136, 6809.148856392951, 6921.688524016431, 6956.165260168812, 6986.650667466606, 3964.980175099106, 4050.3316952702476, 4177.26897792885, 4307.138572285556, 4370.278903980808, 1762.4712586224082, 1765.6910040742819, 1805.6840052990938, 1856.935007274766, 1877.1740434208905, 825.1707034430359, 835.0814104485017, 839.0, 842.4103127810557, 895.3106108296575, 15575.454859080104, 16848.494545163663, 17178.1410929453, 17271.481855544353, 17347.826521734874, 801.8276070644723, 812.6993012585381, 870.525563567857, 897.8249241397865, 906.664534122379, 9069.183773460289, 9284.767880803034, 9512.1439070484, 9551.188149007274, 9709.36889102206, 340203.0, 343318.0, 344966.0, 346376.0, 357458.0, 71345.0, 75749.0, 76782.0, 78232.2176778225, 78384.2161578377, 840.6217202259008, 870.090755160871, 872.376250980552, 873.6461732998146, 873.785922449004, 14734.926325368304, 14801.777973330194, 14903.552893413214, 14909.254537272876, 15554.455594054154, 32842.17894552655, 35341.469877951335, 35480.0, 35632.28735425329, 35640.643593563735, 45138.322925155495, 48054.5194548064, 48978.0, 50621.493785063154, 51169.744151279, 7100.964495177491, 7347.889781653173, 7359.484836061424, 7440.107187137578, 7670.232976702285, 10968.122550195805, 11651.88348116508, 11890.643280701594, 12036.699082522657, 12413.131080824256, 9938.354006989523, 10147.289689721649, 10342.276040677081, 10697.465126743788, 10802.243842930919, 10436.165106791286, 10464.738381540523, 10564.947175264075, 10661.680149595524, 10788.352698838095, 10499.79000419972, 10617.203709721956, 10644.520996555328, 10803.189760767817, 11106.722331941766, 7396.445266605134, 7418.332350088518, 7489.213632568501, 7558.546487210785, 7680.6543705534505, 10193.337433066827, 10526.157907367238, 10586.8411973822, 10827.296225745302, 11209.327440353605], "value": 7919.295923878272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.779359715252, 1306.1118439461166, 1327.9800802987957, 1381.841088274848, 1644.457329081404, 5784.421557844214, 6277.089821975816, 6550.0, 6566.1464009678675, 6728.629925354116, 6563.212414510253, 6617.073609694647, 6620.6358650274215, 6622.4370928471135, 6633.734650613982, 1773.9379121730742, 1994.8204661580419, 2023.3221870673342, 2029.4317591074448, 2031.2281333093404, 1815.4553633909775, 1833.3308342454975, 1834.7889992650883, 1835.5227640813418, 1992.511834600525, 2006.8193862552369, 2018.7173795668618, 2026.0983862181336, 2026.9189232430685, 2027.5032617008853, 1939.0401751133209, 1940.689489681644, 1946.5717542140706, 1946.902654867251, 1949.093671442786, 1935.6128774245208, 1973.980260197394, 1990.7013947907785, 1991.332903477337, 1993.362124120282, 6474.935250647481, 6516.57642253252, 6530.183727034121, 6534.93465065348, 6535.313792051861, 3935.7048221383225, 4082.2447847148374, 4082.6937979651643, 4085.3259212229946, 4087.8364865405347, 2610.582306830917, 2707.323169207698, 2774.250952242883, 2783.8886444542195, 2788.7490125888767, 793.9722109726132, 818.2431251092715, 845.9280961118312, 870.7997160653085, 871.7384784564669, 8567.871481927776, 8569.742907712778, 8593.570321483901, 8594.312455003585, 8602.09677983809, 3536.522569453091, 3711.7216208783907, 3717.70258379329, 3756.38019726742, 3765.378712512405, 7308.123025237006, 7318.048653675095, 7318.707251709979, 7322.707091716378, 7324.597147156957, 4063.065494936181, 4101.118259574206, 4139.2135494256, 4149.294619914622, 4149.958500415018, 3679.466477360768, 3811.9047023824073, 3815.713821463346, 3816.332141875216, 3823.1971286030243, 2901.4632293025857, 2990.5065664165604, 3013.9246518836767, 3194.440972829792, 3209.791363561361, 990.1138481059412, 1003.7841863999275, 1009.7929924365487, 1068.8076146293743, 1112.67732357617, 694.5277211496231, 832.1553623072587, 840.6511297811462, 845.7758693946109, 856.2379482260793, 4553.408056952641, 4568.680192386501, 4600.5169457207185, 4684.508126646721, 4756.096341695067, 793.8452001859697, 794.7258195922398, 800.543690096651, 827.5986146718836, 866.250693150433, 3110.3623757130185, 3236.110069730843, 3296.538484612156, 3308.8345582720767, 3450.9827450863086, 7418.740344087931, 7786.1435242123325, 7791.0650721913735, 7796.610169491502, 7826.1391246962785, 6775.525713200029, 7072.504924655224, 7133.179684336264, 7350.742724004741, 7764.262395072459, 5983.461488466059, 6082.878342433215, 6088.36072212429, 6089.725962331706, 6092.208012958287, 4635.490096089495, 4750.952490475051, 4758.476567577494, 4827.927581086216, 4999.67502112376, 6869.4543727660875, 6918.965405173143, 7020.719171233093, 7025.402840758593, 7051.365377116084, 7141.571505709674, 7141.607211603204, 7146.142462904277, 7150.392216661642, 7168.0, 5396.0556902542685, 5459.808906688247, 5459.836204913859, 5465.0, 5466.508014278734, 6130.785422510191, 6197.070439434121, 6198.101275315144, 6205.6586887721605, 6205.81382558524, 5632.098864181875, 5688.3742788294085, 5805.564582656402, 5901.704914754159, 5903.026000709835, 5651.745671444877, 5698.1737648041635, 5709.3719690834805, 5715.685637289989, 5718.056520674042, 5186.092433824141, 5221.660592061504, 5262.552683021833, 5263.763130659053, 5270.683758974474, 3924.646781789653, 3953.8418463262296, 4010.899727506719, 4022.175454031858, 4113.25961326964, 3953.6244056814558, 4000.599940005976, 4034.697397695126, 4096.959030409657, 4116.341385378325], "value": 3582.7825194388142, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.91449851290895, 323.6375259709125, 326.9199046233673, 328.3793630039225, 334.3263324401331, 4713.2694432363, 4764.285357196422, 4779.091972525218, 4782.306565547998, 4788.497207793183, 4452.755098469591, 4679.719216846992, 4722.91372984213, 4723.055388922212, 4724.503927087658, 3646.7629604075782, 3652.8721494747624, 3735.0, 3753.887383378503, 3762.51087358643, 3737.7009839212797, 3747.9625203747887, 3754.9624503754885, 3760.135168911152, 3766.491523644314, 3532.9116772080647, 3723.292574410867, 3727.589965103836, 3729.4219395993664, 3735.9626403736024, 3602.0994751312173, 3620.149264922741, 3711.9443208351895, 3717.847467285123, 3732.533433320835, 3340.4321265384942, 3349.882754103619, 3352.7485438592203, 3362.7477939154414, 3364.5626068610923, 4567.680262381635, 4575.4738205106505, 4583.0, 4597.678162528624, 4615.492295847454, 4152.8131234094535, 4248.129133527619, 4261.21167583998, 4273.87178384649, 4278.42241297424, 4851.56335929768, 4886.633502487328, 4892.434420985286, 4913.336699545587, 4917.803287868481, 3633.5276414066, 3635.291118231946, 3636.563612366533, 3639.854405823764, 3640.7269454791, 4872.3909511311085, 5128.871778205537, 5134.743262836843, 5134.871628209287, 5144.4083930348115, 3456.1532424556144, 3494.4932984717075, 3501.842417091237, 3504.229069604683, 3505.298940211968, 3543.7696549724187, 3546.982265088658, 3554.8222588870453, 3564.465330200491, 3565.1265439966855, 4087.894734211883, 4105.311021281066, 4123.9175216495505, 4128.690348223895, 4128.772917489567, 4786.1863483207935, 4802.447718512346, 4860.635452341088, 4944.777485013183, 4967.726775027409, 1176.3823992404057, 1198.4007996002, 1201.2192075151222, 1202.3387137074574, 1209.4859684633996, 774.5855967057597, 784.5880912520972, 808.5189312359137, 815.8368326334756, 820.4011071917533, 4199.769012704331, 4201.327787553977, 4221.78891055446, 4256.638185754246, 4266.146770645883, 4819.421669399694, 4845.830395936126, 4850.102730994778, 4869.488703686133, 4884.95115048852, 4085.7946905662902, 4242.957570424318, 4248.150369926027, 4265.808038638269, 4268.658507319407, 2589.2361753282826, 2591.6501272327996, 2599.636050952868, 2601.245638764775, 2608.0480624571896, 4557.794899229542, 4570.65720070996, 4619.330197121399, 4620.491745907947, 4636.86089417318, 4758.310799666138, 5007.324011258506, 5029.346184995927, 5035.874103147451, 5040.521150490697, 4554.931676024862, 4606.216943119678, 4608.654350923627, 4616.746078965689, 4636.44362676481, 4900.387451568554, 4908.092002979461, 4918.2868484068895, 4918.803247870188, 4930.0, 4540.343898819096, 4797.928031079607, 4806.759662016815, 4821.228603423576, 4834.6374021947795, 4552.362669226245, 4578.221702310549, 4585.220512512814, 4594.7702614869795, 4604.907901841877, 3375.3080618472663, 3383.424817780934, 3385.3398587275246, 3396.3207358527898, 3397.966020339765, 4877.219644856806, 4902.8774280643265, 4920.040592084509, 4932.423992605332, 4932.704037757746, 4643.326717625993, 4726.235152435726, 4939.75301234944, 4958.975205123951, 4977.581389304031, 4904.0, 4907.288443175791, 4927.507249275044, 4927.655064145475, 4955.2567114933045, 4865.318855360181, 4870.392770385835, 4886.804527818989, 4889.706617602813, 4891.1658128201925, 4749.192637251745, 4943.159662857251, 4963.677360971526, 4986.426560945538, 5007.974960125176, 4842.491538388418, 4864.829730959399, 4865.245886887538, 4873.975630121969, 4877.195262781744], "value": 3677.1309929581694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.2911790707083, 674.7098747538558, 680.0683064202044, 722.2019668266565, 750.4146765522894, 12048.939755301222, 13334.13328133673, 13423.530176443826, 13483.325833708312, 13504.864951350484, 12082.637520874388, 12156.817647735292, 12324.198927069756, 12354.258744475315, 12379.319137447437, 767.163791467302, 777.9416543759212, 784.5724080376209, 784.5998540744233, 785.1441928298154, 783.4515838912755, 783.7178615698344, 784.2902173532933, 785.9410544209179, 787.6258777080898, 827.983440331193, 829.2909562324186, 829.854775414303, 830.0122853803985, 830.5058490198322, 822.3010441125056, 822.7367242482408, 822.9629666665014, 823.1685997142869, 823.3618945317367, 607.7872744539376, 607.8784243151388, 607.8996965500687, 607.9118527813487, 608.0150156746056, 11632.941835290854, 11634.418279086096, 11661.70845728855, 12279.69300767479, 12833.871661283454, 12438.440270187863, 12984.675383115404, 12987.545435909793, 13194.472221111144, 13566.321683915863, 10341.0, 10349.327293725884, 10632.0, 10663.626773062982, 10741.19441041925, 3183.5383869338816, 3218.6942240487115, 3245.0913744151676, 3265.591801024872, 3337.566116404852, 51368.0, 54213.0, 63336.68331658312, 63856.36143638551, 64972.350276497105, 10107.7473063174, 10179.898201018043, 10267.9486602568, 10372.688819335432, 10427.113695335982, 17946.577212076463, 18141.183646735928, 18169.7274540882, 18330.0, 18482.630347393246, 6887.070245516891, 7000.334968178015, 7017.017617533549, 7034.0, 7214.891776623354, 3681.7606855554304, 3744.6255374462335, 3753.6246375362794, 3776.8300426480873, 3783.7135373972433, 2741.300968253083, 2804.032608750019, 2821.492131416324, 2827.2083816531403, 2851.5865199546365, 470.962323014158, 474.43779121740846, 478.0272146182502, 478.2849639788469, 487.50518224002667, 448.37004009366893, 555.0, 568.4878223924342, 574.9827505174851, 595.8500094816958, 7916.633568988722, 8046.678132874619, 8356.749297521084, 8466.619002144918, 8879.156480134377, 600.5165841497549, 606.4148097086332, 617.3579477343512, 624.5971348480296, 624.9031400132895, 3779.7732136071922, 3957.426173204869, 3966.087799806003, 4072.8370865165653, 4121.793910304473, 57943.0, 58157.70921145367, 60072.69963650241, 62131.689341553, 62163.689181554706, 45348.319775203396, 45823.541764582595, 46060.5393946063, 53798.462015379344, 54712.17931731027, 42105.36841947373, 42579.14841703149, 42938.0, 48834.26748598774, 49183.75408123008, 8508.489490630582, 8843.336749743667, 8902.73291801247, 9021.684241051531, 9473.384230025027, 30549.847250763603, 32866.0, 34363.65636343705, 34741.65258347384, 34931.0, 45012.0, 46801.0, 47030.52969470398, 47035.529644703114, 47527.0, 10419.843702344318, 10886.891131088905, 10914.890851091388, 11235.213535052795, 11674.76650467003, 12493.562725304571, 12723.0, 12831.743365132832, 12854.871451285368, 12937.223766574036, 11328.773424531628, 11349.716257093638, 11466.0, 12150.513979440724, 12423.875761242272, 11862.347570883685, 12137.271763694207, 12162.513499460276, 12854.357282136043, 12912.548060817826, 10614.73463163427, 10728.678139655824, 11051.28166669196, 11090.667279981613, 11152.944235278772, 8990.460572365679, 9172.678956236767, 9252.398594091363, 9577.185939195246, 9751.0, 9892.0, 10345.534450949575, 10360.533775979948, 10373.0, 10379.325343852626], "value": 6164.527290181975, "unit": "score"}], "name": "dromaeo_css", "value": 6038.872918966455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 118.0, 118.0, 117.0, 116.0, 115.0, 117.0, 119.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 135.0, 172.0, 132.0, 132.0, 130.0, 130.0, 159.0, 130.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 163.0, 163.0, 163.0, 163.0, 164.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 109.0, 76.0, 77.0, 77.0, 77.0, 91.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 107.0, 85.0, 86.0, 87.0, 101.0, 85.0, 86.0, 105.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 128.0, 128.0, 128.0, 128.0, 128.0, 127.0, 130.0, 128.0], "value": 128.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 148.0, 146.0, 146.0, 147.0, 147.0, 148.0, 150.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 63.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 68.0, 68.0, 66.0, 66.0, 67.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 87.0, 91.0, 84.0, 95.0, 86.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 141.0, 139.0, 139.0, 140.0, 142.0, 151.0, 139.0, 248.0, 150.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 174.0, 176.0, 174.0, 174.0, 177.0, 176.0, 173.0, 174.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 67.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1580.1000000000001, "alertThreshold": 2.0}]} 11:44:50 INFO - Return code: 0 11:44:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:50 INFO - # TBPL SUCCESS # 11:44:50 INFO - Running post-action listener: _resource_record_post_action 11:44:50 INFO - [mozharness: 2016-12-15 19:44:50.558258Z] Finished run-tests step (success) 11:44:50 INFO - Running post-run listener: _resource_record_post_run 11:44:50 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 389636096; Read time: 12; Write time: 289140 11:44:50 INFO - TinderboxPrint: CPU usage
13.2% 11:44:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:44:50 INFO - TinderboxPrint: I/O write bytes / time
389,636,096 / 289,140 11:44:50 INFO - TinderboxPrint: CPU idle
8,347.3 (86.8%) 11:44:50 INFO - TinderboxPrint: CPU user
1,215.0 (12.6%) 11:44:50 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99831808; Read time: 0; Write time: 107492 11:44:50 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289804288; Read time: 0; Write time: 181648 11:44:51 INFO - Running post-run listener: _upload_blobber_files 11:44:51 INFO - Blob upload gear active. 11:44:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:51 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 11:44:51 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:51 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:55 INFO - (blobuploader) - INFO - Done attempting. 11:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:56 INFO - (blobuploader) - INFO - Done attempting. 11:44:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:57 INFO - (blobuploader) - INFO - Done attempting. 11:44:57 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:57 INFO - Return code: 0 11:44:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4b8f1baa8bbc5fa20663b3221b691c68976e3e3f41587613813c372f53ea0f2a6a306fc9b9b896db5024399f4f640e3b6d95a63f3f1e9ab152b7219eb00956a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/81ee0b0288ffbb24fe8000175fd8ee50f0c2f1e0bac301930546fab559959c5b0f801556e14a66e981c320a427e43eccbd4d11ae15b9762031c1bb26ebb31276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a200a6807723344ae0957576dd036f6ea6d1cf561b5930d357e55e2d92d27b53b230b2bc3448b04dd79d0e840b57b5d08218cbc3aed74475e809519843e3290a"} 11:44:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:57 INFO - Contents: 11:44:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4b8f1baa8bbc5fa20663b3221b691c68976e3e3f41587613813c372f53ea0f2a6a306fc9b9b896db5024399f4f640e3b6d95a63f3f1e9ab152b7219eb00956a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/81ee0b0288ffbb24fe8000175fd8ee50f0c2f1e0bac301930546fab559959c5b0f801556e14a66e981c320a427e43eccbd4d11ae15b9762031c1bb26ebb31276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a200a6807723344ae0957576dd036f6ea6d1cf561b5930d357e55e2d92d27b53b230b2bc3448b04dd79d0e840b57b5d08218cbc3aed74475e809519843e3290a"} 11:44:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:57 INFO - Copying logs to upload dir... 11:44:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.317874 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-12-15 11:44:57.366851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 11:44:57.370404) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4b8f1baa8bbc5fa20663b3221b691c68976e3e3f41587613813c372f53ea0f2a6a306fc9b9b896db5024399f4f640e3b6d95a63f3f1e9ab152b7219eb00956a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/81ee0b0288ffbb24fe8000175fd8ee50f0c2f1e0bac301930546fab559959c5b0f801556e14a66e981c320a427e43eccbd4d11ae15b9762031c1bb26ebb31276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a200a6807723344ae0957576dd036f6ea6d1cf561b5930d357e55e2d92d27b53b230b2bc3448b04dd79d0e840b57b5d08218cbc3aed74475e809519843e3290a"} build_url:https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011802 build_url: 'https://queue.taskcluster.net/v1/task/HdikyQ5wR9eQp9dBIHZpBA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4b8f1baa8bbc5fa20663b3221b691c68976e3e3f41587613813c372f53ea0f2a6a306fc9b9b896db5024399f4f640e3b6d95a63f3f1e9ab152b7219eb00956a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/81ee0b0288ffbb24fe8000175fd8ee50f0c2f1e0bac301930546fab559959c5b0f801556e14a66e981c320a427e43eccbd4d11ae15b9762031c1bb26ebb31276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a200a6807723344ae0957576dd036f6ea6d1cf561b5930d357e55e2d92d27b53b230b2bc3448b04dd79d0e840b57b5d08218cbc3aed74475e809519843e3290a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 11:44:57.395560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:44:57.395858) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1481827407.931098-1289567320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:44:57.479897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 11:44:57.480223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 11:44:57.480514) ========= ========= Total master_lag: 0.15 =========