builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1481755319.84 results: success (0) buildid: 20161214135000 builduid: c251271b41f94eec9b757d6ba5304dc7 revision: 92f621d51f1f1b395b131a7bb1f505e828585362 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 14:41:59.839362) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 14:41:59.839801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 14:41:59.840087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 14:41:59.854554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 14:41:59.854871) ========= 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=fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-14 14:42:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-12-14 14:42:00 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123752 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 14:41:59.992179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 14:41:59.992488) ========= 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=fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017855 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 14:42:00.041853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 14:42:00.042208) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 92f621d51f1f1b395b131a7bb1f505e828585362 --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 92f621d51f1f1b395b131a7bb1f505e828585362 --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=fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-14 14:42:00,709 truncating revision to first 12 chars 2016-12-14 14:42:00,709 Setting DEBUG logging. 2016-12-14 14:42:00,709 attempt 1/10 2016-12-14 14:42:00,709 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/92f621d51f1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 14:42:01,161 unpacking tar archive at: graphics-92f621d51f1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.773797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 14:42:00.829020) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 14:42:00.829534) ========= script_repo_revision: 92f621d51f1f1b395b131a7bb1f505e828585362 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 14:42:00.830158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 14:42:00.830600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 14:42:00.841352) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-14 14:42:00.841650) ========= /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=fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:42:01 INFO - MultiFileLogger online at 20161214 14:42:01 in /builds/slave/test 14:42:01 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 14:42:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:42:01 INFO - {'append_to_log': False, 14:42:01 INFO - 'base_work_dir': '/builds/slave/test', 14:42:01 INFO - 'blob_upload_branch': 'Graphics', 14:42:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:42:01 INFO - 'branch': 'Graphics', 14:42:01 INFO - 'buildbot_json_path': 'buildprops.json', 14:42:01 INFO - 'config_files': ('talos/linux_config.py',), 14:42:01 INFO - 'default_actions': ('clobber', 14:42:01 INFO - 'read-buildbot-config', 14:42:01 INFO - 'download-and-extract', 14:42:01 INFO - 'populate-webroot', 14:42:01 INFO - 'create-virtualenv', 14:42:01 INFO - 'install', 14:42:01 INFO - 'run-tests'), 14:42:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:42:01 INFO - 'download_minidump_stackwalk': True, 14:42:01 INFO - 'download_symbols': 'ondemand', 14:42:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:42:01 INFO - 'tooltool.py': '/tools/tooltool.py', 14:42:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:42:01 INFO - '/tools/misc-python/virtualenv.py')}, 14:42:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:42:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:42:01 INFO - 'installer_path': 'installer.exe', 14:42:01 INFO - 'log_level': 'info', 14:42:01 INFO - 'log_name': 'talos', 14:42:01 INFO - 'log_to_console': True, 14:42:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:42:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:42:01 INFO - 'opt_config_files': (), 14:42:01 INFO - 'pip_index': False, 14:42:01 INFO - 'sps_profile': False, 14:42:01 INFO - 'sps_profile_interval': 0, 14:42:01 INFO - 'suite': 'dromaeojs', 14:42:01 INFO - 'system_bits': '32', 14:42:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:42:01 INFO - 'title': 'talos-linux64-ix-048', 14:42:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:42:01 INFO - 'use_talos_json': True, 14:42:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:42:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:42:01 INFO - 'work_dir': 'build'} 14:42:01 INFO - [mozharness: 2016-12-14 22:42:01.606198Z] Running clobber step. 14:42:01 INFO - Running pre-action listener: _resource_record_pre_action 14:42:01 INFO - Running main action method: clobber 14:42:01 INFO - rmtree: /builds/slave/test/build 14:42:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:42:02 INFO - Running post-action listener: _resource_record_post_action 14:42:02 INFO - [mozharness: 2016-12-14 22:42:02.574968Z] Finished clobber step (success) 14:42:02 INFO - [mozharness: 2016-12-14 22:42:02.575067Z] Running read-buildbot-config step. 14:42:02 INFO - Running pre-action listener: _resource_record_pre_action 14:42:02 INFO - Running main action method: read_buildbot_config 14:42:02 INFO - Using buildbot properties: 14:42:02 INFO - { 14:42:02 INFO - "project": "", 14:42:02 INFO - "product": "firefox", 14:42:02 INFO - "script_repo_revision": "default", 14:42:02 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 14:42:02 INFO - "repository": "", 14:42:02 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 14:42:02 INFO - "buildid": "20161214135000", 14:42:02 INFO - "pgo_build": "False", 14:42:02 INFO - "basedir": "/builds/slave/test", 14:42:02 INFO - "buildnumber": 20, 14:42:02 INFO - "slavename": "talos-linux64-ix-048", 14:42:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:42:02 INFO - "platform": "ubuntu64_hw", 14:42:02 INFO - "scheduler": "tests-graphics-linux64-talos", 14:42:02 INFO - "branch": "graphics", 14:42:02 INFO - "repo_path": "projects/graphics", 14:42:02 INFO - "revision": "92f621d51f1f1b395b131a7bb1f505e828585362", 14:42:02 INFO - "stage_platform": "linux64", 14:42:02 INFO - "builduid": "c251271b41f94eec9b757d6ba5304dc7", 14:42:02 INFO - "slavebuilddir": "test" 14:42:02 INFO - } 14:42:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 14:42:02 INFO - Running post-action listener: _resource_record_post_action 14:42:02 INFO - [mozharness: 2016-12-14 22:42:02.577471Z] Finished read-buildbot-config step (success) 14:42:02 INFO - [mozharness: 2016-12-14 22:42:02.577559Z] Running download-and-extract step. 14:42:02 INFO - Running pre-action listener: _resource_record_pre_action 14:42:02 INFO - Running main action method: download_and_extract 14:42:02 INFO - mkdir: /builds/slave/test/build/tests 14:42:02 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')]} 14:42:02 INFO - trying https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:42:02 INFO - Downloading https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/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 14:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/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 14:42:03 INFO - Downloaded 1361 bytes. 14:42:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:42:03 INFO - Using the following test package requirements: 14:42:03 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:42:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:42:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:42:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:03 INFO - u'jsshell-linux-x86_64.zip'], 14:42:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:42:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:42:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:42:03 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:42:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:42:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:42:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:42:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:42:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:42:03 INFO - Fetch https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:42:03 INFO - Expected file size: 20211977 14:42:03 INFO - Obtained file size: 20211977 14:42:07 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 14:42:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:42:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:42:07 INFO - Fetch https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:42:08 INFO - Expected file size: 20211977 14:42:08 INFO - Obtained file size: 20211977 14:42:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 14:42:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:42:13 INFO - Fetch https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:42:13 INFO - Expected file size: 14409734 14:42:13 INFO - Obtained file size: 14409734 14:42:14 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')]} 14:42:14 INFO - trying https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:42:14 INFO - Downloading https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/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 14:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/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 14:42:15 INFO - Downloaded 55785428 bytes. 14:42:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:42:15 INFO - mkdir: /builds/slave/test/properties 14:42:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:42:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:42:15 INFO - Contents: 14:42:15 INFO - build_url:https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:42:15 INFO - Running post-action listener: _resource_record_post_action 14:42:15 INFO - Running post-action listener: set_extra_try_arguments 14:42:15 INFO - [mozharness: 2016-12-14 22:42:15.851416Z] Finished download-and-extract step (success) 14:42:15 INFO - [mozharness: 2016-12-14 22:42:15.851641Z] Running populate-webroot step. 14:42:15 INFO - Running pre-action listener: _resource_record_pre_action 14:42:15 INFO - Running main action method: populate_webroot 14:42:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:42:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:42:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:42:15 INFO - '--tppagecycles', 14:42:15 INFO - '7'], 14:42:15 INFO - 'tests': ['tsvgm']}}, 14:42:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:42:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:42:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:42:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:42:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:42:15 INFO - 'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:42:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:42:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:42:15 INFO - 'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['damp', 'tps']}, 14:42:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:42:15 INFO - 'tests': ['damp', 'tps']}, 14:42:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['dromaeo_dom']}, 14:42:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:42:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['basic_compositor_video']}, 14:42:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:42:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['a11yr', 14:42:15 INFO - 'ts_paint', 14:42:15 INFO - 'tpaint', 14:42:15 INFO - 'sessionrestore', 14:42:15 INFO - 'sessionrestore_no_auto_restore', 14:42:15 INFO - 'tabpaint']}, 14:42:15 INFO - 'other-e10s': {'tests': ['a11yr', 14:42:15 INFO - 'ts_paint', 14:42:15 INFO - 'tpaint', 14:42:15 INFO - 'sessionrestore', 14:42:15 INFO - 'sessionrestore_no_auto_restore', 14:42:15 INFO - 'tabpaint']}, 14:42:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:42:15 INFO - 'ts_paint', 14:42:15 INFO - 'tpaint', 14:42:15 INFO - 'sessionrestore', 14:42:15 INFO - 'sessionrestore_no_auto_restore', 14:42:15 INFO - 'tabpaint']}, 14:42:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:42:15 INFO - 'ts_paint', 14:42:15 INFO - 'tpaint', 14:42:15 INFO - 'sessionrestore', 14:42:15 INFO - 'sessionrestore_no_auto_restore', 14:42:15 INFO - 'tabpaint']}, 14:42:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['a11yr', 14:42:15 INFO - 'ts_paint', 14:42:15 INFO - 'tpaint', 14:42:15 INFO - 'sessionrestore', 14:42:15 INFO - 'sessionrestore_no_auto_restore', 14:42:15 INFO - 'tabpaint']}, 14:42:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['a11yr', 14:42:15 INFO - 'ts_paint', 14:42:15 INFO - 'tpaint', 14:42:15 INFO - 'sessionrestore', 14:42:15 INFO - 'sessionrestore_no_auto_restore', 14:42:15 INFO - 'tabpaint']}, 14:42:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['tsvgx', 14:42:15 INFO - 'tsvgr_opacity', 14:42:15 INFO - 'tart', 14:42:15 INFO - 'tscrollx', 14:42:15 INFO - 'cart', 14:42:15 INFO - 'tsvg_static']}, 14:42:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:42:15 INFO - 'tsvgr_opacity', 14:42:15 INFO - 'tart', 14:42:15 INFO - 'tscrollx', 14:42:15 INFO - 'cart', 14:42:15 INFO - 'tsvg_static']}, 14:42:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:42:15 INFO - 'talos_options': ['--disable-e10s'], 14:42:15 INFO - 'tests': ['tp5o']}, 14:42:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:42:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:42:15 INFO - 'talos_options': ['--disable-e10s', 14:42:15 INFO - '--xperf_path', 14:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:42:15 INFO - 'tests': ['tp5n']}, 14:42:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:42:15 INFO - 'talos_options': ['--xperf_path', 14:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:42:15 INFO - 'tests': ['tp5n']}}, 14:42:15 INFO - 'talos.zip': {'path': '', 14:42:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:42:15 INFO - Running post-action listener: _resource_record_post_action 14:42:15 INFO - [mozharness: 2016-12-14 22:42:15.869159Z] Finished populate-webroot step (success) 14:42:15 INFO - [mozharness: 2016-12-14 22:42:15.869247Z] Running create-virtualenv step. 14:42:15 INFO - Running pre-action listener: _resource_record_pre_action 14:42:15 INFO - Running main action method: create_virtualenv 14:42:15 INFO - Creating virtualenv /builds/slave/test/build/venv 14:42:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:42:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:42:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:42:15 INFO - Using real prefix '/usr' 14:42:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:42:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:42:18 INFO - Installing pip.................done. 14:42:18 INFO - Return code: 0 14:42:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:42:18 INFO - Reading from file tmpfile_stdout 14:42:18 INFO - Output received: 14:42:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:42:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:42: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')]} 14:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42: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')]} 14:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:42:18 INFO - Using env: {'DISPLAY': ':0', 14:42:18 INFO - 'HOME': '/home/cltbld', 14:42:18 INFO - 'LANG': 'en_US.UTF-8', 14:42:18 INFO - 'LANGUAGE': 'en_US:en', 14:42:18 INFO - 'LOGNAME': 'cltbld', 14:42:18 INFO - 'MAIL': '/var/mail/cltbld', 14:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:18 INFO - 'MOZ_NO_REMOTE': '1', 14:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:18 INFO - 'NO_EM_RESTART': '1', 14:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:18 INFO - 'PWD': '/builds/slave/test', 14:42:18 INFO - 'SHELL': '/bin/bash', 14:42:18 INFO - 'SHLVL': '1', 14:42:18 INFO - 'TERM': 'linux', 14:42:18 INFO - 'TMOUT': '86400', 14:42:18 INFO - 'USER': 'cltbld', 14:42:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:18 INFO - '_': '/tools/buildbot/bin/python'} 14:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:42:18 INFO - Cleaning up... 14:42:18 INFO - Return code: 0 14:42:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:42: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')]} 14:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42: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')]} 14:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:42:18 INFO - Using env: {'DISPLAY': ':0', 14:42:18 INFO - 'HOME': '/home/cltbld', 14:42:18 INFO - 'LANG': 'en_US.UTF-8', 14:42:18 INFO - 'LANGUAGE': 'en_US:en', 14:42:18 INFO - 'LOGNAME': 'cltbld', 14:42:18 INFO - 'MAIL': '/var/mail/cltbld', 14:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:18 INFO - 'MOZ_NO_REMOTE': '1', 14:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:18 INFO - 'NO_EM_RESTART': '1', 14:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:18 INFO - 'PWD': '/builds/slave/test', 14:42:18 INFO - 'SHELL': '/bin/bash', 14:42:18 INFO - 'SHLVL': '1', 14:42:18 INFO - 'TERM': 'linux', 14:42:18 INFO - 'TMOUT': '86400', 14:42:18 INFO - 'USER': 'cltbld', 14:42:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:18 INFO - '_': '/tools/buildbot/bin/python'} 14:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:19 INFO - Downloading/unpacking psutil>=3.1.1 14:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:42:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:42:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:42:21 INFO - Installing collected packages: psutil 14:42:21 INFO - Running setup.py install for psutil 14:42:21 INFO - building 'psutil._psutil_linux' extension 14:42:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:42:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:42:21 INFO - building 'psutil._psutil_posix' extension 14:42:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:42:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:42:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:42:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:42:21 INFO - Successfully installed psutil 14:42:21 INFO - Cleaning up... 14:42:21 INFO - Return code: 0 14:42:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:42:21 INFO - Using env: {'DISPLAY': ':0', 14:42:21 INFO - 'HOME': '/home/cltbld', 14:42:21 INFO - 'LANG': 'en_US.UTF-8', 14:42:21 INFO - 'LANGUAGE': 'en_US:en', 14:42:21 INFO - 'LOGNAME': 'cltbld', 14:42:21 INFO - 'MAIL': '/var/mail/cltbld', 14:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:21 INFO - 'MOZ_NO_REMOTE': '1', 14:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:21 INFO - 'NO_EM_RESTART': '1', 14:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:21 INFO - 'PWD': '/builds/slave/test', 14:42:21 INFO - 'SHELL': '/bin/bash', 14:42:21 INFO - 'SHLVL': '1', 14:42:21 INFO - 'TERM': 'linux', 14:42:21 INFO - 'TMOUT': '86400', 14:42:21 INFO - 'USER': 'cltbld', 14:42:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:21 INFO - '_': '/tools/buildbot/bin/python'} 14:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:42:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:42:23 INFO - Installing collected packages: mozsystemmonitor 14:42:23 INFO - Running setup.py install for mozsystemmonitor 14:42:24 INFO - Successfully installed mozsystemmonitor 14:42:24 INFO - Cleaning up... 14:42:24 INFO - Return code: 0 14:42:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:42:24 INFO - Using env: {'DISPLAY': ':0', 14:42:24 INFO - 'HOME': '/home/cltbld', 14:42:24 INFO - 'LANG': 'en_US.UTF-8', 14:42:24 INFO - 'LANGUAGE': 'en_US:en', 14:42:24 INFO - 'LOGNAME': 'cltbld', 14:42:24 INFO - 'MAIL': '/var/mail/cltbld', 14:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:24 INFO - 'MOZ_NO_REMOTE': '1', 14:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:24 INFO - 'NO_EM_RESTART': '1', 14:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:24 INFO - 'PWD': '/builds/slave/test', 14:42:24 INFO - 'SHELL': '/bin/bash', 14:42:24 INFO - 'SHLVL': '1', 14:42:24 INFO - 'TERM': 'linux', 14:42:24 INFO - 'TMOUT': '86400', 14:42:24 INFO - 'USER': 'cltbld', 14:42:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:24 INFO - '_': '/tools/buildbot/bin/python'} 14:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:24 INFO - Downloading/unpacking jsonschema==2.5.1 14:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:42:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:26 INFO - Downloading functools32-3.2.3-2.tar.gz 14:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:42:26 INFO - warning: no files found matching '*.txt' 14:42:26 INFO - no previously-included directories found matching 'build' 14:42:26 INFO - no previously-included directories found matching 'dist' 14:42:26 INFO - no previously-included directories found matching '.git*' 14:42:26 INFO - Installing collected packages: jsonschema, functools32 14:42:26 INFO - Running setup.py install for functools32 14:42:26 INFO - warning: no files found matching '*.txt' 14:42:26 INFO - no previously-included directories found matching 'build' 14:42:26 INFO - no previously-included directories found matching 'dist' 14:42:26 INFO - no previously-included directories found matching '.git*' 14:42:26 INFO - Successfully installed jsonschema functools32 14:42:26 INFO - Cleaning up... 14:42:26 INFO - Return code: 0 14:42:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:42: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')]} 14:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42: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')]} 14:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:42:26 INFO - Using env: {'DISPLAY': ':0', 14:42:26 INFO - 'HOME': '/home/cltbld', 14:42:26 INFO - 'LANG': 'en_US.UTF-8', 14:42:26 INFO - 'LANGUAGE': 'en_US:en', 14:42:26 INFO - 'LOGNAME': 'cltbld', 14:42:26 INFO - 'MAIL': '/var/mail/cltbld', 14:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:26 INFO - 'MOZ_NO_REMOTE': '1', 14:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:26 INFO - 'NO_EM_RESTART': '1', 14:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:26 INFO - 'PWD': '/builds/slave/test', 14:42:26 INFO - 'SHELL': '/bin/bash', 14:42:26 INFO - 'SHLVL': '1', 14:42:26 INFO - 'TERM': 'linux', 14:42:26 INFO - 'TMOUT': '86400', 14:42:26 INFO - 'USER': 'cltbld', 14:42:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:26 INFO - '_': '/tools/buildbot/bin/python'} 14:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:42:26 INFO - Cleaning up... 14:42:27 INFO - Return code: 0 14:42:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:42:27 INFO - Using env: {'DISPLAY': ':0', 14:42:27 INFO - 'HOME': '/home/cltbld', 14:42:27 INFO - 'LANG': 'en_US.UTF-8', 14:42:27 INFO - 'LANGUAGE': 'en_US:en', 14:42:27 INFO - 'LOGNAME': 'cltbld', 14:42:27 INFO - 'MAIL': '/var/mail/cltbld', 14:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:27 INFO - 'MOZ_NO_REMOTE': '1', 14:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:27 INFO - 'NO_EM_RESTART': '1', 14:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:27 INFO - 'PWD': '/builds/slave/test', 14:42:27 INFO - 'SHELL': '/bin/bash', 14:42:27 INFO - 'SHLVL': '1', 14:42:27 INFO - 'TERM': 'linux', 14:42:27 INFO - 'TMOUT': '86400', 14:42:27 INFO - 'USER': 'cltbld', 14:42:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:27 INFO - '_': '/tools/buildbot/bin/python'} 14:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:27 INFO - Downloading/unpacking blobuploader==1.2.4 14:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:29 INFO - Downloading blobuploader-1.2.4.tar.gz 14:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:42:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:42:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:29 INFO - Downloading docopt-0.6.1.tar.gz 14:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:42:29 INFO - Installing collected packages: blobuploader, requests, docopt 14:42:29 INFO - Running setup.py install for blobuploader 14:42:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:42:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:42:30 INFO - Running setup.py install for requests 14:42:30 INFO - Running setup.py install for docopt 14:42:30 INFO - Successfully installed blobuploader requests docopt 14:42:30 INFO - Cleaning up... 14:42:30 INFO - Return code: 0 14:42:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:42:30 INFO - Using env: {'DISPLAY': ':0', 14:42:30 INFO - 'HOME': '/home/cltbld', 14:42:30 INFO - 'LANG': 'en_US.UTF-8', 14:42:30 INFO - 'LANGUAGE': 'en_US:en', 14:42:30 INFO - 'LOGNAME': 'cltbld', 14:42:30 INFO - 'MAIL': '/var/mail/cltbld', 14:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:30 INFO - 'MOZ_NO_REMOTE': '1', 14:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:30 INFO - 'NO_EM_RESTART': '1', 14:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:30 INFO - 'PWD': '/builds/slave/test', 14:42:30 INFO - 'SHELL': '/bin/bash', 14:42:30 INFO - 'SHLVL': '1', 14:42:30 INFO - 'TERM': 'linux', 14:42:30 INFO - 'TMOUT': '86400', 14:42:30 INFO - 'USER': 'cltbld', 14:42:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:30 INFO - '_': '/tools/buildbot/bin/python'} 14:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:42:30 INFO - Running setup.py (path:/tmp/pip-KP_vwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:42:30 INFO - Running setup.py (path:/tmp/pip-cGnsDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:42:30 INFO - Running setup.py (path:/tmp/pip-sBFXw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:42:31 INFO - Running setup.py (path:/tmp/pip-o6CCfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:42:31 INFO - Running setup.py (path:/tmp/pip-afDkLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:42:31 INFO - Running setup.py (path:/tmp/pip-8XzdUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:42:31 INFO - Running setup.py (path:/tmp/pip-AD7kbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:42:31 INFO - Running setup.py (path:/tmp/pip-wNCA_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:42:31 INFO - Running setup.py (path:/tmp/pip-GdqFOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:42:31 INFO - Running setup.py (path:/tmp/pip-rxvZog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:42:31 INFO - Running setup.py (path:/tmp/pip-fV4XVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:42:31 INFO - Running setup.py (path:/tmp/pip-yLpime-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:42:31 INFO - Running setup.py (path:/tmp/pip-ZAhxz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:42:31 INFO - Running setup.py (path:/tmp/pip-h4Widc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:42:31 INFO - Running setup.py (path:/tmp/pip-jC9LcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:42:31 INFO - Running setup.py (path:/tmp/pip-9OJ0PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:42:31 INFO - Running setup.py (path:/tmp/pip-VSJup5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:42:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:42:32 INFO - Running setup.py install for manifestparser 14:42:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:42:32 INFO - Running setup.py install for mozcrash 14:42:32 INFO - Running setup.py install for mozdebug 14:42:32 INFO - Running setup.py install for mozdevice 14:42:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:42:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:42:32 INFO - Running setup.py install for mozfile 14:42:32 INFO - Running setup.py install for mozhttpd 14:42:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:42:32 INFO - Running setup.py install for mozinfo 14:42:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:42:32 INFO - Running setup.py install for mozInstall 14:42:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:42:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:42:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:42:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:42:32 INFO - Running setup.py install for mozleak 14:42:32 INFO - Running setup.py install for mozlog 14:42:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:42:33 INFO - Running setup.py install for moznetwork 14:42:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:42:33 INFO - Running setup.py install for mozprocess 14:42:33 INFO - Running setup.py install for mozprofile 14:42:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:42:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:42:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:42:33 INFO - Running setup.py install for mozrunner 14:42:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:42:33 INFO - Running setup.py install for mozscreenshot 14:42:33 INFO - Running setup.py install for moztest 14:42:33 INFO - Running setup.py install for mozversion 14:42:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:42:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:42:33 INFO - Cleaning up... 14:42:33 INFO - Return code: 0 14:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:42:33 INFO - Using env: {'DISPLAY': ':0', 14:42:33 INFO - 'HOME': '/home/cltbld', 14:42:33 INFO - 'LANG': 'en_US.UTF-8', 14:42:33 INFO - 'LANGUAGE': 'en_US:en', 14:42:33 INFO - 'LOGNAME': 'cltbld', 14:42:33 INFO - 'MAIL': '/var/mail/cltbld', 14:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:33 INFO - 'MOZ_NO_REMOTE': '1', 14:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:33 INFO - 'NO_EM_RESTART': '1', 14:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:33 INFO - 'PWD': '/builds/slave/test', 14:42:33 INFO - 'SHELL': '/bin/bash', 14:42:33 INFO - 'SHLVL': '1', 14:42:33 INFO - 'TERM': 'linux', 14:42:33 INFO - 'TMOUT': '86400', 14:42:33 INFO - 'USER': 'cltbld', 14:42:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:33 INFO - '_': '/tools/buildbot/bin/python'} 14:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:42:34 INFO - Running setup.py (path:/tmp/pip-s2GppV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:42:34 INFO - Running setup.py (path:/tmp/pip-efep9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:42:34 INFO - Running setup.py (path:/tmp/pip-WB3ZKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:42:34 INFO - Running setup.py (path:/tmp/pip-5Ggq98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:42:34 INFO - Running setup.py (path:/tmp/pip-GIKzEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:42:34 INFO - Running setup.py (path:/tmp/pip-QEdFBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:42:34 INFO - Running setup.py (path:/tmp/pip-Z5TRZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:42:34 INFO - Running setup.py (path:/tmp/pip-iZ92w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:42:34 INFO - Running setup.py (path:/tmp/pip-80eIv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:42:34 INFO - Running setup.py (path:/tmp/pip-hsNMaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:42:34 INFO - Running setup.py (path:/tmp/pip-lQaVGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:42:34 INFO - Running setup.py (path:/tmp/pip-DNUgHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:42:34 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)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:42:34 INFO - Running setup.py (path:/tmp/pip-tBUirF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:42:34 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)) 14:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:42:35 INFO - Running setup.py (path:/tmp/pip-HjSKjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:42:35 INFO - Running setup.py (path:/tmp/pip-L7KRZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:42:35 INFO - Running setup.py (path:/tmp/pip-LE_F7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:42:35 INFO - Running setup.py (path:/tmp/pip-fJNzFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:42:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:37 INFO - Downloading blessings-1.6.tar.gz 14:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:42:37 INFO - Installing collected packages: blessings 14:42:37 INFO - Running setup.py install for blessings 14:42:37 INFO - Successfully installed blessings 14:42:37 INFO - Cleaning up... 14:42:37 INFO - Return code: 0 14:42:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:42:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:42:37 INFO - Reading from file tmpfile_stdout 14:42:37 INFO - Current package versions: 14:42:37 INFO - argparse == 1.2.1 14:42:37 INFO - blessings == 1.6 14:42:37 INFO - blobuploader == 1.2.4 14:42:37 INFO - docopt == 0.6.1 14:42:37 INFO - functools32 == 3.2.3-2 14:42:37 INFO - jsonschema == 2.5.1 14:42:37 INFO - manifestparser == 1.1 14:42:37 INFO - mozInstall == 1.12 14:42:37 INFO - mozcrash == 1.0 14:42:37 INFO - mozdebug == 0.1 14:42:37 INFO - mozdevice == 0.49 14:42:37 INFO - mozfile == 1.2 14:42:37 INFO - mozhttpd == 0.7 14:42:37 INFO - mozinfo == 0.9 14:42:37 INFO - mozleak == 0.1 14:42:37 INFO - mozlog == 3.4 14:42:37 INFO - moznetwork == 0.27 14:42:37 INFO - mozprocess == 0.23 14:42:37 INFO - mozprofile == 0.28 14:42:37 INFO - mozrunner == 6.13 14:42:37 INFO - mozscreenshot == 0.1 14:42:37 INFO - mozsystemmonitor == 0.3 14:42:37 INFO - moztest == 0.7 14:42:37 INFO - mozversion == 1.4 14:42:37 INFO - psutil == 3.1.1 14:42:37 INFO - requests == 1.2.3 14:42:37 INFO - wsgiref == 0.1.2 14:42:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:42:37 INFO - Using env: {'DISPLAY': ':0', 14:42:37 INFO - 'HOME': '/home/cltbld', 14:42:37 INFO - 'LANG': 'en_US.UTF-8', 14:42:37 INFO - 'LANGUAGE': 'en_US:en', 14:42:37 INFO - 'LOGNAME': 'cltbld', 14:42:37 INFO - 'MAIL': '/var/mail/cltbld', 14:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:37 INFO - 'MOZ_NO_REMOTE': '1', 14:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:37 INFO - 'NO_EM_RESTART': '1', 14:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:37 INFO - 'PWD': '/builds/slave/test', 14:42:37 INFO - 'SHELL': '/bin/bash', 14:42:37 INFO - 'SHLVL': '1', 14:42:37 INFO - 'TERM': 'linux', 14:42:37 INFO - 'TMOUT': '86400', 14:42:37 INFO - 'USER': 'cltbld', 14:42:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:37 INFO - '_': '/tools/buildbot/bin/python'} 14:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:37 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)) 14:42:37 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)) 14:42:37 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)) 14:42:37 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)) 14:42:37 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)) 14:42:37 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)) 14:42:37 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)) 14:42:37 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)) 14:42:37 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)) 14:42:37 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)) 14:42:37 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)) 14:42:37 INFO - Cleaning up... 14:42:37 INFO - Return code: 0 14:42:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9710223e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, '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': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', '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 14:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:42:37 INFO - Using env: {'DISPLAY': ':0', 14:42:37 INFO - 'HOME': '/home/cltbld', 14:42:37 INFO - 'LANG': 'en_US.UTF-8', 14:42:37 INFO - 'LANGUAGE': 'en_US:en', 14:42:37 INFO - 'LOGNAME': 'cltbld', 14:42:37 INFO - 'MAIL': '/var/mail/cltbld', 14:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:37 INFO - 'MOZ_NO_REMOTE': '1', 14:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:37 INFO - 'NO_EM_RESTART': '1', 14:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:37 INFO - 'PWD': '/builds/slave/test', 14:42:37 INFO - 'SHELL': '/bin/bash', 14:42:37 INFO - 'SHLVL': '1', 14:42:37 INFO - 'TERM': 'linux', 14:42:37 INFO - 'TMOUT': '86400', 14:42:37 INFO - 'USER': 'cltbld', 14:42:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:37 INFO - '_': '/tools/buildbot/bin/python'} 14:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:42:38 INFO - Cleaning up... 14:42:38 INFO - Return code: 0 14:42:38 INFO - Running post-action listener: _resource_record_post_action 14:42:38 INFO - Running post-action listener: _start_resource_monitoring 14:42:38 INFO - Starting resource monitoring. 14:42:38 INFO - [mozharness: 2016-12-14 22:42:38.219903Z] Finished create-virtualenv step (success) 14:42:38 INFO - [mozharness: 2016-12-14 22:42:38.220376Z] Running install step. 14:42:38 INFO - Running pre-action listener: _resource_record_pre_action 14:42:38 INFO - Running main action method: install 14:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:42:38 INFO - Reading from file tmpfile_stdout 14:42:38 INFO - Detecting whether we're running mozinstall >=1.0... 14:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:42:38 INFO - Reading from file tmpfile_stdout 14:42:38 INFO - Output received: 14:42:38 INFO - Usage: mozinstall [options] installer 14:42:38 INFO - Options: 14:42:38 INFO - -h, --help show this help message and exit 14:42:38 INFO - -d DEST, --destination=DEST 14:42:38 INFO - Directory to install application into. [default: 14:42:38 INFO - "/builds/slave/test"] 14:42:38 INFO - --app=APP Application being installed. [default: firefox] 14:42:38 INFO - mkdir: /builds/slave/test/build/application 14:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:42:54 INFO - Reading from file tmpfile_stdout 14:42:54 INFO - Output received: 14:42:54 INFO - /builds/slave/test/build/application/firefox/firefox 14:42:54 INFO - Running post-action listener: _resource_record_post_action 14:42:54 INFO - [mozharness: 2016-12-14 22:42:54.590107Z] Finished install step (success) 14:42:54 INFO - [mozharness: 2016-12-14 22:42:54.590348Z] Running run-tests step. 14:42:54 INFO - Running pre-action listener: _resource_record_pre_action 14:42:54 INFO - Running main action method: run_tests 14:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:42:54 INFO - Python 2.7.3 14:42:54 INFO - Return code: 0 14:42:54 INFO - grabbing minidump binary from tooltool 14:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6f20>, '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 0x2a53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a53f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:42:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:42:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:42:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:42:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:42:54 INFO - Return code: 0 14:42:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:42:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:42:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:42:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:42:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:42:54 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/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 14:42:54 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/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 14:42:54 INFO - Using env: {'DISPLAY': ':0', 14:42:54 INFO - 'HOME': '/home/cltbld', 14:42:54 INFO - 'LANG': 'en_US.UTF-8', 14:42:54 INFO - 'LANGUAGE': 'en_US:en', 14:42:54 INFO - 'LOGNAME': 'cltbld', 14:42:54 INFO - 'MAIL': '/var/mail/cltbld', 14:42:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:42:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:54 INFO - 'MOZ_NO_REMOTE': '1', 14:42:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:54 INFO - 'NO_EM_RESTART': '1', 14:42:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:54 INFO - 'PWD': '/builds/slave/test', 14:42:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:42:54 INFO - 'SHELL': '/bin/bash', 14:42:54 INFO - 'SHLVL': '1', 14:42:54 INFO - 'TERM': 'linux', 14:42:54 INFO - 'TMOUT': '86400', 14:42:54 INFO - 'USER': 'cltbld', 14:42:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074', 14:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:54 INFO - '_': '/tools/buildbot/bin/python'} 14:42:54 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/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 14:42:54 INFO - mozversion application_buildid: 20161214135000 14:42:54 INFO - mozversion application_changeset: 92f621d51f1f1b395b131a7bb1f505e828585362 14:42:54 INFO - mozversion application_display_name: Nightly 14:42:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:42:54 INFO - mozversion application_name: Firefox 14:42:54 INFO - mozversion application_remotingname: firefox 14:42:54 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 14:42:54 INFO - mozversion application_vendor: Mozilla 14:42:54 INFO - mozversion application_version: 53.0a1 14:42:54 INFO - mozversion platform_buildid: 20161214135000 14:42:54 INFO - mozversion platform_changeset: 92f621d51f1f1b395b131a7bb1f505e828585362 14:42:54 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 14:42:54 INFO - mozversion platform_version: 53.0a1 14:42:54 INFO - using testdate: 1481755374 14:42:54 INFO - actual date: 1481755374 14:42:54 INFO - starting webserver on 'localhost:59159' 14:42:54 INFO - SUITE-START | Running 2 tests 14:42:54 INFO - TEST-START | dromaeo_css 14:42:54 INFO - operating with platform_type : linux_ 14:42:54 INFO - Initialising browser for dromaeo_css test... 14:42:54 INFO - TEST-INFO | started process 25790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzcSLHY/profile http://localhost:59159/getInfo.html) 14:42:59 INFO - PROCESS | 25790 | __metrics Screen width/height:1600/1200 14:42:59 INFO - PROCESS | 25790 | colorDepth:24 14:42:59 INFO - PROCESS | 25790 | Browser inner width/height: 1024/697 14:42:59 INFO - PROCESS | 25790 | __metrics 14:43:00 INFO - PROCESS | 25790 | 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" 14:43:00 INFO - PROCESS | 25790 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:43:01 INFO - TEST-INFO | 25790: exit 0 14:43:01 INFO - Browser initialized. 14:43:01 INFO - Running cycle 1/1 for dromaeo_css test... 14:43:02 INFO - TEST-INFO | started process 25874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzcSLHY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:14 INFO - PROCESS | 25874 | RSS: Main: 173981696 14:43:14 INFO - PROCESS | 25874 | 14:44:05 INFO - PROCESS | 25874 | 1481755445254 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] 14:46:19 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59159/tests/dromaeo/cssquery-ext.html) 14:46:21 INFO - PROCESS | 25874 | RSS: Main: 337092608 14:46:21 INFO - PROCESS | 25874 | 14:49:23 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-ext.html (next: http://localhost:59159/tests/dromaeo/cssquery-jquery.html) 14:49:24 INFO - PROCESS | 25874 | RSS: Main: 291627008 14:49:24 INFO - PROCESS | 25874 | 14:52:26 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59159/tests/dromaeo/cssquery-mootools.html) 14:52:27 INFO - PROCESS | 25874 | RSS: Main: 237654016 14:52:27 INFO - PROCESS | 25874 | 14:55:29 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59159/tests/dromaeo/cssquery-prototype.html) 14:55:30 INFO - PROCESS | 25874 | RSS: Main: 238526464 14:55:30 INFO - PROCESS | 25874 | 14:58:33 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59159/tests/dromaeo/cssquery-yui.html) 14:58:34 INFO - PROCESS | 25874 | RSS: Main: 224792576 14:58:34 INFO - PROCESS | 25874 | 15:01:37 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-yui.html (next: http://localhost:59159/tests/dromaeo/cssquery-dojo.html) 15:01:37 INFO - PROCESS | 25874 | RSS: Main: 317001728 15:01:37 INFO - PROCESS | 25874 | 15:01:37 INFO - PROCESS | 25874 | __start_tp_report 15:01:37 INFO - PROCESS | 25874 | _x_x_mozilla_page_load 15:01:37 INFO - PROCESS | 25874 | _x_x_mozilla_page_load_details 15:01:37 INFO - PROCESS | 25874 | |i|pagename|runs| 15:01:37 INFO - PROCESS | 25874 | |0;dojo.html;2573.459573489567;2596.065416450079;2601.986990065049;2622.855742934139;2630.539655560278;4415.425994620695;4480.865574032776;4633.606143477804;4653.8371157009515;4657.673962822604;4530.3883975663275;4563.064571762789;4580.038191979688;4605.4703709073465;4618.8452886778305;4138.503379594438;4146.170765846828;4189.476315460567;4249.83000679974;4334.956650433503;4187.099773548686;4225.873223803291;4311.611954924057;4347.956520434803;4377.781110944456;4102.056526998777;4114;4288.656907447396;4352.586504282088;4368.694191406603;4150.3566947123245;4154.50145982481;4166.500019997619;4166.83332666693;4169.833206671729;4144.378343248507;4150.232207041707;4151.066010147722;4152.37714342848;4152.501699796044;4530.207213737583;4533.637309015271;4582.014866803654;4588.816447342102;4617.376654151713;4887.193613053842;4895.902081958377;4898.755062246909;4899.485554016813;4943.233798761198;4742.50203728607;4806;4903.509649035103;4913.950860491385;4960.826371077031;4491.1017796441165;4558.0655965526985;4594.908101837945;4596.47140578831;4655.557722016403;5046.44489106198;5048.3184770056305;5050.873728156826;5053.620978426559;5089.338386009795;4664.696794708333;4786.569208771228;4834.709917404967;4842.249451335048;4849.102915960559;4773.713577185311;4856.95143048572;4884.7069175849565;4900.828471003569;4918.483559226302;4891.559759621651;4944.728039957765;4951.950480495221;4958.752062396866;4968.925466118011;4886.486918873538;4891.192953162688;4897.7403065556655;4900.779464924087;4950.084234416644;3886.0867696091395;3903.843846246175;4045.37296719009;4076.144009757925;4086.1827634473225;3505.631908649606;3518.683318501347;3569.036360182788;3579.838907249128;3625.9637403625625;4229.725067870579;4231.851885184004;4233.364995250737;4245.724027938174;4285.97857010713;4902.191138462185;4910.852674419773;4912.042151780369;4915;4948.38145231846;4094.6928980326593;4123.092919557693;4127.133302006552;4128.1330920507025;4174.749515029108;4287.464066991626;4293.119910418419;4303.612674859215;4308.353746937922;4309.461317335333;4544.295634176708;4550.271956487012;4550.408446901882;4552.203364411281;4553.704009239389;4807.326974223682;4852.320675105559;4878.63410244226;4912.631552633638;4983.950160498349;4615.100055489147;4621.237495813153;4623;4662.067586482649;4668.6498512611015;4813.15769740301;4853.611711063036;4855.49017353187;4860.149473841992;4900.5099490052135;4719.905601888012;4742.288656701522;4745.715257084586;4815.3258543804595;4913.508649135058;4690.765461726968;4690.859274221779;4697.859064228079;4699.130660827758;4700.670953033255;4696.577308042156;4716.268978308368;4729.739864307496;4761.76191190446;4802.039592081528;4681.812727490998;4694.62443004552;4697.788599512962;4705.882352941204;4735;4680.08738296029;4783.04339132168;4784.354112194948;4785.6171506278715;4824.855254342376;4582.679212455096;4656.185167595725;4656.7671616418365;4659.091477161921;4661.906761864811 15:01:37 INFO - PROCESS | 25874 | |1;ext.html;509.8113697931766;529.9761510732019;530.4562823106315;539.3635510098084;555.6388347574078;27020.864895675517;28427.431451370987;36630.450543241874;38792;38884;39480.407793883045;40020.39969400454;40024;40047;40123;7397.926020739791;7565.356944659683;7565.546067235983;7569.772906812805;7573.7349192778265;7332.9266707333045;7553.093628764556;9539.236861051098;9818.263630227726;9831;9881.110700036996;9892.752681182992;9907.256955728313;9935.205183585333;9965.15296199824;9528.142467177953;9584.185344245678;9586.185174260196;9594.280428967786;9599.520023998843;9715.417074975525;9761.707148785548;9777.168940640055;9777.560009799576;9778.315517913748;36621;37076.62923370759;37080.25839483222;37089;37163.25673486542;2926.2538052796613;3184.3153721949893;3257.983710081458;3596.352656521825;3625.764325318872;27639.86180069107;27991.86004069987;28111.297217569725;28221.858890705415;29296.70703292961;3342.4418834897597;3362.3443428531446;3392.355452464024;3416.794992300445;3468.202313467891;240722;240792;241468;241719;242618;49463.25805112926;49468;49542;49761;49856.50143498591;51429.742851285504;51493.485065149616;51536.48463515317;51586.22620660693;51597.8402159781;14679.926600366929;14879.553613391616;14991.625209369635;14998.47505337308;15004.399824007136;10462.790744185226;10776.245662803529;11615.128865334964;11649.59226427071;11780.70548236301;12943.935280323727;13035.869641303465;13069.346532673328;13081;13878.653033674036;4772.379634350631;5652.9152062719095;5707.743151558107;5719.599628025998;5798.304203495523;755.9697612095455;786.1156199275815;813.5769399912131;835.6866175184306;899.6446403670644;25946;26973.325666858094;27708.722912770616;28024.579631305547;28056.579151312748;852.9445586036887;916.029009250197;950.4344914775697;974.9220062394992;1057.7038429239826;13739.519116830863;14636.707265854837;14696.338664760111;14783.778243326358;14851.628709282355;342107;342112;344059;345192;346436;40701.592984070376;41813.58186418158;46324.536754632696;47840;47853.28220076702;1105.8009558279748;1141.3209140561353;1148.7759886821989;1150.71232191952;1151.4933429291252;27085.1874443767;28132.156035318974;28753.712462875104;29205.7079429203;29269.26826829261;40328.59671403366;40903.795481022404;40925.386119207644;40956;41041.58958410378;302548;303192;304306;305887;306680;33876.66123338834;34284.80003199876;34603.65396346004;35996.28007439889;39545.80227098961;39555.2088958225;41795.37306940459;41801.58198417977;41817.372739408325;42811.35782963196;35516.28967420689;35921.64078359183;35930.742424015036;36224.63775362318;36281.45577816282;34612.13469663178;35361.46957795584;35380.29239415146;35802.462963055055;35879.82060089683;34851.65148348484;35495.64504354924;35881;36149.81925090463;36170.819145904105;30353;33228.50157247595;33463;33647.66352336543;33700.32599348048;24721;25341.493170136862;25478.03178380198;25646.87176564105;25986.740132598432 15:01:37 INFO - PROCESS | 25874 | |2;jquery.html;346.4232053630705;360.20754340451;360.7222438722183;364.1533434764173;383.5359215349429;12220.938895305522;14968.401263949443;15151.62120946977;15546.689066218698;16438;15383.384664613402;15811.051336919792;15882.205889705527;16081.919590402062;16392.180390980433;3679.613640567742;4522.095580883828;4676.555727205927;4681.157391669498;4719.669623126382;4630.421197350332;4666.230072038126;4668.719876807386;4669.813207471697;4676.7427791471455;4569.268916973285;4662.230731929228;4671.346011558385;4672.766361681919;4676.415448068991;4971.45314015458;4972.428170760355;5012.323336349583;5014.373203349582;5016.949830501685;4532.79602417892;4542.432195975503;4545.977270113628;4548.8862778430475;4550.613197878184;12419.130660853743;17591.648167036714;18412.81587184138;18989.145488453054;19117.23531058756;1800.4508624869409;1843.2626949220285;1917.1756144857707;2104.4244702836004;2328.348062542491;8303.875441868377;8819.603117859711;9065.456072635598;9294.209992150676;9491.098345657152;1550.4960887711427;1625.0424227905216;1630.7553866920057;1631.3882294139698;1642.7700121982932;62975;63557.364426355605;64212.67893660549;65600;65664.01503977492;9742.31803773729;9858.359206651545;9865.654702085392;10070;10148.746281343025;13605.183688978694;13609.11540749848;13609.659758506117;13615.18308901469;13619.18284902909;6950.826229344307;7290.45321600882;7291.781246562611;7486.326230639269;7544.434167437465;6869.965650171717;6989.615571143534;7049.964750176319;7195.532290401107;7197.676104575306;4147.6267135957905;4241.6214730212805;4283.1433713257475;4345.869623911288;4426.44669416323;1805.2740362053132;1808.2947650416347;1817.2730907636787;1822.2528763207285;1858.6096919646754;610.206731249374;710.989335159973;780.5277806926728;858.4763294390417;893.8257039877161;15602.843971560365;15786.60533486649;16307.91846040786;16318.75521867173;17158.656826863393;802.2619190344897;807.7092246791151;825.6202147012442;832.862577674689;844.5355054719879;9012.954935225413;9113.316501262432;9544.713658590254;9556.187724043395;9654.324197306121;312567;318131;334890.1620821708;336543;336561;66944.3305566938;68601.65699171473;70352;71820.64089679519;73794.8930766039;878.3324673248505;893.9195472407514;917.8026724254318;921.0927236671873;925;14267.357968891218;14406.351714173097;14613.70772584521;14664.70670586561;15212.239388030333;34619;34665.65334346624;34800.82599587087;35378;35498.29003419865;46998.76500617475;47882.76058619685;47915;48377;48406.757966209945;7476.140243871807;7620.961895190489;7645.426593005435;7650.120236172689;7892.171322011336;10527.157827373945;10664.307704609946;11171.608993685182;11368.374739389083;11508.309501429942;7042.436605071684;9148.875803264104;9811.607535698493;9821.312508124649;9909;10071;10129.949350253202;10167.18662506983;10367.896321036693;10384.480775961323;9607.327487075838;9750.561224745046;9837.9016209837;9867.11195992364;10107.3430227035;7324.304191101837;7357.19070902211;7497.325240728361;7669.501482403626;7761.883571746315;7689.577073260801;8760.605772740115;9090.36367454272;9562.856557151508;9923.900760992297 15:01:37 INFO - PROCESS | 25874 | |3;mootools.html;1295.6955115547844;1314.4347930389933;1377.710680757041;1611.1299898055051;1617.1752406272797;5738.626989245707;5924.763009479627;6140.7543698252075;6535.70589323481;6546.901796473051;6054.909176362358;6228.84427889303;6231.158793562868;6387.201599800025;6406.679666016692;1992.9501762455945;2037.8369730421605;2038.1337931379178;2039.7450318710162;2040.9591808163827;1782.7325901114807;1989.3136867780593;2020.0909590684178;2029.8579099463043;2048.7131801547794;1811.05824971015;1959.1673538746047;2025.2202901882733;2028.5942811437699;2052.665767251284;1956.7064940258933;1957.3736404350614;1965.5380985468332;1968.714536392215;1971.9605607887906;2031.2890488329115;2056.9485762856048;2062.267894897305;2063;2065.0500769645982;6598.637074960875;6631.867362652768;6669.633170175687;6682.532222744409;6688.531802773808;4126.752394856288;4246.808893599796;4252.489701235841;4259.403683484315;4263.87208383749;2554.0549996501227;2807.2280122966145;2836.7588754955855;2846.957295640567;2857.6427946506687;862.4911302331592;903.2503022491317;945.3807755919884;948.0519480519481;953.1707414549317;8430.241278284922;8449.873251901226;8455.661773529051;8460.069392366835;8463.915360846375;3641.1443310821937;3793.7723736575895;3824;3875.5155605549307;3886.0479182600443;7376.446766492427;7391.2978267064545;7429.294217049372;7444.702211911571;7455.0681164854395;4229.957700422957;4237.78811059452;4241.27898257297;4242.384854196124;4274.294741367702;3641.5630124385243;3898.629630185128;3903.2974064668633;3904.1996390739832;3906.7851268180525;3191.3564514275167;3225.5322978168033;3354.832258387071;3362.596488421405;3424.417848965682;1032.83990981398;1113.2708076210095;1142.7428828513519;1161.7618388230392;1167.7139100920328;597.5339235396398;768.3929695540572;816.7631386897851;818.8075802186481;839.2321026260903;4662.603678687349;4712.64655150865;4718.551737584924;4752.405949256343;4886.389201349832;840.1808236968907;845.1590667285967;846.7078857794052;875.3216257400566;891.5586784541694;3200.1839530919465;3261.445554255735;3332.600087989457;3398.5921689397433;3412.914677133042;7321.377682896907;7522.699092036367;7568.772936811904;7633;7770.883436748453;7432.85134297311;7478.626068696543;7494.250574942571;7506.849863002819;7508.774736757906;5993.61041532299;6063.5452341073715;6125.693715314305;6156.6921653918025;6173.104899789505;4566.908661826811;4774.283857421276;4815.398075240595;4828.637852161172;4921.704697718148;7091.3263239994185;7103.112110986127;7130.465215108784;7198.7840364789145;7200.639968001684;7172.211056783645;7223.566586004857;7253.673584688807;7292.0520332356455;7384.96307518459;5504.669719816824;5569.860753481195;5613.691246981455;5622.409646987007;5626.156076588544;5880.441358070976;5940.851478713067;5965.671888046026;5978.282606087123;5995.2206213192;4932.654714170118;5247.396549396868;5423.294971653818;5450.972745136249;5556.111022236423;5091.745412729423;5193.195054766517;5272.6309158358545;5356.785728570813;5384.946150538444;5210.947890521046;5292.5501332387175;5298.337707786527;5302.840914772563;5306.25712400272;3968.960310396859;4005.2790497710694;4108.8356465741035;4125.855595054159;4174.582541745801;3992.4410582519054;4084.9795751021056;4095.6928230382246;4102.159057393287;4218.029853133735 15:01:37 INFO - PROCESS | 25874 | |4;prototype.html;337.1402922547503;347.4458239108622;353.42744753499335;360.79254428703484;361.108063084182;4514.074614703986;4637.631898589916;4718.197906355919;4754.667173297867;4769.213079841827;4547.249703798878;4619.353290539327;4637.768111594423;4680.555347242015;4700.623950083994;3818.6754125899192;3821.7579286731784;3823.674987626055;3826.2347530493876;3830.195658911632;3683.631636836308;3831.4444405561176;3834.789086600236;3878.4182372644045;3897.707671924603;3599.316129935317;3745.5205193948373;3755.9812200939095;3782.6406491383273;3790.5072340595684;3768.321702093622;3775.697944164474;3788.829502672359;3807.4859893914245;3821.847126114952;3432.2277487565348;3454.274602333513;3464.4630082337276;3466.9133271668156;3480.582330120402;4443.222436073706;4540.728595993094;4570.291604801261;4608.94901768713;4616.28447590624;4305.655547556188;4327.242732521796;4332.501762297345;4339.132173565299;4340.153670034345;4925.852224433273;4942.629302802268;4949.430815456232;4952.752362381866;4954.20732682769;3367;3721.288207424561;3728.515293011891;3730.9626903730887;3745.921013837319;5075.97979202374;5124.564412024983;5124.923126153073;5139.897202055938;5147.433782283946;3576.445650924111;3596.8021758803516;3606.386914224588;3609.783412995229;3617.738913179263;3631.891043268706;3635.5455568053994;3636.4181730922924;3654.488371627974;3657.2868290683064;3961.3067713150085;4129.587041295847;4153.6677065834665;4177;4181.142865712522;4898.191798353232;4900.387451568554;4901.117798796251;4910.926336104962;4916.582090522345;1176.582313278791;1202.975940481203;1229.6065259116997;1238.1704258147063;1239.2688313894846;834.5034704350901;847.7583888591722;859.2181115185151;863.0894406401306;863.3740538109946;4253.893652658709;4263.531011588722;4268.0183557781265;4270.42349282849;4312.741235525878;4917.311576379309;4924.926126108111;4944.60443164546;4953.72754498506;4967.268002598556;4087.509498860156;4212.810423530948;4226.366045093199;4236.957630423656;4270.636995855325;2578.651881995944;2585.9353516162246;2599.2592111248205;2615.3853844346563;2629;4601.74690392025;4605.562471565196;4613.240209229467;4645.767711614406;4661;4889.242167464049;5026.899462010812;5035.194368901031;5037.420696619935;5046.293518907356;4575.977120114445;4579.702319349231;4599.655025873006;4623.630109591225;4639.118567472237;4874.634402419903;4887;4895.657303988829;4897.3878265216845;4909.631777616622;4654.301854721819;4759.476457589732;4791.137595232892;4806.399200099988;4814.507502674182;4574.199515084913;4574.908501830011;4580.954190458053;4590.954090459053;4593.531883427991;3493.4934434507363;3503.7722548034294;3511.438169892805;3522.929541409106;3535.3636345458062;4590.563896429834;4816;4854.9514504855915;4871.395167576039;4876.609871210366;4706.247000479907;4715.481297057252;4717.410323709536;4720.575148236675;4743.055347307587;4706.717596944194;4713.08094921487;4736.218523943511;4749.931265465243;4796.904061918812;4592.402987611589;4633.490316065163;4637.25803871379;4648.767561621838;4657.580817726421;4971.751412429437;4979.676321039121;4992.80028798844;4998.225275082368;5002.924956125734;4861.465238823797;4867.1969125093965;4880.951190488192;4892.290617860462;4901.9264711028645 15:01:37 INFO - PROCESS | 25874 | |5;yui.html;553.4520824383861;586.765293882447;635.7933671556743;658.9275179730232;663.4526515624608;11204.439778011098;11779.05767538597;12256.325902075383;12268.693282667926;12272.263664180155;12284.201526900746;13243.536476223335;13722.65693357664;13779.931100344484;14618.707625847477;614.4377894226777;760.1714131596544;779.6959185917497;779.8986131802858;780.0989856715503;631.0691729698681;752.8983587215738;771.818622623683;779.3531368963746;782.7143092771126;806.1575653442138;807.7697856111009;807.9636416361249;808.2200676347323;808.9676412943476;638.0333794301637;803.3934379543407;803.6704950970103;803.7387848949056;804.1917872538091;484.8981713840098;576.6280748916967;591.2668291318777;592.7184587321032;594.5273507561499;11572;11573.942130289379;11590.420478976017;11623.825642615368;12377.876221237762;12115;12242.00070982615;12591.874081259253;12635.620931372074;12707.936460317731;11204.775904481865;11296.830547541793;11308.886911130865;11334.546618135264;11496.367699776509;3964.1278918637854;4002.1195337026097;4034.003168431616;4047.1500984792933;4049.473568436114;62978;63530.68234658797;63944.680276598316;66357.66821165863;66834.66582667055;8928.776780580538;9103.772405689911;9207.861882071775;9718.659846905324;9806.215502759906;18121.54696132581;18292.268309267747;18310.542236444195;18350.26598936054;18499.075046247905;5619.662820230799;5682.857928551819;5772.191893134965;5805.912911306334;5817.243758311392;3393.52490651309;3516.665916737957;3542.8051457169586;3573.9642603574152;3588.6411358863907;2460.2496238647386;2531.7088534818363;2539.073238268019;2541.834780739246;2544.7200807911113;423.25507107491035;425.2642927734974;426.5819496893062;428.62923571110764;430.3544682975537;378.97157713171623;431.40896971149726;453.11416181365354;461.0985523301937;468.7227305592234;6665.900011499832;6684.097646817715;6746.595204287759;6788.796336109925;6965.895511567331;405.7808783257008;412.1495373177773;446.1144627913589;448.0769614593947;471.79712723528525;3252.3657886712335;3258.478643417042;3278.9344213115605;3314.121757734202;3317.5023746437746;49683.503164967886;51317.7434112827;51947.480525195024;57195.71402142962;66361.66819165873;51363.22955155675;51391.48608513942;51461.48538514642;51703.48296516987;52199.73900130551;45359.31961020521;46175;47716.5228347719;47921.76039119782;48713.269300960514;7664.156942736183;7882.684692612461;8095.473794203358;8129.268365847102;8179.182081791773;35206.29587408289;35323.116922077155;35454;35512;37489.81255093707;41807.790961045;44107.33838992482;46957.53042469532;46983;49884;10194.541245643815;10414.791704165722;10478.685639430829;10515.57937682484;10635.8936410638;10500.422476763852;10570.471476426303;10645.89354106449;10824.837627435438;10902.400367979837;10858.511366988347;10994.505247263733;11240.606578770032;11661.183717139718;11877.346745929057;10369.325993810378;10524.736881578021;10540.631077912236;10773.89226107729;10903;10061.446620435947;10275.177985761271;10451.68644940653;10683.786324273315;11019.283746556448;8735.825283494421;8958.641654333753;9032.187103160748;9601.039896010343;9621.470819105016;9531.475768832503;9854.901450985399;9875.259355548218;9905.900940990497;9922.900770992197 15:01:37 INFO - PROCESS | 25874 | __end_tp_report 15:01:37 INFO - PROCESS | 25874 | __start_cc_report 15:01:37 INFO - PROCESS | 25874 | _x_x_mozilla_cycle_collect,1685 15:01:37 INFO - PROCESS | 25874 | __end_cc_report 15:01:37 INFO - PROCESS | 25874 | __startTimestamp1481756497386__endTimestamp 15:01:37 INFO - PROCESS | 25874 | 15:01:37 INFO - PROCESS | 25874 | ------- Summary: start ------- 15:01:37 INFO - PROCESS | 25874 | Number of tests: 6 15:01:37 INFO - PROCESS | 25874 | 15:01:37 INFO - PROCESS | 25874 | [#0] dojo.html Cycles:165 Average:4506.87 Median:4655.56 stddev:477.43 (10.3%) stddev-sans-first:454.16 15:01:37 INFO - PROCESS | 25874 | Values: 2573.5 2596.1 2602.0 2622.9 2630.5 4415.4 4480.9 4633.6 4653.8 4657.7 4530.4 4563.1 4580.0 4605.5 4618.8 4138.5 4146.2 4189.5 4249.8 4335.0 4187.1 4225.9 4311.6 4348.0 4377.8 4102.1 4114.0 4288.7 4352.6 4368.7 4150.4 4154.5 4166.5 4166.8 4169.8 4144.4 4150.2 4151.1 4152.4 4152.5 4530.2 4533.6 4582.0 4588.8 4617.4 4887.2 4895.9 4898.8 4899.5 4943.2 4742.5 4806.0 4903.5 4914.0 4960.8 4491.1 4558.1 4594.9 4596.5 4655.6 5046.4 5048.3 5050.9 5053.6 5089.3 4664.7 4786.6 4834.7 4842.2 4849.1 4773.7 4857.0 4884.7 4900.8 4918.5 4891.6 4944.7 4952.0 4958.8 4968.9 4886.5 4891.2 4897.7 4900.8 4950.1 3886.1 3903.8 4045.4 4076.1 4086.2 3505.6 3518.7 3569.0 3579.8 3626.0 4229.7 4231.9 4233.4 4245.7 4286.0 4902.2 4910.9 4912.0 4915.0 4948.4 4094.7 4123.1 4127.1 4128.1 4174.7 4287.5 4293.1 4303.6 4308.4 4309.5 4544.3 4550.3 4550.4 4552.2 4553.7 4807.3 4852.3 4878.6 4912.6 4984.0 4615.1 4621.2 4623.0 4662.1 4668.6 4813.2 4853.6 4855.5 4860.1 4900.5 4719.9 4742.3 4745.7 4815.3 4913.5 4690.8 4690.9 4697.9 4699.1 4700.7 4696.6 4716.3 4729.7 4761.8 4802.0 4681.8 4694.6 4697.8 4705.9 4735.0 4680.1 4783.0 4784.4 4785.6 4824.9 4582.7 4656.2 4656.8 4659.1 4661.9 15:01:37 INFO - PROCESS | 25874 | 15:01:37 INFO - PROCESS | 25874 | [#1] ext.html Cycles:180 Average:45268.27 Median:19796.32 stddev:78512.66 (396.6%) stddev-sans-first:78660.98 15:01:37 INFO - PROCESS | 25874 | Values: 509.8 530.0 530.5 539.4 555.6 27020.9 28427.4 36630.5 38792.0 38884.0 39480.4 40020.4 40024.0 40047.0 40123.0 7397.9 7565.4 7565.5 7569.8 7573.7 7332.9 7553.1 9539.2 9818.3 9831.0 9881.1 9892.8 9907.3 9935.2 9965.2 9528.1 9584.2 9586.2 9594.3 9599.5 9715.4 9761.7 9777.2 9777.6 9778.3 36621.0 37076.6 37080.3 37089.0 37163.3 2926.3 3184.3 3258.0 3596.4 3625.8 27639.9 27991.9 28111.3 28221.9 29296.7 3342.4 3362.3 3392.4 3416.8 3468.2 240722.0 240792.0 241468.0 241719.0 242618.0 49463.3 49468.0 49542.0 49761.0 49856.5 51429.7 51493.5 51536.5 51586.2 51597.8 14679.9 14879.6 14991.6 14998.5 15004.4 10462.8 10776.2 11615.1 11649.6 11780.7 12943.9 13035.9 13069.3 13081.0 13878.7 4772.4 5652.9 5707.7 5719.6 5798.3 756.0 786.1 813.6 835.7 899.6 25946.0 26973.3 27708.7 28024.6 28056.6 852.9 916.0 950.4 974.9 1057.7 13739.5 14636.7 14696.3 14783.8 14851.6 342107.0 342112.0 344059.0 345192.0 346436.0 40701.6 41813.6 46324.5 47840.0 47853.3 1105.8 1141.3 1148.8 1150.7 1151.5 27085.2 28132.2 28753.7 29205.7 29269.3 40328.6 40903.8 40925.4 40956.0 41041.6 302548.0 303192.0 304306.0 305887.0 306680.0 33876.7 34284.8 34603.7 35996.3 39545.8 39555.2 41795.4 41801.6 41817.4 42811.4 35516.3 35921.6 35930.7 36224.6 36281.5 34612.1 35361.5 35380.3 35802.5 35879.8 34851.7 35495.6 35881.0 36149.8 36170.8 30353.0 33228.5 33463.0 33647.7 33700.3 24721.0 25341.5 25478.0 25646.9 25986.7 15:01:37 INFO - PROCESS | 25874 | 15:01:37 INFO - PROCESS | 25874 | [#2] jquery.html Cycles:180 Average:21692.52 Median:4670.58 stddev:54351.72 (1163.7%) stddev-sans-first:54480.56 15:01:37 INFO - PROCESS | 25874 | Values: 346.4 360.2 360.7 364.2 383.5 12220.9 14968.4 15151.6 15546.7 16438.0 15383.4 15811.1 15882.2 16081.9 16392.2 3679.6 4522.1 4676.6 4681.2 4719.7 4630.4 4666.2 4668.7 4669.8 4676.7 4569.3 4662.2 4671.3 4672.8 4676.4 4971.5 4972.4 5012.3 5014.4 5016.9 4532.8 4542.4 4546.0 4548.9 4550.6 12419.1 17591.6 18412.8 18989.1 19117.2 1800.5 1843.3 1917.2 2104.4 2328.3 8303.9 8819.6 9065.5 9294.2 9491.1 1550.5 1625.0 1630.8 1631.4 1642.8 62975.0 63557.4 64212.7 65600.0 65664.0 9742.3 9858.4 9865.7 10070.0 10148.7 13605.2 13609.1 13609.7 13615.2 13619.2 6950.8 7290.5 7291.8 7486.3 7544.4 6870.0 6989.6 7050.0 7195.5 7197.7 4147.6 4241.6 4283.1 4345.9 4426.4 1805.3 1808.3 1817.3 1822.3 1858.6 610.2 711.0 780.5 858.5 893.8 15602.8 15786.6 16307.9 16318.8 17158.7 802.3 807.7 825.6 832.9 844.5 9013.0 9113.3 9544.7 9556.2 9654.3 312567.0 318131.0 334890.2 336543.0 336561.0 66944.3 68601.7 70352.0 71820.6 73794.9 878.3 893.9 917.8 921.1 925.0 14267.4 14406.4 14613.7 14664.7 15212.2 34619.0 34665.7 34800.8 35378.0 35498.3 46998.8 47882.8 47915.0 48377.0 48406.8 7476.1 7621.0 7645.4 7650.1 7892.2 10527.2 10664.3 11171.6 11368.4 11508.3 7042.4 9148.9 9811.6 9821.3 9909.0 10071.0 10129.9 10167.2 10367.9 10384.5 9607.3 9750.6 9837.9 9867.1 10107.3 7324.3 7357.2 7497.3 7669.5 7761.9 7689.6 8760.6 9090.4 9562.9 9923.9 15:01:37 INFO - PROCESS | 25874 | 15:01:37 INFO - PROCESS | 25874 | [#3] mootools.html Cycles:180 Average:4341.44 Median:5012.20 stddev:2205.02 (44.0%) stddev-sans-first:2199.32 15:01:37 INFO - PROCESS | 25874 | Values: 1295.7 1314.4 1377.7 1611.1 1617.2 5738.6 5924.8 6140.8 6535.7 6546.9 6054.9 6228.8 6231.2 6387.2 6406.7 1993.0 2037.8 2038.1 2039.7 2041.0 1782.7 1989.3 2020.1 2029.9 2048.7 1811.1 1959.2 2025.2 2028.6 2052.7 1956.7 1957.4 1965.5 1968.7 1972.0 2031.3 2056.9 2062.3 2063.0 2065.1 6598.6 6631.9 6669.6 6682.5 6688.5 4126.8 4246.8 4252.5 4259.4 4263.9 2554.1 2807.2 2836.8 2847.0 2857.6 862.5 903.3 945.4 948.1 953.2 8430.2 8449.9 8455.7 8460.1 8463.9 3641.1 3793.8 3824.0 3875.5 3886.0 7376.4 7391.3 7429.3 7444.7 7455.1 4230.0 4237.8 4241.3 4242.4 4274.3 3641.6 3898.6 3903.3 3904.2 3906.8 3191.4 3225.5 3354.8 3362.6 3424.4 1032.8 1113.3 1142.7 1161.8 1167.7 597.5 768.4 816.8 818.8 839.2 4662.6 4712.6 4718.6 4752.4 4886.4 840.2 845.2 846.7 875.3 891.6 3200.2 3261.4 3332.6 3398.6 3412.9 7321.4 7522.7 7568.8 7633.0 7770.9 7432.9 7478.6 7494.3 7506.8 7508.8 5993.6 6063.5 6125.7 6156.7 6173.1 4566.9 4774.3 4815.4 4828.6 4921.7 7091.3 7103.1 7130.5 7198.8 7200.6 7172.2 7223.6 7253.7 7292.1 7385.0 5504.7 5569.9 5613.7 5622.4 5626.2 5880.4 5940.9 5965.7 5978.3 5995.2 4932.7 5247.4 5423.3 5451.0 5556.1 5091.7 5193.2 5272.6 5356.8 5384.9 5210.9 5292.6 5298.3 5302.8 5306.3 3969.0 4005.3 4108.8 4125.9 4174.6 3992.4 4085.0 4095.7 4102.2 4218.0 15:01:37 INFO - PROCESS | 25874 | 15:01:37 INFO - PROCESS | 25874 | [#4] prototype.html Cycles:180 Average:4056.60 Median:4590.76 stddev:1141.10 (24.9%) stddev-sans-first:1109.63 15:01:37 INFO - PROCESS | 25874 | Values: 337.1 347.4 353.4 360.8 361.1 4514.1 4637.6 4718.2 4754.7 4769.2 4547.2 4619.4 4637.8 4680.6 4700.6 3818.7 3821.8 3823.7 3826.2 3830.2 3683.6 3831.4 3834.8 3878.4 3897.7 3599.3 3745.5 3756.0 3782.6 3790.5 3768.3 3775.7 3788.8 3807.5 3821.8 3432.2 3454.3 3464.5 3466.9 3480.6 4443.2 4540.7 4570.3 4608.9 4616.3 4305.7 4327.2 4332.5 4339.1 4340.2 4925.9 4942.6 4949.4 4952.8 4954.2 3367.0 3721.3 3728.5 3731.0 3745.9 5076.0 5124.6 5124.9 5139.9 5147.4 3576.4 3596.8 3606.4 3609.8 3617.7 3631.9 3635.5 3636.4 3654.5 3657.3 3961.3 4129.6 4153.7 4177.0 4181.1 4898.2 4900.4 4901.1 4910.9 4916.6 1176.6 1203.0 1229.6 1238.2 1239.3 834.5 847.8 859.2 863.1 863.4 4253.9 4263.5 4268.0 4270.4 4312.7 4917.3 4924.9 4944.6 4953.7 4967.3 4087.5 4212.8 4226.4 4237.0 4270.6 2578.7 2585.9 2599.3 2615.4 2629.0 4601.7 4605.6 4613.2 4645.8 4661.0 4889.2 5026.9 5035.2 5037.4 5046.3 4576.0 4579.7 4599.7 4623.6 4639.1 4874.6 4887.0 4895.7 4897.4 4909.6 4654.3 4759.5 4791.1 4806.4 4814.5 4574.2 4574.9 4581.0 4591.0 4593.5 3493.5 3503.8 3511.4 3522.9 3535.4 4590.6 4816.0 4855.0 4871.4 4876.6 4706.2 4715.5 4717.4 4720.6 4743.1 4706.7 4713.1 4736.2 4749.9 4796.9 4592.4 4633.5 4637.3 4648.8 4657.6 4971.8 4979.7 4992.8 4998.2 5002.9 4861.5 4867.2 4881.0 4892.3 4901.9 15:01:37 INFO - PROCESS | 25874 | 15:01:37 INFO - PROCESS | 25874 | [#5] yui.html Cycles:180 Average:13923.92 Median:22276.73 stddev:17305.08 (77.7%) stddev-sans-first:17324.50 15:01:37 INFO - PROCESS | 25874 | Values: 553.5 586.8 635.8 658.9 663.5 11204.4 11779.1 12256.3 12268.7 12272.3 12284.2 13243.5 13722.7 13779.9 14618.7 614.4 760.2 779.7 779.9 780.1 631.1 752.9 771.8 779.4 782.7 806.2 807.8 808.0 808.2 809.0 638.0 803.4 803.7 803.7 804.2 484.9 576.6 591.3 592.7 594.5 11572.0 11573.9 11590.4 11623.8 12377.9 12115.0 12242.0 12591.9 12635.6 12707.9 11204.8 11296.8 11308.9 11334.5 11496.4 3964.1 4002.1 4034.0 4047.2 4049.5 62978.0 63530.7 63944.7 66357.7 66834.7 8928.8 9103.8 9207.9 9718.7 9806.2 18121.5 18292.3 18310.5 18350.3 18499.1 5619.7 5682.9 5772.2 5805.9 5817.2 3393.5 3516.7 3542.8 3574.0 3588.6 2460.2 2531.7 2539.1 2541.8 2544.7 423.3 425.3 426.6 428.6 430.4 379.0 431.4 453.1 461.1 468.7 6665.9 6684.1 6746.6 6788.8 6965.9 405.8 412.1 446.1 448.1 471.8 3252.4 3258.5 3278.9 3314.1 3317.5 49683.5 51317.7 51947.5 57195.7 66361.7 51363.2 51391.5 51461.5 51703.5 52199.7 45359.3 46175.0 47716.5 47921.8 48713.3 7664.2 7882.7 8095.5 8129.3 8179.2 35206.3 35323.1 35454.0 35512.0 37489.8 41807.8 44107.3 46957.5 46983.0 49884.0 10194.5 10414.8 10478.7 10515.6 10635.9 10500.4 10570.5 10645.9 10824.8 10902.4 10858.5 10994.5 11240.6 11661.2 11877.3 10369.3 10524.7 10540.6 10773.9 10903.0 10061.4 10275.2 10451.7 10683.8 11019.3 8735.8 8958.6 9032.2 9601.0 9621.5 9531.5 9854.9 9875.3 9905.9 9922.9 15:01:37 INFO - PROCESS | 25874 | -------- Summary: end -------- 15:01:37 INFO - PROCESS | 25874 | 15:01:38 INFO - TEST-INFO | 25874: exit 0 15:01:38 INFO - TEST-OK | dromaeo_css | took 1123603ms 15:01:38 INFO - TEST-START | kraken 15:01:38 INFO - operating with platform_type : linux_ 15:01:38 INFO - Initialising browser for kraken test... 15:01:38 INFO - TEST-INFO | started process 26181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_FX3K5/profile http://localhost:59159/getInfo.html) 15:01:42 INFO - PROCESS | 26181 | __metrics Screen width/height:1600/1200 15:01:42 INFO - PROCESS | 26181 | colorDepth:24 15:01:42 INFO - PROCESS | 26181 | Browser inner width/height: 1024/697 15:01:42 INFO - PROCESS | 26181 | __metrics 15:01:43 INFO - PROCESS | 26181 | 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" 15:01:43 INFO - PROCESS | 26181 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:01:43 INFO - PROCESS | 26181 | console.error: 15:01:43 INFO - PROCESS | 26181 | Message: Error: Connection closed before committing the transaction. 15:01:43 INFO - PROCESS | 26181 | Stack: 15:01:43 INFO - PROCESS | 26181 | executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23 15:01:43 INFO - PROCESS | 26181 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 15:01:43 INFO - PROCESS | 26181 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 15:01:43 INFO - PROCESS | 26181 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 15:01:43 INFO - PROCESS | 26181 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 15:01:43 INFO - PROCESS | 26181 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 15:01:43 INFO - PROCESS | 26181 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 15:01:43 INFO - PROCESS | 26181 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 15:01:43 INFO - PROCESS | 26181 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5 15:01:43 INFO - PROCESS | 26181 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 15:01:43 INFO - PROCESS | 26181 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 15:01:43 INFO - PROCESS | 26181 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 15:01:43 INFO - PROCESS | 26181 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 15:01:43 INFO - PROCESS | 26181 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 15:01:43 INFO - PROCESS | 26181 | 15:01:44 INFO - PROCESS | 26181 | console.error: PushService: 15:01:44 INFO - PROCESS | 26181 | stateChangeProcessEnqueue: Error transitioning state 15:01:44 INFO - PROCESS | 26181 | UnknownError 15:01:45 INFO - TEST-INFO | 26181: exit 0 15:01:45 INFO - Browser initialized. 15:01:45 INFO - Running cycle 1/1 for kraken test... 15:01:45 INFO - TEST-INFO | started process 26264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_FX3K5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:57 INFO - PROCESS | 26264 | RSS: Main: 174219264 15:01:57 INFO - PROCESS | 26264 | 15:02:00 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-beat-detection) 15:02:01 INFO - PROCESS | 26264 | RSS: Main: 240488448 15:02:01 INFO - PROCESS | 26264 | 15:02:04 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-dft) 15:02:04 INFO - PROCESS | 26264 | RSS: Main: 218722304 15:02:04 INFO - PROCESS | 26264 | 15:02:07 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-fft) 15:02:08 INFO - PROCESS | 26264 | RSS: Main: 301445120 15:02:08 INFO - PROCESS | 26264 | 15:02:10 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-oscillator) 15:02:11 INFO - PROCESS | 26264 | RSS: Main: 212324352 15:02:11 INFO - PROCESS | 26264 | 15:02:13 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:02:13 INFO - PROCESS | 26264 | RSS: Main: 215117824 15:02:13 INFO - PROCESS | 26264 | 15:02:17 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59159/tests/kraken/driver.html?testName=imaging-darkroom) 15:02:17 INFO - PROCESS | 26264 | RSS: Main: 254484480 15:02:17 INFO - PROCESS | 26264 | 15:02:21 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59159/tests/kraken/driver.html?testName=imaging-desaturate) 15:02:21 INFO - PROCESS | 26264 | RSS: Main: 254181376 15:02:21 INFO - PROCESS | 26264 | 15:02:24 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59159/tests/kraken/driver.html?testName=json-parse-financial) 15:02:25 INFO - PROCESS | 26264 | RSS: Main: 252882944 15:02:25 INFO - PROCESS | 26264 | 15:02:27 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:02:27 INFO - PROCESS | 26264 | RSS: Main: 215035904 15:02:27 INFO - PROCESS | 26264 | 15:02:29 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:02:30 INFO - PROCESS | 26264 | RSS: Main: 223158272 15:02:30 INFO - PROCESS | 26264 | 15:02:32 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:02:33 INFO - PROCESS | 26264 | RSS: Main: 231157760 15:02:33 INFO - PROCESS | 26264 | 15:02:36 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:02:36 INFO - PROCESS | 26264 | RSS: Main: 239955968 15:02:36 INFO - PROCESS | 26264 | 15:02:39 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:02:40 INFO - PROCESS | 26264 | RSS: Main: 237252608 15:02:40 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59159/tests/kraken/driver.html?testName=ai-astar) 15:02:42 INFO - PROCESS | 26264 | RSS: Main: 288157696 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | __start_tp_report 15:02:42 INFO - PROCESS | 26264 | _x_x_mozilla_page_load 15:02:42 INFO - PROCESS | 26264 | _x_x_mozilla_page_load_details 15:02:42 INFO - PROCESS | 26264 | |i|pagename|runs| 15:02:42 INFO - PROCESS | 26264 | |0;ai-astar;107;114;115;116;115;114;117;115;114;116 15:02:42 INFO - PROCESS | 26264 | |1;audio-beat-detection;152;128;129;178;132;132;129;126;147;139 15:02:42 INFO - PROCESS | 26264 | |2;audio-dft;161;162;161;163;163;162;160;162;161;163 15:02:42 INFO - PROCESS | 26264 | |3;audio-fft;77;79;77;118;78;78;77;76;92;77 15:02:42 INFO - PROCESS | 26264 | |4;audio-oscillator;85;84;107;84;85;86;112;84;84;113 15:02:42 INFO - PROCESS | 26264 | |5;imaging-gaussian-blur;128;129;128;127;128;128;128;127;127;127 15:02:42 INFO - PROCESS | 26264 | |6;imaging-darkroom;147;147;146;147;146;147;147;147;147;147 15:02:42 INFO - PROCESS | 26264 | |7;imaging-desaturate;95;96;95;95;96;95;95;96;95;96 15:02:42 INFO - PROCESS | 26264 | |8;json-parse-financial;62;63;63;62;64;64;62;62;64;64 15:02:42 INFO - PROCESS | 26264 | |9;json-stringify-tinderbox;67;66;66;67;67;66;67;66;67;66 15:02:42 INFO - PROCESS | 26264 | |10;stanford-crypto-aes;85;86;97;85;87;85;86;86;87;84 15:02:42 INFO - PROCESS | 26264 | |11;stanford-crypto-ccm;151;143;140;140;139;143;150;161;187;158 15:02:42 INFO - PROCESS | 26264 | |12;stanford-crypto-pbkdf2;178;178;183;182;180;177;177;176;178;176 15:02:42 INFO - PROCESS | 26264 | |13;stanford-crypto-sha256-iterative;70;70;69;69;69;75;68;72;67;69 15:02:42 INFO - PROCESS | 26264 | __end_tp_report 15:02:42 INFO - PROCESS | 26264 | __start_cc_report 15:02:42 INFO - PROCESS | 26264 | _x_x_mozilla_cycle_collect,1928 15:02:42 INFO - PROCESS | 26264 | __end_cc_report 15:02:42 INFO - PROCESS | 26264 | __startTimestamp1481756562484__endTimestamp 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | ------- Summary: start ------- 15:02:42 INFO - PROCESS | 26264 | Number of tests: 14 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:2.75 (2.4%) stddev-sans-first:1.05 15:02:42 INFO - PROCESS | 26264 | Values: 107.0 114.0 115.0 116.0 115.0 114.0 117.0 115.0 114.0 116.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:135.50 stddev:16.13 (11.9%) stddev-sans-first:16.43 15:02:42 INFO - PROCESS | 26264 | Values: 152.0 128.0 129.0 178.0 132.0 132.0 129.0 126.0 147.0 139.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 15:02:42 INFO - PROCESS | 26264 | Values: 161.0 162.0 161.0 163.0 163.0 162.0 160.0 162.0 161.0 163.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.50 stddev:13.19 (17.0%) stddev-sans-first:13.81 15:02:42 INFO - PROCESS | 26264 | Values: 77.0 79.0 77.0 118.0 78.0 78.0 77.0 76.0 92.0 77.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:84.00 stddev:12.71 (15.1%) stddev-sans-first:13.20 15:02:42 INFO - PROCESS | 26264 | Values: 85.0 84.0 107.0 84.0 85.0 86.0 112.0 84.0 84.0 113.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#5] imaging-gaussian-blur Cycles:10 Average:127.70 Median:128.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:02:42 INFO - PROCESS | 26264 | Values: 128.0 129.0 128.0 127.0 128.0 128.0 128.0 127.0 127.0 127.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 15:02:42 INFO - PROCESS | 26264 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:02:42 INFO - PROCESS | 26264 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.50 stddev:0.94 (1.5%) stddev-sans-first:0.93 15:02:42 INFO - PROCESS | 26264 | Values: 62.0 63.0 63.0 62.0 64.0 64.0 62.0 62.0 64.0 64.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:02:42 INFO - PROCESS | 26264 | Values: 67.0 66.0 66.0 67.0 67.0 66.0 67.0 66.0 67.0 66.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:3.71 (4.3%) stddev-sans-first:3.87 15:02:42 INFO - PROCESS | 26264 | Values: 85.0 86.0 97.0 85.0 87.0 85.0 86.0 86.0 87.0 84.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:150.50 stddev:14.76 (9.8%) stddev-sans-first:15.65 15:02:42 INFO - PROCESS | 26264 | Values: 151.0 143.0 140.0 140.0 139.0 143.0 150.0 161.0 187.0 158.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:178.00 stddev:2.42 (1.4%) stddev-sans-first:2.55 15:02:42 INFO - PROCESS | 26264 | Values: 178.0 178.0 183.0 182.0 180.0 177.0 177.0 176.0 178.0 176.0 15:02:42 INFO - PROCESS | 26264 | 15:02:42 INFO - PROCESS | 26264 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:2.25 (3.2%) stddev-sans-first:2.39 15:02:42 INFO - PROCESS | 26264 | Values: 70.0 70.0 69.0 69.0 69.0 75.0 68.0 72.0 67.0 69.0 15:02:42 INFO - PROCESS | 26264 | -------- Summary: end -------- 15:02:42 INFO - PROCESS | 26264 | 15:02:43 INFO - TEST-INFO | 26264: exit 0 15:02:43 INFO - TEST-OK | kraken | took 65361ms 15:02:43 INFO - SUITE-END | took 1188s 15:02:44 INFO - Completed test suite (00:19:49) 15:02:44 INFO - javascript benchmark 15:02:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.459573489567, 2596.065416450079, 2601.986990065049, 2622.855742934139, 2630.539655560278, 4415.425994620695, 4480.865574032776, 4633.606143477804, 4653.8371157009515, 4657.673962822604, 4530.3883975663275, 4563.064571762789, 4580.038191979688, 4605.4703709073465, 4618.8452886778305, 4138.503379594438, 4146.170765846828, 4189.476315460567, 4249.83000679974, 4334.956650433503, 4187.099773548686, 4225.873223803291, 4311.611954924057, 4347.956520434803, 4377.781110944456, 4102.056526998777, 4114.0, 4288.656907447396, 4352.586504282088, 4368.694191406603, 4150.3566947123245, 4154.50145982481, 4166.500019997619, 4166.83332666693, 4169.833206671729, 4144.378343248507, 4150.232207041707, 4151.066010147722, 4152.37714342848, 4152.501699796044, 4530.207213737583, 4533.637309015271, 4582.014866803654, 4588.816447342102, 4617.376654151713, 4887.193613053842, 4895.902081958377, 4898.755062246909, 4899.485554016813, 4943.233798761198, 4742.50203728607, 4806.0, 4903.509649035103, 4913.950860491385, 4960.826371077031, 4491.1017796441165, 4558.0655965526985, 4594.908101837945, 4596.47140578831, 4655.557722016403, 5046.44489106198, 5048.3184770056305, 5050.873728156826, 5053.620978426559, 5089.338386009795, 4664.696794708333, 4786.569208771228, 4834.709917404967, 4842.249451335048, 4849.102915960559, 4773.713577185311, 4856.95143048572, 4884.7069175849565, 4900.828471003569, 4918.483559226302, 4891.559759621651, 4944.728039957765, 4951.950480495221, 4958.752062396866, 4968.925466118011, 4886.486918873538, 4891.192953162688, 4897.7403065556655, 4900.779464924087, 4950.084234416644, 3886.0867696091395, 3903.843846246175, 4045.37296719009, 4076.144009757925, 4086.1827634473225, 3505.631908649606, 3518.683318501347, 3569.036360182788, 3579.838907249128, 3625.9637403625625, 4229.725067870579, 4231.851885184004, 4233.364995250737, 4245.724027938174, 4285.97857010713, 4902.191138462185, 4910.852674419773, 4912.042151780369, 4915.0, 4948.38145231846, 4094.6928980326593, 4123.092919557693, 4127.133302006552, 4128.1330920507025, 4174.749515029108, 4287.464066991626, 4293.119910418419, 4303.612674859215, 4308.353746937922, 4309.461317335333, 4544.295634176708, 4550.271956487012, 4550.408446901882, 4552.203364411281, 4553.704009239389, 4807.326974223682, 4852.320675105559, 4878.63410244226, 4912.631552633638, 4983.950160498349, 4615.100055489147, 4621.237495813153, 4623.0, 4662.067586482649, 4668.6498512611015, 4813.15769740301, 4853.611711063036, 4855.49017353187, 4860.149473841992, 4900.5099490052135, 4719.905601888012, 4742.288656701522, 4745.715257084586, 4815.3258543804595, 4913.508649135058, 4690.765461726968, 4690.859274221779, 4697.859064228079, 4699.130660827758, 4700.670953033255, 4696.577308042156, 4716.268978308368, 4729.739864307496, 4761.76191190446, 4802.039592081528, 4681.812727490998, 4694.62443004552, 4697.788599512962, 4705.882352941204, 4735.0, 4680.08738296029, 4783.04339132168, 4784.354112194948, 4785.6171506278715, 4824.855254342376, 4582.679212455096, 4656.185167595725, 4656.7671616418365, 4659.091477161921, 4661.906761864811], "value": 4476.692300335968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.8113697931766, 529.9761510732019, 530.4562823106315, 539.3635510098084, 555.6388347574078, 27020.864895675517, 28427.431451370987, 36630.450543241874, 38792.0, 38884.0, 39480.407793883045, 40020.39969400454, 40024.0, 40047.0, 40123.0, 7397.926020739791, 7565.356944659683, 7565.546067235983, 7569.772906812805, 7573.7349192778265, 7332.9266707333045, 7553.093628764556, 9539.236861051098, 9818.263630227726, 9831.0, 9881.110700036996, 9892.752681182992, 9907.256955728313, 9935.205183585333, 9965.15296199824, 9528.142467177953, 9584.185344245678, 9586.185174260196, 9594.280428967786, 9599.520023998843, 9715.417074975525, 9761.707148785548, 9777.168940640055, 9777.560009799576, 9778.315517913748, 36621.0, 37076.62923370759, 37080.25839483222, 37089.0, 37163.25673486542, 2926.2538052796613, 3184.3153721949893, 3257.983710081458, 3596.352656521825, 3625.764325318872, 27639.86180069107, 27991.86004069987, 28111.297217569725, 28221.858890705415, 29296.70703292961, 3342.4418834897597, 3362.3443428531446, 3392.355452464024, 3416.794992300445, 3468.202313467891, 240722.0, 240792.0, 241468.0, 241719.0, 242618.0, 49463.25805112926, 49468.0, 49542.0, 49761.0, 49856.50143498591, 51429.742851285504, 51493.485065149616, 51536.48463515317, 51586.22620660693, 51597.8402159781, 14679.926600366929, 14879.553613391616, 14991.625209369635, 14998.47505337308, 15004.399824007136, 10462.790744185226, 10776.245662803529, 11615.128865334964, 11649.59226427071, 11780.70548236301, 12943.935280323727, 13035.869641303465, 13069.346532673328, 13081.0, 13878.653033674036, 4772.379634350631, 5652.9152062719095, 5707.743151558107, 5719.599628025998, 5798.304203495523, 755.9697612095455, 786.1156199275815, 813.5769399912131, 835.6866175184306, 899.6446403670644, 25946.0, 26973.325666858094, 27708.722912770616, 28024.579631305547, 28056.579151312748, 852.9445586036887, 916.029009250197, 950.4344914775697, 974.9220062394992, 1057.7038429239826, 13739.519116830863, 14636.707265854837, 14696.338664760111, 14783.778243326358, 14851.628709282355, 342107.0, 342112.0, 344059.0, 345192.0, 346436.0, 40701.592984070376, 41813.58186418158, 46324.536754632696, 47840.0, 47853.28220076702, 1105.8009558279748, 1141.3209140561353, 1148.7759886821989, 1150.71232191952, 1151.4933429291252, 27085.1874443767, 28132.156035318974, 28753.712462875104, 29205.7079429203, 29269.26826829261, 40328.59671403366, 40903.795481022404, 40925.386119207644, 40956.0, 41041.58958410378, 302548.0, 303192.0, 304306.0, 305887.0, 306680.0, 33876.66123338834, 34284.80003199876, 34603.65396346004, 35996.28007439889, 39545.80227098961, 39555.2088958225, 41795.37306940459, 41801.58198417977, 41817.372739408325, 42811.35782963196, 35516.28967420689, 35921.64078359183, 35930.742424015036, 36224.63775362318, 36281.45577816282, 34612.13469663178, 35361.46957795584, 35380.29239415146, 35802.462963055055, 35879.82060089683, 34851.65148348484, 35495.64504354924, 35881.0, 36149.81925090463, 36170.819145904105, 30353.0, 33228.50157247595, 33463.0, 33647.66352336543, 33700.32599348048, 24721.0, 25341.493170136862, 25478.03178380198, 25646.87176564105, 25986.740132598432], "value": 17374.57466181645, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.4232053630705, 360.20754340451, 360.7222438722183, 364.1533434764173, 383.5359215349429, 12220.938895305522, 14968.401263949443, 15151.62120946977, 15546.689066218698, 16438.0, 15383.384664613402, 15811.051336919792, 15882.205889705527, 16081.919590402062, 16392.180390980433, 3679.613640567742, 4522.095580883828, 4676.555727205927, 4681.157391669498, 4719.669623126382, 4630.421197350332, 4666.230072038126, 4668.719876807386, 4669.813207471697, 4676.7427791471455, 4569.268916973285, 4662.230731929228, 4671.346011558385, 4672.766361681919, 4676.415448068991, 4971.45314015458, 4972.428170760355, 5012.323336349583, 5014.373203349582, 5016.949830501685, 4532.79602417892, 4542.432195975503, 4545.977270113628, 4548.8862778430475, 4550.613197878184, 12419.130660853743, 17591.648167036714, 18412.81587184138, 18989.145488453054, 19117.23531058756, 1800.4508624869409, 1843.2626949220285, 1917.1756144857707, 2104.4244702836004, 2328.348062542491, 8303.875441868377, 8819.603117859711, 9065.456072635598, 9294.209992150676, 9491.098345657152, 1550.4960887711427, 1625.0424227905216, 1630.7553866920057, 1631.3882294139698, 1642.7700121982932, 62975.0, 63557.364426355605, 64212.67893660549, 65600.0, 65664.01503977492, 9742.31803773729, 9858.359206651545, 9865.654702085392, 10070.0, 10148.746281343025, 13605.183688978694, 13609.11540749848, 13609.659758506117, 13615.18308901469, 13619.18284902909, 6950.826229344307, 7290.45321600882, 7291.781246562611, 7486.326230639269, 7544.434167437465, 6869.965650171717, 6989.615571143534, 7049.964750176319, 7195.532290401107, 7197.676104575306, 4147.6267135957905, 4241.6214730212805, 4283.1433713257475, 4345.869623911288, 4426.44669416323, 1805.2740362053132, 1808.2947650416347, 1817.2730907636787, 1822.2528763207285, 1858.6096919646754, 610.206731249374, 710.989335159973, 780.5277806926728, 858.4763294390417, 893.8257039877161, 15602.843971560365, 15786.60533486649, 16307.91846040786, 16318.75521867173, 17158.656826863393, 802.2619190344897, 807.7092246791151, 825.6202147012442, 832.862577674689, 844.5355054719879, 9012.954935225413, 9113.316501262432, 9544.713658590254, 9556.187724043395, 9654.324197306121, 312567.0, 318131.0, 334890.1620821708, 336543.0, 336561.0, 66944.3305566938, 68601.65699171473, 70352.0, 71820.64089679519, 73794.8930766039, 878.3324673248505, 893.9195472407514, 917.8026724254318, 921.0927236671873, 925.0, 14267.357968891218, 14406.351714173097, 14613.70772584521, 14664.70670586561, 15212.239388030333, 34619.0, 34665.65334346624, 34800.82599587087, 35378.0, 35498.29003419865, 46998.76500617475, 47882.76058619685, 47915.0, 48377.0, 48406.757966209945, 7476.140243871807, 7620.961895190489, 7645.426593005435, 7650.120236172689, 7892.171322011336, 10527.157827373945, 10664.307704609946, 11171.608993685182, 11368.374739389083, 11508.309501429942, 7042.436605071684, 9148.875803264104, 9811.607535698493, 9821.312508124649, 9909.0, 10071.0, 10129.949350253202, 10167.18662506983, 10367.896321036693, 10384.480775961323, 9607.327487075838, 9750.561224745046, 9837.9016209837, 9867.11195992364, 10107.3430227035, 7324.304191101837, 7357.19070902211, 7497.325240728361, 7669.501482403626, 7761.883571746315, 7689.577073260801, 8760.605772740115, 9090.36367454272, 9562.856557151508, 9923.900760992297], "value": 7713.775462787695, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.6955115547844, 1314.4347930389933, 1377.710680757041, 1611.1299898055051, 1617.1752406272797, 5738.626989245707, 5924.763009479627, 6140.7543698252075, 6535.70589323481, 6546.901796473051, 6054.909176362358, 6228.84427889303, 6231.158793562868, 6387.201599800025, 6406.679666016692, 1992.9501762455945, 2037.8369730421605, 2038.1337931379178, 2039.7450318710162, 2040.9591808163827, 1782.7325901114807, 1989.3136867780593, 2020.0909590684178, 2029.8579099463043, 2048.7131801547794, 1811.05824971015, 1959.1673538746047, 2025.2202901882733, 2028.5942811437699, 2052.665767251284, 1956.7064940258933, 1957.3736404350614, 1965.5380985468332, 1968.714536392215, 1971.9605607887906, 2031.2890488329115, 2056.9485762856048, 2062.267894897305, 2063.0, 2065.0500769645982, 6598.637074960875, 6631.867362652768, 6669.633170175687, 6682.532222744409, 6688.531802773808, 4126.752394856288, 4246.808893599796, 4252.489701235841, 4259.403683484315, 4263.87208383749, 2554.0549996501227, 2807.2280122966145, 2836.7588754955855, 2846.957295640567, 2857.6427946506687, 862.4911302331592, 903.2503022491317, 945.3807755919884, 948.0519480519481, 953.1707414549317, 8430.241278284922, 8449.873251901226, 8455.661773529051, 8460.069392366835, 8463.915360846375, 3641.1443310821937, 3793.7723736575895, 3824.0, 3875.5155605549307, 3886.0479182600443, 7376.446766492427, 7391.2978267064545, 7429.294217049372, 7444.702211911571, 7455.0681164854395, 4229.957700422957, 4237.78811059452, 4241.27898257297, 4242.384854196124, 4274.294741367702, 3641.5630124385243, 3898.629630185128, 3903.2974064668633, 3904.1996390739832, 3906.7851268180525, 3191.3564514275167, 3225.5322978168033, 3354.832258387071, 3362.596488421405, 3424.417848965682, 1032.83990981398, 1113.2708076210095, 1142.7428828513519, 1161.7618388230392, 1167.7139100920328, 597.5339235396398, 768.3929695540572, 816.7631386897851, 818.8075802186481, 839.2321026260903, 4662.603678687349, 4712.64655150865, 4718.551737584924, 4752.405949256343, 4886.389201349832, 840.1808236968907, 845.1590667285967, 846.7078857794052, 875.3216257400566, 891.5586784541694, 3200.1839530919465, 3261.445554255735, 3332.600087989457, 3398.5921689397433, 3412.914677133042, 7321.377682896907, 7522.699092036367, 7568.772936811904, 7633.0, 7770.883436748453, 7432.85134297311, 7478.626068696543, 7494.250574942571, 7506.849863002819, 7508.774736757906, 5993.61041532299, 6063.5452341073715, 6125.693715314305, 6156.6921653918025, 6173.104899789505, 4566.908661826811, 4774.283857421276, 4815.398075240595, 4828.637852161172, 4921.704697718148, 7091.3263239994185, 7103.112110986127, 7130.465215108784, 7198.7840364789145, 7200.639968001684, 7172.211056783645, 7223.566586004857, 7253.673584688807, 7292.0520332356455, 7384.96307518459, 5504.669719816824, 5569.860753481195, 5613.691246981455, 5622.409646987007, 5626.156076588544, 5880.441358070976, 5940.851478713067, 5965.671888046026, 5978.282606087123, 5995.2206213192, 4932.654714170118, 5247.396549396868, 5423.294971653818, 5450.972745136249, 5556.111022236423, 5091.745412729423, 5193.195054766517, 5272.6309158358545, 5356.785728570813, 5384.946150538444, 5210.947890521046, 5292.5501332387175, 5298.337707786527, 5302.840914772563, 5306.25712400272, 3968.960310396859, 4005.2790497710694, 4108.8356465741035, 4125.855595054159, 4174.582541745801, 3992.4410582519054, 4084.9795751021056, 4095.6928230382246, 4102.159057393287, 4218.029853133735], "value": 3625.7476314564697, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.1402922547503, 347.4458239108622, 353.42744753499335, 360.79254428703484, 361.108063084182, 4514.074614703986, 4637.631898589916, 4718.197906355919, 4754.667173297867, 4769.213079841827, 4547.249703798878, 4619.353290539327, 4637.768111594423, 4680.555347242015, 4700.623950083994, 3818.6754125899192, 3821.7579286731784, 3823.674987626055, 3826.2347530493876, 3830.195658911632, 3683.631636836308, 3831.4444405561176, 3834.789086600236, 3878.4182372644045, 3897.707671924603, 3599.316129935317, 3745.5205193948373, 3755.9812200939095, 3782.6406491383273, 3790.5072340595684, 3768.321702093622, 3775.697944164474, 3788.829502672359, 3807.4859893914245, 3821.847126114952, 3432.2277487565348, 3454.274602333513, 3464.4630082337276, 3466.9133271668156, 3480.582330120402, 4443.222436073706, 4540.728595993094, 4570.291604801261, 4608.94901768713, 4616.28447590624, 4305.655547556188, 4327.242732521796, 4332.501762297345, 4339.132173565299, 4340.153670034345, 4925.852224433273, 4942.629302802268, 4949.430815456232, 4952.752362381866, 4954.20732682769, 3367.0, 3721.288207424561, 3728.515293011891, 3730.9626903730887, 3745.921013837319, 5075.97979202374, 5124.564412024983, 5124.923126153073, 5139.897202055938, 5147.433782283946, 3576.445650924111, 3596.8021758803516, 3606.386914224588, 3609.783412995229, 3617.738913179263, 3631.891043268706, 3635.5455568053994, 3636.4181730922924, 3654.488371627974, 3657.2868290683064, 3961.3067713150085, 4129.587041295847, 4153.6677065834665, 4177.0, 4181.142865712522, 4898.191798353232, 4900.387451568554, 4901.117798796251, 4910.926336104962, 4916.582090522345, 1176.582313278791, 1202.975940481203, 1229.6065259116997, 1238.1704258147063, 1239.2688313894846, 834.5034704350901, 847.7583888591722, 859.2181115185151, 863.0894406401306, 863.3740538109946, 4253.893652658709, 4263.531011588722, 4268.0183557781265, 4270.42349282849, 4312.741235525878, 4917.311576379309, 4924.926126108111, 4944.60443164546, 4953.72754498506, 4967.268002598556, 4087.509498860156, 4212.810423530948, 4226.366045093199, 4236.957630423656, 4270.636995855325, 2578.651881995944, 2585.9353516162246, 2599.2592111248205, 2615.3853844346563, 2629.0, 4601.74690392025, 4605.562471565196, 4613.240209229467, 4645.767711614406, 4661.0, 4889.242167464049, 5026.899462010812, 5035.194368901031, 5037.420696619935, 5046.293518907356, 4575.977120114445, 4579.702319349231, 4599.655025873006, 4623.630109591225, 4639.118567472237, 4874.634402419903, 4887.0, 4895.657303988829, 4897.3878265216845, 4909.631777616622, 4654.301854721819, 4759.476457589732, 4791.137595232892, 4806.399200099988, 4814.507502674182, 4574.199515084913, 4574.908501830011, 4580.954190458053, 4590.954090459053, 4593.531883427991, 3493.4934434507363, 3503.7722548034294, 3511.438169892805, 3522.929541409106, 3535.3636345458062, 4590.563896429834, 4816.0, 4854.9514504855915, 4871.395167576039, 4876.609871210366, 4706.247000479907, 4715.481297057252, 4717.410323709536, 4720.575148236675, 4743.055347307587, 4706.717596944194, 4713.08094921487, 4736.218523943511, 4749.931265465243, 4796.904061918812, 4592.402987611589, 4633.490316065163, 4637.25803871379, 4648.767561621838, 4657.580817726421, 4971.751412429437, 4979.676321039121, 4992.80028798844, 4998.225275082368, 5002.924956125734, 4861.465238823797, 4867.1969125093965, 4880.951190488192, 4892.290617860462, 4901.9264711028645], "value": 3708.6186950879205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4520824383861, 586.765293882447, 635.7933671556743, 658.9275179730232, 663.4526515624608, 11204.439778011098, 11779.05767538597, 12256.325902075383, 12268.693282667926, 12272.263664180155, 12284.201526900746, 13243.536476223335, 13722.65693357664, 13779.931100344484, 14618.707625847477, 614.4377894226777, 760.1714131596544, 779.6959185917497, 779.8986131802858, 780.0989856715503, 631.0691729698681, 752.8983587215738, 771.818622623683, 779.3531368963746, 782.7143092771126, 806.1575653442138, 807.7697856111009, 807.9636416361249, 808.2200676347323, 808.9676412943476, 638.0333794301637, 803.3934379543407, 803.6704950970103, 803.7387848949056, 804.1917872538091, 484.8981713840098, 576.6280748916967, 591.2668291318777, 592.7184587321032, 594.5273507561499, 11572.0, 11573.942130289379, 11590.420478976017, 11623.825642615368, 12377.876221237762, 12115.0, 12242.00070982615, 12591.874081259253, 12635.620931372074, 12707.936460317731, 11204.775904481865, 11296.830547541793, 11308.886911130865, 11334.546618135264, 11496.367699776509, 3964.1278918637854, 4002.1195337026097, 4034.003168431616, 4047.1500984792933, 4049.473568436114, 62978.0, 63530.68234658797, 63944.680276598316, 66357.66821165863, 66834.66582667055, 8928.776780580538, 9103.772405689911, 9207.861882071775, 9718.659846905324, 9806.215502759906, 18121.54696132581, 18292.268309267747, 18310.542236444195, 18350.26598936054, 18499.075046247905, 5619.662820230799, 5682.857928551819, 5772.191893134965, 5805.912911306334, 5817.243758311392, 3393.52490651309, 3516.665916737957, 3542.8051457169586, 3573.9642603574152, 3588.6411358863907, 2460.2496238647386, 2531.7088534818363, 2539.073238268019, 2541.834780739246, 2544.7200807911113, 423.25507107491035, 425.2642927734974, 426.5819496893062, 428.62923571110764, 430.3544682975537, 378.97157713171623, 431.40896971149726, 453.11416181365354, 461.0985523301937, 468.7227305592234, 6665.900011499832, 6684.097646817715, 6746.595204287759, 6788.796336109925, 6965.895511567331, 405.7808783257008, 412.1495373177773, 446.1144627913589, 448.0769614593947, 471.79712723528525, 3252.3657886712335, 3258.478643417042, 3278.9344213115605, 3314.121757734202, 3317.5023746437746, 49683.503164967886, 51317.7434112827, 51947.480525195024, 57195.71402142962, 66361.66819165873, 51363.22955155675, 51391.48608513942, 51461.48538514642, 51703.48296516987, 52199.73900130551, 45359.31961020521, 46175.0, 47716.5228347719, 47921.76039119782, 48713.269300960514, 7664.156942736183, 7882.684692612461, 8095.473794203358, 8129.268365847102, 8179.182081791773, 35206.29587408289, 35323.116922077155, 35454.0, 35512.0, 37489.81255093707, 41807.790961045, 44107.33838992482, 46957.53042469532, 46983.0, 49884.0, 10194.541245643815, 10414.791704165722, 10478.685639430829, 10515.57937682484, 10635.8936410638, 10500.422476763852, 10570.471476426303, 10645.89354106449, 10824.837627435438, 10902.400367979837, 10858.511366988347, 10994.505247263733, 11240.606578770032, 11661.183717139718, 11877.346745929057, 10369.325993810378, 10524.736881578021, 10540.631077912236, 10773.89226107729, 10903.0, 10061.446620435947, 10275.177985761271, 10451.68644940653, 10683.786324273315, 11019.283746556448, 8735.825283494421, 8958.641654333753, 9032.187103160748, 9601.039896010343, 9621.470819105016, 9531.475768832503, 9854.901450985399, 9875.259355548218, 9905.900940990497, 9922.900770992197], "value": 5800.938956777055, "unit": "score"}], "name": "dromaeo_css", "value": 6003.212847173615, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 115.0, 116.0, 115.0, 114.0, 117.0, 115.0, 114.0, 116.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 129.0, 178.0, 132.0, 132.0, 129.0, 126.0, 147.0, 139.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 163.0, 163.0, 162.0, 160.0, 162.0, 161.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 77.0, 118.0, 78.0, 78.0, 77.0, 76.0, 92.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 107.0, 84.0, 85.0, 86.0, 112.0, 84.0, 84.0, 113.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 128.0, 127.0, 128.0, 128.0, 128.0, 127.0, 127.0, 127.0], "value": 127.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 64.0, 64.0, 62.0, 62.0, 64.0, 64.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 97.0, 85.0, 87.0, 85.0, 86.0, 86.0, 87.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 143.0, 140.0, 140.0, 139.0, 143.0, 150.0, 161.0, 187.0, 158.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 183.0, 182.0, 180.0, 177.0, 177.0, 176.0, 178.0, 176.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 69.0, 69.0, 75.0, 68.0, 72.0, 67.0, 69.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1576.3, "alertThreshold": 2.0}]} 15:02:44 INFO - Return code: 0 15:02:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:02:44 INFO - # TBPL SUCCESS # 15:02:44 INFO - Running post-action listener: _resource_record_post_action 15:02:44 INFO - [mozharness: 2016-12-14 23:02:44.291048Z] Finished run-tests step (success) 15:02:44 INFO - Running post-run listener: _resource_record_post_run 15:02:44 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390758400; Read time: 12; Write time: 417004 15:02:44 INFO - TinderboxPrint: CPU usage
13.2% 15:02:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:02:44 INFO - TinderboxPrint: I/O write bytes / time
390,758,400 / 417,004 15:02:44 INFO - TinderboxPrint: CPU idle
8,345.9 (86.8%) 15:02:44 INFO - TinderboxPrint: CPU user
1,216.5 (12.7%) 15:02:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:02:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99373056; Read time: 0; Write time: 79212 15:02:44 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 291385344; Read time: 0; Write time: 337792 15:02:44 INFO - Running post-run listener: _upload_blobber_files 15:02:44 INFO - Blob upload gear active. 15:02:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:02:44 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 15:02:44 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'] 15:02:44 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 15:02:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:02:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:02:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:02:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:02:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:02:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:02:49 INFO - (blobuploader) - INFO - Done attempting. 15:02:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:02:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:02:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:02:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:02:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:02:50 INFO - (blobuploader) - INFO - Done attempting. 15:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:02:51 INFO - (blobuploader) - INFO - Done attempting. 15:02:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:02:51 INFO - Return code: 0 15:02:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:02:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:02:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1c7c302b53800b00a0bbbba107c4811900c650bdd6d971768e5cf31984bfdf65f6f0134ef4160969e2d1c1d3de556c38c1e5286a277a6a13f50ad47fce32a283", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6c17513f7247c2b355cdbf3f2110c158f34278764389a1ba11742f7d00249b4afd14bc12692eecc3230a5a51618a9715dee8a9d0e3dabd41cfccb71a381a1911", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7114722e810008106184c25f18b1e845572205c1b4786c3074a6dd73d35f772606edcb0fdca787355e5533d26b5f277406ecbc7e0743a3d69bc5db7160dfc5a9"} 15:02:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:02:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:02:51 INFO - Contents: 15:02:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1c7c302b53800b00a0bbbba107c4811900c650bdd6d971768e5cf31984bfdf65f6f0134ef4160969e2d1c1d3de556c38c1e5286a277a6a13f50ad47fce32a283", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6c17513f7247c2b355cdbf3f2110c158f34278764389a1ba11742f7d00249b4afd14bc12692eecc3230a5a51618a9715dee8a9d0e3dabd41cfccb71a381a1911", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7114722e810008106184c25f18b1e845572205c1b4786c3074a6dd73d35f772606edcb0fdca787355e5533d26b5f277406ecbc7e0743a3d69bc5db7160dfc5a9"} 15:02:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:02:51 INFO - Copying logs to upload dir... 15:02:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:02:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.821910 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-14 15:02:50.669873) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 15:02:50.673769) ========= 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=fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074 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/1c7c302b53800b00a0bbbba107c4811900c650bdd6d971768e5cf31984bfdf65f6f0134ef4160969e2d1c1d3de556c38c1e5286a277a6a13f50ad47fce32a283", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6c17513f7247c2b355cdbf3f2110c158f34278764389a1ba11742f7d00249b4afd14bc12692eecc3230a5a51618a9715dee8a9d0e3dabd41cfccb71a381a1911", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7114722e810008106184c25f18b1e845572205c1b4786c3074a6dd73d35f772606edcb0fdca787355e5533d26b5f277406ecbc7e0743a3d69bc5db7160dfc5a9"} build_url:https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.012051 build_url: 'https://queue.taskcluster.net/v1/task/TCGBjE-2SByNjrl0XmfCbQ/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/1c7c302b53800b00a0bbbba107c4811900c650bdd6d971768e5cf31984bfdf65f6f0134ef4160969e2d1c1d3de556c38c1e5286a277a6a13f50ad47fce32a283", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6c17513f7247c2b355cdbf3f2110c158f34278764389a1ba11742f7d00249b4afd14bc12692eecc3230a5a51618a9715dee8a9d0e3dabd41cfccb71a381a1911", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7114722e810008106184c25f18b1e845572205c1b4786c3074a6dd73d35f772606edcb0fdca787355e5533d26b5f277406ecbc7e0743a3d69bc5db7160dfc5a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 15:02:50.706219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 15:02:50.706802) ========= 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=fa44defc139c4ba8574fe040000001db-1481755319.847128-211667074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 15:02:50.791090) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 15:02:50.791416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 15:02:50.791742) ========= ========= Total master_lag: 0.16 =========