builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1483709637.73 results: success (0) buildid: 20170106032113 builduid: 60e151a48c9e4028a77fd57e522dc501 revision: 77005e00cdef605b05b0f4a6ef9ac8e641dcc588 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 05:33:57.733519) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 05:33:57.733989) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2017-01-06 05:33:57.734285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2017-01-06 05:34:00.168111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.168666) ========= 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=337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-06 05:34: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% 219M=0s 2017-01-06 05:34:00 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107548 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.290507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.290818) ========= 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=337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016498 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.340802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.341170) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 77005e00cdef605b05b0f4a6ef9ac8e641dcc588 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 77005e00cdef605b05b0f4a6ef9ac8e641dcc588 --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=337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-06 05:34:00,854 truncating revision to first 12 chars 2017-01-06 05:34:00,855 Setting DEBUG logging. 2017-01-06 05:34:00,855 attempt 1/10 2017-01-06 05:34:00,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/77005e00cdef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 05:34:01,171 unpacking tar archive at: mozilla-beta-77005e00cdef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620174 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.975988) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.976321) ========= script_repo_revision: 77005e00cdef605b05b0f4a6ef9ac8e641dcc588 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.976786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.977048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 05:34:00.987961) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-06 05:34:00.988322) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:34:01 INFO - MultiFileLogger online at 20170106 05:34:01 in /builds/slave/test 05:34:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:34:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:34:01 INFO - {'append_to_log': False, 05:34:01 INFO - 'base_work_dir': '/builds/slave/test', 05:34:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:34:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:34:01 INFO - 'branch': 'Mozilla-Beta', 05:34:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:34:01 INFO - 'config_files': ('talos/linux_config.py',), 05:34:01 INFO - 'default_actions': ('clobber', 05:34:01 INFO - 'read-buildbot-config', 05:34:01 INFO - 'download-and-extract', 05:34:01 INFO - 'populate-webroot', 05:34:01 INFO - 'create-virtualenv', 05:34:01 INFO - 'install', 05:34:01 INFO - 'run-tests'), 05:34:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:34:01 INFO - 'download_minidump_stackwalk': True, 05:34:01 INFO - 'download_symbols': 'ondemand', 05:34:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:34:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:34:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:34:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:34:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:34:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:34:01 INFO - 'installer_path': 'installer.exe', 05:34:01 INFO - 'log_level': 'info', 05:34:01 INFO - 'log_name': 'talos', 05:34:01 INFO - 'log_to_console': True, 05:34:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:34:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:34:01 INFO - 'opt_config_files': (), 05:34:01 INFO - 'pip_index': False, 05:34:01 INFO - 'sps_profile': False, 05:34:01 INFO - 'sps_profile_interval': 0, 05:34:01 INFO - 'suite': 'dromaeojs', 05:34:01 INFO - 'system_bits': '32', 05:34:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:34:01 INFO - 'title': 'talos-linux64-ix-060', 05:34:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:34:01 INFO - 'use_talos_json': True, 05:34:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:34:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:34:01 INFO - 'work_dir': 'build'} 05:34:01 INFO - [mozharness: 2017-01-06 13:34:01.592617Z] Running clobber step. 05:34:01 INFO - Running pre-action listener: _resource_record_pre_action 05:34:01 INFO - Running main action method: clobber 05:34:01 INFO - rmtree: /builds/slave/test/build 05:34:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:34:02 INFO - Running post-action listener: _resource_record_post_action 05:34:02 INFO - [mozharness: 2017-01-06 13:34:02.570157Z] Finished clobber step (success) 05:34:02 INFO - [mozharness: 2017-01-06 13:34:02.570256Z] Running read-buildbot-config step. 05:34:02 INFO - Running pre-action listener: _resource_record_pre_action 05:34:02 INFO - Running main action method: read_buildbot_config 05:34:02 INFO - Using buildbot properties: 05:34:02 INFO - { 05:34:02 INFO - "project": "", 05:34:02 INFO - "product": "firefox", 05:34:02 INFO - "script_repo_revision": "production", 05:34:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:34:02 INFO - "repository": "", 05:34:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:34:02 INFO - "buildid": "20170106032113", 05:34:02 INFO - "pgo_build": "True", 05:34:02 INFO - "basedir": "/builds/slave/test", 05:34:02 INFO - "buildnumber": 79, 05:34:02 INFO - "slavename": "talos-linux64-ix-060", 05:34:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:34:02 INFO - "platform": "ubuntu64_hw", 05:34:02 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:34:02 INFO - "branch": "mozilla-beta", 05:34:02 INFO - "repo_path": "releases/mozilla-beta", 05:34:02 INFO - "revision": "77005e00cdef605b05b0f4a6ef9ac8e641dcc588", 05:34:02 INFO - "stage_platform": "linux64-pgo", 05:34:02 INFO - "builduid": "60e151a48c9e4028a77fd57e522dc501", 05:34:02 INFO - "slavebuilddir": "test" 05:34:02 INFO - } 05:34:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 05:34:02 INFO - Running post-action listener: _resource_record_post_action 05:34:02 INFO - [mozharness: 2017-01-06 13:34:02.572674Z] Finished read-buildbot-config step (success) 05:34:02 INFO - [mozharness: 2017-01-06 13:34:02.572764Z] Running download-and-extract step. 05:34:02 INFO - Running pre-action listener: _resource_record_pre_action 05:34:02 INFO - Running main action method: download_and_extract 05:34:02 INFO - mkdir: /builds/slave/test/build/tests 05:34: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')]} 05:34:02 INFO - trying https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 05:34:02 INFO - Downloading https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 05:34:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:34:03 INFO - Downloaded 1327 bytes. 05:34:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 05:34:03 INFO - Using the following test package requirements: 05:34:03 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 05:34:03 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:34:03 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:34:03 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:34:03 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 05:34:03 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:34:03 INFO - u'jsshell-linux-x86_64.zip'], 05:34:03 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:34:03 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:34:03 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 05:34:03 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:34:03 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 05:34:03 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:34:03 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 05:34:03 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:34:03 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:34:03 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:34:03 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:34:03 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:34:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 05:34:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:34:03 INFO - Fetch https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 05:34:04 INFO - Expected file size: 21968338 05:34:11 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:34:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 05:34:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:34:11 INFO - Fetch https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 05:34:12 INFO - Expected file size: 21968338 05:34:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 05:34:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:34:16 INFO - Fetch https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 05:34:17 INFO - Expected file size: 14414089 05:34: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')]} 05:34:18 INFO - trying https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:34:18 INFO - Downloading https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:34:19 INFO - Downloaded 57004383 bytes. 05:34:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:34:19 INFO - mkdir: /builds/slave/test/properties 05:34:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:34:19 INFO - Writing to file /builds/slave/test/properties/build_url 05:34:19 INFO - Contents: 05:34:19 INFO - build_url:https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:34:20 INFO - Running post-action listener: _resource_record_post_action 05:34:20 INFO - Running post-action listener: set_extra_try_arguments 05:34:20 INFO - [mozharness: 2017-01-06 13:34:20.032048Z] Finished download-and-extract step (success) 05:34:20 INFO - [mozharness: 2017-01-06 13:34:20.032274Z] Running populate-webroot step. 05:34:20 INFO - Running pre-action listener: _resource_record_pre_action 05:34:20 INFO - Running main action method: populate_webroot 05:34:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:34:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:34:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:34:20 INFO - '--tppagecycles', 05:34:20 INFO - '7'], 05:34:20 INFO - 'tests': ['tsvgm']}}, 05:34:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:34:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:34:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:34:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:34:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:20 INFO - 'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:20 INFO - 'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['damp', 'tps']}, 05:34:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:20 INFO - 'tests': ['damp', 'tps']}, 05:34:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['dromaeo_dom']}, 05:34:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:34:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['basic_compositor_video']}, 05:34:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:34:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['a11yr', 05:34:20 INFO - 'ts_paint', 05:34:20 INFO - 'tpaint', 05:34:20 INFO - 'sessionrestore', 05:34:20 INFO - 'sessionrestore_no_auto_restore', 05:34:20 INFO - 'tabpaint']}, 05:34:20 INFO - 'other-e10s': {'tests': ['a11yr', 05:34:20 INFO - 'ts_paint', 05:34:20 INFO - 'tpaint', 05:34:20 INFO - 'sessionrestore', 05:34:20 INFO - 'sessionrestore_no_auto_restore', 05:34:20 INFO - 'tabpaint']}, 05:34:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:34:20 INFO - 'ts_paint', 05:34:20 INFO - 'tpaint', 05:34:20 INFO - 'sessionrestore', 05:34:20 INFO - 'sessionrestore_no_auto_restore', 05:34:20 INFO - 'tabpaint']}, 05:34:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:34:20 INFO - 'ts_paint', 05:34:20 INFO - 'tpaint', 05:34:20 INFO - 'sessionrestore', 05:34:20 INFO - 'sessionrestore_no_auto_restore', 05:34:20 INFO - 'tabpaint']}, 05:34:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['a11yr', 05:34:20 INFO - 'ts_paint', 05:34:20 INFO - 'tpaint', 05:34:20 INFO - 'sessionrestore', 05:34:20 INFO - 'sessionrestore_no_auto_restore', 05:34:20 INFO - 'tabpaint']}, 05:34:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['a11yr', 05:34:20 INFO - 'ts_paint', 05:34:20 INFO - 'tpaint', 05:34:20 INFO - 'sessionrestore', 05:34:20 INFO - 'sessionrestore_no_auto_restore', 05:34:20 INFO - 'tabpaint']}, 05:34:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['tsvgx', 05:34:20 INFO - 'tsvgr_opacity', 05:34:20 INFO - 'tart', 05:34:20 INFO - 'tscrollx', 05:34:20 INFO - 'cart']}, 05:34:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:34:20 INFO - 'tsvgr_opacity', 05:34:20 INFO - 'tart', 05:34:20 INFO - 'tscrollx', 05:34:20 INFO - 'cart']}, 05:34:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:20 INFO - 'talos_options': ['--disable-e10s'], 05:34:20 INFO - 'tests': ['tp5o']}, 05:34:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:20 INFO - 'tests': ['tp5o']}, 05:34:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:20 INFO - 'talos_options': ['--disable-e10s', 05:34:20 INFO - '--xperf_path', 05:34:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:20 INFO - 'tests': ['tp5n']}, 05:34:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:20 INFO - 'talos_options': ['--xperf_path', 05:34:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:20 INFO - 'tests': ['tp5n']}}, 05:34:20 INFO - 'talos.zip': {'path': '', 05:34:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:34:20 INFO - Running post-action listener: _resource_record_post_action 05:34:20 INFO - [mozharness: 2017-01-06 13:34:20.054163Z] Finished populate-webroot step (success) 05:34:20 INFO - [mozharness: 2017-01-06 13:34:20.054257Z] Running create-virtualenv step. 05:34:20 INFO - Running pre-action listener: _resource_record_pre_action 05:34:20 INFO - Running main action method: create_virtualenv 05:34:20 INFO - Creating virtualenv /builds/slave/test/build/venv 05:34:20 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 05:34:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:34:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:34:20 INFO - Using real prefix '/usr' 05:34:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:34:20 INFO - Installing distribute.............................................................................................................................................................................................done. 05:34:22 INFO - Installing pip.................done. 05:34:22 INFO - Return code: 0 05:34:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:22 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 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:22 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 05:34:22 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 05:34:22 INFO - Using env: {'DISPLAY': ':0', 05:34:22 INFO - 'HOME': '/home/cltbld', 05:34:22 INFO - 'LANG': 'en_US.UTF-8', 05:34:22 INFO - 'LANGUAGE': 'en_US:en', 05:34:22 INFO - 'LOGNAME': 'cltbld', 05:34:22 INFO - 'MAIL': '/var/mail/cltbld', 05:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:22 INFO - 'MOZ_NO_REMOTE': '1', 05:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:22 INFO - 'NO_EM_RESTART': '1', 05:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:22 INFO - 'PWD': '/builds/slave/test', 05:34:22 INFO - 'SHELL': '/bin/bash', 05:34:22 INFO - 'SHLVL': '1', 05:34:22 INFO - 'TERM': 'linux', 05:34:22 INFO - 'TMOUT': '86400', 05:34:22 INFO - 'USER': 'cltbld', 05:34:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:22 INFO - '_': '/tools/buildbot/bin/python'} 05:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:22 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 05:34:22 INFO - Cleaning up... 05:34:22 INFO - Return code: 0 05:34:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:22 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 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:22 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 05:34:22 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 05:34:22 INFO - Using env: {'DISPLAY': ':0', 05:34:22 INFO - 'HOME': '/home/cltbld', 05:34:22 INFO - 'LANG': 'en_US.UTF-8', 05:34:22 INFO - 'LANGUAGE': 'en_US:en', 05:34:22 INFO - 'LOGNAME': 'cltbld', 05:34:22 INFO - 'MAIL': '/var/mail/cltbld', 05:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:22 INFO - 'MOZ_NO_REMOTE': '1', 05:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:22 INFO - 'NO_EM_RESTART': '1', 05:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:22 INFO - 'PWD': '/builds/slave/test', 05:34:22 INFO - 'SHELL': '/bin/bash', 05:34:22 INFO - 'SHLVL': '1', 05:34:22 INFO - 'TERM': 'linux', 05:34:22 INFO - 'TMOUT': '86400', 05:34:22 INFO - 'USER': 'cltbld', 05:34:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:22 INFO - '_': '/tools/buildbot/bin/python'} 05:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:23 INFO - Downloading/unpacking psutil>=3.1.1 05:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:34:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:25 INFO - Installing collected packages: psutil 05:34:25 INFO - Running setup.py install for psutil 05:34:25 INFO - building 'psutil._psutil_linux' extension 05:34:25 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 05:34:25 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 05:34:25 INFO - building 'psutil._psutil_posix' extension 05:34:25 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 05:34:25 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 05:34:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:25 INFO - Successfully installed psutil 05:34:25 INFO - Cleaning up... 05:34:25 INFO - Return code: 0 05:34:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:34:25 INFO - Using env: {'DISPLAY': ':0', 05:34:25 INFO - 'HOME': '/home/cltbld', 05:34:25 INFO - 'LANG': 'en_US.UTF-8', 05:34:25 INFO - 'LANGUAGE': 'en_US:en', 05:34:25 INFO - 'LOGNAME': 'cltbld', 05:34:25 INFO - 'MAIL': '/var/mail/cltbld', 05:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:25 INFO - 'MOZ_NO_REMOTE': '1', 05:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:25 INFO - 'NO_EM_RESTART': '1', 05:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:25 INFO - 'PWD': '/builds/slave/test', 05:34:25 INFO - 'SHELL': '/bin/bash', 05:34:25 INFO - 'SHLVL': '1', 05:34:25 INFO - 'TERM': 'linux', 05:34:25 INFO - 'TMOUT': '86400', 05:34:25 INFO - 'USER': 'cltbld', 05:34:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:25 INFO - '_': '/tools/buildbot/bin/python'} 05:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:34:25 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 05:34:25 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 05:34:25 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 05:34:25 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 05:34:25 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 05:34:25 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 05:34:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:34:28 INFO - Installing collected packages: mozsystemmonitor 05:34:28 INFO - Running setup.py install for mozsystemmonitor 05:34:28 INFO - Successfully installed mozsystemmonitor 05:34:28 INFO - Cleaning up... 05:34:28 INFO - Return code: 0 05:34:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:34:28 INFO - Using env: {'DISPLAY': ':0', 05:34:28 INFO - 'HOME': '/home/cltbld', 05:34:28 INFO - 'LANG': 'en_US.UTF-8', 05:34:28 INFO - 'LANGUAGE': 'en_US:en', 05:34:28 INFO - 'LOGNAME': 'cltbld', 05:34:28 INFO - 'MAIL': '/var/mail/cltbld', 05:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:28 INFO - 'MOZ_NO_REMOTE': '1', 05:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:28 INFO - 'NO_EM_RESTART': '1', 05:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:28 INFO - 'PWD': '/builds/slave/test', 05:34:28 INFO - 'SHELL': '/bin/bash', 05:34:28 INFO - 'SHLVL': '1', 05:34:28 INFO - 'TERM': 'linux', 05:34:28 INFO - 'TMOUT': '86400', 05:34:28 INFO - 'USER': 'cltbld', 05:34:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:28 INFO - '_': '/tools/buildbot/bin/python'} 05:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:28 INFO - Downloading/unpacking jsonschema==2.5.1 05:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:34:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:34:30 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 05:34:30 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 05:34:30 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 05:34:30 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 05:34:30 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 05:34:30 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 05:34:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:34:30 INFO - warning: no files found matching '*.txt' 05:34:30 INFO - no previously-included directories found matching 'build' 05:34:30 INFO - no previously-included directories found matching 'dist' 05:34:30 INFO - no previously-included directories found matching '.git*' 05:34:30 INFO - Installing collected packages: jsonschema, functools32 05:34:30 INFO - Running setup.py install for functools32 05:34:30 INFO - warning: no files found matching '*.txt' 05:34:30 INFO - no previously-included directories found matching 'build' 05:34:30 INFO - no previously-included directories found matching 'dist' 05:34:30 INFO - no previously-included directories found matching '.git*' 05:34:30 INFO - Successfully installed jsonschema functools32 05:34:30 INFO - Cleaning up... 05:34:30 INFO - Return code: 0 05:34:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:34: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')]} 05:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34: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')]} 05:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:30 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 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:30 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 05:34:30 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 05:34:30 INFO - Using env: {'DISPLAY': ':0', 05:34:30 INFO - 'HOME': '/home/cltbld', 05:34:30 INFO - 'LANG': 'en_US.UTF-8', 05:34:30 INFO - 'LANGUAGE': 'en_US:en', 05:34:30 INFO - 'LOGNAME': 'cltbld', 05:34:30 INFO - 'MAIL': '/var/mail/cltbld', 05:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:30 INFO - 'MOZ_NO_REMOTE': '1', 05:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:30 INFO - 'NO_EM_RESTART': '1', 05:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:30 INFO - 'PWD': '/builds/slave/test', 05:34:30 INFO - 'SHELL': '/bin/bash', 05:34:30 INFO - 'SHLVL': '1', 05:34:30 INFO - 'TERM': 'linux', 05:34:30 INFO - 'TMOUT': '86400', 05:34:30 INFO - 'USER': 'cltbld', 05:34:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:30 INFO - '_': '/tools/buildbot/bin/python'} 05:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:34:31 INFO - Cleaning up... 05:34:31 INFO - Return code: 0 05:34:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:34:31 INFO - Using env: {'DISPLAY': ':0', 05:34:31 INFO - 'HOME': '/home/cltbld', 05:34:31 INFO - 'LANG': 'en_US.UTF-8', 05:34:31 INFO - 'LANGUAGE': 'en_US:en', 05:34:31 INFO - 'LOGNAME': 'cltbld', 05:34:31 INFO - 'MAIL': '/var/mail/cltbld', 05:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:31 INFO - 'MOZ_NO_REMOTE': '1', 05:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:31 INFO - 'NO_EM_RESTART': '1', 05:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:31 INFO - 'PWD': '/builds/slave/test', 05:34:31 INFO - 'SHELL': '/bin/bash', 05:34:31 INFO - 'SHLVL': '1', 05:34:31 INFO - 'TERM': 'linux', 05:34:31 INFO - 'TMOUT': '86400', 05:34:31 INFO - 'USER': 'cltbld', 05:34:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:31 INFO - '_': '/tools/buildbot/bin/python'} 05:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:31 INFO - Downloading/unpacking blobuploader==1.2.4 05:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:33 INFO - Downloading blobuploader-1.2.4.tar.gz 05:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:34:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:34:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:34 INFO - Downloading docopt-0.6.1.tar.gz 05:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:34:34 INFO - Installing collected packages: blobuploader, requests, docopt 05:34:34 INFO - Running setup.py install for blobuploader 05:34:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:34:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:34:34 INFO - Running setup.py install for requests 05:34:34 INFO - Running setup.py install for docopt 05:34:34 INFO - Successfully installed blobuploader requests docopt 05:34:34 INFO - Cleaning up... 05:34:34 INFO - Return code: 0 05:34:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:34 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 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:34 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 05:34:34 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 05:34:34 INFO - Using env: {'DISPLAY': ':0', 05:34:34 INFO - 'HOME': '/home/cltbld', 05:34:34 INFO - 'LANG': 'en_US.UTF-8', 05:34:34 INFO - 'LANGUAGE': 'en_US:en', 05:34:34 INFO - 'LOGNAME': 'cltbld', 05:34:34 INFO - 'MAIL': '/var/mail/cltbld', 05:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:34 INFO - 'MOZ_NO_REMOTE': '1', 05:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:34 INFO - 'NO_EM_RESTART': '1', 05:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:34 INFO - 'PWD': '/builds/slave/test', 05:34:34 INFO - 'SHELL': '/bin/bash', 05:34:34 INFO - 'SHLVL': '1', 05:34:34 INFO - 'TERM': 'linux', 05:34:34 INFO - 'TMOUT': '86400', 05:34:34 INFO - 'USER': 'cltbld', 05:34:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:34 INFO - '_': '/tools/buildbot/bin/python'} 05:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:34 INFO - Running setup.py (path:/tmp/pip-rArj9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:35 INFO - Running setup.py (path:/tmp/pip-Cl44Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:35 INFO - Running setup.py (path:/tmp/pip-OrnuYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:35 INFO - Running setup.py (path:/tmp/pip-UbIfqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:35 INFO - Running setup.py (path:/tmp/pip-euyrlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:35 INFO - Running setup.py (path:/tmp/pip-P9PsFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:35 INFO - Running setup.py (path:/tmp/pip-Z1fZiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:35 INFO - Running setup.py (path:/tmp/pip-PNIVyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:35 INFO - Running setup.py (path:/tmp/pip-QYGKNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:35 INFO - Running setup.py (path:/tmp/pip-oAFUv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:35 INFO - Running setup.py (path:/tmp/pip-Ci7Z6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:35 INFO - Running setup.py (path:/tmp/pip-mvB6QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:35 INFO - Running setup.py (path:/tmp/pip-LF0n1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:35 INFO - Running setup.py (path:/tmp/pip-QNRQzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:35 INFO - Running setup.py (path:/tmp/pip-4WqJmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:36 INFO - Running setup.py (path:/tmp/pip-SgFWA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:36 INFO - Running setup.py (path:/tmp/pip-GmrBt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:34:36 INFO - Running setup.py install for manifestparser 05:34:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:34:36 INFO - Running setup.py install for mozcrash 05:34:36 INFO - Running setup.py install for mozdebug 05:34:36 INFO - Running setup.py install for mozdevice 05:34:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:34:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:34:36 INFO - Running setup.py install for mozfile 05:34:36 INFO - Running setup.py install for mozhttpd 05:34:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:34:36 INFO - Running setup.py install for mozinfo 05:34:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:34:36 INFO - Running setup.py install for mozInstall 05:34:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:34:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:34:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:34:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:34:37 INFO - Running setup.py install for mozleak 05:34:37 INFO - Running setup.py install for mozlog 05:34:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:34:37 INFO - Running setup.py install for moznetwork 05:34:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:34:37 INFO - Running setup.py install for mozprocess 05:34:37 INFO - Running setup.py install for mozprofile 05:34:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:34:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:34:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:34:37 INFO - Running setup.py install for mozrunner 05:34:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:34:37 INFO - Running setup.py install for mozscreenshot 05:34:37 INFO - Running setup.py install for moztest 05:34:37 INFO - Running setup.py install for mozversion 05:34:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:34:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:34:38 INFO - Cleaning up... 05:34:38 INFO - Return code: 0 05:34:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:38 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')]} 05:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:38 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')]} 05:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:38 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 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:38 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 05:34:38 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 05:34:38 INFO - Using env: {'DISPLAY': ':0', 05:34:38 INFO - 'HOME': '/home/cltbld', 05:34:38 INFO - 'LANG': 'en_US.UTF-8', 05:34:38 INFO - 'LANGUAGE': 'en_US:en', 05:34:38 INFO - 'LOGNAME': 'cltbld', 05:34:38 INFO - 'MAIL': '/var/mail/cltbld', 05:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:38 INFO - 'MOZ_NO_REMOTE': '1', 05:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:38 INFO - 'NO_EM_RESTART': '1', 05:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:38 INFO - 'PWD': '/builds/slave/test', 05:34:38 INFO - 'SHELL': '/bin/bash', 05:34:38 INFO - 'SHLVL': '1', 05:34:38 INFO - 'TERM': 'linux', 05:34:38 INFO - 'TMOUT': '86400', 05:34:38 INFO - 'USER': 'cltbld', 05:34:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:38 INFO - '_': '/tools/buildbot/bin/python'} 05:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:38 INFO - Running setup.py (path:/tmp/pip-LkVJSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:38 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)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:38 INFO - Running setup.py (path:/tmp/pip-jv2CbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:38 INFO - Running setup.py (path:/tmp/pip-pPtUv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:38 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)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:38 INFO - Running setup.py (path:/tmp/pip-TSpT7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:38 INFO - Running setup.py (path:/tmp/pip-HyaVSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:38 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)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:38 INFO - Running setup.py (path:/tmp/pip-odze7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:38 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)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:38 INFO - Running setup.py (path:/tmp/pip-wONnzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:38 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)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:38 INFO - Running setup.py (path:/tmp/pip-zTfJM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:38 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)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:38 INFO - Running setup.py (path:/tmp/pip-gHlNWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:38 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)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:38 INFO - Running setup.py (path:/tmp/pip-qgLh9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:38 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)) 05:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:38 INFO - Running setup.py (path:/tmp/pip-c7IVzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:39 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)) 05:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:39 INFO - Running setup.py (path:/tmp/pip-lW0rbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:39 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)) 05:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:39 INFO - Running setup.py (path:/tmp/pip-GsMblc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:39 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)) 05:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:39 INFO - Running setup.py (path:/tmp/pip-0qv_LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:39 INFO - Running setup.py (path:/tmp/pip-cMbtUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:39 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)) 05:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:39 INFO - Running setup.py (path:/tmp/pip-cl_jz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:39 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)) 05:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:39 INFO - Running setup.py (path:/tmp/pip-WyFRnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:39 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)) 05:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:34:39 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)) 05:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:34:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:41 INFO - Downloading blessings-1.6.tar.gz 05:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:34:41 INFO - Installing collected packages: blessings 05:34:41 INFO - Running setup.py install for blessings 05:34:41 INFO - Successfully installed blessings 05:34:41 INFO - Cleaning up... 05:34:41 INFO - Return code: 0 05:34:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:34:41 INFO - Reading from file tmpfile_stdout 05:34:41 INFO - Current package versions: 05:34:41 INFO - argparse == 1.2.1 05:34:41 INFO - blessings == 1.6 05:34:41 INFO - blobuploader == 1.2.4 05:34:41 INFO - docopt == 0.6.1 05:34:41 INFO - functools32 == 3.2.3-2 05:34:41 INFO - jsonschema == 2.5.1 05:34:41 INFO - manifestparser == 1.1 05:34:41 INFO - mozInstall == 1.12 05:34:41 INFO - mozcrash == 0.17 05:34:41 INFO - mozdebug == 0.1 05:34:41 INFO - mozdevice == 0.48 05:34:41 INFO - mozfile == 1.2 05:34:41 INFO - mozhttpd == 0.7 05:34:41 INFO - mozinfo == 0.9 05:34:41 INFO - mozleak == 0.1 05:34:41 INFO - mozlog == 3.4 05:34:41 INFO - moznetwork == 0.27 05:34:41 INFO - mozprocess == 0.23 05:34:41 INFO - mozprofile == 0.28 05:34:41 INFO - mozrunner == 6.12 05:34:41 INFO - mozscreenshot == 0.1 05:34:41 INFO - mozsystemmonitor == 0.3 05:34:41 INFO - moztest == 0.7 05:34:41 INFO - mozversion == 1.4 05:34:41 INFO - psutil == 3.1.1 05:34:41 INFO - requests == 1.2.3 05:34:41 INFO - wsgiref == 0.1.2 05:34:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:41 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')]} 05:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:41 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')]} 05:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:41 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 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:41 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 05:34:41 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 05:34:41 INFO - Using env: {'DISPLAY': ':0', 05:34:41 INFO - 'HOME': '/home/cltbld', 05:34:41 INFO - 'LANG': 'en_US.UTF-8', 05:34:41 INFO - 'LANGUAGE': 'en_US:en', 05:34:41 INFO - 'LOGNAME': 'cltbld', 05:34:41 INFO - 'MAIL': '/var/mail/cltbld', 05:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:41 INFO - 'MOZ_NO_REMOTE': '1', 05:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:41 INFO - 'NO_EM_RESTART': '1', 05:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:41 INFO - 'PWD': '/builds/slave/test', 05:34:41 INFO - 'SHELL': '/bin/bash', 05:34:41 INFO - 'SHLVL': '1', 05:34:41 INFO - 'TERM': 'linux', 05:34:41 INFO - 'TMOUT': '86400', 05:34:41 INFO - 'USER': 'cltbld', 05:34:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:41 INFO - '_': '/tools/buildbot/bin/python'} 05:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:42 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)) 05:34:42 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)) 05:34:42 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)) 05:34:42 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)) 05:34:42 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)) 05:34:42 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)) 05:34:42 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)) 05:34:42 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)) 05:34:42 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)) 05:34:42 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)) 05:34:42 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)) 05:34:42 INFO - Cleaning up... 05:34:42 INFO - Return code: 0 05:34:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50637ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', '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 05:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:34:42 INFO - Using env: {'DISPLAY': ':0', 05:34:42 INFO - 'HOME': '/home/cltbld', 05:34:42 INFO - 'LANG': 'en_US.UTF-8', 05:34:42 INFO - 'LANGUAGE': 'en_US:en', 05:34:42 INFO - 'LOGNAME': 'cltbld', 05:34:42 INFO - 'MAIL': '/var/mail/cltbld', 05:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:42 INFO - 'MOZ_NO_REMOTE': '1', 05:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:42 INFO - 'NO_EM_RESTART': '1', 05:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:42 INFO - 'PWD': '/builds/slave/test', 05:34:42 INFO - 'SHELL': '/bin/bash', 05:34:42 INFO - 'SHLVL': '1', 05:34:42 INFO - 'TERM': 'linux', 05:34:42 INFO - 'TMOUT': '86400', 05:34:42 INFO - 'USER': 'cltbld', 05:34:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:42 INFO - '_': '/tools/buildbot/bin/python'} 05:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:34:42 INFO - Cleaning up... 05:34:42 INFO - Return code: 0 05:34:42 INFO - Running post-action listener: _resource_record_post_action 05:34:42 INFO - Running post-action listener: _start_resource_monitoring 05:34:42 INFO - Starting resource monitoring. 05:34:42 INFO - [mozharness: 2017-01-06 13:34:42.469007Z] Finished create-virtualenv step (success) 05:34:42 INFO - [mozharness: 2017-01-06 13:34:42.469457Z] Running install step. 05:34:42 INFO - Running pre-action listener: _resource_record_pre_action 05:34:42 INFO - Running main action method: install 05:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:34:42 INFO - Reading from file tmpfile_stdout 05:34:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:34:42 INFO - Reading from file tmpfile_stdout 05:34:42 INFO - Output received: 05:34:42 INFO - Usage: mozinstall [options] installer 05:34:42 INFO - Options: 05:34:42 INFO - -h, --help show this help message and exit 05:34:42 INFO - -d DEST, --destination=DEST 05:34:42 INFO - Directory to install application into. [default: 05:34:42 INFO - "/builds/slave/test"] 05:34:42 INFO - --app=APP Application being installed. [default: firefox] 05:34:42 INFO - mkdir: /builds/slave/test/build/application 05:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:34:56 INFO - Reading from file tmpfile_stdout 05:34:56 INFO - Output received: 05:34:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:34:56 INFO - Running post-action listener: _resource_record_post_action 05:34:56 INFO - [mozharness: 2017-01-06 13:34:56.262376Z] Finished install step (success) 05:34:56 INFO - [mozharness: 2017-01-06 13:34:56.262619Z] Running run-tests step. 05:34:56 INFO - Running pre-action listener: _resource_record_pre_action 05:34:56 INFO - Running main action method: run_tests 05:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:34:56 INFO - Python 2.7.3 05:34:56 INFO - Return code: 0 05:34:56 INFO - grabbing minidump binary from tooltool 05:34:56 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')]} 05:34:56 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 0x1a32f60>, '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 0x1a33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a341d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:34:56 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 05:34:56 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 05:34:56 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 05:34:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:56 INFO - Return code: 0 05:34:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:34:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:34:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:34:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:34:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 05:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 05:34:56 INFO - Using env: {'DISPLAY': ':0', 05:34:56 INFO - 'HOME': '/home/cltbld', 05:34:56 INFO - 'LANG': 'en_US.UTF-8', 05:34:56 INFO - 'LANGUAGE': 'en_US:en', 05:34:56 INFO - 'LOGNAME': 'cltbld', 05:34:56 INFO - 'MAIL': '/var/mail/cltbld', 05:34:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:34:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:56 INFO - 'MOZ_NO_REMOTE': '1', 05:34:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:56 INFO - 'NO_EM_RESTART': '1', 05:34:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:56 INFO - 'PWD': '/builds/slave/test', 05:34:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:34:56 INFO - 'SHELL': '/bin/bash', 05:34:56 INFO - 'SHLVL': '1', 05:34:56 INFO - 'TERM': 'linux', 05:34:56 INFO - 'TMOUT': '86400', 05:34:56 INFO - 'USER': 'cltbld', 05:34:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550', 05:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:56 INFO - '_': '/tools/buildbot/bin/python'} 05:34:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 05:34:56 INFO - mozversion application_buildid: 20170106032113 05:34:56 INFO - mozversion application_changeset: 77005e00cdef605b05b0f4a6ef9ac8e641dcc588 05:34:56 INFO - mozversion application_display_name: Firefox 05:34:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:56 INFO - mozversion application_name: Firefox 05:34:56 INFO - mozversion application_remotingname: firefox 05:34:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:34:56 INFO - mozversion application_vendor: Mozilla 05:34:56 INFO - mozversion application_version: 51.0 05:34:56 INFO - mozversion platform_buildid: 20170106032113 05:34:56 INFO - mozversion platform_changeset: 77005e00cdef605b05b0f4a6ef9ac8e641dcc588 05:34:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:34:56 INFO - mozversion platform_version: 51.0 05:34:56 INFO - using testdate: 1483709696 05:34:56 INFO - actual date: 1483709696 05:34:56 INFO - starting webserver on 'localhost:44711' 05:34:56 INFO - SUITE-START | Running 2 tests 05:34:56 INFO - TEST-START | dromaeo_css 05:34:56 INFO - operating with platform_type : linux_ 05:34:56 INFO - Initialising browser for dromaeo_css test... 05:34:56 INFO - TEST-INFO | started process 16153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ZCXJf/profile http://localhost:44711/getInfo.html) 05:35:00 INFO - PROCESS | 16153 | __metrics Screen width/height:1600/1200 05:35:00 INFO - PROCESS | 16153 | colorDepth:24 05:35:00 INFO - PROCESS | 16153 | Browser inner width/height: 1024/697 05:35:00 INFO - PROCESS | 16153 | __metrics 05:35:01 INFO - PROCESS | 16153 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:35:01 INFO - PROCESS | 16153 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:35:01 INFO - PROCESS | 16153 | console.error: PushService: 05:35:01 INFO - PROCESS | 16153 | stateChangeProcessEnqueue: Error transitioning state 05:35:01 INFO - PROCESS | 16153 | UnknownError 05:35:02 INFO - TEST-INFO | 16153: exit 0 05:35:02 INFO - Browser initialized. 05:35:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:35:02 INFO - TEST-INFO | started process 16244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ZCXJf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:13 INFO - PROCESS | 16244 | RSS: Main: 143585280 05:35:13 INFO - PROCESS | 16244 | 05:36:05 INFO - PROCESS | 16244 | 1483709765215 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] 05:38:14 INFO - PROCESS | 16244 | Cycle 1(1): loaded http://localhost:44711/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44711/tests/dromaeo/cssquery-ext.html) 05:38:15 INFO - PROCESS | 16244 | RSS: Main: 261464064 05:38:15 INFO - PROCESS | 16244 | 05:41:18 INFO - PROCESS | 16244 | Cycle 1(1): loaded http://localhost:44711/tests/dromaeo/cssquery-ext.html (next: http://localhost:44711/tests/dromaeo/cssquery-jquery.html) 05:41:18 INFO - PROCESS | 16244 | RSS: Main: 233041920 05:41:18 INFO - PROCESS | 16244 | 05:44:20 INFO - PROCESS | 16244 | Cycle 1(1): loaded http://localhost:44711/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44711/tests/dromaeo/cssquery-mootools.html) 05:44:21 INFO - PROCESS | 16244 | RSS: Main: 194695168 05:44:21 INFO - PROCESS | 16244 | 05:47:23 INFO - PROCESS | 16244 | Cycle 1(1): loaded http://localhost:44711/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44711/tests/dromaeo/cssquery-prototype.html) 05:47:23 INFO - PROCESS | 16244 | RSS: Main: 229400576 05:47:23 INFO - PROCESS | 16244 | 05:50:26 INFO - PROCESS | 16244 | Cycle 1(1): loaded http://localhost:44711/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44711/tests/dromaeo/cssquery-yui.html) 05:50:26 INFO - PROCESS | 16244 | RSS: Main: 175493120 05:50:26 INFO - PROCESS | 16244 | 05:53:29 INFO - PROCESS | 16244 | Cycle 1(1): loaded http://localhost:44711/tests/dromaeo/cssquery-yui.html (next: http://localhost:44711/tests/dromaeo/cssquery-dojo.html) 05:53:29 INFO - PROCESS | 16244 | RSS: Main: 263991296 05:53:29 INFO - PROCESS | 16244 | 05:53:29 INFO - PROCESS | 16244 | __start_tp_report 05:53:29 INFO - PROCESS | 16244 | _x_x_mozilla_page_load 05:53:29 INFO - PROCESS | 16244 | _x_x_mozilla_page_load_details 05:53:29 INFO - PROCESS | 16244 | |i|pagename|runs| 05:53:29 INFO - PROCESS | 16244 | |0;dojo.html;3132.968670313297;3166.1926208816735;3184.0288711942853;3214.019723984187;3217.2761128746033;5657.462541058603;5691.8292451226425;5729.39841316662;5760.913586296204;5765.682887441194;5648.632838865471;5657.2928383952;5703.515201207892;5722.885542289152;5728.369879313273;5131.050755610215;5169.147090730025;5177.896442071175;5199.376074871021;5234.555062819665;5016.523430274118;5049.4193167785625;5243.501867322599;5253.317068781053;5254.474552544734;5089.745512724349;5140.511651393112;5143.614228932845;5146.356705411824;5155.329807125068;5114.846554603368;5147.124988751922;5158.845234642967;5179.223116532513;5195;5098.286239926413;5122.641415100945;5126.077306084903;5198.090334191501;5232.633715639907;5508.91736623951;5643.294588176478;5647.37878833328;5736.770529178828;5755.309362876482;5907.2911250650195;5907.379725128842;5941.910871336933;5964.135200395918;6026.246719160105;5975.163477113208;5989.730462129215;6051.062085376773;6065.2418447694035;6066.6663333516635;5635.746391412396;5638.267025286768;5642.802501912454;5644.6330988486025;5646.604737668324;5920.674362910081;5979.701014949323;6071.908921366183;6119.204503414528;6122.234720659918;5957.582969192202;5961.5826892118;5961.642301461926;5965.880682386328;5972.044472884318;6048.062550304622;6049.243844519435;6055.757769689163;6059.424354686298;6060.545459090586;5870.823875283749;5879.029960056543;5965.463108320272;5999.880002399927;6032.125341825411;6066.636001839904;6071.726772295169;6105.32841387447;6106.45041946218;6117.174181485442;4659.9767001165455;4666.113438446684;4669.719816811003;4670.53294670537;4673.626109911199;3983.0042489377656;4003.5195776507007;4135.069609337875;4142.2958097123565;4176.979115104405;5629.521490673257;5657.745401456944;5673.716314184274;5722.713864306768;5749;6053.8486537836025;6058.969705151534;6061.939380606225;6063;6065.695875386725;5549.278593782782;5637.746301416446;5719.456651618089;5720.08478643415;5727.169560413717;4995.450500444948;5080.720560369141;5082.415522214918;5085.694858308513;5088.669236499616;6084.452399284086;6117.9187529241;6135.2326666699655;6145.525073982212;6208.751649933952;6135.1408007826785;6136.090214303778;6140.04415716754;6144.064619644798;6144.986077297374;6291.874162516816;6296.5277604178955;6296.842578935563;6300.9684951574945;6304.085907543289;5804.158397032491;5853.590248682552;5857.736401862012;5877.265341832271;5891;6034.004389275896;6034.275886893601;6035.969820151046;6042.758289668364;6077.726502307319;5876.41235876409;5918.17145599625;5918.585699001201;5923.7926672566255;5929.792457263975;5820.970895145667;5865.530757539472;5872.354041055395;5877.441643044075;5918.17145599625;5905.498032667271;5921.851953701192;5927.8221653350465;5929.080992446177;5974.074018527135;5956.523478121827;5975.880482390241;5983.192269043798;5989.101634754822;5989.371116032754;5691.3170419549915;5705.914411283751;5780.768769249183;5833.387494313206;5840.561957853093 05:53:29 INFO - PROCESS | 16244 | |1;ext.html;586.9031609784386;610.1305639463764;652.4845372155995;659.7196191618558;671.7078071039095;34720.65279347206;35541.111472213175;36991;37060.44409333862;37251.627483725155;38467;47581.52418475814;48331.758341208246;48461.51538484614;52262;9300.953495232532;9432.858507122364;9438.575264113131;9442.433453992748;9449.858252126223;8628;9119.452832830018;9212.355135140542;9245.861312080324;9285.767855803626;8684.739457816275;11191.552337906474;11482.425878706073;11485.368304743235;11825.645230643095;11340.262882912626;11396.316221026766;11397.886021139766;11398.544058237661;11407.771844563145;11094.500747466383;11206.495707693173;11219.214654974156;11219.326840389604;11225.887741122648;45616.54383456156;45875.31187032197;46052.53947460516;46069.769651151866;46074.5392546077;3868.2843673920133;3916.862909798172;3952.960470395317;3953.644172024503;4315.43899293093;34888.302233955175;34926.476102858476;34968.65031349705;35130.64869351325;35355.646443535494;4478.865634030952;4562.977185114053;4580.450345958473;4588.059447813191;4636.5131661175765;372889;374996;375370;377282.113589433;377431;38951.80524097361;39662.20675586472;65159.34840651533;65371;65517.67241163859;40780.38829417561;40999.3350432221;41172.38241426381;41247.587524124974;41310.58689413127;17950.730739038925;18105.909470452825;18174.818251817578;18177.72733409;18184.727229091575;13604.31978401076;13617.114887532278;13663.316834158253;13669.589912302647;13686.863131368758;8931.374803763674;9094.909050909406;9301.34890557668;9550.808983820285;9611.519424028771;3618.8009659468457;3630.41913293877;3646.234290798962;3647.562292524861;3685.355062863988;1044.7753732947301;1053.0027964177993;1076.4025965589174;1078.8166011778017;1150.649052039136;33793.199972007846;33989.32021359608;34695.65304346924;34842.30315393729;35117.64882351195;1123.9494222759995;1127.9154063445274;1178.93515856627;1206.1775445457672;1290.748304080714;16597.41909033178;17596.736048959276;17800.9109954452;18427.53931151732;18518;534112;545796;547581;547732;549089;61934;62501.37498624955;62571.061434078525;62679.37320626735;62690;1383.8201033865532;1441.4018182454374;1448.3844366144347;1461.5250043735828;1470.1179292424674;32342.191445213117;34409.00993508;34546.136346591535;34635.4804677925;34851;56568.43431565632;57328.71335643462;57330.713346433;57345;57361.42638573728;467342;471270;471423;472490;472886;40506.39240411337;40895.591044089175;40896.79551602223;46652.300215496114;46741.76629116833;44331.55668443274;52579.47420525746;54744.45255547394;56529;56931;43416.34875476934;43852.34221486744;44236;44588.33117503305;45427.54572454233;43563.12873742444;44273.33589996217;44693;45445;46266.53733462622;43744;44062.77968610136;44872;45143.7742811297;45554.31668525041;37695.623043769214;39565.60434395619;39889.80055099822;40175.79912100538;40711.79644101879;29538.55692164662;29605.25986850346;29802.317791398877;29816.70183298139;29962.25094372658 05:53:29 INFO - PROCESS | 16244 | |2;jquery.html;427.82459191731357;429.4352925902438;430.5801843202877;432.93382572726125;449.6807266840545;18747;19527;20313.187472501082;20333.593328133447;20389.49026274344;19630.705539416922;20089.29687460939;20142.69785953212;20316.695249571232;20476.488087797774;5724.942750572493;6021.879562408749;6022.638641681491;6023.42777436145;6026.397360263961;5825.854353641151;5886.793962211324;5955.196048533436;5958.195643588125;5987.85030374242;5904.025835737119;5925.022371308729;5928.49607783339;5931.762729490837;5937.9905416079155;5670.3555968769215;5893.381194974509;5936.139259807325;5943.435373639497;5960.076188190794;5367.75845086972;5374.677519348852;5375.032494151052;5376.946230537684;5378.112611419111;24065.87967060171;24144;24216;24273.1504397347;24398.756012440004;2587.922362329114;2677.3708178578017;2796.720327967207;2864.5273529867545;2966.4512065267995;14689.70620587593;15345.693086138326;15347.539573812803;15536.300866461037;15653.452129175424;2082.6771850363216;2094.853360264782;2136.690179923918;2139.5079131799616;2184.7924447177493;57758;73454.63272683656;77223;79592;80623.59688201522;11535.71160720972;11633.6509904703;11796;11999.460024298927;12008.939955300168;16662.916685416494;16664.08347540897;16689.83310166907;16691.749623755655;16697.749533757004;8861.867071993796;8965.686200982935;9073.13805188506;9167.358284919992;9184.586693598803;8842.91157088421;8862.86705699415;8901.198892099612;9071.27429805614;9136.634534618674;7066.152061752623;7085.539439936388;7125.251848555827;7176.7488137914925;7182.138143422822;2031.766346870129;2049.3134799841923;2055.1162999909884;2103.3059090500096;2176.194807921048;982.6462473509531;996.8504724291414;1058.1270451877233;1077.224398433127;1078.6925726168004;20202.393928182177;20254.493637659176;20534.897325513575;20676.689849652266;21141.154353825983;1003.6236411345745;1044.6291566493937;1056.709404913655;1058.804121237558;1099.9890001099886;11095.334279943228;11694.925408902927;11931.76136477283;12168.939155304166;12242.755144897052;518272;531405;540140;541976;551904;87364.95303040104;89281.55359223162;90259;90706;91194.54402728076;1075.4300220882944;1084.116445097259;1086.9619563315405;1089.1667874076338;1092.7432053467428;17061.232244549272;18042.72935905936;18560.442666111394;18723.344682936033;18854.05729713536;40621.79689101536;41435.7928210357;41491.58508414877;42806.35790463083;44520.33219501775;58157;59491;63001.36998630138;63205.36794631995;64471.677641611495;9032.548372581214;9191.080891910755;9219.677311294072;9557.665481708107;9565.904340956502;13476.124051936593;14150.575482735534;14286.142831430148;14415.351309191321;14736.189509577076;12443.502259909503;12520.436580353724;12559.497620095093;12711.936440317739;12777.8083328752;12001.579944701894;12013.75972480563;12374.876251237372;12519.624411267676;12909.612711618667;12578.622641320775;12895.16181448203;12911.289879056741;13022.348882555645;13072.80390794158;9225.72322830316;9281.86077208856;9409.388389754644;9446.008169142417;9541.284403669892;12152;12163.513459461523;12376.690582735144;12531.373431328579;12970.092093553361 05:53:29 INFO - PROCESS | 16244 | |3;mootools.html;1380.4961189165958;1519.2859356102636;1550.2868680407012;1653.9173041347938;1797.5775692712211;7876.960615196923;8717.084706105863;8968.596413161398;8984.775380615472;9249.6300147994;8809.691660791874;8906.198442140207;8908.287337013024;8908.955455222731;8928.19646231839;2437.1348171399163;2462.4705688277018;2462.495188486365;2467.679201703785;2468.691413573303;2375.3586531636447;2415.625578035407;2416.0094361311867;2416.0456619635233;2420.8426452280546;2365.042157926043;2374.7150341958904;2375.061850569024;2407.8194135439826;2408.036785285891;2304.5045315257134;2330.2310237621546;2350.9059637614473;2359.95280094398;2360.834741568091;2329.895154718042;2351.7648235176343;2363.2673871100014;2364.101641376283;2364.397078744926;8987.820243595157;9011.45931244121;9063.864042039375;9102.226310763594;9187.448753074837;5514.338279406497;5644.266245388073;5649.378568357477;5655.915161272585;5659.179418984224;3348.564686590752;3392.830358482066;3397.405454045557;3455.8617655293756;3469.0460123465996;1212.5331747277273;1212.6483319837237;1220.3044264769085;1256.422045858906;1257.8239046533492;12835.165714228546;12901.612951611467;12956.611301660965;12964.092513524058;12975.675608109872;4553.658475614276;4662.347271382009;4801.807927682854;4812.831550895702;4853.2720091985775;10147.543360548792;10158.695239142837;10167.237457190593;10169.084782369475;10183.54174062169;5494.642848214933;5506.91739623906;5508.724563771875;5512.614117011851;5522.751476183581;4475.686701930834;4617.746023968647;4948.257761335828;5069.366329208849;5113.53978141969;3999.440078389028;4050.311447054008;4124.1133156371525;4162.4796900387455;4165.97917010413;1193.2124797633521;1195.0401341799457;1199.8800119988107;1221.773971815217;1231.082843281761;909.3543584055262;1001.7874836313285;1026.5483187397522;1034.5551412892378;1034.9275550711377;5950.464458198783;6195.876082478325;6316.115743795872;6360.968195158995;6364.840878978062;491.20915326324587;492.9457759646436;499.7950840155519;508.23256882107546;514.3005512502993;4189.706720529594;4231.132617813341;4245.617894389458;4250.3199488081755;4357.346398040256;10860.294080884718;11361.772764544663;11368.65894023164;11374.715632109264;11410.600628977945;11052.171087168495;11144.442777861075;11230.438478076227;11283.097352211804;11302.604408845815;8232.958835205785;8366.790830229293;8584.356173287028;8586.570671466401;8587.95706021466;5932.228810254812;6002.939970600238;6090.3605121461605;6097.725602347817;6118.082287656887;10107.22051435861;10294.536745846604;10426.165906727292;10442.895571044497;10525.578976840841;10755.516001779783;10759.623413180501;10797.352158870493;10815.783684326427;10845.240833141605;6858.6570671467225;7047.154341479055;7262.564246145248;7764.883526747216;7828.84342313162;8699.739007829776;9052;9054;9054.63781448761;9064.093590641147;7743.612819359122;7902.565358905315;7915.920840791749;8167.877481837659;8242.722378031174;7795.532268063935;7876.527408355517;7896.32881205104;7957.721479748181;7966.522008679498;7395.556266624019;7438.962805185939;7508.436867235088;7518.135414427411;7542;5398.838034858961;5462.289902312674;5481.342238931354;5502.257195278587;5643.858903527444;5367.329083864517;5540.22436858832;5552.833414997556;5574.052411090205;5716.885662286814 05:53:29 INFO - PROCESS | 16244 | |4;prototype.html;345.73896707985466;355.8950109717634;360.31719890806903;363.3350967729056;363.565539180679;5324.76038578264;5453.59098067645;5499.202615620733;5533.47431993961;5538.861528461785;5465.945340546593;5483.382402191353;5485.0949593317055;5506.283258800314;5511.5039646431815;4031.314676505001;4362.956370436303;4370.907273181705;4384.232759267132;4394.934075988863;3828.827702753369;4235.74585524868;4304.827806887736;4324.82700691972;4329.783510824462;4285.592868677486;4286.87139385819;4291.249031419505;4291.935620965688;4322.935155972663;4306.849260275907;4311.223979683656;4313.245182093153;4313.309870420733;4320.935185972197;3582.42681171014;3736.3087828751495;3829.6447684673726;3885.61143885612;3919.510061242345;5340.893182136336;5360.115580929181;5366.517013468768;5368.543673787733;5369.650972686802;4947.356843610343;4949;4957.190625421731;4987.226979818134;5015.498450154992;5657.3494048184575;5687.7156142192725;5714.200011998323;5718.571107166979;5792.740831075884;4158.688098392633;4159.313713237312;4175.770332631704;4176.582341765799;4179.435776170209;5668.206451096849;5824.417558244227;5969.31352894414;5997.7001149942325;6004.39956004396;4137.46212992309;4148.087420767426;4269.5090064642345;4281.9812032517;4296.2696341621995;4313.094250207491;4325.329573916048;4343.893211792279;4371.628411584988;4379.810094952523;4737.336772851803;4940.827071052496;4947.183714687037;4968.540572416605;4979.850604481871;5708.771649133988;5730.34101078373;5753.913691294634;5761.9135712964335;5803.564732645069;1473.3296350160651;1495.820501539822;1507.1785876697227;1518.9088654680754;1521.8706409955278;935.5462600638684;963;966.2221911361421;966.9419834809793;993.2352088891513;4780.354652121989;4876.29293752411;4891.926621100686;4917.508249175054;4923.676518350099;5157.406898206679;5170.379554453414;5172.663776854492;5173.81891633791;5181.870453238624;4662.487126416091;4910.238912968495;4937.876553086202;4941.344649542371;4970.279309500174;2735.329844188147;2768.9723102769117;2777.375090604598;2787.5400558907554;2791.813479271342;5284.313039304942;5297.337832770903;5299.138465228811;5312.5218730314455;5336.306280183629;5302.231176479466;5328.626996110313;5680.5171560417;6067.605605635707;6093.69531523422;6198.0785956353675;6201.271440566226;6205.162303089115;6207.596506227081;6209.112762565429;5776.8555786104;6050;6062.727177277121;6086.513078953584;6103.969480152571;5862.94137058641;5914.58597898143;5932.614380065282;5932.673702946379;5959.404059594006;5912.320083190488;5979.880402391841;6031.336552979256;6152.876942461216;6168.19813424252;4275.135659108342;4300;4303.268444364403;4307.3416734556795;4310.612044915847;5793.580572759701;5970.910436343545;6051.909221361771;6076.848078798065;6082.452579267887;5808.357197475223;5830.309210328957;5831.446012628793;5832.941670583409;5840.328362238227;5821.650700957956;5832.883342333044;5835.7373918174635;5841.912371314349;5842.649441033552;5477.096279114061;5727.052802047324;5768.077107662753;5799.565032622654;5800.24596802413;5844.503217226584;5856.531477481706;5860.853478663067;5866.941330586639;5873.2658417697785;5548.778048878;5689.175069614966;5724.599278050663;5778.364379918122;5805.94194058054 05:53:29 INFO - PROCESS | 16244 | |5;yui.html;792.6829268292679;815.8613035783916;846.9957650211747;868.2880038368538;886.0696268917637;15441.227938603068;16309.91845040776;16417.343306267765;16490.17549122545;16496.752548711764;15329.84670153298;15414.69170616587;15501.302441390137;15529;15531.757459403249;711.0436462957314;732.8424388756416;836.0928392693904;855.3969451536652;864.775158458799;864.11859902899;865.8874346334968;867.4231635962109;867.5185272173941;867.7873920889391;901.4456109492647;907.2016625369698;908.0919080919081;910.6311943662827;913.0276255787599;904.0417157812707;910.8360495110877;911.9772005699845;912.808310254844;912.9634814607408;659.7690808217134;667.152716050613;667.9833004174886;667.9966600167016;668.759246671198;15035.624109397244;15096.169710665908;15119.924400378037;15127;15144.54566363011;16477.258523366356;17142.742858857127;17424.21591028394;17504;17941.551461213574;12175.51297948081;12221.755564888652;12379;12442.875571244262;12754.426050827735;4668.766561671937;4669;4680.134175177603;4684.414448193976;4734.26618874075;84348.57825710894;84719;85403;85598;86071.70892436682;12127.272363658032;12304.569340073054;12306.938465307616;12481.31352775588;12527.997760179163;21117.26089586857;21207.257745978815;21284.255051073138;21284.574308513744;21393.67909481359;9083.545822708838;9107.408018478778;9174.770630734285;9320.161185493338;9488.240940724725;5144.897102057937;5179.8446046618665;5207.609429292818;5247.711375874287;5248.265242866002;3526.682598566141;3639.454081887738;3644.5444319460066;3646;3648.781073135567;550.9146082357241;620.9906851397233;624.7785579192667;625.5339771869895;625.6402568523117;618.2010349881822;659.6306068601599;688.5352387138662;714.3749219432996;771.9961400193075;9511;10112;10141.49292535385;10532.947335263274;10659.94670026645;646.3375040583439;731.5903094267121;740.3373980287612;740.6111791309498;797.2386371015666;4662.463816661059;4949.7772600233075;5020.573251273682;5024.397072351341;5073.441921388644;78576;132356.3382183083;132640;133360;137963;109824;113082;114387;115120.42439787748;118062;95510.52244738732;97612.51193743986;97990;100007.49996249973;100392;9652.2278217741;9671.468069255978;9838.114569688762;9867;9875.259355548505;52130.478695212565;52529.47470525246;53207;56485.152722710016;58575;47909.76045119891;61400.07899881416;62892;69212.61574768375;70064.29935700577;13654.590362289147;13695.657608559866;13700.109492882932;14271.57185284443;14751.92624036873;15803.446879359168;15907.761383579487;16176.514704558882;16418.589535261715;16473.83526164723;15014.624634384229;15125.924370378078;15272.083674979536;15290.388384464497;15374.231288435758;14870.182139982406;15023.248837558296;15586.688266234385;15837.524874253791;16268.267927943034;14601.269936503344;14823.925880370529;14856.554303370916;15541.533753987398;16017.119058451897;11703.473343699725;11826.940865295619;12483.687907802378;12502.562410315595;12652.114351995271;12705.745885082062;12756.936215318863;12791.616251512469;12980.935095324463;13078.869211308145 05:53:29 INFO - PROCESS | 16244 | __end_tp_report 05:53:29 INFO - PROCESS | 16244 | __start_cc_report 05:53:29 INFO - PROCESS | 16244 | _x_x_mozilla_cycle_collect,912 05:53:29 INFO - PROCESS | 16244 | __end_cc_report 05:53:29 INFO - PROCESS | 16244 | __startTimestamp1483710809393__endTimestamp 05:53:29 INFO - PROCESS | 16244 | 05:53:29 INFO - PROCESS | 16244 | ------- Summary: start ------- 05:53:29 INFO - PROCESS | 16244 | Number of tests: 6 05:53:29 INFO - PROCESS | 16244 | 05:53:29 INFO - PROCESS | 16244 | [#0] dojo.html Cycles:165 Average:5604.81 Median:5853.59 stddev:643.11 (11.0%) stddev-sans-first:615.16 05:53:29 INFO - PROCESS | 16244 | Values: 3133.0 3166.2 3184.0 3214.0 3217.3 5657.5 5691.8 5729.4 5760.9 5765.7 5648.6 5657.3 5703.5 5722.9 5728.4 5131.1 5169.1 5177.9 5199.4 5234.6 5016.5 5049.4 5243.5 5253.3 5254.5 5089.7 5140.5 5143.6 5146.4 5155.3 5114.8 5147.1 5158.8 5179.2 5195.0 5098.3 5122.6 5126.1 5198.1 5232.6 5508.9 5643.3 5647.4 5736.8 5755.3 5907.3 5907.4 5941.9 5964.1 6026.2 5975.2 5989.7 6051.1 6065.2 6066.7 5635.7 5638.3 5642.8 5644.6 5646.6 5920.7 5979.7 6071.9 6119.2 6122.2 5957.6 5961.6 5961.6 5965.9 5972.0 6048.1 6049.2 6055.8 6059.4 6060.5 5870.8 5879.0 5965.5 5999.9 6032.1 6066.6 6071.7 6105.3 6106.5 6117.2 4660.0 4666.1 4669.7 4670.5 4673.6 3983.0 4003.5 4135.1 4142.3 4177.0 5629.5 5657.7 5673.7 5722.7 5749.0 6053.8 6059.0 6061.9 6063.0 6065.7 5549.3 5637.7 5719.5 5720.1 5727.2 4995.5 5080.7 5082.4 5085.7 5088.7 6084.5 6117.9 6135.2 6145.5 6208.8 6135.1 6136.1 6140.0 6144.1 6145.0 6291.9 6296.5 6296.8 6301.0 6304.1 5804.2 5853.6 5857.7 5877.3 5891.0 6034.0 6034.3 6036.0 6042.8 6077.7 5876.4 5918.2 5918.6 5923.8 5929.8 5821.0 5865.5 5872.4 5877.4 5918.2 5905.5 5921.9 5927.8 5929.1 5974.1 5956.5 5975.9 5983.2 5989.1 5989.4 5691.3 5705.9 5780.8 5833.4 5840.6 05:53:29 INFO - PROCESS | 16244 | 05:53:29 INFO - PROCESS | 16244 | [#1] ext.html Cycles:180 Average:62971.83 Median:40609.09 stddev:124295.16 (306.1%) stddev-sans-first:124555.59 05:53:29 INFO - PROCESS | 16244 | Values: 586.9 610.1 652.5 659.7 671.7 34720.7 35541.1 36991.0 37060.4 37251.6 38467.0 47581.5 48331.8 48461.5 52262.0 9301.0 9432.9 9438.6 9442.4 9449.9 8628.0 9119.5 9212.4 9245.9 9285.8 8684.7 11191.6 11482.4 11485.4 11825.6 11340.3 11396.3 11397.9 11398.5 11407.8 11094.5 11206.5 11219.2 11219.3 11225.9 45616.5 45875.3 46052.5 46069.8 46074.5 3868.3 3916.9 3953.0 3953.6 4315.4 34888.3 34926.5 34968.7 35130.6 35355.6 4478.9 4563.0 4580.5 4588.1 4636.5 372889.0 374996.0 375370.0 377282.1 377431.0 38951.8 39662.2 65159.3 65371.0 65517.7 40780.4 40999.3 41172.4 41247.6 41310.6 17950.7 18105.9 18174.8 18177.7 18184.7 13604.3 13617.1 13663.3 13669.6 13686.9 8931.4 9094.9 9301.3 9550.8 9611.5 3618.8 3630.4 3646.2 3647.6 3685.4 1044.8 1053.0 1076.4 1078.8 1150.6 33793.2 33989.3 34695.7 34842.3 35117.6 1123.9 1127.9 1178.9 1206.2 1290.7 16597.4 17596.7 17800.9 18427.5 18518.0 534112.0 545796.0 547581.0 547732.0 549089.0 61934.0 62501.4 62571.1 62679.4 62690.0 1383.8 1441.4 1448.4 1461.5 1470.1 32342.2 34409.0 34546.1 34635.5 34851.0 56568.4 57328.7 57330.7 57345.0 57361.4 467342.0 471270.0 471423.0 472490.0 472886.0 40506.4 40895.6 40896.8 46652.3 46741.8 44331.6 52579.5 54744.5 56529.0 56931.0 43416.3 43852.3 44236.0 44588.3 45427.5 43563.1 44273.3 44693.0 45445.0 46266.5 43744.0 44062.8 44872.0 45143.8 45554.3 37695.6 39565.6 39889.8 40175.8 40711.8 29538.6 29605.3 29802.3 29816.7 29962.3 05:53:29 INFO - PROCESS | 16244 | 05:53:29 INFO - PROCESS | 16244 | [#2] jquery.html Cycles:180 Average:30853.58 Median:24244.58 stddev:88033.86 (363.1%) stddev-sans-first:88251.18 05:53:29 INFO - PROCESS | 16244 | Values: 427.8 429.4 430.6 432.9 449.7 18747.0 19527.0 20313.2 20333.6 20389.5 19630.7 20089.3 20142.7 20316.7 20476.5 5724.9 6021.9 6022.6 6023.4 6026.4 5825.9 5886.8 5955.2 5958.2 5987.9 5904.0 5925.0 5928.5 5931.8 5938.0 5670.4 5893.4 5936.1 5943.4 5960.1 5367.8 5374.7 5375.0 5376.9 5378.1 24065.9 24144.0 24216.0 24273.2 24398.8 2587.9 2677.4 2796.7 2864.5 2966.5 14689.7 15345.7 15347.5 15536.3 15653.5 2082.7 2094.9 2136.7 2139.5 2184.8 57758.0 73454.6 77223.0 79592.0 80623.6 11535.7 11633.7 11796.0 11999.5 12008.9 16662.9 16664.1 16689.8 16691.7 16697.7 8861.9 8965.7 9073.1 9167.4 9184.6 8842.9 8862.9 8901.2 9071.3 9136.6 7066.2 7085.5 7125.3 7176.7 7182.1 2031.8 2049.3 2055.1 2103.3 2176.2 982.6 996.9 1058.1 1077.2 1078.7 20202.4 20254.5 20534.9 20676.7 21141.2 1003.6 1044.6 1056.7 1058.8 1100.0 11095.3 11694.9 11931.8 12168.9 12242.8 518272.0 531405.0 540140.0 541976.0 551904.0 87365.0 89281.6 90259.0 90706.0 91194.5 1075.4 1084.1 1087.0 1089.2 1092.7 17061.2 18042.7 18560.4 18723.3 18854.1 40621.8 41435.8 41491.6 42806.4 44520.3 58157.0 59491.0 63001.4 63205.4 64471.7 9032.5 9191.1 9219.7 9557.7 9565.9 13476.1 14150.6 14286.1 14415.4 14736.2 12443.5 12520.4 12559.5 12711.9 12777.8 12001.6 12013.8 12374.9 12519.6 12909.6 12578.6 12895.2 12911.3 13022.3 13072.8 9225.7 9281.9 9409.4 9446.0 9541.3 12152.0 12163.5 12376.7 12531.4 12970.1 05:53:29 INFO - PROCESS | 16244 | 05:53:29 INFO - PROCESS | 16244 | [#3] mootools.html Cycles:180 Average:5969.99 Median:4585.70 stddev:3415.79 (74.5%) stddev-sans-first:3407.96 05:53:29 INFO - PROCESS | 16244 | Values: 1380.5 1519.3 1550.3 1653.9 1797.6 7877.0 8717.1 8968.6 8984.8 9249.6 8809.7 8906.2 8908.3 8909.0 8928.2 2437.1 2462.5 2462.5 2467.7 2468.7 2375.4 2415.6 2416.0 2416.0 2420.8 2365.0 2374.7 2375.1 2407.8 2408.0 2304.5 2330.2 2350.9 2360.0 2360.8 2329.9 2351.8 2363.3 2364.1 2364.4 8987.8 9011.5 9063.9 9102.2 9187.4 5514.3 5644.3 5649.4 5655.9 5659.2 3348.6 3392.8 3397.4 3455.9 3469.0 1212.5 1212.6 1220.3 1256.4 1257.8 12835.2 12901.6 12956.6 12964.1 12975.7 4553.7 4662.3 4801.8 4812.8 4853.3 10147.5 10158.7 10167.2 10169.1 10183.5 5494.6 5506.9 5508.7 5512.6 5522.8 4475.7 4617.7 4948.3 5069.4 5113.5 3999.4 4050.3 4124.1 4162.5 4166.0 1193.2 1195.0 1199.9 1221.8 1231.1 909.4 1001.8 1026.5 1034.6 1034.9 5950.5 6195.9 6316.1 6361.0 6364.8 491.2 492.9 499.8 508.2 514.3 4189.7 4231.1 4245.6 4250.3 4357.3 10860.3 11361.8 11368.7 11374.7 11410.6 11052.2 11144.4 11230.4 11283.1 11302.6 8233.0 8366.8 8584.4 8586.6 8588.0 5932.2 6002.9 6090.4 6097.7 6118.1 10107.2 10294.5 10426.2 10442.9 10525.6 10755.5 10759.6 10797.4 10815.8 10845.2 6858.7 7047.2 7262.6 7764.9 7828.8 8699.7 9052.0 9054.0 9054.6 9064.1 7743.6 7902.6 7915.9 8167.9 8242.7 7795.5 7876.5 7896.3 7957.7 7966.5 7395.6 7439.0 7508.4 7518.1 7542.0 5398.8 5462.3 5481.3 5502.3 5643.9 5367.3 5540.2 5552.8 5574.1 5716.9 05:53:29 INFO - PROCESS | 16244 | 05:53:29 INFO - PROCESS | 16244 | [#4] prototype.html Cycles:180 Average:4782.98 Median:5326.69 stddev:1408.67 (26.4%) stddev-sans-first:1372.69 05:53:29 INFO - PROCESS | 16244 | Values: 345.7 355.9 360.3 363.3 363.6 5324.8 5453.6 5499.2 5533.5 5538.9 5465.9 5483.4 5485.1 5506.3 5511.5 4031.3 4363.0 4370.9 4384.2 4394.9 3828.8 4235.7 4304.8 4324.8 4329.8 4285.6 4286.9 4291.2 4291.9 4322.9 4306.8 4311.2 4313.2 4313.3 4320.9 3582.4 3736.3 3829.6 3885.6 3919.5 5340.9 5360.1 5366.5 5368.5 5369.7 4947.4 4949.0 4957.2 4987.2 5015.5 5657.3 5687.7 5714.2 5718.6 5792.7 4158.7 4159.3 4175.8 4176.6 4179.4 5668.2 5824.4 5969.3 5997.7 6004.4 4137.5 4148.1 4269.5 4282.0 4296.3 4313.1 4325.3 4343.9 4371.6 4379.8 4737.3 4940.8 4947.2 4968.5 4979.9 5708.8 5730.3 5753.9 5761.9 5803.6 1473.3 1495.8 1507.2 1518.9 1521.9 935.5 963.0 966.2 966.9 993.2 4780.4 4876.3 4891.9 4917.5 4923.7 5157.4 5170.4 5172.7 5173.8 5181.9 4662.5 4910.2 4937.9 4941.3 4970.3 2735.3 2769.0 2777.4 2787.5 2791.8 5284.3 5297.3 5299.1 5312.5 5336.3 5302.2 5328.6 5680.5 6067.6 6093.7 6198.1 6201.3 6205.2 6207.6 6209.1 5776.9 6050.0 6062.7 6086.5 6104.0 5862.9 5914.6 5932.6 5932.7 5959.4 5912.3 5979.9 6031.3 6152.9 6168.2 4275.1 4300.0 4303.3 4307.3 4310.6 5793.6 5970.9 6051.9 6076.8 6082.5 5808.4 5830.3 5831.4 5832.9 5840.3 5821.7 5832.9 5835.7 5841.9 5842.6 5477.1 5727.1 5768.1 5799.6 5800.2 5844.5 5856.5 5860.9 5866.9 5873.3 5548.8 5689.2 5724.6 5778.4 5805.9 05:53:29 INFO - PROCESS | 16244 | 05:53:29 INFO - PROCESS | 16244 | [#5] yui.html Cycles:180 Average:22317.86 Median:4665.62 stddev:32672.77 (700.3%) stddev-sans-first:32724.45 05:53:29 INFO - PROCESS | 16244 | Values: 792.7 815.9 847.0 868.3 886.1 15441.2 16309.9 16417.3 16490.2 16496.8 15329.8 15414.7 15501.3 15529.0 15531.8 711.0 732.8 836.1 855.4 864.8 864.1 865.9 867.4 867.5 867.8 901.4 907.2 908.1 910.6 913.0 904.0 910.8 912.0 912.8 913.0 659.8 667.2 668.0 668.0 668.8 15035.6 15096.2 15119.9 15127.0 15144.5 16477.3 17142.7 17424.2 17504.0 17941.6 12175.5 12221.8 12379.0 12442.9 12754.4 4668.8 4669.0 4680.1 4684.4 4734.3 84348.6 84719.0 85403.0 85598.0 86071.7 12127.3 12304.6 12306.9 12481.3 12528.0 21117.3 21207.3 21284.3 21284.6 21393.7 9083.5 9107.4 9174.8 9320.2 9488.2 5144.9 5179.8 5207.6 5247.7 5248.3 3526.7 3639.5 3644.5 3646.0 3648.8 550.9 621.0 624.8 625.5 625.6 618.2 659.6 688.5 714.4 772.0 9511.0 10112.0 10141.5 10532.9 10659.9 646.3 731.6 740.3 740.6 797.2 4662.5 4949.8 5020.6 5024.4 5073.4 78576.0 132356.3 132640.0 133360.0 137963.0 109824.0 113082.0 114387.0 115120.4 118062.0 95510.5 97612.5 97990.0 100007.5 100392.0 9652.2 9671.5 9838.1 9867.0 9875.3 52130.5 52529.5 53207.0 56485.2 58575.0 47909.8 61400.1 62892.0 69212.6 70064.3 13654.6 13695.7 13700.1 14271.6 14751.9 15803.4 15907.8 16176.5 16418.6 16473.8 15014.6 15125.9 15272.1 15290.4 15374.2 14870.2 15023.2 15586.7 15837.5 16268.3 14601.3 14823.9 14856.6 15541.5 16017.1 11703.5 11826.9 12483.7 12502.6 12652.1 12705.7 12756.9 12791.6 12980.9 13078.9 05:53:29 INFO - PROCESS | 16244 | -------- Summary: end -------- 05:53:29 INFO - PROCESS | 16244 | 05:53:30 INFO - TEST-INFO | 16244: exit 0 05:53:30 INFO - TEST-OK | dromaeo_css | took 1113538ms 05:53:30 INFO - TEST-START | kraken 05:53:30 INFO - operating with platform_type : linux_ 05:53:30 INFO - Initialising browser for kraken test... 05:53:30 INFO - TEST-INFO | started process 16543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYeiqKX/profile http://localhost:44711/getInfo.html) 05:53:34 INFO - PROCESS | 16543 | __metrics Screen width/height:1600/1200 05:53:34 INFO - PROCESS | 16543 | colorDepth:24 05:53:34 INFO - PROCESS | 16543 | Browser inner width/height: 1024/697 05:53:34 INFO - PROCESS | 16543 | __metrics 05:53:34 INFO - PROCESS | 16543 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:53:34 INFO - PROCESS | 16543 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:34 INFO - PROCESS | 16543 | console.error: PushService: 05:53:34 INFO - PROCESS | 16543 | stateChangeProcessEnqueue: Error transitioning state 05:53:34 INFO - PROCESS | 16543 | UnknownError 05:53:35 INFO - TEST-INFO | 16543: exit 0 05:53:35 INFO - Browser initialized. 05:53:35 INFO - Running cycle 1/1 for kraken test... 05:53:35 INFO - TEST-INFO | started process 16634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYeiqKX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:47 INFO - PROCESS | 16634 | RSS: Main: 143802368 05:53:47 INFO - PROCESS | 16634 | 05:53:49 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44711/tests/kraken/driver.html?testName=audio-beat-detection) 05:53:50 INFO - PROCESS | 16634 | RSS: Main: 187109376 05:53:50 INFO - PROCESS | 16634 | 05:53:53 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44711/tests/kraken/driver.html?testName=audio-dft) 05:53:53 INFO - PROCESS | 16634 | RSS: Main: 174563328 05:53:53 INFO - PROCESS | 16634 | 05:53:56 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44711/tests/kraken/driver.html?testName=audio-fft) 05:53:57 INFO - PROCESS | 16634 | RSS: Main: 266633216 05:53:57 INFO - PROCESS | 16634 | 05:53:59 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44711/tests/kraken/driver.html?testName=audio-oscillator) 05:53:59 INFO - PROCESS | 16634 | RSS: Main: 172392448 05:53:59 INFO - PROCESS | 16634 | 05:54:01 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44711/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:54:02 INFO - PROCESS | 16634 | RSS: Main: 173670400 05:54:02 INFO - PROCESS | 16634 | 05:54:05 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44711/tests/kraken/driver.html?testName=imaging-darkroom) 05:54:06 INFO - PROCESS | 16634 | RSS: Main: 210128896 05:54:06 INFO - PROCESS | 16634 | 05:54:09 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44711/tests/kraken/driver.html?testName=imaging-desaturate) 05:54:09 INFO - PROCESS | 16634 | RSS: Main: 209035264 05:54:09 INFO - PROCESS | 16634 | 05:54:12 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44711/tests/kraken/driver.html?testName=json-parse-financial) 05:54:13 INFO - PROCESS | 16634 | RSS: Main: 208396288 05:54:13 INFO - PROCESS | 16634 | 05:54:14 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44711/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:54:15 INFO - PROCESS | 16634 | RSS: Main: 170364928 05:54:15 INFO - PROCESS | 16634 | 05:54:17 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44711/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:54:17 INFO - PROCESS | 16634 | RSS: Main: 177737728 05:54:17 INFO - PROCESS | 16634 | 05:54:19 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44711/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:54:20 INFO - PROCESS | 16634 | RSS: Main: 187518976 05:54:20 INFO - PROCESS | 16634 | 05:54:22 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:54:23 INFO - PROCESS | 16634 | RSS: Main: 195674112 05:54:23 INFO - PROCESS | 16634 | 05:54:26 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:54:26 INFO - PROCESS | 16634 | RSS: Main: 191979520 05:54:26 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:44711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44711/tests/kraken/driver.html?testName=ai-astar) 05:54:28 INFO - PROCESS | 16634 | RSS: Main: 244846592 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | __start_tp_report 05:54:28 INFO - PROCESS | 16634 | _x_x_mozilla_page_load 05:54:28 INFO - PROCESS | 16634 | _x_x_mozilla_page_load_details 05:54:28 INFO - PROCESS | 16634 | |i|pagename|runs| 05:54:28 INFO - PROCESS | 16634 | |0;ai-astar;112;111;110;111;112;111;110;112;110;108 05:54:28 INFO - PROCESS | 16634 | |1;audio-beat-detection;149;122;116;169;119;116;117;119;152;121 05:54:28 INFO - PROCESS | 16634 | |2;audio-dft;163;161;161;162;163;162;161;160;160;162 05:54:28 INFO - PROCESS | 16634 | |3;audio-fft;75;75;75;112;75;75;76;75;96;75 05:54:28 INFO - PROCESS | 16634 | |4;audio-oscillator;83;82;123;82;83;83;99;82;81;103 05:54:28 INFO - PROCESS | 16634 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;116;117;116 05:54:28 INFO - PROCESS | 16634 | |6;imaging-darkroom;145;147;145;145;145;145;146;146;145;145 05:54:28 INFO - PROCESS | 16634 | |7;imaging-desaturate;94;95;95;95;95;94;96;95;94;95 05:54:28 INFO - PROCESS | 16634 | |8;json-parse-financial;52;49;49;51;51;51;49;50;50;51 05:54:28 INFO - PROCESS | 16634 | |9;json-stringify-tinderbox;59;60;60;60;60;60;59;59;59;59 05:54:28 INFO - PROCESS | 16634 | |10;stanford-crypto-aes;74;73;73;73;73;73;75;74;75;73 05:54:28 INFO - PROCESS | 16634 | |11;stanford-crypto-ccm;122;124;123;132;126;122;131;123;164;137 05:54:28 INFO - PROCESS | 16634 | |12;stanford-crypto-pbkdf2;159;157;154;153;155;155;155;155;153;153 05:54:28 INFO - PROCESS | 16634 | |13;stanford-crypto-sha256-iterative;63;63;64;62;63;63;64;64;61;63 05:54:28 INFO - PROCESS | 16634 | __end_tp_report 05:54:28 INFO - PROCESS | 16634 | __start_cc_report 05:54:28 INFO - PROCESS | 16634 | _x_x_mozilla_cycle_collect,1513 05:54:28 INFO - PROCESS | 16634 | __end_cc_report 05:54:28 INFO - PROCESS | 16634 | __startTimestamp1483710868544__endTimestamp 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | ------- Summary: start ------- 05:54:28 INFO - PROCESS | 16634 | Number of tests: 14 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.25 (1.1%) stddev-sans-first:1.24 05:54:28 INFO - PROCESS | 16634 | Values: 112.0 111.0 110.0 111.0 112.0 111.0 110.0 112.0 110.0 108.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:121.50 stddev:19.19 (15.8%) stddev-sans-first:19.08 05:54:28 INFO - PROCESS | 16634 | Values: 149.0 122.0 116.0 169.0 119.0 116.0 117.0 119.0 152.0 121.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 05:54:28 INFO - PROCESS | 16634 | Values: 163.0 161.0 161.0 162.0 163.0 162.0 161.0 160.0 160.0 162.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.75 (17.0%) stddev-sans-first:13.34 05:54:28 INFO - PROCESS | 16634 | Values: 75.0 75.0 75.0 112.0 75.0 75.0 76.0 75.0 96.0 75.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.50 stddev:13.98 (16.9%) stddev-sans-first:14.59 05:54:28 INFO - PROCESS | 16634 | Values: 83.0 82.0 123.0 82.0 83.0 83.0 99.0 82.0 81.0 103.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:54:28 INFO - PROCESS | 16634 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 05:54:28 INFO - PROCESS | 16634 | Values: 145.0 147.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 05:54:28 INFO - PROCESS | 16634 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 94.0 95.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:51.00 stddev:1.06 (2.1%) stddev-sans-first:0.93 05:54:28 INFO - PROCESS | 16634 | Values: 52.0 49.0 49.0 51.0 51.0 51.0 49.0 50.0 50.0 51.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 05:54:28 INFO - PROCESS | 16634 | Values: 59.0 60.0 60.0 60.0 60.0 60.0 59.0 59.0 59.0 59.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 05:54:28 INFO - PROCESS | 16634 | Values: 74.0 73.0 73.0 73.0 73.0 73.0 75.0 74.0 75.0 73.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:128.50 stddev:12.85 (10.0%) stddev-sans-first:13.27 05:54:28 INFO - PROCESS | 16634 | Values: 122.0 124.0 123.0 132.0 126.0 122.0 131.0 123.0 164.0 137.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.00 stddev:1.91 (1.2%) stddev-sans-first:1.33 05:54:28 INFO - PROCESS | 16634 | Values: 159.0 157.0 154.0 153.0 155.0 155.0 155.0 155.0 153.0 153.0 05:54:28 INFO - PROCESS | 16634 | 05:54:28 INFO - PROCESS | 16634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 05:54:28 INFO - PROCESS | 16634 | Values: 63.0 63.0 64.0 62.0 63.0 63.0 64.0 64.0 61.0 63.0 05:54:28 INFO - PROCESS | 16634 | -------- Summary: end -------- 05:54:28 INFO - PROCESS | 16634 | 05:54:29 INFO - TEST-INFO | 16634: exit 0 05:54:29 INFO - TEST-OK | kraken | took 59421ms 05:54:29 INFO - SUITE-END | took 1172s 05:54:29 INFO - Completed test suite (00:19:33) 05:54:29 INFO - javascript benchmark 05:54:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.968670313297, 3166.1926208816735, 3184.0288711942853, 3214.019723984187, 3217.2761128746033, 5657.462541058603, 5691.8292451226425, 5729.39841316662, 5760.913586296204, 5765.682887441194, 5648.632838865471, 5657.2928383952, 5703.515201207892, 5722.885542289152, 5728.369879313273, 5131.050755610215, 5169.147090730025, 5177.896442071175, 5199.376074871021, 5234.555062819665, 5016.523430274118, 5049.4193167785625, 5243.501867322599, 5253.317068781053, 5254.474552544734, 5089.745512724349, 5140.511651393112, 5143.614228932845, 5146.356705411824, 5155.329807125068, 5114.846554603368, 5147.124988751922, 5158.845234642967, 5179.223116532513, 5195.0, 5098.286239926413, 5122.641415100945, 5126.077306084903, 5198.090334191501, 5232.633715639907, 5508.91736623951, 5643.294588176478, 5647.37878833328, 5736.770529178828, 5755.309362876482, 5907.2911250650195, 5907.379725128842, 5941.910871336933, 5964.135200395918, 6026.246719160105, 5975.163477113208, 5989.730462129215, 6051.062085376773, 6065.2418447694035, 6066.6663333516635, 5635.746391412396, 5638.267025286768, 5642.802501912454, 5644.6330988486025, 5646.604737668324, 5920.674362910081, 5979.701014949323, 6071.908921366183, 6119.204503414528, 6122.234720659918, 5957.582969192202, 5961.5826892118, 5961.642301461926, 5965.880682386328, 5972.044472884318, 6048.062550304622, 6049.243844519435, 6055.757769689163, 6059.424354686298, 6060.545459090586, 5870.823875283749, 5879.029960056543, 5965.463108320272, 5999.880002399927, 6032.125341825411, 6066.636001839904, 6071.726772295169, 6105.32841387447, 6106.45041946218, 6117.174181485442, 4659.9767001165455, 4666.113438446684, 4669.719816811003, 4670.53294670537, 4673.626109911199, 3983.0042489377656, 4003.5195776507007, 4135.069609337875, 4142.2958097123565, 4176.979115104405, 5629.521490673257, 5657.745401456944, 5673.716314184274, 5722.713864306768, 5749.0, 6053.8486537836025, 6058.969705151534, 6061.939380606225, 6063.0, 6065.695875386725, 5549.278593782782, 5637.746301416446, 5719.456651618089, 5720.08478643415, 5727.169560413717, 4995.450500444948, 5080.720560369141, 5082.415522214918, 5085.694858308513, 5088.669236499616, 6084.452399284086, 6117.9187529241, 6135.2326666699655, 6145.525073982212, 6208.751649933952, 6135.1408007826785, 6136.090214303778, 6140.04415716754, 6144.064619644798, 6144.986077297374, 6291.874162516816, 6296.5277604178955, 6296.842578935563, 6300.9684951574945, 6304.085907543289, 5804.158397032491, 5853.590248682552, 5857.736401862012, 5877.265341832271, 5891.0, 6034.004389275896, 6034.275886893601, 6035.969820151046, 6042.758289668364, 6077.726502307319, 5876.41235876409, 5918.17145599625, 5918.585699001201, 5923.7926672566255, 5929.792457263975, 5820.970895145667, 5865.530757539472, 5872.354041055395, 5877.441643044075, 5918.17145599625, 5905.498032667271, 5921.851953701192, 5927.8221653350465, 5929.080992446177, 5974.074018527135, 5956.523478121827, 5975.880482390241, 5983.192269043798, 5989.101634754822, 5989.371116032754, 5691.3170419549915, 5705.914411283751, 5780.768769249183, 5833.387494313206, 5840.561957853093], "value": 5560.166615601138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.9031609784386, 610.1305639463764, 652.4845372155995, 659.7196191618558, 671.7078071039095, 34720.65279347206, 35541.111472213175, 36991.0, 37060.44409333862, 37251.627483725155, 38467.0, 47581.52418475814, 48331.758341208246, 48461.51538484614, 52262.0, 9300.953495232532, 9432.858507122364, 9438.575264113131, 9442.433453992748, 9449.858252126223, 8628.0, 9119.452832830018, 9212.355135140542, 9245.861312080324, 9285.767855803626, 8684.739457816275, 11191.552337906474, 11482.425878706073, 11485.368304743235, 11825.645230643095, 11340.262882912626, 11396.316221026766, 11397.886021139766, 11398.544058237661, 11407.771844563145, 11094.500747466383, 11206.495707693173, 11219.214654974156, 11219.326840389604, 11225.887741122648, 45616.54383456156, 45875.31187032197, 46052.53947460516, 46069.769651151866, 46074.5392546077, 3868.2843673920133, 3916.862909798172, 3952.960470395317, 3953.644172024503, 4315.43899293093, 34888.302233955175, 34926.476102858476, 34968.65031349705, 35130.64869351325, 35355.646443535494, 4478.865634030952, 4562.977185114053, 4580.450345958473, 4588.059447813191, 4636.5131661175765, 372889.0, 374996.0, 375370.0, 377282.113589433, 377431.0, 38951.80524097361, 39662.20675586472, 65159.34840651533, 65371.0, 65517.67241163859, 40780.38829417561, 40999.3350432221, 41172.38241426381, 41247.587524124974, 41310.58689413127, 17950.730739038925, 18105.909470452825, 18174.818251817578, 18177.72733409, 18184.727229091575, 13604.31978401076, 13617.114887532278, 13663.316834158253, 13669.589912302647, 13686.863131368758, 8931.374803763674, 9094.909050909406, 9301.34890557668, 9550.808983820285, 9611.519424028771, 3618.8009659468457, 3630.41913293877, 3646.234290798962, 3647.562292524861, 3685.355062863988, 1044.7753732947301, 1053.0027964177993, 1076.4025965589174, 1078.8166011778017, 1150.649052039136, 33793.199972007846, 33989.32021359608, 34695.65304346924, 34842.30315393729, 35117.64882351195, 1123.9494222759995, 1127.9154063445274, 1178.93515856627, 1206.1775445457672, 1290.748304080714, 16597.41909033178, 17596.736048959276, 17800.9109954452, 18427.53931151732, 18518.0, 534112.0, 545796.0, 547581.0, 547732.0, 549089.0, 61934.0, 62501.37498624955, 62571.061434078525, 62679.37320626735, 62690.0, 1383.8201033865532, 1441.4018182454374, 1448.3844366144347, 1461.5250043735828, 1470.1179292424674, 32342.191445213117, 34409.00993508, 34546.136346591535, 34635.4804677925, 34851.0, 56568.43431565632, 57328.71335643462, 57330.713346433, 57345.0, 57361.42638573728, 467342.0, 471270.0, 471423.0, 472490.0, 472886.0, 40506.39240411337, 40895.591044089175, 40896.79551602223, 46652.300215496114, 46741.76629116833, 44331.55668443274, 52579.47420525746, 54744.45255547394, 56529.0, 56931.0, 43416.34875476934, 43852.34221486744, 44236.0, 44588.33117503305, 45427.54572454233, 43563.12873742444, 44273.33589996217, 44693.0, 45445.0, 46266.53733462622, 43744.0, 44062.77968610136, 44872.0, 45143.7742811297, 45554.31668525041, 37695.623043769214, 39565.60434395619, 39889.80055099822, 40175.79912100538, 40711.79644101879, 29538.55692164662, 29605.25986850346, 29802.317791398877, 29816.70183298139, 29962.25094372658], "value": 20685.730283327503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.82459191731357, 429.4352925902438, 430.5801843202877, 432.93382572726125, 449.6807266840545, 18747.0, 19527.0, 20313.187472501082, 20333.593328133447, 20389.49026274344, 19630.705539416922, 20089.29687460939, 20142.69785953212, 20316.695249571232, 20476.488087797774, 5724.942750572493, 6021.879562408749, 6022.638641681491, 6023.42777436145, 6026.397360263961, 5825.854353641151, 5886.793962211324, 5955.196048533436, 5958.195643588125, 5987.85030374242, 5904.025835737119, 5925.022371308729, 5928.49607783339, 5931.762729490837, 5937.9905416079155, 5670.3555968769215, 5893.381194974509, 5936.139259807325, 5943.435373639497, 5960.076188190794, 5367.75845086972, 5374.677519348852, 5375.032494151052, 5376.946230537684, 5378.112611419111, 24065.87967060171, 24144.0, 24216.0, 24273.1504397347, 24398.756012440004, 2587.922362329114, 2677.3708178578017, 2796.720327967207, 2864.5273529867545, 2966.4512065267995, 14689.70620587593, 15345.693086138326, 15347.539573812803, 15536.300866461037, 15653.452129175424, 2082.6771850363216, 2094.853360264782, 2136.690179923918, 2139.5079131799616, 2184.7924447177493, 57758.0, 73454.63272683656, 77223.0, 79592.0, 80623.59688201522, 11535.71160720972, 11633.6509904703, 11796.0, 11999.460024298927, 12008.939955300168, 16662.916685416494, 16664.08347540897, 16689.83310166907, 16691.749623755655, 16697.749533757004, 8861.867071993796, 8965.686200982935, 9073.13805188506, 9167.358284919992, 9184.586693598803, 8842.91157088421, 8862.86705699415, 8901.198892099612, 9071.27429805614, 9136.634534618674, 7066.152061752623, 7085.539439936388, 7125.251848555827, 7176.7488137914925, 7182.138143422822, 2031.766346870129, 2049.3134799841923, 2055.1162999909884, 2103.3059090500096, 2176.194807921048, 982.6462473509531, 996.8504724291414, 1058.1270451877233, 1077.224398433127, 1078.6925726168004, 20202.393928182177, 20254.493637659176, 20534.897325513575, 20676.689849652266, 21141.154353825983, 1003.6236411345745, 1044.6291566493937, 1056.709404913655, 1058.804121237558, 1099.9890001099886, 11095.334279943228, 11694.925408902927, 11931.76136477283, 12168.939155304166, 12242.755144897052, 518272.0, 531405.0, 540140.0, 541976.0, 551904.0, 87364.95303040104, 89281.55359223162, 90259.0, 90706.0, 91194.54402728076, 1075.4300220882944, 1084.116445097259, 1086.9619563315405, 1089.1667874076338, 1092.7432053467428, 17061.232244549272, 18042.72935905936, 18560.442666111394, 18723.344682936033, 18854.05729713536, 40621.79689101536, 41435.7928210357, 41491.58508414877, 42806.35790463083, 44520.33219501775, 58157.0, 59491.0, 63001.36998630138, 63205.36794631995, 64471.677641611495, 9032.548372581214, 9191.080891910755, 9219.677311294072, 9557.665481708107, 9565.904340956502, 13476.124051936593, 14150.575482735534, 14286.142831430148, 14415.351309191321, 14736.189509577076, 12443.502259909503, 12520.436580353724, 12559.497620095093, 12711.936440317739, 12777.8083328752, 12001.579944701894, 12013.75972480563, 12374.876251237372, 12519.624411267676, 12909.612711618667, 12578.622641320775, 12895.16181448203, 12911.289879056741, 13022.348882555645, 13072.80390794158, 9225.72322830316, 9281.86077208856, 9409.388389754644, 9446.008169142417, 9541.284403669892, 12152.0, 12163.513459461523, 12376.690582735144, 12531.373431328579, 12970.092093553361], "value": 9972.623483811845, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.4961189165958, 1519.2859356102636, 1550.2868680407012, 1653.9173041347938, 1797.5775692712211, 7876.960615196923, 8717.084706105863, 8968.596413161398, 8984.775380615472, 9249.6300147994, 8809.691660791874, 8906.198442140207, 8908.287337013024, 8908.955455222731, 8928.19646231839, 2437.1348171399163, 2462.4705688277018, 2462.495188486365, 2467.679201703785, 2468.691413573303, 2375.3586531636447, 2415.625578035407, 2416.0094361311867, 2416.0456619635233, 2420.8426452280546, 2365.042157926043, 2374.7150341958904, 2375.061850569024, 2407.8194135439826, 2408.036785285891, 2304.5045315257134, 2330.2310237621546, 2350.9059637614473, 2359.95280094398, 2360.834741568091, 2329.895154718042, 2351.7648235176343, 2363.2673871100014, 2364.101641376283, 2364.397078744926, 8987.820243595157, 9011.45931244121, 9063.864042039375, 9102.226310763594, 9187.448753074837, 5514.338279406497, 5644.266245388073, 5649.378568357477, 5655.915161272585, 5659.179418984224, 3348.564686590752, 3392.830358482066, 3397.405454045557, 3455.8617655293756, 3469.0460123465996, 1212.5331747277273, 1212.6483319837237, 1220.3044264769085, 1256.422045858906, 1257.8239046533492, 12835.165714228546, 12901.612951611467, 12956.611301660965, 12964.092513524058, 12975.675608109872, 4553.658475614276, 4662.347271382009, 4801.807927682854, 4812.831550895702, 4853.2720091985775, 10147.543360548792, 10158.695239142837, 10167.237457190593, 10169.084782369475, 10183.54174062169, 5494.642848214933, 5506.91739623906, 5508.724563771875, 5512.614117011851, 5522.751476183581, 4475.686701930834, 4617.746023968647, 4948.257761335828, 5069.366329208849, 5113.53978141969, 3999.440078389028, 4050.311447054008, 4124.1133156371525, 4162.4796900387455, 4165.97917010413, 1193.2124797633521, 1195.0401341799457, 1199.8800119988107, 1221.773971815217, 1231.082843281761, 909.3543584055262, 1001.7874836313285, 1026.5483187397522, 1034.5551412892378, 1034.9275550711377, 5950.464458198783, 6195.876082478325, 6316.115743795872, 6360.968195158995, 6364.840878978062, 491.20915326324587, 492.9457759646436, 499.7950840155519, 508.23256882107546, 514.3005512502993, 4189.706720529594, 4231.132617813341, 4245.617894389458, 4250.3199488081755, 4357.346398040256, 10860.294080884718, 11361.772764544663, 11368.65894023164, 11374.715632109264, 11410.600628977945, 11052.171087168495, 11144.442777861075, 11230.438478076227, 11283.097352211804, 11302.604408845815, 8232.958835205785, 8366.790830229293, 8584.356173287028, 8586.570671466401, 8587.95706021466, 5932.228810254812, 6002.939970600238, 6090.3605121461605, 6097.725602347817, 6118.082287656887, 10107.22051435861, 10294.536745846604, 10426.165906727292, 10442.895571044497, 10525.578976840841, 10755.516001779783, 10759.623413180501, 10797.352158870493, 10815.783684326427, 10845.240833141605, 6858.6570671467225, 7047.154341479055, 7262.564246145248, 7764.883526747216, 7828.84342313162, 8699.739007829776, 9052.0, 9054.0, 9054.63781448761, 9064.093590641147, 7743.612819359122, 7902.565358905315, 7915.920840791749, 8167.877481837659, 8242.722378031174, 7795.532268063935, 7876.527408355517, 7896.32881205104, 7957.721479748181, 7966.522008679498, 7395.556266624019, 7438.962805185939, 7508.436867235088, 7518.135414427411, 7542.0, 5398.838034858961, 5462.289902312674, 5481.342238931354, 5502.257195278587, 5643.858903527444, 5367.329083864517, 5540.22436858832, 5552.833414997556, 5574.052411090205, 5716.885662286814], "value": 4699.333909783767, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.73896707985466, 355.8950109717634, 360.31719890806903, 363.3350967729056, 363.565539180679, 5324.76038578264, 5453.59098067645, 5499.202615620733, 5533.47431993961, 5538.861528461785, 5465.945340546593, 5483.382402191353, 5485.0949593317055, 5506.283258800314, 5511.5039646431815, 4031.314676505001, 4362.956370436303, 4370.907273181705, 4384.232759267132, 4394.934075988863, 3828.827702753369, 4235.74585524868, 4304.827806887736, 4324.82700691972, 4329.783510824462, 4285.592868677486, 4286.87139385819, 4291.249031419505, 4291.935620965688, 4322.935155972663, 4306.849260275907, 4311.223979683656, 4313.245182093153, 4313.309870420733, 4320.935185972197, 3582.42681171014, 3736.3087828751495, 3829.6447684673726, 3885.61143885612, 3919.510061242345, 5340.893182136336, 5360.115580929181, 5366.517013468768, 5368.543673787733, 5369.650972686802, 4947.356843610343, 4949.0, 4957.190625421731, 4987.226979818134, 5015.498450154992, 5657.3494048184575, 5687.7156142192725, 5714.200011998323, 5718.571107166979, 5792.740831075884, 4158.688098392633, 4159.313713237312, 4175.770332631704, 4176.582341765799, 4179.435776170209, 5668.206451096849, 5824.417558244227, 5969.31352894414, 5997.7001149942325, 6004.39956004396, 4137.46212992309, 4148.087420767426, 4269.5090064642345, 4281.9812032517, 4296.2696341621995, 4313.094250207491, 4325.329573916048, 4343.893211792279, 4371.628411584988, 4379.810094952523, 4737.336772851803, 4940.827071052496, 4947.183714687037, 4968.540572416605, 4979.850604481871, 5708.771649133988, 5730.34101078373, 5753.913691294634, 5761.9135712964335, 5803.564732645069, 1473.3296350160651, 1495.820501539822, 1507.1785876697227, 1518.9088654680754, 1521.8706409955278, 935.5462600638684, 963.0, 966.2221911361421, 966.9419834809793, 993.2352088891513, 4780.354652121989, 4876.29293752411, 4891.926621100686, 4917.508249175054, 4923.676518350099, 5157.406898206679, 5170.379554453414, 5172.663776854492, 5173.81891633791, 5181.870453238624, 4662.487126416091, 4910.238912968495, 4937.876553086202, 4941.344649542371, 4970.279309500174, 2735.329844188147, 2768.9723102769117, 2777.375090604598, 2787.5400558907554, 2791.813479271342, 5284.313039304942, 5297.337832770903, 5299.138465228811, 5312.5218730314455, 5336.306280183629, 5302.231176479466, 5328.626996110313, 5680.5171560417, 6067.605605635707, 6093.69531523422, 6198.0785956353675, 6201.271440566226, 6205.162303089115, 6207.596506227081, 6209.112762565429, 5776.8555786104, 6050.0, 6062.727177277121, 6086.513078953584, 6103.969480152571, 5862.94137058641, 5914.58597898143, 5932.614380065282, 5932.673702946379, 5959.404059594006, 5912.320083190488, 5979.880402391841, 6031.336552979256, 6152.876942461216, 6168.19813424252, 4275.135659108342, 4300.0, 4303.268444364403, 4307.3416734556795, 4310.612044915847, 5793.580572759701, 5970.910436343545, 6051.909221361771, 6076.848078798065, 6082.452579267887, 5808.357197475223, 5830.309210328957, 5831.446012628793, 5832.941670583409, 5840.328362238227, 5821.650700957956, 5832.883342333044, 5835.7373918174635, 5841.912371314349, 5842.649441033552, 5477.096279114061, 5727.052802047324, 5768.077107662753, 5799.565032622654, 5800.24596802413, 5844.503217226584, 5856.531477481706, 5860.853478663067, 5866.941330586639, 5873.2658417697785, 5548.778048878, 5689.175069614966, 5724.599278050663, 5778.364379918122, 5805.94194058054], "value": 4340.458684494104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.6829268292679, 815.8613035783916, 846.9957650211747, 868.2880038368538, 886.0696268917637, 15441.227938603068, 16309.91845040776, 16417.343306267765, 16490.17549122545, 16496.752548711764, 15329.84670153298, 15414.69170616587, 15501.302441390137, 15529.0, 15531.757459403249, 711.0436462957314, 732.8424388756416, 836.0928392693904, 855.3969451536652, 864.775158458799, 864.11859902899, 865.8874346334968, 867.4231635962109, 867.5185272173941, 867.7873920889391, 901.4456109492647, 907.2016625369698, 908.0919080919081, 910.6311943662827, 913.0276255787599, 904.0417157812707, 910.8360495110877, 911.9772005699845, 912.808310254844, 912.9634814607408, 659.7690808217134, 667.152716050613, 667.9833004174886, 667.9966600167016, 668.759246671198, 15035.624109397244, 15096.169710665908, 15119.924400378037, 15127.0, 15144.54566363011, 16477.258523366356, 17142.742858857127, 17424.21591028394, 17504.0, 17941.551461213574, 12175.51297948081, 12221.755564888652, 12379.0, 12442.875571244262, 12754.426050827735, 4668.766561671937, 4669.0, 4680.134175177603, 4684.414448193976, 4734.26618874075, 84348.57825710894, 84719.0, 85403.0, 85598.0, 86071.70892436682, 12127.272363658032, 12304.569340073054, 12306.938465307616, 12481.31352775588, 12527.997760179163, 21117.26089586857, 21207.257745978815, 21284.255051073138, 21284.574308513744, 21393.67909481359, 9083.545822708838, 9107.408018478778, 9174.770630734285, 9320.161185493338, 9488.240940724725, 5144.897102057937, 5179.8446046618665, 5207.609429292818, 5247.711375874287, 5248.265242866002, 3526.682598566141, 3639.454081887738, 3644.5444319460066, 3646.0, 3648.781073135567, 550.9146082357241, 620.9906851397233, 624.7785579192667, 625.5339771869895, 625.6402568523117, 618.2010349881822, 659.6306068601599, 688.5352387138662, 714.3749219432996, 771.9961400193075, 9511.0, 10112.0, 10141.49292535385, 10532.947335263274, 10659.94670026645, 646.3375040583439, 731.5903094267121, 740.3373980287612, 740.6111791309498, 797.2386371015666, 4662.463816661059, 4949.7772600233075, 5020.573251273682, 5024.397072351341, 5073.441921388644, 78576.0, 132356.3382183083, 132640.0, 133360.0, 137963.0, 109824.0, 113082.0, 114387.0, 115120.42439787748, 118062.0, 95510.52244738732, 97612.51193743986, 97990.0, 100007.49996249973, 100392.0, 9652.2278217741, 9671.468069255978, 9838.114569688762, 9867.0, 9875.259355548505, 52130.478695212565, 52529.47470525246, 53207.0, 56485.152722710016, 58575.0, 47909.76045119891, 61400.07899881416, 62892.0, 69212.61574768375, 70064.29935700577, 13654.590362289147, 13695.657608559866, 13700.109492882932, 14271.57185284443, 14751.92624036873, 15803.446879359168, 15907.761383579487, 16176.514704558882, 16418.589535261715, 16473.83526164723, 15014.624634384229, 15125.924370378078, 15272.083674979536, 15290.388384464497, 15374.231288435758, 14870.182139982406, 15023.248837558296, 15586.688266234385, 15837.524874253791, 16268.267927943034, 14601.269936503344, 14823.925880370529, 14856.554303370916, 15541.533753987398, 16017.119058451897, 11703.473343699725, 11826.940865295619, 12483.687907802378, 12502.562410315595, 12652.114351995271, 12705.745885082062, 12756.936215318863, 12791.616251512469, 12980.935095324463, 13078.869211308145], "value": 8066.65669425324, "unit": "score"}], "name": "dromaeo_css", "value": 7573.786912710049, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 111.0, 112.0, 111.0, 110.0, 112.0, 110.0, 108.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 116.0, 169.0, 119.0, 116.0, 117.0, 119.0, 152.0, 121.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 163.0, 162.0, 161.0, 160.0, 160.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 112.0, 75.0, 75.0, 76.0, 75.0, 96.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 123.0, 82.0, 83.0, 83.0, 99.0, 82.0, 81.0, 103.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 49.0, 51.0, 51.0, 51.0, 49.0, 50.0, 50.0, 51.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 73.0, 75.0, 74.0, 75.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 123.0, 132.0, 126.0, 122.0, 131.0, 123.0, 164.0, 137.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 154.0, 153.0, 155.0, 155.0, 155.0, 155.0, 153.0, 153.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 63.0, 63.0, 64.0, 64.0, 61.0, 63.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1461.6, "alertThreshold": 2.0}]} 05:54:29 INFO - Return code: 0 05:54:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:54:29 INFO - # TBPL SUCCESS # 05:54:29 INFO - Running post-action listener: _resource_record_post_action 05:54:29 INFO - [mozharness: 2017-01-06 13:54:29.866600Z] Finished run-tests step (success) 05:54:29 INFO - Running post-run listener: _resource_record_post_run 05:54:29 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 1744896; Write bytes: 321302528; Read time: 204; Write time: 191492 05:54:29 INFO - TinderboxPrint: CPU usage
12.9% 05:54:29 INFO - TinderboxPrint: I/O read bytes / time
1,744,896 / 204 05:54:29 INFO - TinderboxPrint: I/O write bytes / time
321,302,528 / 191,492 05:54:29 INFO - TinderboxPrint: CPU idle
8,249.7 (87.1%) 05:54:29 INFO - TinderboxPrint: CPU user
1,183.9 (12.5%) 05:54:29 INFO - TinderboxPrint: Swap in / out
0 / 0 05:54:29 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 100593664; Read time: 144; Write time: 87948 05:54:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 220708864; Read time: 24; Write time: 103544 05:54:30 INFO - Running post-run listener: _upload_blobber_files 05:54:30 INFO - Blob upload gear active. 05:54:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:54:30 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 05:54:30 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:54:30 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:54:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:54:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:54:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:54:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:31 INFO - (blobuploader) - INFO - Done attempting. 05:54:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:54:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:54:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:32 INFO - (blobuploader) - INFO - Done attempting. 05:54:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:54:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:54:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:35 INFO - (blobuploader) - INFO - Done attempting. 05:54:35 INFO - (blobuploader) - INFO - Iteration through files over. 05:54:35 INFO - Return code: 0 05:54:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:54:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:54:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/127817a60d56d27e8b9a28de5827f491fc5e18b2f3030ee382666d7929fe078a78246fe51c6f74508eef71c0c009e1f0c8ff018afee6b5d7c76409c258018975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c9e1aa72af4967257232159f91685aa8d59e43cd99752a4f2c33ad2c22dc10001af4680a432d4db70ecfd1142fac4ea129ca61d5099dd8ea312fdeeb3ca2f8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5a36f419911e0d8307b6d0635b2070860d0404d9471cd3a55190233e0c0a42c9a53b3ef8cbcbbecce5e8457d9dda7fd1691aeeddb5bfcf6831f53044721b7f9"} 05:54:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:54:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:54:35 INFO - Contents: 05:54:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/127817a60d56d27e8b9a28de5827f491fc5e18b2f3030ee382666d7929fe078a78246fe51c6f74508eef71c0c009e1f0c8ff018afee6b5d7c76409c258018975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c9e1aa72af4967257232159f91685aa8d59e43cd99752a4f2c33ad2c22dc10001af4680a432d4db70ecfd1142fac4ea129ca61d5099dd8ea312fdeeb3ca2f8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5a36f419911e0d8307b6d0635b2070860d0404d9471cd3a55190233e0c0a42c9a53b3ef8cbcbbecce5e8457d9dda7fd1691aeeddb5bfcf6831f53044721b7f9"} 05:54:35 INFO - Running post-run listener: copy_logs_to_upload_dir 05:54:35 INFO - Copying logs to upload dir... 05:54:35 INFO - mkdir: /builds/slave/test/build/upload/logs 05:54:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.168047 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-06 05:54:35.171567) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 05:54:35.176634) ========= 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=337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/127817a60d56d27e8b9a28de5827f491fc5e18b2f3030ee382666d7929fe078a78246fe51c6f74508eef71c0c009e1f0c8ff018afee6b5d7c76409c258018975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c9e1aa72af4967257232159f91685aa8d59e43cd99752a4f2c33ad2c22dc10001af4680a432d4db70ecfd1142fac4ea129ca61d5099dd8ea312fdeeb3ca2f8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5a36f419911e0d8307b6d0635b2070860d0404d9471cd3a55190233e0c0a42c9a53b3ef8cbcbbecce5e8457d9dda7fd1691aeeddb5bfcf6831f53044721b7f9"} build_url:https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/U9dEq-BYRIO6AZAinMCP5w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/127817a60d56d27e8b9a28de5827f491fc5e18b2f3030ee382666d7929fe078a78246fe51c6f74508eef71c0c009e1f0c8ff018afee6b5d7c76409c258018975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c9e1aa72af4967257232159f91685aa8d59e43cd99752a4f2c33ad2c22dc10001af4680a432d4db70ecfd1142fac4ea129ca61d5099dd8ea312fdeeb3ca2f8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e5a36f419911e0d8307b6d0635b2070860d0404d9471cd3a55190233e0c0a42c9a53b3ef8cbcbbecce5e8457d9dda7fd1691aeeddb5bfcf6831f53044721b7f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 05:54:35.202224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 05:54:35.202589) ========= 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=337fe3f4b1febe37b85fccc40000019e-1483709045.561651-284396550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 05:54:35.288528) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 05:54:35.288891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 05:54:35.289234) ========= ========= Total master_lag: 0.17 =========