builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1481220104.48 results: success (0) buildid: 20161208091456 builduid: 9659fbb5b5f74c59b53cc053a2594384 revision: ed2fa5b96829ae548df302f29920f47a39a80234 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:44.479622) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:44.480076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:44.480384) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:44.496637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:44.496940) ========= 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=6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-08 10:01:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-12-08 10:01:45 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:44.628842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:44.629205) ========= 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=6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015107 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:44.679866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:44.680220) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev ed2fa5b96829ae548df302f29920f47a39a80234 --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 ed2fa5b96829ae548df302f29920f47a39a80234 --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=6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-08 10:01:45,724 truncating revision to first 12 chars 2016-12-08 10:01:45,724 Setting DEBUG logging. 2016-12-08 10:01:45,725 attempt 1/10 2016-12-08 10:01:45,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/ed2fa5b96829?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-08 10:01:46,194 unpacking tar archive at: graphics-ed2fa5b96829/testing/mozharness/ program finished with exit code 0 elapsedTime=0.825957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:45.530056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:45.530369) ========= script_repo_revision: ed2fa5b96829ae548df302f29920f47a39a80234 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:45.530975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:45.531573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 10:01:45.542696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-12-08 10:01:45.543011) ========= /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=6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:46 INFO - MultiFileLogger online at 20161208 10:01:46 in /builds/slave/test 10:01:46 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 10:01:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:01:46 INFO - {'append_to_log': False, 10:01:46 INFO - 'base_work_dir': '/builds/slave/test', 10:01:46 INFO - 'blob_upload_branch': 'Graphics', 10:01:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:01:46 INFO - 'branch': 'Graphics', 10:01:46 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:46 INFO - 'config_files': ('talos/linux_config.py',), 10:01:46 INFO - 'default_actions': ('clobber', 10:01:46 INFO - 'read-buildbot-config', 10:01:46 INFO - 'download-and-extract', 10:01:46 INFO - 'populate-webroot', 10:01:46 INFO - 'create-virtualenv', 10:01:46 INFO - 'install', 10:01:46 INFO - 'run-tests'), 10:01:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:46 INFO - 'download_minidump_stackwalk': True, 10:01:46 INFO - 'download_symbols': 'ondemand', 10:01:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:46 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:46 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:46 INFO - 'installer_path': 'installer.exe', 10:01:46 INFO - 'log_level': 'info', 10:01:46 INFO - 'log_name': 'talos', 10:01:46 INFO - 'log_to_console': True, 10:01:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:46 INFO - 'opt_config_files': (), 10:01:46 INFO - 'pip_index': False, 10:01:46 INFO - 'sps_profile': False, 10:01:46 INFO - 'sps_profile_interval': 0, 10:01:46 INFO - 'suite': 'dromaeojs', 10:01:46 INFO - 'system_bits': '32', 10:01:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:46 INFO - 'title': 'talos-linux64-ix-050', 10:01:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:46 INFO - 'use_talos_json': True, 10:01:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:01:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:46 INFO - 'work_dir': 'build'} 10:01:46 INFO - [mozharness: 2016-12-08 18:01:46.675293Z] Running clobber step. 10:01:46 INFO - Running pre-action listener: _resource_record_pre_action 10:01:46 INFO - Running main action method: clobber 10:01:46 INFO - rmtree: /builds/slave/test/build 10:01:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:01:47 INFO - Running post-action listener: _resource_record_post_action 10:01:47 INFO - [mozharness: 2016-12-08 18:01:47.661803Z] Finished clobber step (success) 10:01:47 INFO - [mozharness: 2016-12-08 18:01:47.661903Z] Running read-buildbot-config step. 10:01:47 INFO - Running pre-action listener: _resource_record_pre_action 10:01:47 INFO - Running main action method: read_buildbot_config 10:01:47 INFO - Using buildbot properties: 10:01:47 INFO - { 10:01:47 INFO - "project": "", 10:01:47 INFO - "product": "firefox", 10:01:47 INFO - "script_repo_revision": "default", 10:01:47 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 10:01:47 INFO - "repository": "", 10:01:47 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 10:01:47 INFO - "buildid": "20161208091456", 10:01:47 INFO - "pgo_build": "False", 10:01:47 INFO - "basedir": "/builds/slave/test", 10:01:47 INFO - "buildnumber": 33, 10:01:47 INFO - "slavename": "talos-linux64-ix-050", 10:01:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:01:47 INFO - "platform": "ubuntu64_hw", 10:01:47 INFO - "scheduler": "tests-graphics-linux64-talos", 10:01:47 INFO - "branch": "graphics", 10:01:47 INFO - "repo_path": "projects/graphics", 10:01:47 INFO - "revision": "ed2fa5b96829ae548df302f29920f47a39a80234", 10:01:47 INFO - "stage_platform": "linux64", 10:01:47 INFO - "builduid": "9659fbb5b5f74c59b53cc053a2594384", 10:01:47 INFO - "slavebuilddir": "test" 10:01:47 INFO - } 10:01:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:01:47 INFO - Running post-action listener: _resource_record_post_action 10:01:47 INFO - [mozharness: 2016-12-08 18:01:47.664346Z] Finished read-buildbot-config step (success) 10:01:47 INFO - [mozharness: 2016-12-08 18:01:47.664435Z] Running download-and-extract step. 10:01:47 INFO - Running pre-action listener: _resource_record_pre_action 10:01:47 INFO - Running main action method: download_and_extract 10:01:47 INFO - mkdir: /builds/slave/test/build/tests 10:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:47 INFO - trying https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:01:47 INFO - Downloading https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/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 10:01:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/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 10:01:48 INFO - Downloaded 1361 bytes. 10:01:48 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:01:48 INFO - Using the following test package requirements: 10:01:48 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:48 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:48 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:01:48 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:48 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:01:48 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:48 INFO - u'jsshell-linux-x86_64.zip'], 10:01:48 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:48 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:01:48 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:48 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:48 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:01:48 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:48 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:01:48 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:48 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:01:48 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:48 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:01:48 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:01:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:01:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:48 INFO - Fetch https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:01:49 INFO - Expected file size: 20218977 10:01:49 INFO - Obtained file size: 20218977 10:01:53 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 10:01:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:01:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:53 INFO - Fetch https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:01:54 INFO - Expected file size: 20218977 10:01:54 INFO - Obtained file size: 20218977 10:01:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:01:58 INFO - Fetch https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:02:00 INFO - Expected file size: 14409734 10:02:00 INFO - Obtained file size: 14409734 10:02:00 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')]} 10:02:00 INFO - trying https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:02:00 INFO - Downloading https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/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 10:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/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 10:02:03 INFO - Downloaded 55716704 bytes. 10:02:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:02:03 INFO - mkdir: /builds/slave/test/properties 10:02:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:03 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:03 INFO - Contents: 10:02:03 INFO - build_url:https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:02:04 INFO - Running post-action listener: _resource_record_post_action 10:02:04 INFO - Running post-action listener: set_extra_try_arguments 10:02:04 INFO - [mozharness: 2016-12-08 18:02:04.096098Z] Finished download-and-extract step (success) 10:02:04 INFO - [mozharness: 2016-12-08 18:02:04.096326Z] Running populate-webroot step. 10:02:04 INFO - Running pre-action listener: _resource_record_pre_action 10:02:04 INFO - Running main action method: populate_webroot 10:02:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:02:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:02:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:02:04 INFO - '--tppagecycles', 10:02:04 INFO - '7'], 10:02:04 INFO - 'tests': ['tsvgm']}}, 10:02:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:02:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:02:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:02:04 INFO - 'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:02:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:02:04 INFO - 'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['damp', 'tps']}, 10:02:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:02:04 INFO - 'tests': ['damp', 'tps']}, 10:02:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['dromaeo_dom']}, 10:02:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['basic_compositor_video']}, 10:02:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:02:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['a11yr', 10:02:04 INFO - 'ts_paint', 10:02:04 INFO - 'tpaint', 10:02:04 INFO - 'sessionrestore', 10:02:04 INFO - 'sessionrestore_no_auto_restore', 10:02:04 INFO - 'tabpaint']}, 10:02:04 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:04 INFO - 'ts_paint', 10:02:04 INFO - 'tpaint', 10:02:04 INFO - 'sessionrestore', 10:02:04 INFO - 'sessionrestore_no_auto_restore', 10:02:04 INFO - 'tabpaint']}, 10:02:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:02:04 INFO - 'ts_paint', 10:02:04 INFO - 'tpaint', 10:02:04 INFO - 'sessionrestore', 10:02:04 INFO - 'sessionrestore_no_auto_restore', 10:02:04 INFO - 'tabpaint']}, 10:02:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:02:04 INFO - 'ts_paint', 10:02:04 INFO - 'tpaint', 10:02:04 INFO - 'sessionrestore', 10:02:04 INFO - 'sessionrestore_no_auto_restore', 10:02:04 INFO - 'tabpaint']}, 10:02:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['a11yr', 10:02:04 INFO - 'ts_paint', 10:02:04 INFO - 'tpaint', 10:02:04 INFO - 'sessionrestore', 10:02:04 INFO - 'sessionrestore_no_auto_restore', 10:02:04 INFO - 'tabpaint']}, 10:02:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['a11yr', 10:02:04 INFO - 'ts_paint', 10:02:04 INFO - 'tpaint', 10:02:04 INFO - 'sessionrestore', 10:02:04 INFO - 'sessionrestore_no_auto_restore', 10:02:04 INFO - 'tabpaint']}, 10:02:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['tsvgx', 10:02:04 INFO - 'tsvgr_opacity', 10:02:04 INFO - 'tart', 10:02:04 INFO - 'tscrollx', 10:02:04 INFO - 'cart', 10:02:04 INFO - 'tsvg_static']}, 10:02:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:04 INFO - 'tsvgr_opacity', 10:02:04 INFO - 'tart', 10:02:04 INFO - 'tscrollx', 10:02:04 INFO - 'cart', 10:02:04 INFO - 'tsvg_static']}, 10:02:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:02:04 INFO - 'talos_options': ['--disable-e10s'], 10:02:04 INFO - 'tests': ['tp5o']}, 10:02:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:02:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:02:04 INFO - 'talos_options': ['--disable-e10s', 10:02:04 INFO - '--xperf_path', 10:02:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:04 INFO - 'tests': ['tp5n']}, 10:02:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:02:04 INFO - 'talos_options': ['--xperf_path', 10:02:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:04 INFO - 'tests': ['tp5n']}}, 10:02:04 INFO - 'talos.zip': {'path': '', 10:02:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:02:04 INFO - Running post-action listener: _resource_record_post_action 10:02:04 INFO - [mozharness: 2016-12-08 18:02:04.115571Z] Finished populate-webroot step (success) 10:02:04 INFO - [mozharness: 2016-12-08 18:02:04.115660Z] Running create-virtualenv step. 10:02:04 INFO - Running pre-action listener: _resource_record_pre_action 10:02:04 INFO - Running main action method: create_virtualenv 10:02:04 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:04 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 10:02:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:02:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:04 INFO - Using real prefix '/usr' 10:02:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:02:06 INFO - Installing pip.................done. 10:02:06 INFO - Return code: 0 10:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:02:06 INFO - Reading from file tmpfile_stdout 10:02:06 INFO - Output received: 10:02:06 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) 10:02:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:06 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 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:06 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 10:02:06 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 10:02:06 INFO - Using env: {'DISPLAY': ':0', 10:02:06 INFO - 'HOME': '/home/cltbld', 10:02:06 INFO - 'LANG': 'en_US.UTF-8', 10:02:06 INFO - 'LANGUAGE': 'en_US:en', 10:02:06 INFO - 'LOGNAME': 'cltbld', 10:02:06 INFO - 'MAIL': '/var/mail/cltbld', 10:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:06 INFO - 'MOZ_NO_REMOTE': '1', 10:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:06 INFO - 'NO_EM_RESTART': '1', 10:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:06 INFO - 'PWD': '/builds/slave/test', 10:02:06 INFO - 'SHELL': '/bin/bash', 10:02:06 INFO - 'SHLVL': '1', 10:02:06 INFO - 'TERM': 'linux', 10:02:06 INFO - 'TMOUT': '86400', 10:02:06 INFO - 'USER': 'cltbld', 10:02:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:06 INFO - '_': '/tools/buildbot/bin/python'} 10:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:07 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 10:02:07 INFO - Cleaning up... 10:02:07 INFO - Return code: 0 10:02:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:02:07 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')]} 10:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:07 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')]} 10:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:07 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 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:07 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 10:02:07 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 10:02:07 INFO - Using env: {'DISPLAY': ':0', 10:02:07 INFO - 'HOME': '/home/cltbld', 10:02:07 INFO - 'LANG': 'en_US.UTF-8', 10:02:07 INFO - 'LANGUAGE': 'en_US:en', 10:02:07 INFO - 'LOGNAME': 'cltbld', 10:02:07 INFO - 'MAIL': '/var/mail/cltbld', 10:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:07 INFO - 'MOZ_NO_REMOTE': '1', 10:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:07 INFO - 'NO_EM_RESTART': '1', 10:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:07 INFO - 'PWD': '/builds/slave/test', 10:02:07 INFO - 'SHELL': '/bin/bash', 10:02:07 INFO - 'SHLVL': '1', 10:02:07 INFO - 'TERM': 'linux', 10:02:07 INFO - 'TMOUT': '86400', 10:02:07 INFO - 'USER': 'cltbld', 10:02:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:07 INFO - '_': '/tools/buildbot/bin/python'} 10:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:07 INFO - Downloading/unpacking psutil>=3.1.1 10:02:07 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 10:02:07 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 10:02:07 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 10:02:07 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 10:02:07 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 10:02:07 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 10:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:09 INFO - Installing collected packages: psutil 10:02:09 INFO - Running setup.py install for psutil 10:02:09 INFO - building 'psutil._psutil_linux' extension 10:02:09 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 10:02:09 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 10:02:09 INFO - building 'psutil._psutil_posix' extension 10:02:09 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 10:02:09 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 10:02:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:09 INFO - Successfully installed psutil 10:02:09 INFO - Cleaning up... 10:02:10 INFO - Return code: 0 10:02:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:02:10 INFO - Using env: {'DISPLAY': ':0', 10:02:10 INFO - 'HOME': '/home/cltbld', 10:02:10 INFO - 'LANG': 'en_US.UTF-8', 10:02:10 INFO - 'LANGUAGE': 'en_US:en', 10:02:10 INFO - 'LOGNAME': 'cltbld', 10:02:10 INFO - 'MAIL': '/var/mail/cltbld', 10:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:10 INFO - 'MOZ_NO_REMOTE': '1', 10:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:10 INFO - 'NO_EM_RESTART': '1', 10:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:10 INFO - 'PWD': '/builds/slave/test', 10:02:10 INFO - 'SHELL': '/bin/bash', 10:02:10 INFO - 'SHLVL': '1', 10:02:10 INFO - 'TERM': 'linux', 10:02:10 INFO - 'TMOUT': '86400', 10:02:10 INFO - 'USER': 'cltbld', 10:02:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:10 INFO - '_': '/tools/buildbot/bin/python'} 10:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 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 10:02:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:02:12 INFO - Installing collected packages: mozsystemmonitor 10:02:12 INFO - Running setup.py install for mozsystemmonitor 10:02:12 INFO - Successfully installed mozsystemmonitor 10:02:12 INFO - Cleaning up... 10:02:12 INFO - Return code: 0 10:02:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:02:12 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')]} 10:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:12 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')]} 10:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:12 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 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:12 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 10:02:12 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 10:02:12 INFO - Using env: {'DISPLAY': ':0', 10:02:12 INFO - 'HOME': '/home/cltbld', 10:02:12 INFO - 'LANG': 'en_US.UTF-8', 10:02:12 INFO - 'LANGUAGE': 'en_US:en', 10:02:12 INFO - 'LOGNAME': 'cltbld', 10:02:12 INFO - 'MAIL': '/var/mail/cltbld', 10:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:12 INFO - 'MOZ_NO_REMOTE': '1', 10:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:12 INFO - 'NO_EM_RESTART': '1', 10:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:12 INFO - 'PWD': '/builds/slave/test', 10:02:12 INFO - 'SHELL': '/bin/bash', 10:02:12 INFO - 'SHLVL': '1', 10:02:12 INFO - 'TERM': 'linux', 10:02:12 INFO - 'TMOUT': '86400', 10:02:12 INFO - 'USER': 'cltbld', 10:02:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:12 INFO - '_': '/tools/buildbot/bin/python'} 10:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:12 INFO - Downloading/unpacking jsonschema==2.5.1 10:02:12 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 10:02:12 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 10:02:12 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 10:02:12 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 10:02:12 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 10:02:12 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 10:02:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:02:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:02:14 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 10:02:14 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 10:02:14 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 10:02:14 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 10:02:14 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 10:02:14 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 10:02:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:02:14 INFO - warning: no files found matching '*.txt' 10:02:14 INFO - no previously-included directories found matching 'build' 10:02:14 INFO - no previously-included directories found matching 'dist' 10:02:14 INFO - no previously-included directories found matching '.git*' 10:02:14 INFO - Installing collected packages: jsonschema, functools32 10:02:14 INFO - Running setup.py install for functools32 10:02:15 INFO - warning: no files found matching '*.txt' 10:02:15 INFO - no previously-included directories found matching 'build' 10:02:15 INFO - no previously-included directories found matching 'dist' 10:02:15 INFO - no previously-included directories found matching '.git*' 10:02:15 INFO - Successfully installed jsonschema functools32 10:02:15 INFO - Cleaning up... 10:02:15 INFO - Return code: 0 10:02:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:02:15 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')]} 10:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:15 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')]} 10:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:15 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 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:15 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 10:02:15 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 10:02:15 INFO - Using env: {'DISPLAY': ':0', 10:02:15 INFO - 'HOME': '/home/cltbld', 10:02:15 INFO - 'LANG': 'en_US.UTF-8', 10:02:15 INFO - 'LANGUAGE': 'en_US:en', 10:02:15 INFO - 'LOGNAME': 'cltbld', 10:02:15 INFO - 'MAIL': '/var/mail/cltbld', 10:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:15 INFO - 'MOZ_NO_REMOTE': '1', 10:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:15 INFO - 'NO_EM_RESTART': '1', 10:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:15 INFO - 'PWD': '/builds/slave/test', 10:02:15 INFO - 'SHELL': '/bin/bash', 10:02:15 INFO - 'SHLVL': '1', 10:02:15 INFO - 'TERM': 'linux', 10:02:15 INFO - 'TMOUT': '86400', 10:02:15 INFO - 'USER': 'cltbld', 10:02:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:15 INFO - '_': '/tools/buildbot/bin/python'} 10:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:02:15 INFO - Cleaning up... 10:02:15 INFO - Return code: 0 10:02:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02:15 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')]} 10:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:15 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')]} 10:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:15 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 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:15 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 10:02:15 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 10:02:15 INFO - Using env: {'DISPLAY': ':0', 10:02:15 INFO - 'HOME': '/home/cltbld', 10:02:15 INFO - 'LANG': 'en_US.UTF-8', 10:02:15 INFO - 'LANGUAGE': 'en_US:en', 10:02:15 INFO - 'LOGNAME': 'cltbld', 10:02:15 INFO - 'MAIL': '/var/mail/cltbld', 10:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:15 INFO - 'MOZ_NO_REMOTE': '1', 10:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:15 INFO - 'NO_EM_RESTART': '1', 10:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:15 INFO - 'PWD': '/builds/slave/test', 10:02:15 INFO - 'SHELL': '/bin/bash', 10:02:15 INFO - 'SHLVL': '1', 10:02:15 INFO - 'TERM': 'linux', 10:02:15 INFO - 'TMOUT': '86400', 10:02:15 INFO - 'USER': 'cltbld', 10:02:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:15 INFO - '_': '/tools/buildbot/bin/python'} 10:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:02:15 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 10:02:15 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 10:02:15 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 10:02:15 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 10:02:15 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 10:02:15 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 10:02:17 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02:17 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 10:02:17 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 10:02:17 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 10:02:17 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 10:02:17 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 10:02:17 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 10:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:18 INFO - Downloading docopt-0.6.1.tar.gz 10:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:18 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:18 INFO - Running setup.py install for blobuploader 10:02:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:18 INFO - Running setup.py install for requests 10:02:18 INFO - Running setup.py install for docopt 10:02:18 INFO - Successfully installed blobuploader requests docopt 10:02:18 INFO - Cleaning up... 10:02:18 INFO - Return code: 0 10:02:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:18 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 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:18 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 10:02:18 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 10:02:18 INFO - Using env: {'DISPLAY': ':0', 10:02:18 INFO - 'HOME': '/home/cltbld', 10:02:18 INFO - 'LANG': 'en_US.UTF-8', 10:02:18 INFO - 'LANGUAGE': 'en_US:en', 10:02:18 INFO - 'LOGNAME': 'cltbld', 10:02:18 INFO - 'MAIL': '/var/mail/cltbld', 10:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:18 INFO - 'MOZ_NO_REMOTE': '1', 10:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:18 INFO - 'NO_EM_RESTART': '1', 10:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:18 INFO - 'PWD': '/builds/slave/test', 10:02:18 INFO - 'SHELL': '/bin/bash', 10:02:18 INFO - 'SHLVL': '1', 10:02:18 INFO - 'TERM': 'linux', 10:02:18 INFO - 'TMOUT': '86400', 10:02:18 INFO - 'USER': 'cltbld', 10:02:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:18 INFO - '_': '/tools/buildbot/bin/python'} 10:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:19 INFO - Running setup.py (path:/tmp/pip-0nEGW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:19 INFO - Running setup.py (path:/tmp/pip-BXzamC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:19 INFO - Running setup.py (path:/tmp/pip-fBHc_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:19 INFO - Running setup.py (path:/tmp/pip-77VGx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:19 INFO - Running setup.py (path:/tmp/pip-6Neur7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:19 INFO - Running setup.py (path:/tmp/pip-teSUYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:19 INFO - Running setup.py (path:/tmp/pip-dOcnyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:19 INFO - Running setup.py (path:/tmp/pip-wVZv7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:19 INFO - Running setup.py (path:/tmp/pip-ra7Vkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:19 INFO - Running setup.py (path:/tmp/pip-hLTPwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:19 INFO - Running setup.py (path:/tmp/pip-YG4Pxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:19 INFO - Running setup.py (path:/tmp/pip-Pmle5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:20 INFO - Running setup.py (path:/tmp/pip-d5E0fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:20 INFO - Running setup.py (path:/tmp/pip-wdYd_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:20 INFO - Running setup.py (path:/tmp/pip-m86XwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:20 INFO - Running setup.py (path:/tmp/pip-h0Fc01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:20 INFO - Running setup.py (path:/tmp/pip-7TOMz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:20 INFO - Running setup.py install for manifestparser 10:02:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:20 INFO - Running setup.py install for mozcrash 10:02:20 INFO - Running setup.py install for mozdebug 10:02:20 INFO - Running setup.py install for mozdevice 10:02:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:02:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:20 INFO - Running setup.py install for mozfile 10:02:20 INFO - Running setup.py install for mozhttpd 10:02:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:20 INFO - Running setup.py install for mozinfo 10:02:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Running setup.py install for mozInstall 10:02:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Running setup.py install for mozleak 10:02:21 INFO - Running setup.py install for mozlog 10:02:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Running setup.py install for moznetwork 10:02:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Running setup.py install for mozprocess 10:02:21 INFO - Running setup.py install for mozprofile 10:02:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Running setup.py install for mozrunner 10:02:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:21 INFO - Running setup.py install for mozscreenshot 10:02:21 INFO - Running setup.py install for moztest 10:02:22 INFO - Running setup.py install for mozversion 10:02:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:22 INFO - Cleaning up... 10:02:22 INFO - Return code: 0 10:02:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:22 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 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:22 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 10:02:22 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 10:02:22 INFO - Using env: {'DISPLAY': ':0', 10:02:22 INFO - 'HOME': '/home/cltbld', 10:02:22 INFO - 'LANG': 'en_US.UTF-8', 10:02:22 INFO - 'LANGUAGE': 'en_US:en', 10:02:22 INFO - 'LOGNAME': 'cltbld', 10:02:22 INFO - 'MAIL': '/var/mail/cltbld', 10:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:22 INFO - 'MOZ_NO_REMOTE': '1', 10:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:22 INFO - 'NO_EM_RESTART': '1', 10:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:22 INFO - 'PWD': '/builds/slave/test', 10:02:22 INFO - 'SHELL': '/bin/bash', 10:02:22 INFO - 'SHLVL': '1', 10:02:22 INFO - 'TERM': 'linux', 10:02:22 INFO - 'TMOUT': '86400', 10:02:22 INFO - 'USER': 'cltbld', 10:02:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:22 INFO - '_': '/tools/buildbot/bin/python'} 10:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:22 INFO - Running setup.py (path:/tmp/pip-PkOzd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:22 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)) 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:22 INFO - Running setup.py (path:/tmp/pip-n_BDZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:22 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)) 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:22 INFO - Running setup.py (path:/tmp/pip-s_Wl7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:22 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)) 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:22 INFO - Running setup.py (path:/tmp/pip-ce6a3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:22 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)) 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:22 INFO - Running setup.py (path:/tmp/pip-gaRALc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:22 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)) 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:22 INFO - Running setup.py (path:/tmp/pip-j_MjRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:22 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)) 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:22 INFO - Running setup.py (path:/tmp/pip-_tqjlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:22 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)) 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:22 INFO - Running setup.py (path:/tmp/pip-e6tPz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:22 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)) 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:22 INFO - Running setup.py (path:/tmp/pip-4Dg3EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:23 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)) 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:23 INFO - Running setup.py (path:/tmp/pip-G3yjVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:23 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)) 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:23 INFO - Running setup.py (path:/tmp/pip-pW1T8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:23 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)) 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:23 INFO - Running setup.py (path:/tmp/pip-wtVyE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:23 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)) 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:23 INFO - Running setup.py (path:/tmp/pip-RlB7Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:23 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)) 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:23 INFO - Running setup.py (path:/tmp/pip-GE1Lqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:23 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)) 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:23 INFO - Running setup.py (path:/tmp/pip-Z2IFhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:23 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)) 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:23 INFO - Running setup.py (path:/tmp/pip-x9wiaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:23 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)) 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:23 INFO - Running setup.py (path:/tmp/pip-6gW7wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:23 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)) 10:02:23 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)) 10:02:23 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)) 10:02:23 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)) 10:02:23 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)) 10:02:23 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)) 10:02:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:23 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 10:02:23 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 10:02:23 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 10:02:23 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 10:02:23 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 10:02:23 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 10:02:25 INFO - Downloading blessings-1.6.tar.gz 10:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:25 INFO - Installing collected packages: blessings 10:02:25 INFO - Running setup.py install for blessings 10:02:25 INFO - Successfully installed blessings 10:02:25 INFO - Cleaning up... 10:02:25 INFO - Return code: 0 10:02:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:26 INFO - Reading from file tmpfile_stdout 10:02:26 INFO - Current package versions: 10:02:26 INFO - argparse == 1.2.1 10:02:26 INFO - blessings == 1.6 10:02:26 INFO - blobuploader == 1.2.4 10:02:26 INFO - docopt == 0.6.1 10:02:26 INFO - functools32 == 3.2.3-2 10:02:26 INFO - jsonschema == 2.5.1 10:02:26 INFO - manifestparser == 1.1 10:02:26 INFO - mozInstall == 1.12 10:02:26 INFO - mozcrash == 1.0 10:02:26 INFO - mozdebug == 0.1 10:02:26 INFO - mozdevice == 0.49 10:02:26 INFO - mozfile == 1.2 10:02:26 INFO - mozhttpd == 0.7 10:02:26 INFO - mozinfo == 0.9 10:02:26 INFO - mozleak == 0.1 10:02:26 INFO - mozlog == 3.4 10:02:26 INFO - moznetwork == 0.27 10:02:26 INFO - mozprocess == 0.23 10:02:26 INFO - mozprofile == 0.28 10:02:26 INFO - mozrunner == 6.13 10:02:26 INFO - mozscreenshot == 0.1 10:02:26 INFO - mozsystemmonitor == 0.3 10:02:26 INFO - moztest == 0.7 10:02:26 INFO - mozversion == 1.4 10:02:26 INFO - psutil == 3.1.1 10:02:26 INFO - requests == 1.2.3 10:02:26 INFO - wsgiref == 0.1.2 10:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:26 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 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:26 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 10:02:26 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 10:02:26 INFO - Using env: {'DISPLAY': ':0', 10:02:26 INFO - 'HOME': '/home/cltbld', 10:02:26 INFO - 'LANG': 'en_US.UTF-8', 10:02:26 INFO - 'LANGUAGE': 'en_US:en', 10:02:26 INFO - 'LOGNAME': 'cltbld', 10:02:26 INFO - 'MAIL': '/var/mail/cltbld', 10:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:26 INFO - 'MOZ_NO_REMOTE': '1', 10:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:26 INFO - 'NO_EM_RESTART': '1', 10:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:26 INFO - 'PWD': '/builds/slave/test', 10:02:26 INFO - 'SHELL': '/bin/bash', 10:02:26 INFO - 'SHLVL': '1', 10:02:26 INFO - 'TERM': 'linux', 10:02:26 INFO - 'TMOUT': '86400', 10:02:26 INFO - 'USER': 'cltbld', 10:02:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:26 INFO - '_': '/tools/buildbot/bin/python'} 10:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 INFO - Cleaning up... 10:02:26 INFO - Return code: 0 10:02:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75981aae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, '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': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', '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 10:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:02:26 INFO - Using env: {'DISPLAY': ':0', 10:02:26 INFO - 'HOME': '/home/cltbld', 10:02:26 INFO - 'LANG': 'en_US.UTF-8', 10:02:26 INFO - 'LANGUAGE': 'en_US:en', 10:02:26 INFO - 'LOGNAME': 'cltbld', 10:02:26 INFO - 'MAIL': '/var/mail/cltbld', 10:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:26 INFO - 'MOZ_NO_REMOTE': '1', 10:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:26 INFO - 'NO_EM_RESTART': '1', 10:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:26 INFO - 'PWD': '/builds/slave/test', 10:02:26 INFO - 'SHELL': '/bin/bash', 10:02:26 INFO - 'SHLVL': '1', 10:02:26 INFO - 'TERM': 'linux', 10:02:26 INFO - 'TMOUT': '86400', 10:02:26 INFO - 'USER': 'cltbld', 10:02:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:26 INFO - '_': '/tools/buildbot/bin/python'} 10:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:26 INFO - Cleaning up... 10:02:26 INFO - Return code: 0 10:02:26 INFO - Running post-action listener: _resource_record_post_action 10:02:26 INFO - Running post-action listener: _start_resource_monitoring 10:02:26 INFO - Starting resource monitoring. 10:02:26 INFO - [mozharness: 2016-12-08 18:02:26.566827Z] Finished create-virtualenv step (success) 10:02:26 INFO - [mozharness: 2016-12-08 18:02:26.567361Z] Running install step. 10:02:26 INFO - Running pre-action listener: _resource_record_pre_action 10:02:26 INFO - Running main action method: install 10:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:26 INFO - Reading from file tmpfile_stdout 10:02:26 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:26 INFO - Reading from file tmpfile_stdout 10:02:26 INFO - Output received: 10:02:26 INFO - Usage: mozinstall [options] installer 10:02:26 INFO - Options: 10:02:26 INFO - -h, --help show this help message and exit 10:02:26 INFO - -d DEST, --destination=DEST 10:02:26 INFO - Directory to install application into. [default: 10:02:26 INFO - "/builds/slave/test"] 10:02:26 INFO - --app=APP Application being installed. [default: firefox] 10:02:26 INFO - mkdir: /builds/slave/test/build/application 10:02:26 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'] 10:02:26 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 10:02:42 INFO - Reading from file tmpfile_stdout 10:02:42 INFO - Output received: 10:02:42 INFO - /builds/slave/test/build/application/firefox/firefox 10:02:42 INFO - Running post-action listener: _resource_record_post_action 10:02:42 INFO - [mozharness: 2016-12-08 18:02:42.922608Z] Finished install step (success) 10:02:42 INFO - [mozharness: 2016-12-08 18:02:42.922848Z] Running run-tests step. 10:02:42 INFO - Running pre-action listener: _resource_record_pre_action 10:02:42 INFO - Running main action method: run_tests 10:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:02:42 INFO - Python 2.7.3 10:02:42 INFO - Return code: 0 10:02:42 INFO - grabbing minidump binary from tooltool 10:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:42 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 0x290ef20>, '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 0x287bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:02:42 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 10:02:42 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 10:02:42 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 10:02:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:43 INFO - Return code: 0 10:02:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:02:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:02:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:02:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:02:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:02:43 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/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:02:43 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/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 10:02:43 INFO - Using env: {'DISPLAY': ':0', 10:02:43 INFO - 'HOME': '/home/cltbld', 10:02:43 INFO - 'LANG': 'en_US.UTF-8', 10:02:43 INFO - 'LANGUAGE': 'en_US:en', 10:02:43 INFO - 'LOGNAME': 'cltbld', 10:02:43 INFO - 'MAIL': '/var/mail/cltbld', 10:02:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:02:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:43 INFO - 'MOZ_NO_REMOTE': '1', 10:02:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:43 INFO - 'NO_EM_RESTART': '1', 10:02:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:43 INFO - 'PWD': '/builds/slave/test', 10:02:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:02:43 INFO - 'SHELL': '/bin/bash', 10:02:43 INFO - 'SHLVL': '1', 10:02:43 INFO - 'TERM': 'linux', 10:02:43 INFO - 'TMOUT': '86400', 10:02:43 INFO - 'USER': 'cltbld', 10:02:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006', 10:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:43 INFO - '_': '/tools/buildbot/bin/python'} 10:02:43 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/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:02:43 INFO - mozversion application_buildid: 20161208091456 10:02:43 INFO - mozversion application_changeset: ed2fa5b96829ae548df302f29920f47a39a80234 10:02:43 INFO - mozversion application_display_name: Nightly 10:02:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:43 INFO - mozversion application_name: Firefox 10:02:43 INFO - mozversion application_remotingname: firefox 10:02:43 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 10:02:43 INFO - mozversion application_vendor: Mozilla 10:02:43 INFO - mozversion application_version: 53.0a1 10:02:43 INFO - mozversion platform_buildid: 20161208091456 10:02:43 INFO - mozversion platform_changeset: ed2fa5b96829ae548df302f29920f47a39a80234 10:02:43 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 10:02:43 INFO - mozversion platform_version: 53.0a1 10:02:43 INFO - using testdate: 1481220163 10:02:43 INFO - actual date: 1481220163 10:02:43 INFO - starting webserver on 'localhost:44011' 10:02:43 INFO - SUITE-START | Running 2 tests 10:02:43 INFO - TEST-START | dromaeo_css 10:02:43 INFO - operating with platform_type : linux_ 10:02:43 INFO - Initialising browser for dromaeo_css test... 10:02:43 INFO - TEST-INFO | started process 28025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxuBd95/profile http://localhost:44011/getInfo.html) 10:02:47 INFO - PROCESS | 28025 | __metrics Screen width/height:1600/1200 10:02:47 INFO - PROCESS | 28025 | colorDepth:24 10:02:47 INFO - PROCESS | 28025 | Browser inner width/height: 1024/697 10:02:47 INFO - PROCESS | 28025 | __metrics 10:02:48 INFO - PROCESS | 28025 | 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" 10:02:48 INFO - PROCESS | 28025 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:02:48 INFO - PROCESS | 28025 | console.error: PushService: 10:02:48 INFO - PROCESS | 28025 | stateChangeProcessEnqueue: Error transitioning state 10:02:48 INFO - PROCESS | 28025 | UnknownError 10:02:49 INFO - TEST-INFO | 28025: exit 0 10:02:49 INFO - Browser initialized. 10:02:49 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:49 INFO - TEST-INFO | started process 28109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxuBd95/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:01 INFO - PROCESS | 28109 | RSS: Main: 173367296 10:03:01 INFO - PROCESS | 28109 | 10:03:53 INFO - PROCESS | 28109 | 1481220233024 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] 10:06:06 INFO - PROCESS | 28109 | Cycle 1(1): loaded http://localhost:44011/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44011/tests/dromaeo/cssquery-ext.html) 10:06:08 INFO - PROCESS | 28109 | RSS: Main: 321232896 10:06:08 INFO - PROCESS | 28109 | 10:09:11 INFO - PROCESS | 28109 | Cycle 1(1): loaded http://localhost:44011/tests/dromaeo/cssquery-ext.html (next: http://localhost:44011/tests/dromaeo/cssquery-jquery.html) 10:09:11 INFO - PROCESS | 28109 | RSS: Main: 281853952 10:09:11 INFO - PROCESS | 28109 | 10:12:14 INFO - PROCESS | 28109 | Cycle 1(1): loaded http://localhost:44011/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44011/tests/dromaeo/cssquery-mootools.html) 10:12:14 INFO - PROCESS | 28109 | RSS: Main: 267132928 10:12:14 INFO - PROCESS | 28109 | 10:15:17 INFO - PROCESS | 28109 | Cycle 1(1): loaded http://localhost:44011/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44011/tests/dromaeo/cssquery-prototype.html) 10:15:17 INFO - PROCESS | 28109 | RSS: Main: 222519296 10:15:17 INFO - PROCESS | 28109 | 10:18:20 INFO - PROCESS | 28109 | Cycle 1(1): loaded http://localhost:44011/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44011/tests/dromaeo/cssquery-yui.html) 10:18:21 INFO - PROCESS | 28109 | RSS: Main: 222867456 10:18:21 INFO - PROCESS | 28109 | 10:21:24 INFO - PROCESS | 28109 | Cycle 1(1): loaded http://localhost:44011/tests/dromaeo/cssquery-yui.html (next: http://localhost:44011/tests/dromaeo/cssquery-dojo.html) 10:21:25 INFO - PROCESS | 28109 | RSS: Main: 313503744 10:21:25 INFO - PROCESS | 28109 | 10:21:25 INFO - PROCESS | 28109 | __start_tp_report 10:21:25 INFO - PROCESS | 28109 | _x_x_mozilla_page_load 10:21:25 INFO - PROCESS | 28109 | _x_x_mozilla_page_load_details 10:21:25 INFO - PROCESS | 28109 | |i|pagename|runs| 10:21:25 INFO - PROCESS | 28109 | |0;dojo.html;2577.819552631316;2619.410632607662;2643.1806140096564;2653.946921061579;2663.9866800666005;4566.611837993774;4635.930461043087;4722.7874745636445;4726.14929312724;4755.096531658983;4681.789319480623;4683.180443422396;4683.367745354376;4690.390249267599;4700.811967521304;4292.120115376348;4316.525182229968;4322.84870029549;4344.522102568715;4348.195583816988;4309.525952145262;4357.978210108945;4359.149965756678;4368.628666563346;4377.562243775629;4352.825886964518;4356.085222103362;4371.213181627306;4373.365861950016;4411.294192929132;4425.867223983286;4435.046465010038;4439.600435960747;4440.600345968846;4442.444694413199;4250.298700714378;4287.6141147296585;4319.179355922396;4333.674974376903;4382.53983331752;4659.464161621389;4659.743714095724;4665.813367465297;4706.058788242331;4706.411698537683;5028.974855125701;5059.721715305656;5075.847724568232;5085.974570127163;5125;4903.901921961577;4950.628702847301;5088.084144853925;5100.795968161269;5138.3577052868395;4666.883327916796;4698.694584851974;4719.95280047202;4725.527447255247;4789.042191561702;5173.301604283449;5179.870503237374;5181.1969144782615;5183.867318512278;5197.948020519822;4991.251312303184;4992.500749925051;4998.02538504988;4998.300237966688;5039.546440820343;4911.115999120121;4938.1358262304675;4953.380827396575;4995.650304478724;5007.574356179693;5004.199328107486;5022.42242142151;5053.54518093366;5058.140116180258;5071.54356107952;4958.776855041459;4994.575461085776;5004.3494345734825;5010.874728131826;5054.368203974504;4103.199876024206;4164.271252530795;4165.500139983222;4261.509926358446;4271.124419493996;3697.8890633281044;3699.2416554606243;3707.443883417455;3716.163863130828;3740.831662575191;4265.214453233697;4269.124829409963;4270.44484217056;4301.225779359683;4307.806148723315;4873.41519017713;5024.2463630454995;5029.5221953914315;5033.421156566968;5086.92369614456;4166.895827604273;4225.767582782915;4254.064105896698;4256.4679415073115;4268.317069268902;4543.409356783597;4545.863624091283;4548.522405147478;4577.931331030038;4587.8623641290815;4734.26618874075;4739.289106634033;4741.596964258077;4749.216379297377;4787.281907713732;4906.018796240694;4954.950450495449;4957.256411538298;4996.450390457119;5062.265971434195;4713.3401323814005;4741.478437371955;4744.928826067543;4749.002709431058;4788.856334309976;4986.301917731593;4993.425756038102;4995.675281106716;4996.975015124901;5043.193089105725;4870.09903167915;4925.261210818406;5044.041632090038;5049;5092.007058623532;4821.445533763522;4837.395325584302;4870.1233777920315;4870.707757534559;4897.191963326011;4806.375171227718;4827.275908613736;4834.492378300228;4876.4392094909535;4882.218844984785;4772.141014617263;4773.498782627774;4774.761261936958;4775.33145359643;4806.975965120152;4762.738049407316;4827.662063655511;4829.203181475017;4888.755562221803;4953.925691114564;4760.309755085563;4797.688150270221;4798.664093513421;4810.11012962603;4860.562549370574 10:21:25 INFO - PROCESS | 28109 | |1;ext.html;561.9606627536073;565.3074983145647;566.7477972302327;591.5947575910499;595.8927393069246;27147.18558443245;37391.4391284131;38620.42069368955;38688;42953.57046429535;38712;39114.21771564567;39142.21715565687;39167.804160979154;39246;7496.737614183518;7647.961760191191;7659.770206893802;7713.305802477776;7717.536947783151;7436.256374362574;7629.8474030519355;9640.325177237597;9869.161121304662;9872.111509964101;9392.248620110375;9397.483138427384;9401.952990235039;9402.952985235064;9410.43537387759;9882.703518894445;9945.40327580344;9959.75100622483;9959.850602240973;9976.80046399068;9791.118799308097;9818.607255709763;9842.557084931195;9846.9507652462;9847.852282215772;37607.623923760686;37768.62231377706;37844.24311513754;37890.24219515622;37905.431418528744;2699.9730002699916;2805.2566069991467;2805.6492938382703;2928.7364137227537;3159.7946133501478;27847.303817404525;28169;28275;28607.427851443063;29536.8523157385;3389.1865952171547;3487.8576222316074;3532;3564.429691249388;3577.6422357764277;234126;234258;235543;235568;236337.81831090906;52283.47716522786;52774.20838687423;52828.47171528312;52831.207531887056;52865.735671321396;55496.445035549936;55599;55685.443145568024;55835.72082139645;56035.43964560384;12154.756904861853;12331.876681233252;12349.135560510858;12349.876501235052;12352.197107188003;8203.507789532647;9104.180623743894;9131.863022054675;9165.679201227926;9181.127792859668;14711.55865324042;16910.661786764194;17307.3077076918;17406.91296543509;17860.464186074438;6531.804045878631;6629.939114842773;6701.664916754143;6713.932860671429;6777.220619628707;738.471992525347;822.8025273934333;844.4848642328175;848.2323497235012;934.4346670264392;26972.865135674587;26998.730012700016;27338.179854604394;27538;27629.171124866287;893.6068130022769;895.2435192262528;911.380261422226;928.1831987850649;1003.0120331473493;14147.43410263578;14743.483978060716;14747.631309217355;14877.925610371878;15013.324400402009;114979.42510287395;115637.4218128904;115717;115960;116009.4199528997;45133.77433112814;46409.30386044212;46827.531724683;48152;48208.27687584689;1027.8047171037479;1127.808272593661;1157.2362240920952;1157.346099453806;1159.8782127876789;26849.597256040783;27912.30219244535;28264;28573.28566785847;28682.856585716938;41157;41507.37738933979;41559.376609351486;41578.58421415747;41602.375964359955;295162;295950;296444;296575;296859;24834.50330993406;25173.87413062923;25298.74701252964;25363.239102826945;25363.746362536138;39837.60162398339;40430.393544096274;40457.1908561833;40549.79725101356;41658.37512437255;34821.651783482856;35215.06317152581;35291.470627940085;35360;35673;34432.48351274783;34809.82595087009;34844.82577587197;34854.82572587222;35401.29197415986;34238;34593.65406346005;35262.11844703903;35338.46992295066;35507.82246088753;29539;32002.67997319997;32331.515027274138;32494.51258231081;32501;24458.877705611358;24459.633105503075;24601.261962141165;24994.37514062163;25065.373365665273 10:21:25 INFO - PROCESS | 28109 | |2;jquery.html;345.12166536165455;365.1546669460199;374.3729253500387;384.5558380071017;393.17825744194647;11829;11870.16908816382;12542.686432839184;15112.093274403516;15726.764098538502;13728.450861965533;14054;15767.684646307067;15941.920290398532;16054.678906421865;4956.157453232941;4963.379577552797;5132.948670513284;5177.715225662587;5190.221466779994;3641.6540428659237;5072.137736584771;5133.794648214067;5164.819231326905;5167.044096842077;3803.581606023335;5674.858128546799;5927.644341339512;5930.584859059867;6031.547633927473;5803.506701930341;5940.762369505214;6018.518518518508;6025.578209525335;6026.427489388479;5272.05103081449;5272.578193744491;5274.446183150752;5274.815381461669;5275.947240527584;19275.22899084035;19573.902130489256;19923.20307187711;20105.29631462892;20149;1807.8644101692425;1859.0797555210258;1864.7482589850333;1950.8731932424348;2176.967345489819;8753.212210901049;8946.731598052069;8958.23854972328;9058.637654493812;9217.124373184537;1608.5898095985565;1669.0820048973017;1672.7741754863182;1741.3992172700398;1766.814484479124;65453.672731636034;65595;65881;66360.3363966359;66506.3349366505;9348.53257337144;9542.141207291377;9713.320067595201;9716.465594392235;9983.45284059571;13800;13847.584572462842;13848.93075534636;13854.445822167001;13854.445822167001;6571.737130514822;6584.934150658432;6749.763758268536;6761.154855643044;6832.180138383326;6034.1853849730605;6047.969760151171;6150.108234306001;6186.536009799283;6192.907106393408;4101.692373072032;4106.753594784323;4248.830046798155;4337.82648694055;4340.958170039231;1722.8277172282922;1725.810160882302;1782.2603619498022;1798.9820101799075;1815.7730283714536;793.3415265329762;803.722081889798;840.4663038970298;851.2381418630291;897.6768363389175;15718.21408929549;16639.41762038323;16913.154342282836;17045.306893484165;17217;844.8310337932315;856.9657213711506;866.5104216117874;884.1070518776082;945.4091193004373;8783.814185085059;9309.95345023284;9328.253739700807;9398.342116051948;9565.808683826284;309759;324132;327423;337154;339757.01214939647;50535;52740.472595274325;80246.7531169076;82580.58709706413;82856.58571707102;923.1783712495884;939.1782190583376;963.012911765432;963.2294164668237;969.1471505075489;15142;15222.771658425354;15652.982556133815;15872.920635397211;16031.919840400724;29137.85431072831;33218;33773.66226337705;35287.29425411426;37078.8146059268;50566.2415063767;50587.49412505975;51198.48801511937;51358.48641513537;51473.22790158226;7272;7439.218882017527;7660.195679453577;7710.11333696632;7812.101608314889;11522.82715759281;11583.07335413148;12442.813357799821;12449.875501245235;12503.17788689186;10204.642837500653;10332.431716255678;10339.896601033894;10370.585176592851;11092.112630989663;10171.542280597243;10258.692239232834;10338.276320657782;10346.741331466472;10420.47897605132;10565;10787.406692631981;10795.596572445531;10831.67504974852;10844.837327440253;7570.091589009354;7653.693852245848;7678.577678227751;7689.730859419893;8008.799780005546;8718.60766265507;10042.899571004196;10511.316764410289;10740.677779666623;11055.889441105486 10:21:25 INFO - PROCESS | 28109 | |3;mootools.html;1164.3770582738236;1246.97506049879;1251.393074358936;1305.2233920817112;1624.6019725167328;5876.941230587693;6479.157709497765;6597;6649.8005059848165;6793.864122717555;6647.966760166204;6684.598924064548;6691;6693.899591506131;6711;1746.8864523805912;2002.4192984034612;2050.456628993318;2052.9794702052936;2054.794520547948;1803.0804289812158;2007.7992200779952;2069.037897377719;2070.2340134150386;2087.9060442280056;2006.0571531380301;2015.7581090269189;2016.4353980885376;2018.5861898310811;2020.7878172791866;1957.354073155855;1996.4310171601169;1997.0414201183369;1998.5003749062735;1999.3502111813718;1966.3216190414284;1973.2994786850747;1991.7012448132896;2021.4036859126593;2023.0997206243228;6573.276939536647;6788.898166527457;6910.101686780737;6915.4121899638085;6917.550359226634;4069.267531844267;4176.770277634729;4182.330827067654;4187.8324867005285;4190.182914331706;2581;2795.51078561253;2849.786266030056;2854.9714502854913;2870.138958312498;886.1962689504873;917.1928702741611;929.8558723397884;937.6155776131753;951.4434056077204;8861.778455538599;8906.643734250687;8964.462132272085;8969.910300896972;8990.460572365679;3723.3617208428204;3852.614738526125;3931.233409485123;3948.0919388540797;3961.980190099031;7793.415493837985;7800.297973182441;7804.804879878048;7807.609619519001;7807.765767026998;4198.160367926366;4204.831806727758;4207.621314081747;4209.137126888981;4211.705180637326;3361.09250502363;3428.9828550857087;3804.6005169456807;3805.46723458716;3813.1801662642665;3051.1304278281027;3126.3590963852357;3407.7103446206856;3416.367971925202;3487.9476807847905;1141.868685101224;1176.1531697178018;1180.2033627301537;1191.065013964034;1206.7526157137765;708.7271400510738;714.242902523327;729.2051663686607;755.1806290175222;757.8711619024779;4588.902490818684;4674.742889141062;4678.836240731626;4757.643176761757;4774.785134668949;385.58549559223945;395.8594698881913;397.4138146234339;399.22550252510035;408.3384916435334;3138.1997590614706;3157.9684203158135;3171.413288541627;3195.568598239208;3330.3505816365578;7860.685572577033;7963.6814527418255;8162.102168761431;8202.876956845652;8237.135100814448;8122.268995790408;8130.3495720342235;8132.918670813335;8133.59332033396;8137.511749295061;6058.394160583906;6244.781432649836;6289.402506761941;6384.106225128393;6461.353864613501;4811.206150985048;4858.562729354375;4883.437300064087;4890.266460031024;4967;7487.064116985377;7496.137944136276;7496.287852653989;7512;7523.3229009389415;7245.818854528679;7526.736564220226;7527.962360188164;7558.055243094614;7672.5012874163;5651.180578816131;5771.076627739541;5788.652680839163;5793.015187418065;5800.100984347433;5617;5822.155787410887;5966.791162309299;6096.237970253718;6158.107074474266;5847.181394604844;5894.70526473666;5910.911336329872;5921.467067963904;5938.465538101592;5809.331926828469;5811.883762324645;5829.358770535153;5903.144044113494;5997.790077347272;5122.974385128051;5174.560162386239;5237.685738855681;5324.334458192726;5374.919376209438;4048.7773172475795;4050.5949405060437;4088.836446542224;4104.548499664975;4106.3635136553885;4006.8196931137586;4074.8777536673947;4086.366613174963;4133.3879786883745;4308.569143085666 10:21:25 INFO - PROCESS | 28109 | |4;prototype.html;291.9095080525037;296.3968324459725;300.7804302858914;303.36445147416157;305.6469777407093;4792.808287668493;4853.077915196111;4858.34412354332;4862.173430516812;4884.38945131859;4730.219513780222;4734.90530189396;4750.619950403968;4772.761361931907;4793.760311984404;3544.556930383702;3653.378925582644;3692.593814680383;3716.4425336199515;3754.042719106624;3739.5325584301963;3760.6051364606733;3762.6613604775566;3767.3030489359558;3774.2262836118666;3725.1245957200035;3749.4938183345307;3751.4372844073337;3768.453574231735;3774.0942173878207;3569.5716514018486;3580.4629305604108;3690.298843219793;3729.5151630287887;3737.177820879402;3293.604767427924;3302.8440045983953;3303.884364047247;3307.074019274607;3320.5517255170485;4598.356230127785;4607.562281583244;4629.421322334708;4629.930551041737;4638.536146385368;4073.3279008963486;4216.51510076339;4261.701680882339;4282.935755963663;4298.613124818781;4929.556339929388;4946.848121067312;4948.628852836052;4963.478834722338;4970.353853998993;3615.403458429382;3617.607221219823;3618.9685939507112;3621.2214373909474;3627.836747346376;5108.182690769459;5193.662851716705;5219.582433405357;5231.163013917755;5279.419263880932;3678.779273243614;3700.611435799256;3702.4816525686424;3704.5369328833895;3723.106454450912;3745.8949609865153;3751.4560388744026;3759.248150369937;3766.3408903441787;3775.6224377562025;4247.5752424757275;4254.893627659271;4263.552327005682;4273.594008569181;4284.528701842794;4857.125717370907;4956.330895329156;5002.049610573979;5025.698458092526;5077.771500282496;1245.4644502863855;1249.325364303266;1252.5929073051295;1253.3607859991287;1258.5091814192472;824.6000689665508;862.3575436299997;862.9352798540135;863.7149740585592;867.3538214030461;4174.269502837052;4215.178040282177;4233.30150525166;4257.829686812554;4336.6530677545725;5095.490450954949;5125.923111153335;5132.28148059272;5145.382554093533;5158.845234642967;4320.891977700519;4339.631131353807;4344.587264209895;4356.847510337123;4359.346098085312;2556.57816460282;2634.459935713174;2634.8287361321454;2647.907323243716;2649.894004239847;4693.225617773098;4704.717716936994;4706.835260765857;4706.929396059062;4725.291206319011;5070.188769796889;5112.974435127875;5135.998480296306;5145.742712864342;5171.534561889448;4426.336049592523;4654.232051711498;4668.626509879202;4680.976595117003;4688.320193571981;4977.253411988086;4984.675996060245;5005.899882002413;5020.748962551931;5023.6985780853265;4941.308216849716;4943.728094954812;4963.305137280856;4970.254461830755;4990.251462280687;4589.219832628528;4653.580657899373;4868.2940973557925;4887.682300650446;4888.095702295087;3612.151144480992;3622.3298689742483;3622.7645203061716;3631;3633.182533929845;5205.895882082413;5210.374755029421;5221.869453263699;5226.686398816083;5235.293235413171;4930.186519224288;5008.9248661269385;5015.1975683890405;5046.99703676312;5079.136546787129;4962.33008543842;4989.850304490871;5002.624803139852;5014.749262536931;5041.798328066836;4972.925406118983;4977.377827771528;4984.177610694195;4993.550580447777;4997.125503037027;4752.334673145831;4898;5080.542751152414;5104.642675012714;5126.231065340229;4751.334813126235;4791.185498465339;4917.442929676619;4922.827701030446;4934.111859865116 10:21:25 INFO - PROCESS | 28109 | |5;yui.html;591.5365534793782;607.747784669362;650.4081286029714;676.3338111959721;684.2063206680249;11972.521099156034;14108.365123569438;14686.118832870035;14799.852001479981;14864.777028344584;14271.143731376098;14279.21464319462;14510.201938893357;14674.413023479075;15009.32458039388;743.2456057102046;763.526613499631;765.2615226306613;765.5712800831552;765.6401491299081;602.8944934636443;629.9275583307932;737.2553720742036;758.7723682895137;762.8550575390658;802.430274505102;802.6027116577302;803.0564087197549;804.6298702596813;805.1867613710166;797.6330887791594;801.1507801730185;801.5070731500115;801.7795106345743;802.4783890471182;462.20962154715477;478.7103802199654;557.275541795664;574.704027425876;585.2304219950794;13329.533466328729;13439.932800335935;13445;13461.259630720306;13471.663208419868;11921.225120367148;12237.877621223763;12260.81608775869;12444.191127576678;12683.873161268362;11051.17116216279;11080;11169.776604467947;11496.31022138666;11708;4037.6164264394833;4116.938245926313;4190.308599081148;4259.169461954889;4260.850870219559;63795.36204637941;64660.35339646637;65485;65635.3436465634;68008;9992.350497217658;10072;10152.543135558917;10297.07326340633;10357.948210259052;18443.17005734745;19074.2370305189;19224.71162932557;19335;19361;6406.67966601668;6545.509086818508;6709.087909945642;6742.460603151736;6869.656517174221;3665.52348194733;3706.6664000240107;3741.4948981887096;3748.8687895923513;3886.3198940185353;2712.0643378034547;2910.083323753011;3020.2600362911226;3022.9244268893012;3050.145959131447;504.33176041744105;517.891242839008;528.7541293298558;535.6330913324385;539.719345940109;530.8062557166684;546.1289243656362;552.7484994327572;566.9886602267932;572.1960645293369;7325.340719335285;7412.295831895961;7453.962730186423;8086.312663423675;8095.797605059921;439.05602953649907;454.856720133157;518.0623072239259;526.2080568744092;535.4377903201623;3770.1328694399895;3884.1260716338597;4129.256733787947;4306.89232769177;4390.912181756347;53994;68765.65617171882;71777.28222717706;72678.2732172682;72876.27123728694;50104.749476252386;57670;57914;58706;58822.41177588255;42997.785011074746;46091.30863037057;50945.98108037819;53376;54084.459155407945;7687.308697830707;8095.55474448911;8119.431639785158;8325.666973321242;8391.244787969112;33058.669413306525;38189.2362152761;38425.23149536938;38583.61416385912;39176;47870;48262.75868620775;49212.75393623009;49748.25377619411;49779;11365.886341136813;11415.543378264776;11556.324332971504;11615.419229038684;12056.397180141134;13394.665133371744;13436.865631343953;13654.93172534131;14208.431662733788;14268.072575282573;11410.885891140982;11539.5961141363;11552.711182220175;11920.165588408729;12036.338001410006;10945.507452164513;11376.886231137583;11440.313581185155;11515.078793696652;11537.769244615229;10665.733356666145;11454.370009649549;11485.425728713699;11485.712857178638;11898.107641927063;9561.235101191749;9876.604935802774;10006.145176037067;10025.498725063571;10202.948985255027;8903.421277616933;9158.175764181256;9366.344355895022;9479.620815167593;10050.89949100529 10:21:25 INFO - PROCESS | 28109 | __end_tp_report 10:21:25 INFO - PROCESS | 28109 | __start_cc_report 10:21:25 INFO - PROCESS | 28109 | _x_x_mozilla_cycle_collect,1519 10:21:25 INFO - PROCESS | 28109 | __end_cc_report 10:21:25 INFO - PROCESS | 28109 | __startTimestamp1481221284999__endTimestamp 10:21:25 INFO - PROCESS | 28109 | 10:21:25 INFO - PROCESS | 28109 | ------- Summary: start ------- 10:21:25 INFO - PROCESS | 28109 | Number of tests: 6 10:21:25 INFO - PROCESS | 28109 | 10:21:25 INFO - PROCESS | 28109 | [#0] dojo.html Cycles:165 Average:4639.97 Median:4760.31 stddev:485.85 (10.2%) stddev-sans-first:459.63 10:21:25 INFO - PROCESS | 28109 | Values: 2577.8 2619.4 2643.2 2653.9 2664.0 4566.6 4635.9 4722.8 4726.1 4755.1 4681.8 4683.2 4683.4 4690.4 4700.8 4292.1 4316.5 4322.8 4344.5 4348.2 4309.5 4358.0 4359.1 4368.6 4377.6 4352.8 4356.1 4371.2 4373.4 4411.3 4425.9 4435.0 4439.6 4440.6 4442.4 4250.3 4287.6 4319.2 4333.7 4382.5 4659.5 4659.7 4665.8 4706.1 4706.4 5029.0 5059.7 5075.8 5086.0 5125.0 4903.9 4950.6 5088.1 5100.8 5138.4 4666.9 4698.7 4720.0 4725.5 4789.0 5173.3 5179.9 5181.2 5183.9 5197.9 4991.3 4992.5 4998.0 4998.3 5039.5 4911.1 4938.1 4953.4 4995.7 5007.6 5004.2 5022.4 5053.5 5058.1 5071.5 4958.8 4994.6 5004.3 5010.9 5054.4 4103.2 4164.3 4165.5 4261.5 4271.1 3697.9 3699.2 3707.4 3716.2 3740.8 4265.2 4269.1 4270.4 4301.2 4307.8 4873.4 5024.2 5029.5 5033.4 5086.9 4166.9 4225.8 4254.1 4256.5 4268.3 4543.4 4545.9 4548.5 4577.9 4587.9 4734.3 4739.3 4741.6 4749.2 4787.3 4906.0 4955.0 4957.3 4996.5 5062.3 4713.3 4741.5 4744.9 4749.0 4788.9 4986.3 4993.4 4995.7 4997.0 5043.2 4870.1 4925.3 5044.0 5049.0 5092.0 4821.4 4837.4 4870.1 4870.7 4897.2 4806.4 4827.3 4834.5 4876.4 4882.2 4772.1 4773.5 4774.8 4775.3 4807.0 4762.7 4827.7 4829.2 4888.8 4953.9 4760.3 4797.7 4798.7 4810.1 4860.6 10:21:25 INFO - PROCESS | 28109 | 10:21:25 INFO - PROCESS | 28109 | [#1] ext.html Cycles:180 Average:38445.54 Median:19625.32 stddev:59916.99 (305.3%) stddev-sans-first:60017.56 10:21:25 INFO - PROCESS | 28109 | Values: 562.0 565.3 566.7 591.6 595.9 27147.2 37391.4 38620.4 38688.0 42953.6 38712.0 39114.2 39142.2 39167.8 39246.0 7496.7 7648.0 7659.8 7713.3 7717.5 7436.3 7629.8 9640.3 9869.2 9872.1 9392.2 9397.5 9402.0 9403.0 9410.4 9882.7 9945.4 9959.8 9959.9 9976.8 9791.1 9818.6 9842.6 9847.0 9847.9 37607.6 37768.6 37844.2 37890.2 37905.4 2700.0 2805.3 2805.6 2928.7 3159.8 27847.3 28169.0 28275.0 28607.4 29536.9 3389.2 3487.9 3532.0 3564.4 3577.6 234126.0 234258.0 235543.0 235568.0 236337.8 52283.5 52774.2 52828.5 52831.2 52865.7 55496.4 55599.0 55685.4 55835.7 56035.4 12154.8 12331.9 12349.1 12349.9 12352.2 8203.5 9104.2 9131.9 9165.7 9181.1 14711.6 16910.7 17307.3 17406.9 17860.5 6531.8 6629.9 6701.7 6713.9 6777.2 738.5 822.8 844.5 848.2 934.4 26972.9 26998.7 27338.2 27538.0 27629.2 893.6 895.2 911.4 928.2 1003.0 14147.4 14743.5 14747.6 14877.9 15013.3 114979.4 115637.4 115717.0 115960.0 116009.4 45133.8 46409.3 46827.5 48152.0 48208.3 1027.8 1127.8 1157.2 1157.3 1159.9 26849.6 27912.3 28264.0 28573.3 28682.9 41157.0 41507.4 41559.4 41578.6 41602.4 295162.0 295950.0 296444.0 296575.0 296859.0 24834.5 25173.9 25298.7 25363.2 25363.7 39837.6 40430.4 40457.2 40549.8 41658.4 34821.7 35215.1 35291.5 35360.0 35673.0 34432.5 34809.8 34844.8 34854.8 35401.3 34238.0 34593.7 35262.1 35338.5 35507.8 29539.0 32002.7 32331.5 32494.5 32501.0 24458.9 24459.6 24601.3 24994.4 25065.4 10:21:25 INFO - PROCESS | 28109 | 10:21:25 INFO - PROCESS | 28109 | [#2] jquery.html Cycles:180 Average:21994.08 Median:4648.56 stddev:54407.98 (1170.4%) stddev-sans-first:54536.33 10:21:25 INFO - PROCESS | 28109 | Values: 345.1 365.2 374.4 384.6 393.2 11829.0 11870.2 12542.7 15112.1 15726.8 13728.5 14054.0 15767.7 15941.9 16054.7 4956.2 4963.4 5132.9 5177.7 5190.2 3641.7 5072.1 5133.8 5164.8 5167.0 3803.6 5674.9 5927.6 5930.6 6031.5 5803.5 5940.8 6018.5 6025.6 6026.4 5272.1 5272.6 5274.4 5274.8 5275.9 19275.2 19573.9 19923.2 20105.3 20149.0 1807.9 1859.1 1864.7 1950.9 2177.0 8753.2 8946.7 8958.2 9058.6 9217.1 1608.6 1669.1 1672.8 1741.4 1766.8 65453.7 65595.0 65881.0 66360.3 66506.3 9348.5 9542.1 9713.3 9716.5 9983.5 13800.0 13847.6 13848.9 13854.4 13854.4 6571.7 6584.9 6749.8 6761.2 6832.2 6034.2 6048.0 6150.1 6186.5 6192.9 4101.7 4106.8 4248.8 4337.8 4341.0 1722.8 1725.8 1782.3 1799.0 1815.8 793.3 803.7 840.5 851.2 897.7 15718.2 16639.4 16913.2 17045.3 17217.0 844.8 857.0 866.5 884.1 945.4 8783.8 9310.0 9328.3 9398.3 9565.8 309759.0 324132.0 327423.0 337154.0 339757.0 50535.0 52740.5 80246.8 82580.6 82856.6 923.2 939.2 963.0 963.2 969.1 15142.0 15222.8 15653.0 15872.9 16031.9 29137.9 33218.0 33773.7 35287.3 37078.8 50566.2 50587.5 51198.5 51358.5 51473.2 7272.0 7439.2 7660.2 7710.1 7812.1 11522.8 11583.1 12442.8 12449.9 12503.2 10204.6 10332.4 10339.9 10370.6 11092.1 10171.5 10258.7 10338.3 10346.7 10420.5 10565.0 10787.4 10795.6 10831.7 10844.8 7570.1 7653.7 7678.6 7689.7 8008.8 8718.6 10042.9 10511.3 10740.7 11055.9 10:21:25 INFO - PROCESS | 28109 | 10:21:25 INFO - PROCESS | 28109 | [#3] mootools.html Cycles:180 Average:4457.09 Median:4834.88 stddev:2390.09 (49.4%) stddev-sans-first:2383.98 10:21:25 INFO - PROCESS | 28109 | Values: 1164.4 1247.0 1251.4 1305.2 1624.6 5876.9 6479.2 6597.0 6649.8 6793.9 6648.0 6684.6 6691.0 6693.9 6711.0 1746.9 2002.4 2050.5 2053.0 2054.8 1803.1 2007.8 2069.0 2070.2 2087.9 2006.1 2015.8 2016.4 2018.6 2020.8 1957.4 1996.4 1997.0 1998.5 1999.4 1966.3 1973.3 1991.7 2021.4 2023.1 6573.3 6788.9 6910.1 6915.4 6917.6 4069.3 4176.8 4182.3 4187.8 4190.2 2581.0 2795.5 2849.8 2855.0 2870.1 886.2 917.2 929.9 937.6 951.4 8861.8 8906.6 8964.5 8969.9 8990.5 3723.4 3852.6 3931.2 3948.1 3962.0 7793.4 7800.3 7804.8 7807.6 7807.8 4198.2 4204.8 4207.6 4209.1 4211.7 3361.1 3429.0 3804.6 3805.5 3813.2 3051.1 3126.4 3407.7 3416.4 3487.9 1141.9 1176.2 1180.2 1191.1 1206.8 708.7 714.2 729.2 755.2 757.9 4588.9 4674.7 4678.8 4757.6 4774.8 385.6 395.9 397.4 399.2 408.3 3138.2 3158.0 3171.4 3195.6 3330.4 7860.7 7963.7 8162.1 8202.9 8237.1 8122.3 8130.3 8132.9 8133.6 8137.5 6058.4 6244.8 6289.4 6384.1 6461.4 4811.2 4858.6 4883.4 4890.3 4967.0 7487.1 7496.1 7496.3 7512.0 7523.3 7245.8 7526.7 7528.0 7558.1 7672.5 5651.2 5771.1 5788.7 5793.0 5800.1 5617.0 5822.2 5966.8 6096.2 6158.1 5847.2 5894.7 5910.9 5921.5 5938.5 5809.3 5811.9 5829.4 5903.1 5997.8 5123.0 5174.6 5237.7 5324.3 5374.9 4048.8 4050.6 4088.8 4104.5 4106.4 4006.8 4074.9 4086.4 4133.4 4308.6 10:21:25 INFO - PROCESS | 28109 | 10:21:25 INFO - PROCESS | 28109 | [#4] prototype.html Cycles:180 Average:4131.99 Median:4684.65 stddev:1196.47 (25.5%) stddev-sans-first:1164.59 10:21:25 INFO - PROCESS | 28109 | Values: 291.9 296.4 300.8 303.4 305.6 4792.8 4853.1 4858.3 4862.2 4884.4 4730.2 4734.9 4750.6 4772.8 4793.8 3544.6 3653.4 3692.6 3716.4 3754.0 3739.5 3760.6 3762.7 3767.3 3774.2 3725.1 3749.5 3751.4 3768.5 3774.1 3569.6 3580.5 3690.3 3729.5 3737.2 3293.6 3302.8 3303.9 3307.1 3320.6 4598.4 4607.6 4629.4 4629.9 4638.5 4073.3 4216.5 4261.7 4282.9 4298.6 4929.6 4946.8 4948.6 4963.5 4970.4 3615.4 3617.6 3619.0 3621.2 3627.8 5108.2 5193.7 5219.6 5231.2 5279.4 3678.8 3700.6 3702.5 3704.5 3723.1 3745.9 3751.5 3759.2 3766.3 3775.6 4247.6 4254.9 4263.6 4273.6 4284.5 4857.1 4956.3 5002.0 5025.7 5077.8 1245.5 1249.3 1252.6 1253.4 1258.5 824.6 862.4 862.9 863.7 867.4 4174.3 4215.2 4233.3 4257.8 4336.7 5095.5 5125.9 5132.3 5145.4 5158.8 4320.9 4339.6 4344.6 4356.8 4359.3 2556.6 2634.5 2634.8 2647.9 2649.9 4693.2 4704.7 4706.8 4706.9 4725.3 5070.2 5113.0 5136.0 5145.7 5171.5 4426.3 4654.2 4668.6 4681.0 4688.3 4977.3 4984.7 5005.9 5020.7 5023.7 4941.3 4943.7 4963.3 4970.3 4990.3 4589.2 4653.6 4868.3 4887.7 4888.1 3612.2 3622.3 3622.8 3631.0 3633.2 5205.9 5210.4 5221.9 5226.7 5235.3 4930.2 5008.9 5015.2 5047.0 5079.1 4962.3 4989.9 5002.6 5014.7 5041.8 4972.9 4977.4 4984.2 4993.6 4997.1 4752.3 4898.0 5080.5 5104.6 5126.2 4751.3 4791.2 4917.4 4922.8 4934.1 10:21:25 INFO - PROCESS | 28109 | 10:21:25 INFO - PROCESS | 28109 | [#5] yui.html Cycles:180 Average:15096.55 Median:23273.08 stddev:18866.20 (81.1%) stddev-sans-first:18887.68 10:21:25 INFO - PROCESS | 28109 | Values: 591.5 607.7 650.4 676.3 684.2 11972.5 14108.4 14686.1 14799.9 14864.8 14271.1 14279.2 14510.2 14674.4 15009.3 743.2 763.5 765.3 765.6 765.6 602.9 629.9 737.3 758.8 762.9 802.4 802.6 803.1 804.6 805.2 797.6 801.2 801.5 801.8 802.5 462.2 478.7 557.3 574.7 585.2 13329.5 13439.9 13445.0 13461.3 13471.7 11921.2 12237.9 12260.8 12444.2 12683.9 11051.2 11080.0 11169.8 11496.3 11708.0 4037.6 4116.9 4190.3 4259.2 4260.9 63795.4 64660.4 65485.0 65635.3 68008.0 9992.4 10072.0 10152.5 10297.1 10357.9 18443.2 19074.2 19224.7 19335.0 19361.0 6406.7 6545.5 6709.1 6742.5 6869.7 3665.5 3706.7 3741.5 3748.9 3886.3 2712.1 2910.1 3020.3 3022.9 3050.1 504.3 517.9 528.8 535.6 539.7 530.8 546.1 552.7 567.0 572.2 7325.3 7412.3 7454.0 8086.3 8095.8 439.1 454.9 518.1 526.2 535.4 3770.1 3884.1 4129.3 4306.9 4390.9 53994.0 68765.7 71777.3 72678.3 72876.3 50104.7 57670.0 57914.0 58706.0 58822.4 42997.8 46091.3 50946.0 53376.0 54084.5 7687.3 8095.6 8119.4 8325.7 8391.2 33058.7 38189.2 38425.2 38583.6 39176.0 47870.0 48262.8 49212.8 49748.3 49779.0 11365.9 11415.5 11556.3 11615.4 12056.4 13394.7 13436.9 13654.9 14208.4 14268.1 11410.9 11539.6 11552.7 11920.2 12036.3 10945.5 11376.9 11440.3 11515.1 11537.8 10665.7 11454.4 11485.4 11485.7 11898.1 9561.2 9876.6 10006.1 10025.5 10202.9 8903.4 9158.2 9366.3 9479.6 10050.9 10:21:25 INFO - PROCESS | 28109 | -------- Summary: end -------- 10:21:25 INFO - PROCESS | 28109 | 10:21:25 INFO - TEST-INFO | 28109: exit 0 10:21:25 INFO - TEST-OK | dromaeo_css | took 1122799ms 10:21:25 INFO - TEST-START | kraken 10:21:25 INFO - operating with platform_type : linux_ 10:21:25 INFO - Initialising browser for kraken test... 10:21:26 INFO - TEST-INFO | started process 28419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWU_lFw/profile http://localhost:44011/getInfo.html) 10:21:30 INFO - PROCESS | 28419 | __metrics Screen width/height:1600/1200 10:21:30 INFO - PROCESS | 28419 | colorDepth:24 10:21:30 INFO - PROCESS | 28419 | Browser inner width/height: 1024/697 10:21:30 INFO - PROCESS | 28419 | __metrics 10:21:30 INFO - PROCESS | 28419 | 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" 10:21:30 INFO - PROCESS | 28419 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:31 INFO - PROCESS | 28419 | console.error: PushService: 10:21:31 INFO - PROCESS | 28419 | stateChangeProcessEnqueue: Error transitioning state 10:21:31 INFO - PROCESS | 28419 | UnknownError 10:21:32 INFO - TEST-INFO | 28419: exit 0 10:21:32 INFO - Browser initialized. 10:21:32 INFO - Running cycle 1/1 for kraken test... 10:21:32 INFO - TEST-INFO | started process 28500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWU_lFw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:44 INFO - PROCESS | 28500 | RSS: Main: 173395968 10:21:44 INFO - PROCESS | 28500 | 10:21:47 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44011/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:48 INFO - PROCESS | 28500 | RSS: Main: 239919104 10:21:48 INFO - PROCESS | 28500 | 10:21:51 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44011/tests/kraken/driver.html?testName=audio-dft) 10:21:51 INFO - PROCESS | 28500 | RSS: Main: 217317376 10:21:51 INFO - PROCESS | 28500 | 10:21:54 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44011/tests/kraken/driver.html?testName=audio-fft) 10:21:55 INFO - PROCESS | 28500 | RSS: Main: 300232704 10:21:55 INFO - PROCESS | 28500 | 10:21:57 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44011/tests/kraken/driver.html?testName=audio-oscillator) 10:21:58 INFO - PROCESS | 28500 | RSS: Main: 211394560 10:21:58 INFO - PROCESS | 28500 | 10:22:00 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44011/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:22:01 INFO - PROCESS | 28500 | RSS: Main: 214192128 10:22:01 INFO - PROCESS | 28500 | 10:22:04 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44011/tests/kraken/driver.html?testName=imaging-darkroom) 10:22:05 INFO - PROCESS | 28500 | RSS: Main: 253206528 10:22:05 INFO - PROCESS | 28500 | 10:22:08 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44011/tests/kraken/driver.html?testName=imaging-desaturate) 10:22:09 INFO - PROCESS | 28500 | RSS: Main: 247762944 10:22:09 INFO - PROCESS | 28500 | 10:22:12 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44011/tests/kraken/driver.html?testName=json-parse-financial) 10:22:12 INFO - PROCESS | 28500 | RSS: Main: 249356288 10:22:12 INFO - PROCESS | 28500 | 10:22:14 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44011/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:22:14 INFO - PROCESS | 28500 | RSS: Main: 212758528 10:22:15 INFO - PROCESS | 28500 | 10:22:16 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44011/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:22:17 INFO - PROCESS | 28500 | RSS: Main: 220467200 10:22:17 INFO - PROCESS | 28500 | 10:22:19 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44011/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:22:20 INFO - PROCESS | 28500 | RSS: Main: 228868096 10:22:20 INFO - PROCESS | 28500 | 10:22:23 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:22:23 INFO - PROCESS | 28500 | RSS: Main: 237371392 10:22:23 INFO - PROCESS | 28500 | 10:22:27 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:27 INFO - PROCESS | 28500 | RSS: Main: 234655744 10:22:27 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | Cycle 1(1): loaded http://localhost:44011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44011/tests/kraken/driver.html?testName=ai-astar) 10:22:29 INFO - PROCESS | 28500 | RSS: Main: 286035968 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | __start_tp_report 10:22:29 INFO - PROCESS | 28500 | _x_x_mozilla_page_load 10:22:29 INFO - PROCESS | 28500 | _x_x_mozilla_page_load_details 10:22:29 INFO - PROCESS | 28500 | |i|pagename|runs| 10:22:29 INFO - PROCESS | 28500 | |0;ai-astar;109;117;115;115;117;117;116;116;116;114 10:22:29 INFO - PROCESS | 28500 | |1;audio-beat-detection;155;130;136;186;131;131;131;130;161;136 10:22:29 INFO - PROCESS | 28500 | |2;audio-dft;163;162;161;162;162;163;162;161;162;162 10:22:29 INFO - PROCESS | 28500 | |3;audio-fft;76;77;77;110;77;76;76;77;97;76 10:22:29 INFO - PROCESS | 28500 | |4;audio-oscillator;83;85;110;84;83;84;109;83;83;111 10:22:29 INFO - PROCESS | 28500 | |5;imaging-gaussian-blur;117;116;117;118;117;116;117;117;117;117 10:22:29 INFO - PROCESS | 28500 | |6;imaging-darkroom;148;146;146;147;147;147;148;147;147;147 10:22:29 INFO - PROCESS | 28500 | |7;imaging-desaturate;95;95;95;96;96;96;96;96;95;95 10:22:29 INFO - PROCESS | 28500 | |8;json-parse-financial;67;65;65;65;67;64;66;67;66;66 10:22:29 INFO - PROCESS | 28500 | |9;json-stringify-tinderbox;66;66;65;65;65;65;66;66;66;66 10:22:29 INFO - PROCESS | 28500 | |10;stanford-crypto-aes;85;95;88;85;86;84;85;85;85;86 10:22:29 INFO - PROCESS | 28500 | |11;stanford-crypto-ccm;154;149;141;139;150;141;139;137;199;151 10:22:29 INFO - PROCESS | 28500 | |12;stanford-crypto-pbkdf2;177;176;179;177;177;180;177;175;177;177 10:22:29 INFO - PROCESS | 28500 | |13;stanford-crypto-sha256-iterative;69;68;77;71;80;71;69;68;68;67 10:22:29 INFO - PROCESS | 28500 | __end_tp_report 10:22:29 INFO - PROCESS | 28500 | __start_cc_report 10:22:29 INFO - PROCESS | 28500 | _x_x_mozilla_cycle_collect,1964 10:22:29 INFO - PROCESS | 28500 | __end_cc_report 10:22:29 INFO - PROCESS | 28500 | __startTimestamp1481221349711__endTimestamp 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | ------- Summary: start ------- 10:22:29 INFO - PROCESS | 28500 | Number of tests: 14 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:2.39 (2.1%) stddev-sans-first:1.05 10:22:29 INFO - PROCESS | 28500 | Values: 109.0 117.0 115.0 115.0 117.0 117.0 116.0 116.0 116.0 114.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:136.00 stddev:18.81 (13.8%) stddev-sans-first:19.42 10:22:29 INFO - PROCESS | 28500 | Values: 155.0 130.0 136.0 186.0 131.0 131.0 131.0 130.0 161.0 136.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 10:22:29 INFO - PROCESS | 28500 | Values: 163.0 162.0 161.0 162.0 162.0 163.0 162.0 161.0 162.0 162.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:11.80 (15.3%) stddev-sans-first:12.32 10:22:29 INFO - PROCESS | 28500 | Values: 76.0 77.0 77.0 110.0 77.0 76.0 76.0 77.0 97.0 76.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.00 stddev:12.79 (15.4%) stddev-sans-first:13.19 10:22:29 INFO - PROCESS | 28500 | Values: 83.0 85.0 110.0 84.0 83.0 84.0 109.0 83.0 83.0 111.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:22:29 INFO - PROCESS | 28500 | Values: 117.0 116.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 10:22:29 INFO - PROCESS | 28500 | Values: 148.0 146.0 146.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:22:29 INFO - PROCESS | 28500 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 10:22:29 INFO - PROCESS | 28500 | Values: 67.0 65.0 65.0 65.0 67.0 64.0 66.0 67.0 66.0 66.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 10:22:29 INFO - PROCESS | 28500 | Values: 66.0 66.0 65.0 65.0 65.0 65.0 66.0 66.0 66.0 66.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.50 stddev:3.20 (3.7%) stddev-sans-first:3.36 10:22:29 INFO - PROCESS | 28500 | Values: 85.0 95.0 88.0 85.0 86.0 84.0 85.0 85.0 85.0 86.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:149.50 stddev:18.23 (12.2%) stddev-sans-first:19.28 10:22:29 INFO - PROCESS | 28500 | Values: 154.0 149.0 141.0 139.0 150.0 141.0 139.0 137.0 199.0 151.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:177.00 stddev:1.40 (0.8%) stddev-sans-first:1.48 10:22:29 INFO - PROCESS | 28500 | Values: 177.0 176.0 179.0 177.0 177.0 180.0 177.0 175.0 177.0 177.0 10:22:29 INFO - PROCESS | 28500 | 10:22:29 INFO - PROCESS | 28500 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:70.00 stddev:4.32 (6.2%) stddev-sans-first:4.53 10:22:29 INFO - PROCESS | 28500 | Values: 69.0 68.0 77.0 71.0 80.0 71.0 69.0 68.0 68.0 67.0 10:22:29 INFO - PROCESS | 28500 | -------- Summary: end -------- 10:22:29 INFO - PROCESS | 28500 | 10:22:31 INFO - TEST-INFO | 28500: exit 0 10:22:31 INFO - TEST-OK | kraken | took 65058ms 10:22:31 INFO - SUITE-END | took 1187s 10:22:31 INFO - Completed test suite (00:19:48) 10:22:31 INFO - javascript benchmark 10:22:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.819552631316, 2619.410632607662, 2643.1806140096564, 2653.946921061579, 2663.9866800666005, 4566.611837993774, 4635.930461043087, 4722.7874745636445, 4726.14929312724, 4755.096531658983, 4681.789319480623, 4683.180443422396, 4683.367745354376, 4690.390249267599, 4700.811967521304, 4292.120115376348, 4316.525182229968, 4322.84870029549, 4344.522102568715, 4348.195583816988, 4309.525952145262, 4357.978210108945, 4359.149965756678, 4368.628666563346, 4377.562243775629, 4352.825886964518, 4356.085222103362, 4371.213181627306, 4373.365861950016, 4411.294192929132, 4425.867223983286, 4435.046465010038, 4439.600435960747, 4440.600345968846, 4442.444694413199, 4250.298700714378, 4287.6141147296585, 4319.179355922396, 4333.674974376903, 4382.53983331752, 4659.464161621389, 4659.743714095724, 4665.813367465297, 4706.058788242331, 4706.411698537683, 5028.974855125701, 5059.721715305656, 5075.847724568232, 5085.974570127163, 5125.0, 4903.901921961577, 4950.628702847301, 5088.084144853925, 5100.795968161269, 5138.3577052868395, 4666.883327916796, 4698.694584851974, 4719.95280047202, 4725.527447255247, 4789.042191561702, 5173.301604283449, 5179.870503237374, 5181.1969144782615, 5183.867318512278, 5197.948020519822, 4991.251312303184, 4992.500749925051, 4998.02538504988, 4998.300237966688, 5039.546440820343, 4911.115999120121, 4938.1358262304675, 4953.380827396575, 4995.650304478724, 5007.574356179693, 5004.199328107486, 5022.42242142151, 5053.54518093366, 5058.140116180258, 5071.54356107952, 4958.776855041459, 4994.575461085776, 5004.3494345734825, 5010.874728131826, 5054.368203974504, 4103.199876024206, 4164.271252530795, 4165.500139983222, 4261.509926358446, 4271.124419493996, 3697.8890633281044, 3699.2416554606243, 3707.443883417455, 3716.163863130828, 3740.831662575191, 4265.214453233697, 4269.124829409963, 4270.44484217056, 4301.225779359683, 4307.806148723315, 4873.41519017713, 5024.2463630454995, 5029.5221953914315, 5033.421156566968, 5086.92369614456, 4166.895827604273, 4225.767582782915, 4254.064105896698, 4256.4679415073115, 4268.317069268902, 4543.409356783597, 4545.863624091283, 4548.522405147478, 4577.931331030038, 4587.8623641290815, 4734.26618874075, 4739.289106634033, 4741.596964258077, 4749.216379297377, 4787.281907713732, 4906.018796240694, 4954.950450495449, 4957.256411538298, 4996.450390457119, 5062.265971434195, 4713.3401323814005, 4741.478437371955, 4744.928826067543, 4749.002709431058, 4788.856334309976, 4986.301917731593, 4993.425756038102, 4995.675281106716, 4996.975015124901, 5043.193089105725, 4870.09903167915, 4925.261210818406, 5044.041632090038, 5049.0, 5092.007058623532, 4821.445533763522, 4837.395325584302, 4870.1233777920315, 4870.707757534559, 4897.191963326011, 4806.375171227718, 4827.275908613736, 4834.492378300228, 4876.4392094909535, 4882.218844984785, 4772.141014617263, 4773.498782627774, 4774.761261936958, 4775.33145359643, 4806.975965120152, 4762.738049407316, 4827.662063655511, 4829.203181475017, 4888.755562221803, 4953.925691114564, 4760.309755085563, 4797.688150270221, 4798.664093513421, 4810.11012962603, 4860.562549370574], "value": 4608.97929267128, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9606627536073, 565.3074983145647, 566.7477972302327, 591.5947575910499, 595.8927393069246, 27147.18558443245, 37391.4391284131, 38620.42069368955, 38688.0, 42953.57046429535, 38712.0, 39114.21771564567, 39142.21715565687, 39167.804160979154, 39246.0, 7496.737614183518, 7647.961760191191, 7659.770206893802, 7713.305802477776, 7717.536947783151, 7436.256374362574, 7629.8474030519355, 9640.325177237597, 9869.161121304662, 9872.111509964101, 9392.248620110375, 9397.483138427384, 9401.952990235039, 9402.952985235064, 9410.43537387759, 9882.703518894445, 9945.40327580344, 9959.75100622483, 9959.850602240973, 9976.80046399068, 9791.118799308097, 9818.607255709763, 9842.557084931195, 9846.9507652462, 9847.852282215772, 37607.623923760686, 37768.62231377706, 37844.24311513754, 37890.24219515622, 37905.431418528744, 2699.9730002699916, 2805.2566069991467, 2805.6492938382703, 2928.7364137227537, 3159.7946133501478, 27847.303817404525, 28169.0, 28275.0, 28607.427851443063, 29536.8523157385, 3389.1865952171547, 3487.8576222316074, 3532.0, 3564.429691249388, 3577.6422357764277, 234126.0, 234258.0, 235543.0, 235568.0, 236337.81831090906, 52283.47716522786, 52774.20838687423, 52828.47171528312, 52831.207531887056, 52865.735671321396, 55496.445035549936, 55599.0, 55685.443145568024, 55835.72082139645, 56035.43964560384, 12154.756904861853, 12331.876681233252, 12349.135560510858, 12349.876501235052, 12352.197107188003, 8203.507789532647, 9104.180623743894, 9131.863022054675, 9165.679201227926, 9181.127792859668, 14711.55865324042, 16910.661786764194, 17307.3077076918, 17406.91296543509, 17860.464186074438, 6531.804045878631, 6629.939114842773, 6701.664916754143, 6713.932860671429, 6777.220619628707, 738.471992525347, 822.8025273934333, 844.4848642328175, 848.2323497235012, 934.4346670264392, 26972.865135674587, 26998.730012700016, 27338.179854604394, 27538.0, 27629.171124866287, 893.6068130022769, 895.2435192262528, 911.380261422226, 928.1831987850649, 1003.0120331473493, 14147.43410263578, 14743.483978060716, 14747.631309217355, 14877.925610371878, 15013.324400402009, 114979.42510287395, 115637.4218128904, 115717.0, 115960.0, 116009.4199528997, 45133.77433112814, 46409.30386044212, 46827.531724683, 48152.0, 48208.27687584689, 1027.8047171037479, 1127.808272593661, 1157.2362240920952, 1157.346099453806, 1159.8782127876789, 26849.597256040783, 27912.30219244535, 28264.0, 28573.28566785847, 28682.856585716938, 41157.0, 41507.37738933979, 41559.376609351486, 41578.58421415747, 41602.375964359955, 295162.0, 295950.0, 296444.0, 296575.0, 296859.0, 24834.50330993406, 25173.87413062923, 25298.74701252964, 25363.239102826945, 25363.746362536138, 39837.60162398339, 40430.393544096274, 40457.1908561833, 40549.79725101356, 41658.37512437255, 34821.651783482856, 35215.06317152581, 35291.470627940085, 35360.0, 35673.0, 34432.48351274783, 34809.82595087009, 34844.82577587197, 34854.82572587222, 35401.29197415986, 34238.0, 34593.65406346005, 35262.11844703903, 35338.46992295066, 35507.82246088753, 29539.0, 32002.67997319997, 32331.515027274138, 32494.51258231081, 32501.0, 24458.877705611358, 24459.633105503075, 24601.261962141165, 24994.37514062163, 25065.373365665273], "value": 16727.16047636321, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.12166536165455, 365.1546669460199, 374.3729253500387, 384.5558380071017, 393.17825744194647, 11829.0, 11870.16908816382, 12542.686432839184, 15112.093274403516, 15726.764098538502, 13728.450861965533, 14054.0, 15767.684646307067, 15941.920290398532, 16054.678906421865, 4956.157453232941, 4963.379577552797, 5132.948670513284, 5177.715225662587, 5190.221466779994, 3641.6540428659237, 5072.137736584771, 5133.794648214067, 5164.819231326905, 5167.044096842077, 3803.581606023335, 5674.858128546799, 5927.644341339512, 5930.584859059867, 6031.547633927473, 5803.506701930341, 5940.762369505214, 6018.518518518508, 6025.578209525335, 6026.427489388479, 5272.05103081449, 5272.578193744491, 5274.446183150752, 5274.815381461669, 5275.947240527584, 19275.22899084035, 19573.902130489256, 19923.20307187711, 20105.29631462892, 20149.0, 1807.8644101692425, 1859.0797555210258, 1864.7482589850333, 1950.8731932424348, 2176.967345489819, 8753.212210901049, 8946.731598052069, 8958.23854972328, 9058.637654493812, 9217.124373184537, 1608.5898095985565, 1669.0820048973017, 1672.7741754863182, 1741.3992172700398, 1766.814484479124, 65453.672731636034, 65595.0, 65881.0, 66360.3363966359, 66506.3349366505, 9348.53257337144, 9542.141207291377, 9713.320067595201, 9716.465594392235, 9983.45284059571, 13800.0, 13847.584572462842, 13848.93075534636, 13854.445822167001, 13854.445822167001, 6571.737130514822, 6584.934150658432, 6749.763758268536, 6761.154855643044, 6832.180138383326, 6034.1853849730605, 6047.969760151171, 6150.108234306001, 6186.536009799283, 6192.907106393408, 4101.692373072032, 4106.753594784323, 4248.830046798155, 4337.82648694055, 4340.958170039231, 1722.8277172282922, 1725.810160882302, 1782.2603619498022, 1798.9820101799075, 1815.7730283714536, 793.3415265329762, 803.722081889798, 840.4663038970298, 851.2381418630291, 897.6768363389175, 15718.21408929549, 16639.41762038323, 16913.154342282836, 17045.306893484165, 17217.0, 844.8310337932315, 856.9657213711506, 866.5104216117874, 884.1070518776082, 945.4091193004373, 8783.814185085059, 9309.95345023284, 9328.253739700807, 9398.342116051948, 9565.808683826284, 309759.0, 324132.0, 327423.0, 337154.0, 339757.01214939647, 50535.0, 52740.472595274325, 80246.7531169076, 82580.58709706413, 82856.58571707102, 923.1783712495884, 939.1782190583376, 963.012911765432, 963.2294164668237, 969.1471505075489, 15142.0, 15222.771658425354, 15652.982556133815, 15872.920635397211, 16031.919840400724, 29137.85431072831, 33218.0, 33773.66226337705, 35287.29425411426, 37078.8146059268, 50566.2415063767, 50587.49412505975, 51198.48801511937, 51358.48641513537, 51473.22790158226, 7272.0, 7439.218882017527, 7660.195679453577, 7710.11333696632, 7812.101608314889, 11522.82715759281, 11583.07335413148, 12442.813357799821, 12449.875501245235, 12503.17788689186, 10204.642837500653, 10332.431716255678, 10339.896601033894, 10370.585176592851, 11092.112630989663, 10171.542280597243, 10258.692239232834, 10338.276320657782, 10346.741331466472, 10420.47897605132, 10565.0, 10787.406692631981, 10795.596572445531, 10831.67504974852, 10844.837327440253, 7570.091589009354, 7653.693852245848, 7678.577678227751, 7689.730859419893, 8008.799780005546, 8718.60766265507, 10042.899571004196, 10511.316764410289, 10740.677779666623, 11055.889441105486], "value": 7969.600425077689, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1164.3770582738236, 1246.97506049879, 1251.393074358936, 1305.2233920817112, 1624.6019725167328, 5876.941230587693, 6479.157709497765, 6597.0, 6649.8005059848165, 6793.864122717555, 6647.966760166204, 6684.598924064548, 6691.0, 6693.899591506131, 6711.0, 1746.8864523805912, 2002.4192984034612, 2050.456628993318, 2052.9794702052936, 2054.794520547948, 1803.0804289812158, 2007.7992200779952, 2069.037897377719, 2070.2340134150386, 2087.9060442280056, 2006.0571531380301, 2015.7581090269189, 2016.4353980885376, 2018.5861898310811, 2020.7878172791866, 1957.354073155855, 1996.4310171601169, 1997.0414201183369, 1998.5003749062735, 1999.3502111813718, 1966.3216190414284, 1973.2994786850747, 1991.7012448132896, 2021.4036859126593, 2023.0997206243228, 6573.276939536647, 6788.898166527457, 6910.101686780737, 6915.4121899638085, 6917.550359226634, 4069.267531844267, 4176.770277634729, 4182.330827067654, 4187.8324867005285, 4190.182914331706, 2581.0, 2795.51078561253, 2849.786266030056, 2854.9714502854913, 2870.138958312498, 886.1962689504873, 917.1928702741611, 929.8558723397884, 937.6155776131753, 951.4434056077204, 8861.778455538599, 8906.643734250687, 8964.462132272085, 8969.910300896972, 8990.460572365679, 3723.3617208428204, 3852.614738526125, 3931.233409485123, 3948.0919388540797, 3961.980190099031, 7793.415493837985, 7800.297973182441, 7804.804879878048, 7807.609619519001, 7807.765767026998, 4198.160367926366, 4204.831806727758, 4207.621314081747, 4209.137126888981, 4211.705180637326, 3361.09250502363, 3428.9828550857087, 3804.6005169456807, 3805.46723458716, 3813.1801662642665, 3051.1304278281027, 3126.3590963852357, 3407.7103446206856, 3416.367971925202, 3487.9476807847905, 1141.868685101224, 1176.1531697178018, 1180.2033627301537, 1191.065013964034, 1206.7526157137765, 708.7271400510738, 714.242902523327, 729.2051663686607, 755.1806290175222, 757.8711619024779, 4588.902490818684, 4674.742889141062, 4678.836240731626, 4757.643176761757, 4774.785134668949, 385.58549559223945, 395.8594698881913, 397.4138146234339, 399.22550252510035, 408.3384916435334, 3138.1997590614706, 3157.9684203158135, 3171.413288541627, 3195.568598239208, 3330.3505816365578, 7860.685572577033, 7963.6814527418255, 8162.102168761431, 8202.876956845652, 8237.135100814448, 8122.268995790408, 8130.3495720342235, 8132.918670813335, 8133.59332033396, 8137.511749295061, 6058.394160583906, 6244.781432649836, 6289.402506761941, 6384.106225128393, 6461.353864613501, 4811.206150985048, 4858.562729354375, 4883.437300064087, 4890.266460031024, 4967.0, 7487.064116985377, 7496.137944136276, 7496.287852653989, 7512.0, 7523.3229009389415, 7245.818854528679, 7526.736564220226, 7527.962360188164, 7558.055243094614, 7672.5012874163, 5651.180578816131, 5771.076627739541, 5788.652680839163, 5793.015187418065, 5800.100984347433, 5617.0, 5822.155787410887, 5966.791162309299, 6096.237970253718, 6158.107074474266, 5847.181394604844, 5894.70526473666, 5910.911336329872, 5921.467067963904, 5938.465538101592, 5809.331926828469, 5811.883762324645, 5829.358770535153, 5903.144044113494, 5997.790077347272, 5122.974385128051, 5174.560162386239, 5237.685738855681, 5324.334458192726, 5374.919376209438, 4048.7773172475795, 4050.5949405060437, 4088.836446542224, 4104.548499664975, 4106.3635136553885, 4006.8196931137586, 4074.8777536673947, 4086.366613174963, 4133.3879786883745, 4308.569143085666], "value": 3605.1895869962636, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.9095080525037, 296.3968324459725, 300.7804302858914, 303.36445147416157, 305.6469777407093, 4792.808287668493, 4853.077915196111, 4858.34412354332, 4862.173430516812, 4884.38945131859, 4730.219513780222, 4734.90530189396, 4750.619950403968, 4772.761361931907, 4793.760311984404, 3544.556930383702, 3653.378925582644, 3692.593814680383, 3716.4425336199515, 3754.042719106624, 3739.5325584301963, 3760.6051364606733, 3762.6613604775566, 3767.3030489359558, 3774.2262836118666, 3725.1245957200035, 3749.4938183345307, 3751.4372844073337, 3768.453574231735, 3774.0942173878207, 3569.5716514018486, 3580.4629305604108, 3690.298843219793, 3729.5151630287887, 3737.177820879402, 3293.604767427924, 3302.8440045983953, 3303.884364047247, 3307.074019274607, 3320.5517255170485, 4598.356230127785, 4607.562281583244, 4629.421322334708, 4629.930551041737, 4638.536146385368, 4073.3279008963486, 4216.51510076339, 4261.701680882339, 4282.935755963663, 4298.613124818781, 4929.556339929388, 4946.848121067312, 4948.628852836052, 4963.478834722338, 4970.353853998993, 3615.403458429382, 3617.607221219823, 3618.9685939507112, 3621.2214373909474, 3627.836747346376, 5108.182690769459, 5193.662851716705, 5219.582433405357, 5231.163013917755, 5279.419263880932, 3678.779273243614, 3700.611435799256, 3702.4816525686424, 3704.5369328833895, 3723.106454450912, 3745.8949609865153, 3751.4560388744026, 3759.248150369937, 3766.3408903441787, 3775.6224377562025, 4247.5752424757275, 4254.893627659271, 4263.552327005682, 4273.594008569181, 4284.528701842794, 4857.125717370907, 4956.330895329156, 5002.049610573979, 5025.698458092526, 5077.771500282496, 1245.4644502863855, 1249.325364303266, 1252.5929073051295, 1253.3607859991287, 1258.5091814192472, 824.6000689665508, 862.3575436299997, 862.9352798540135, 863.7149740585592, 867.3538214030461, 4174.269502837052, 4215.178040282177, 4233.30150525166, 4257.829686812554, 4336.6530677545725, 5095.490450954949, 5125.923111153335, 5132.28148059272, 5145.382554093533, 5158.845234642967, 4320.891977700519, 4339.631131353807, 4344.587264209895, 4356.847510337123, 4359.346098085312, 2556.57816460282, 2634.459935713174, 2634.8287361321454, 2647.907323243716, 2649.894004239847, 4693.225617773098, 4704.717716936994, 4706.835260765857, 4706.929396059062, 4725.291206319011, 5070.188769796889, 5112.974435127875, 5135.998480296306, 5145.742712864342, 5171.534561889448, 4426.336049592523, 4654.232051711498, 4668.626509879202, 4680.976595117003, 4688.320193571981, 4977.253411988086, 4984.675996060245, 5005.899882002413, 5020.748962551931, 5023.6985780853265, 4941.308216849716, 4943.728094954812, 4963.305137280856, 4970.254461830755, 4990.251462280687, 4589.219832628528, 4653.580657899373, 4868.2940973557925, 4887.682300650446, 4888.095702295087, 3612.151144480992, 3622.3298689742483, 3622.7645203061716, 3631.0, 3633.182533929845, 5205.895882082413, 5210.374755029421, 5221.869453263699, 5226.686398816083, 5235.293235413171, 4930.186519224288, 5008.9248661269385, 5015.1975683890405, 5046.99703676312, 5079.136546787129, 4962.33008543842, 4989.850304490871, 5002.624803139852, 5014.749262536931, 5041.798328066836, 4972.925406118983, 4977.377827771528, 4984.177610694195, 4993.550580447777, 4997.125503037027, 4752.334673145831, 4898.0, 5080.542751152414, 5104.642675012714, 5126.231065340229, 4751.334813126235, 4791.185498465339, 4917.442929676619, 4922.827701030446, 4934.111859865116], "value": 3752.733239957816, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.5365534793782, 607.747784669362, 650.4081286029714, 676.3338111959721, 684.2063206680249, 11972.521099156034, 14108.365123569438, 14686.118832870035, 14799.852001479981, 14864.777028344584, 14271.143731376098, 14279.21464319462, 14510.201938893357, 14674.413023479075, 15009.32458039388, 743.2456057102046, 763.526613499631, 765.2615226306613, 765.5712800831552, 765.6401491299081, 602.8944934636443, 629.9275583307932, 737.2553720742036, 758.7723682895137, 762.8550575390658, 802.430274505102, 802.6027116577302, 803.0564087197549, 804.6298702596813, 805.1867613710166, 797.6330887791594, 801.1507801730185, 801.5070731500115, 801.7795106345743, 802.4783890471182, 462.20962154715477, 478.7103802199654, 557.275541795664, 574.704027425876, 585.2304219950794, 13329.533466328729, 13439.932800335935, 13445.0, 13461.259630720306, 13471.663208419868, 11921.225120367148, 12237.877621223763, 12260.81608775869, 12444.191127576678, 12683.873161268362, 11051.17116216279, 11080.0, 11169.776604467947, 11496.31022138666, 11708.0, 4037.6164264394833, 4116.938245926313, 4190.308599081148, 4259.169461954889, 4260.850870219559, 63795.36204637941, 64660.35339646637, 65485.0, 65635.3436465634, 68008.0, 9992.350497217658, 10072.0, 10152.543135558917, 10297.07326340633, 10357.948210259052, 18443.17005734745, 19074.2370305189, 19224.71162932557, 19335.0, 19361.0, 6406.67966601668, 6545.509086818508, 6709.087909945642, 6742.460603151736, 6869.656517174221, 3665.52348194733, 3706.6664000240107, 3741.4948981887096, 3748.8687895923513, 3886.3198940185353, 2712.0643378034547, 2910.083323753011, 3020.2600362911226, 3022.9244268893012, 3050.145959131447, 504.33176041744105, 517.891242839008, 528.7541293298558, 535.6330913324385, 539.719345940109, 530.8062557166684, 546.1289243656362, 552.7484994327572, 566.9886602267932, 572.1960645293369, 7325.340719335285, 7412.295831895961, 7453.962730186423, 8086.312663423675, 8095.797605059921, 439.05602953649907, 454.856720133157, 518.0623072239259, 526.2080568744092, 535.4377903201623, 3770.1328694399895, 3884.1260716338597, 4129.256733787947, 4306.89232769177, 4390.912181756347, 53994.0, 68765.65617171882, 71777.28222717706, 72678.2732172682, 72876.27123728694, 50104.749476252386, 57670.0, 57914.0, 58706.0, 58822.41177588255, 42997.785011074746, 46091.30863037057, 50945.98108037819, 53376.0, 54084.459155407945, 7687.308697830707, 8095.55474448911, 8119.431639785158, 8325.666973321242, 8391.244787969112, 33058.669413306525, 38189.2362152761, 38425.23149536938, 38583.61416385912, 39176.0, 47870.0, 48262.75868620775, 49212.75393623009, 49748.25377619411, 49779.0, 11365.886341136813, 11415.543378264776, 11556.324332971504, 11615.419229038684, 12056.397180141134, 13394.665133371744, 13436.865631343953, 13654.93172534131, 14208.431662733788, 14268.072575282573, 11410.885891140982, 11539.5961141363, 11552.711182220175, 11920.165588408729, 12036.338001410006, 10945.507452164513, 11376.886231137583, 11440.313581185155, 11515.078793696652, 11537.769244615229, 10665.733356666145, 11454.370009649549, 11485.425728713699, 11485.712857178638, 11898.107641927063, 9561.235101191749, 9876.604935802774, 10006.145176037067, 10025.498725063571, 10202.948985255027, 8903.421277616933, 9158.175764181256, 9366.344355895022, 9479.620815167593, 10050.89949100529], "value": 6273.286436910784, "unit": "score"}], "name": "dromaeo_css", "value": 6112.441351536091, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 115.0, 115.0, 117.0, 117.0, 116.0, 116.0, 116.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 136.0, 186.0, 131.0, 131.0, 131.0, 130.0, 161.0, 136.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 110.0, 77.0, 76.0, 76.0, 77.0, 97.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 110.0, 84.0, 83.0, 84.0, 109.0, 83.0, 83.0, 111.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 65.0, 67.0, 64.0, 66.0, 67.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 95.0, 88.0, 85.0, 86.0, 84.0, 85.0, 85.0, 85.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 149.0, 141.0, 139.0, 150.0, 141.0, 139.0, 137.0, 199.0, 151.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 179.0, 177.0, 177.0, 180.0, 177.0, 175.0, 177.0, 177.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 77.0, 71.0, 80.0, 71.0, 69.0, 68.0, 68.0, 67.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1568.5, "alertThreshold": 2.0}]} 10:22:31 INFO - Return code: 0 10:22:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:31 INFO - # TBPL SUCCESS # 10:22:31 INFO - Running post-action listener: _resource_record_post_action 10:22:31 INFO - [mozharness: 2016-12-08 18:22:31.519534Z] Finished run-tests step (success) 10:22:31 INFO - Running post-run listener: _resource_record_post_run 10:22:31 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390684672; Read time: 12; Write time: 196572 10:22:31 INFO - TinderboxPrint: CPU usage
13.1% 10:22:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:22:31 INFO - TinderboxPrint: I/O write bytes / time
390,684,672 / 196,572 10:22:31 INFO - TinderboxPrint: CPU idle
8,349.2 (86.9%) 10:22:31 INFO - TinderboxPrint: CPU user
1,208.3 (12.6%) 10:22:31 INFO - TinderboxPrint: Swap in / out
0 / 0 10:22:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99745792; Read time: 0; Write time: 63360 10:22:31 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290938880; Read time: 0; Write time: 133212 10:22:32 INFO - Running post-run listener: _upload_blobber_files 10:22:32 INFO - Blob upload gear active. 10:22:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:32 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 10:22:32 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'] 10:22:32 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 10:22:32 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:33 INFO - (blobuploader) - INFO - Done attempting. 10:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:36 INFO - (blobuploader) - INFO - Done attempting. 10:22:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:22:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:22:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:37 INFO - (blobuploader) - INFO - Done attempting. 10:22:37 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:37 INFO - Return code: 0 10:22:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a054f3176f6eca7222278a4ad0d7cdc3d8e6f0770e1918e8894eed9d3a994b5027f05e18412ef2dfc81136593187afab601989a3ebc5023815f01cc5d9ea135c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/89c48981ab40b3733b0eb65db1c9273acdf91516b1e2a461fe8fc71ed0e2144bd39e30219ff44a4a10522cb971c29392d59dbbc7f6c4a539aafd88a459f1aa1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a4a08a636d59aaff9963f441836c6f82acbe5d3701c55b06b0140db1568bbc6a2259e5b4d71ecd7df0fd87bb543441fa29fda784d3aef7cddd8b453b431e9af"} 10:22:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:37 INFO - Contents: 10:22:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a054f3176f6eca7222278a4ad0d7cdc3d8e6f0770e1918e8894eed9d3a994b5027f05e18412ef2dfc81136593187afab601989a3ebc5023815f01cc5d9ea135c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/89c48981ab40b3733b0eb65db1c9273acdf91516b1e2a461fe8fc71ed0e2144bd39e30219ff44a4a10522cb971c29392d59dbbc7f6c4a539aafd88a459f1aa1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a4a08a636d59aaff9963f441836c6f82acbe5d3701c55b06b0140db1568bbc6a2259e5b4d71ecd7df0fd87bb543441fa29fda784d3aef7cddd8b453b431e9af"} 10:22:37 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:37 INFO - Copying logs to upload dir... 10:22:37 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.039787 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-12-08 10:22:36.588382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 10:22:36.592440) ========= 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=6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006 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/a054f3176f6eca7222278a4ad0d7cdc3d8e6f0770e1918e8894eed9d3a994b5027f05e18412ef2dfc81136593187afab601989a3ebc5023815f01cc5d9ea135c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/89c48981ab40b3733b0eb65db1c9273acdf91516b1e2a461fe8fc71ed0e2144bd39e30219ff44a4a10522cb971c29392d59dbbc7f6c4a539aafd88a459f1aa1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a4a08a636d59aaff9963f441836c6f82acbe5d3701c55b06b0140db1568bbc6a2259e5b4d71ecd7df0fd87bb543441fa29fda784d3aef7cddd8b453b431e9af"} build_url:https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011497 build_url: 'https://queue.taskcluster.net/v1/task/WO-RSg5GTDeEJVkx3A4GNA/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/a054f3176f6eca7222278a4ad0d7cdc3d8e6f0770e1918e8894eed9d3a994b5027f05e18412ef2dfc81136593187afab601989a3ebc5023815f01cc5d9ea135c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/89c48981ab40b3733b0eb65db1c9273acdf91516b1e2a461fe8fc71ed0e2144bd39e30219ff44a4a10522cb971c29392d59dbbc7f6c4a539aafd88a459f1aa1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a4a08a636d59aaff9963f441836c6f82acbe5d3701c55b06b0140db1568bbc6a2259e5b4d71ecd7df0fd87bb543441fa29fda784d3aef7cddd8b453b431e9af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 10:22:36.618507) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:22:36.618869) ========= 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=6dbc10da6d83fee962c624be000001a8-1481219861.494776-738054006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:22:36.702838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 10:22:36.703166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 10:22:36.703466) ========= ========= Total master_lag: 0.17 =========