builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1481343352.74 results: success (0) buildid: 20161209183558 builduid: f0bbce7076d74b23b868a33c5758659f revision: edb24e0ff1e147e44f042f8d0dccf59eac6f6de0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:52.744048) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:52.744560) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:52.745220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:52.788870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:52.789250) ========= 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=1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-09 20:15:52-- 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% 46.5M=0s 2016-12-09 20:15:52 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126847 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:52.951063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:52.951370) ========= 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=1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.086681 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:53.050680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-09 20:15:53.051030) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev edb24e0ff1e147e44f042f8d0dccf59eac6f6de0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev edb24e0ff1e147e44f042f8d0dccf59eac6f6de0 --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=1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-09 20:15:53,114 truncating revision to first 12 chars 2016-12-09 20:15:53,114 Setting DEBUG logging. 2016-12-09 20:15:53,114 attempt 1/10 2016-12-09 20:15:53,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/edb24e0ff1e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-09 20:15:54,167 unpacking tar archive at: mozilla-inbound-edb24e0ff1e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.422561 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-09 20:15:54.486671) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:54.486977) ========= script_repo_revision: edb24e0ff1e147e44f042f8d0dccf59eac6f6de0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:54.487381) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:54.487672) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 20:15:54.494394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-09 20:15:54.494728) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:15:54 INFO - MultiFileLogger online at 20161209 20:15:54 in /builds/slave/test 20:15:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 20:15:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:15:54 INFO - {'append_to_log': False, 20:15:54 INFO - 'base_work_dir': '/builds/slave/test', 20:15:54 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 20:15:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:15:54 INFO - 'branch': 'Mozilla-Inbound', 20:15:54 INFO - 'buildbot_json_path': 'buildprops.json', 20:15:54 INFO - 'config_files': ('talos/linux_config.py',), 20:15:54 INFO - 'default_actions': ('clobber', 20:15:54 INFO - 'read-buildbot-config', 20:15:54 INFO - 'download-and-extract', 20:15:54 INFO - 'populate-webroot', 20:15:54 INFO - 'create-virtualenv', 20:15:54 INFO - 'install', 20:15:54 INFO - 'run-tests'), 20:15:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:15:54 INFO - 'download_minidump_stackwalk': True, 20:15:54 INFO - 'download_symbols': 'ondemand', 20:15:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:15:54 INFO - 'tooltool.py': '/tools/tooltool.py', 20:15:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:15:54 INFO - '/tools/misc-python/virtualenv.py')}, 20:15:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:15:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:15:54 INFO - 'installer_path': 'installer.exe', 20:15:54 INFO - 'log_level': 'info', 20:15:54 INFO - 'log_name': 'talos', 20:15:54 INFO - 'log_to_console': True, 20:15:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:15:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:15:54 INFO - 'opt_config_files': (), 20:15:54 INFO - 'pip_index': False, 20:15:54 INFO - 'sps_profile': False, 20:15:54 INFO - 'sps_profile_interval': 0, 20:15:54 INFO - 'suite': 'dromaeojs', 20:15:54 INFO - 'system_bits': '32', 20:15:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:15:54 INFO - 'title': 'talos-linux64-ix-027', 20:15:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:15:54 INFO - 'use_talos_json': True, 20:15:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:15:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:15:54 INFO - 'work_dir': 'build'} 20:15:54 INFO - [mozharness: 2016-12-10 04:15:54.752462Z] Running clobber step. 20:15:54 INFO - Running pre-action listener: _resource_record_pre_action 20:15:54 INFO - Running main action method: clobber 20:15:54 INFO - rmtree: /builds/slave/test/build 20:15:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:15:55 INFO - Running post-action listener: _resource_record_post_action 20:15:55 INFO - [mozharness: 2016-12-10 04:15:55.768024Z] Finished clobber step (success) 20:15:55 INFO - [mozharness: 2016-12-10 04:15:55.768193Z] Running read-buildbot-config step. 20:15:55 INFO - Running pre-action listener: _resource_record_pre_action 20:15:55 INFO - Running main action method: read_buildbot_config 20:15:55 INFO - Using buildbot properties: 20:15:55 INFO - { 20:15:55 INFO - "project": "", 20:15:55 INFO - "product": "firefox", 20:15:55 INFO - "script_repo_revision": "production", 20:15:55 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 20:15:55 INFO - "repository": "", 20:15:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 20:15:55 INFO - "buildid": "20161209183558", 20:15:55 INFO - "pgo_build": "True", 20:15:55 INFO - "basedir": "/builds/slave/test", 20:15:55 INFO - "buildnumber": 2223, 20:15:55 INFO - "slavename": "talos-linux64-ix-027", 20:15:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:15:55 INFO - "platform": "ubuntu64_hw", 20:15:55 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 20:15:55 INFO - "branch": "mozilla-inbound", 20:15:55 INFO - "repo_path": "integration/mozilla-inbound", 20:15:55 INFO - "revision": "edb24e0ff1e147e44f042f8d0dccf59eac6f6de0", 20:15:55 INFO - "stage_platform": "linux64-pgo", 20:15:55 INFO - "builduid": "f0bbce7076d74b23b868a33c5758659f", 20:15:55 INFO - "slavebuilddir": "test" 20:15:55 INFO - } 20:15:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:15:55 INFO - Running post-action listener: _resource_record_post_action 20:15:55 INFO - [mozharness: 2016-12-10 04:15:55.772319Z] Finished read-buildbot-config step (success) 20:15:55 INFO - [mozharness: 2016-12-10 04:15:55.772482Z] Running download-and-extract step. 20:15:55 INFO - Running pre-action listener: _resource_record_pre_action 20:15:55 INFO - Running main action method: download_and_extract 20:15:55 INFO - mkdir: /builds/slave/test/build/tests 20:15:55 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')]} 20:15:55 INFO - trying https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:15:55 INFO - Downloading https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:15:56 INFO - Downloaded 1361 bytes. 20:15:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:15:56 INFO - Using the following test package requirements: 20:15:56 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:15:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:15:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:15:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:56 INFO - u'jsshell-linux-x86_64.zip'], 20:15:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:15:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:15:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:15:56 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:15:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:15:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:15:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:15:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:15:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:15:56 INFO - Fetch https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:15:57 INFO - Expected file size: 21786002 20:15:57 INFO - Obtained file size: 21786002 20:16:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:16:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:16:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:01 INFO - Fetch https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:16:02 INFO - Expected file size: 21786002 20:16:02 INFO - Obtained file size: 21786002 20:16:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:16:07 INFO - Fetch https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:16:08 INFO - Expected file size: 14409734 20:16:08 INFO - Obtained file size: 14409734 20:16:08 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')]} 20:16:08 INFO - trying https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:08 INFO - Downloading https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:16:11 INFO - Downloaded 59871466 bytes. 20:16:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:11 INFO - mkdir: /builds/slave/test/properties 20:16:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:11 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:11 INFO - Contents: 20:16:11 INFO - build_url:https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:11 INFO - Running post-action listener: _resource_record_post_action 20:16:11 INFO - Running post-action listener: set_extra_try_arguments 20:16:11 INFO - [mozharness: 2016-12-10 04:16:11.942933Z] Finished download-and-extract step (success) 20:16:11 INFO - [mozharness: 2016-12-10 04:16:11.943159Z] Running populate-webroot step. 20:16:11 INFO - Running pre-action listener: _resource_record_pre_action 20:16:11 INFO - Running main action method: populate_webroot 20:16:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:11 INFO - '--tppagecycles', 20:16:11 INFO - '7'], 20:16:11 INFO - 'tests': ['tsvgm']}}, 20:16:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:16:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:16:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:16:11 INFO - 'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:16:11 INFO - 'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['damp', 'tps']}, 20:16:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:16:11 INFO - 'tests': ['damp', 'tps']}, 20:16:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['dromaeo_dom']}, 20:16:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['basic_compositor_video']}, 20:16:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:16:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['a11yr', 20:16:11 INFO - 'ts_paint', 20:16:11 INFO - 'tpaint', 20:16:11 INFO - 'sessionrestore', 20:16:11 INFO - 'sessionrestore_no_auto_restore', 20:16:11 INFO - 'tabpaint']}, 20:16:11 INFO - 'other-e10s': {'tests': ['a11yr', 20:16:11 INFO - 'ts_paint', 20:16:11 INFO - 'tpaint', 20:16:11 INFO - 'sessionrestore', 20:16:11 INFO - 'sessionrestore_no_auto_restore', 20:16:11 INFO - 'tabpaint']}, 20:16:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:16:11 INFO - 'ts_paint', 20:16:11 INFO - 'tpaint', 20:16:11 INFO - 'sessionrestore', 20:16:11 INFO - 'sessionrestore_no_auto_restore', 20:16:11 INFO - 'tabpaint']}, 20:16:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:16:11 INFO - 'ts_paint', 20:16:11 INFO - 'tpaint', 20:16:11 INFO - 'sessionrestore', 20:16:11 INFO - 'sessionrestore_no_auto_restore', 20:16:11 INFO - 'tabpaint']}, 20:16:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['a11yr', 20:16:11 INFO - 'ts_paint', 20:16:11 INFO - 'tpaint', 20:16:11 INFO - 'sessionrestore', 20:16:11 INFO - 'sessionrestore_no_auto_restore', 20:16:11 INFO - 'tabpaint']}, 20:16:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['a11yr', 20:16:11 INFO - 'ts_paint', 20:16:11 INFO - 'tpaint', 20:16:11 INFO - 'sessionrestore', 20:16:11 INFO - 'sessionrestore_no_auto_restore', 20:16:11 INFO - 'tabpaint']}, 20:16:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['tsvgx', 20:16:11 INFO - 'tsvgr_opacity', 20:16:11 INFO - 'tart', 20:16:11 INFO - 'tscrollx', 20:16:11 INFO - 'cart', 20:16:11 INFO - 'tsvg_static']}, 20:16:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:16:11 INFO - 'tsvgr_opacity', 20:16:11 INFO - 'tart', 20:16:11 INFO - 'tscrollx', 20:16:11 INFO - 'cart', 20:16:11 INFO - 'tsvg_static']}, 20:16:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:16:11 INFO - 'talos_options': ['--disable-e10s'], 20:16:11 INFO - 'tests': ['tp5o']}, 20:16:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:16:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:16:11 INFO - 'talos_options': ['--disable-e10s', 20:16:11 INFO - '--xperf_path', 20:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:11 INFO - 'tests': ['tp5n']}, 20:16:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:16:11 INFO - 'talos_options': ['--xperf_path', 20:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:11 INFO - 'tests': ['tp5n']}}, 20:16:11 INFO - 'talos.zip': {'path': '', 20:16:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:11 INFO - Running post-action listener: _resource_record_post_action 20:16:11 INFO - [mozharness: 2016-12-10 04:16:11.964051Z] Finished populate-webroot step (success) 20:16:11 INFO - [mozharness: 2016-12-10 04:16:11.964140Z] Running create-virtualenv step. 20:16:11 INFO - Running pre-action listener: _resource_record_pre_action 20:16:11 INFO - Running main action method: create_virtualenv 20:16:11 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16:11 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 20:16:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:12 INFO - Using real prefix '/usr' 20:16:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:12 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:14 INFO - Installing pip.................done. 20:16:14 INFO - Return code: 0 20:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:16:15 INFO - Reading from file tmpfile_stdout 20:16:15 INFO - Output received: 20:16:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:16:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:16:15 INFO - Using env: {'DISPLAY': ':0', 20:16:15 INFO - 'HOME': '/home/cltbld', 20:16:15 INFO - 'LANG': 'en_US.UTF-8', 20:16:15 INFO - 'LANGUAGE': 'en_US:en', 20:16:15 INFO - 'LOGNAME': 'cltbld', 20:16:15 INFO - 'MAIL': '/var/mail/cltbld', 20:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:15 INFO - 'MOZ_NO_REMOTE': '1', 20:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:15 INFO - 'NO_EM_RESTART': '1', 20:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:15 INFO - 'PWD': '/builds/slave/test', 20:16:15 INFO - 'SHELL': '/bin/bash', 20:16:15 INFO - 'SHLVL': '1', 20:16:15 INFO - 'TERM': 'linux', 20:16:15 INFO - 'TMOUT': '86400', 20:16:15 INFO - 'USER': 'cltbld', 20:16:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:15 INFO - '_': '/tools/buildbot/bin/python'} 20:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:15 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 20:16:15 INFO - Cleaning up... 20:16:15 INFO - Return code: 0 20:16:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:16:15 INFO - Using env: {'DISPLAY': ':0', 20:16:15 INFO - 'HOME': '/home/cltbld', 20:16:15 INFO - 'LANG': 'en_US.UTF-8', 20:16:15 INFO - 'LANGUAGE': 'en_US:en', 20:16:15 INFO - 'LOGNAME': 'cltbld', 20:16:15 INFO - 'MAIL': '/var/mail/cltbld', 20:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:15 INFO - 'MOZ_NO_REMOTE': '1', 20:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:15 INFO - 'NO_EM_RESTART': '1', 20:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:15 INFO - 'PWD': '/builds/slave/test', 20:16:15 INFO - 'SHELL': '/bin/bash', 20:16:15 INFO - 'SHLVL': '1', 20:16:15 INFO - 'TERM': 'linux', 20:16:15 INFO - 'TMOUT': '86400', 20:16:15 INFO - 'USER': 'cltbld', 20:16:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:15 INFO - '_': '/tools/buildbot/bin/python'} 20:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:15 INFO - Downloading/unpacking psutil>=3.1.1 20:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:16:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:17 INFO - Installing collected packages: psutil 20:16:17 INFO - Running setup.py install for psutil 20:16:17 INFO - building 'psutil._psutil_linux' extension 20:16:17 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 20:16:18 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 20:16:18 INFO - building 'psutil._psutil_posix' extension 20:16:18 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 20:16:18 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 20:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:19 INFO - Successfully installed psutil 20:16:19 INFO - Cleaning up... 20:16:19 INFO - Return code: 0 20:16:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:19 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 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:19 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 20:16:19 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 20:16:19 INFO - Using env: {'DISPLAY': ':0', 20:16:19 INFO - 'HOME': '/home/cltbld', 20:16:19 INFO - 'LANG': 'en_US.UTF-8', 20:16:19 INFO - 'LANGUAGE': 'en_US:en', 20:16:19 INFO - 'LOGNAME': 'cltbld', 20:16:19 INFO - 'MAIL': '/var/mail/cltbld', 20:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:19 INFO - 'MOZ_NO_REMOTE': '1', 20:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:19 INFO - 'NO_EM_RESTART': '1', 20:16:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:19 INFO - 'PWD': '/builds/slave/test', 20:16:19 INFO - 'SHELL': '/bin/bash', 20:16:19 INFO - 'SHLVL': '1', 20:16:19 INFO - 'TERM': 'linux', 20:16:19 INFO - 'TMOUT': '86400', 20:16:19 INFO - 'USER': 'cltbld', 20:16:19 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:19 INFO - '_': '/tools/buildbot/bin/python'} 20:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:16:21 INFO - Installing collected packages: mozsystemmonitor 20:16:21 INFO - Running setup.py install for mozsystemmonitor 20:16:21 INFO - Successfully installed mozsystemmonitor 20:16:21 INFO - Cleaning up... 20:16:21 INFO - Return code: 0 20:16:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:16:21 INFO - Using env: {'DISPLAY': ':0', 20:16:21 INFO - 'HOME': '/home/cltbld', 20:16:21 INFO - 'LANG': 'en_US.UTF-8', 20:16:21 INFO - 'LANGUAGE': 'en_US:en', 20:16:21 INFO - 'LOGNAME': 'cltbld', 20:16:21 INFO - 'MAIL': '/var/mail/cltbld', 20:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:21 INFO - 'MOZ_NO_REMOTE': '1', 20:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:21 INFO - 'NO_EM_RESTART': '1', 20:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:21 INFO - 'PWD': '/builds/slave/test', 20:16:21 INFO - 'SHELL': '/bin/bash', 20:16:21 INFO - 'SHLVL': '1', 20:16:21 INFO - 'TERM': 'linux', 20:16:21 INFO - 'TMOUT': '86400', 20:16:21 INFO - 'USER': 'cltbld', 20:16:21 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:21 INFO - '_': '/tools/buildbot/bin/python'} 20:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:21 INFO - Downloading/unpacking jsonschema==2.5.1 20:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:16:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:16: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 20:16: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 20:16: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 20:16: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 20:16: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 20:16: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 20:16:23 INFO - Downloading functools32-3.2.3-2.tar.gz 20:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:16:23 INFO - warning: no files found matching '*.txt' 20:16:23 INFO - no previously-included directories found matching 'build' 20:16:23 INFO - no previously-included directories found matching 'dist' 20:16:23 INFO - no previously-included directories found matching '.git*' 20:16:24 INFO - Installing collected packages: jsonschema, functools32 20:16:24 INFO - Running setup.py install for functools32 20:16:24 INFO - warning: no files found matching '*.txt' 20:16:24 INFO - no previously-included directories found matching 'build' 20:16:24 INFO - no previously-included directories found matching 'dist' 20:16:24 INFO - no previously-included directories found matching '.git*' 20:16:24 INFO - Successfully installed jsonschema functools32 20:16:24 INFO - Cleaning up... 20:16:24 INFO - Return code: 0 20:16:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:16:24 INFO - Using env: {'DISPLAY': ':0', 20:16:24 INFO - 'HOME': '/home/cltbld', 20:16:24 INFO - 'LANG': 'en_US.UTF-8', 20:16:24 INFO - 'LANGUAGE': 'en_US:en', 20:16:24 INFO - 'LOGNAME': 'cltbld', 20:16:24 INFO - 'MAIL': '/var/mail/cltbld', 20:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:24 INFO - 'MOZ_NO_REMOTE': '1', 20:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:24 INFO - 'NO_EM_RESTART': '1', 20:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:24 INFO - 'PWD': '/builds/slave/test', 20:16:24 INFO - 'SHELL': '/bin/bash', 20:16:24 INFO - 'SHLVL': '1', 20:16:24 INFO - 'TERM': 'linux', 20:16:24 INFO - 'TMOUT': '86400', 20:16:24 INFO - 'USER': 'cltbld', 20:16:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:24 INFO - '_': '/tools/buildbot/bin/python'} 20:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:16:24 INFO - Cleaning up... 20:16:24 INFO - Return code: 0 20:16:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:16:24 INFO - Using env: {'DISPLAY': ':0', 20:16:24 INFO - 'HOME': '/home/cltbld', 20:16:24 INFO - 'LANG': 'en_US.UTF-8', 20:16:24 INFO - 'LANGUAGE': 'en_US:en', 20:16:24 INFO - 'LOGNAME': 'cltbld', 20:16:24 INFO - 'MAIL': '/var/mail/cltbld', 20:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:24 INFO - 'MOZ_NO_REMOTE': '1', 20:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:24 INFO - 'NO_EM_RESTART': '1', 20:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:24 INFO - 'PWD': '/builds/slave/test', 20:16:24 INFO - 'SHELL': '/bin/bash', 20:16:24 INFO - 'SHLVL': '1', 20:16:24 INFO - 'TERM': 'linux', 20:16:24 INFO - 'TMOUT': '86400', 20:16:24 INFO - 'USER': 'cltbld', 20:16:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:24 INFO - '_': '/tools/buildbot/bin/python'} 20:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:24 INFO - Downloading/unpacking blobuploader==1.2.4 20:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:26 INFO - Downloading blobuploader-1.2.4.tar.gz 20:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:16:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:16:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:27 INFO - Downloading docopt-0.6.1.tar.gz 20:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:16:27 INFO - Installing collected packages: blobuploader, requests, docopt 20:16:27 INFO - Running setup.py install for blobuploader 20:16:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:16:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:16:27 INFO - Running setup.py install for requests 20:16:27 INFO - Running setup.py install for docopt 20:16:27 INFO - Successfully installed blobuploader requests docopt 20:16:27 INFO - Cleaning up... 20:16:28 INFO - Return code: 0 20:16:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16: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')]} 20:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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')]} 20:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:28 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 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:28 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 20:16:28 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 20:16:28 INFO - Using env: {'DISPLAY': ':0', 20:16:28 INFO - 'HOME': '/home/cltbld', 20:16:28 INFO - 'LANG': 'en_US.UTF-8', 20:16:28 INFO - 'LANGUAGE': 'en_US:en', 20:16:28 INFO - 'LOGNAME': 'cltbld', 20:16:28 INFO - 'MAIL': '/var/mail/cltbld', 20:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:28 INFO - 'MOZ_NO_REMOTE': '1', 20:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:28 INFO - 'NO_EM_RESTART': '1', 20:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:28 INFO - 'PWD': '/builds/slave/test', 20:16:28 INFO - 'SHELL': '/bin/bash', 20:16:28 INFO - 'SHLVL': '1', 20:16:28 INFO - 'TERM': 'linux', 20:16:28 INFO - 'TMOUT': '86400', 20:16:28 INFO - 'USER': 'cltbld', 20:16:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:28 INFO - '_': '/tools/buildbot/bin/python'} 20:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:28 INFO - Running setup.py (path:/tmp/pip-rOmPO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:28 INFO - Running setup.py (path:/tmp/pip-gF3JR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:28 INFO - Running setup.py (path:/tmp/pip-zIeIUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:28 INFO - Running setup.py (path:/tmp/pip-lRXYsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:28 INFO - Running setup.py (path:/tmp/pip-nGdCvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:28 INFO - Running setup.py (path:/tmp/pip-nR5FRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:28 INFO - Running setup.py (path:/tmp/pip-JpgWCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:28 INFO - Running setup.py (path:/tmp/pip-pjBOMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:28 INFO - Running setup.py (path:/tmp/pip-o9Nz7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:28 INFO - Running setup.py (path:/tmp/pip-eAmL9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:28 INFO - Running setup.py (path:/tmp/pip-tfFU5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:29 INFO - Running setup.py (path:/tmp/pip-ZhdsCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:29 INFO - Running setup.py (path:/tmp/pip-DngCUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:29 INFO - Running setup.py (path:/tmp/pip-JNsfd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:29 INFO - Running setup.py (path:/tmp/pip-_9J4iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:29 INFO - Running setup.py (path:/tmp/pip-0nAF6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:29 INFO - Running setup.py (path:/tmp/pip-gYaGLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:16:29 INFO - Running setup.py install for manifestparser 20:16:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:16:29 INFO - Running setup.py install for mozcrash 20:16:29 INFO - Running setup.py install for mozdebug 20:16:29 INFO - Running setup.py install for mozdevice 20:16:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:16:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:16:29 INFO - Running setup.py install for mozfile 20:16:30 INFO - Running setup.py install for mozhttpd 20:16:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Running setup.py install for mozinfo 20:16:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Running setup.py install for mozInstall 20:16:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Running setup.py install for mozleak 20:16:30 INFO - Running setup.py install for mozlog 20:16:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Running setup.py install for moznetwork 20:16:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Running setup.py install for mozprocess 20:16:30 INFO - Running setup.py install for mozprofile 20:16:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Running setup.py install for mozrunner 20:16:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:16:30 INFO - Running setup.py install for mozscreenshot 20:16:31 INFO - Running setup.py install for moztest 20:16:31 INFO - Running setup.py install for mozversion 20:16:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:16:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:16:31 INFO - Cleaning up... 20:16:31 INFO - Return code: 0 20:16:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16: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')]} 20:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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')]} 20:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:31 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 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:31 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 20:16:31 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 20:16:31 INFO - Using env: {'DISPLAY': ':0', 20:16:31 INFO - 'HOME': '/home/cltbld', 20:16:31 INFO - 'LANG': 'en_US.UTF-8', 20:16:31 INFO - 'LANGUAGE': 'en_US:en', 20:16:31 INFO - 'LOGNAME': 'cltbld', 20:16:31 INFO - 'MAIL': '/var/mail/cltbld', 20:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:31 INFO - 'MOZ_NO_REMOTE': '1', 20:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:31 INFO - 'NO_EM_RESTART': '1', 20:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:31 INFO - 'PWD': '/builds/slave/test', 20:16:31 INFO - 'SHELL': '/bin/bash', 20:16:31 INFO - 'SHLVL': '1', 20:16:31 INFO - 'TERM': 'linux', 20:16:31 INFO - 'TMOUT': '86400', 20:16:31 INFO - 'USER': 'cltbld', 20:16:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:31 INFO - '_': '/tools/buildbot/bin/python'} 20:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:31 INFO - Running setup.py (path:/tmp/pip-KPq7hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:31 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)) 20:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:31 INFO - Running setup.py (path:/tmp/pip-zzmcKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:31 INFO - Running setup.py (path:/tmp/pip-Mv4TTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:31 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)) 20:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:31 INFO - Running setup.py (path:/tmp/pip-vqI7go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:31 INFO - Running setup.py (path:/tmp/pip-4Ov0w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:31 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)) 20:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:31 INFO - Running setup.py (path:/tmp/pip-bByQSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:31 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)) 20:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:31 INFO - Running setup.py (path:/tmp/pip-zi_cPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:32 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)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:32 INFO - Running setup.py (path:/tmp/pip-hmTzn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:32 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)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:32 INFO - Running setup.py (path:/tmp/pip-XGEvX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:32 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)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:32 INFO - Running setup.py (path:/tmp/pip-XKj2mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:32 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)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:32 INFO - Running setup.py (path:/tmp/pip-MDhO_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:32 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)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:32 INFO - Running setup.py (path:/tmp/pip-vTV7_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:32 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)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:32 INFO - Running setup.py (path:/tmp/pip-a_Z6ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:32 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)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:32 INFO - Running setup.py (path:/tmp/pip-DdLi0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:32 INFO - Running setup.py (path:/tmp/pip-NHnrcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:32 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)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:32 INFO - Running setup.py (path:/tmp/pip-9BmAJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:32 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)) 20:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:32 INFO - Running setup.py (path:/tmp/pip-oU5xpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:32 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)) 20:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:32 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)) 20:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:16:32 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 20:16:32 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 20:16:32 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 20:16:32 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 20:16:32 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 20:16:32 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 20:16:34 INFO - Downloading blessings-1.6.tar.gz 20:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:16:34 INFO - Installing collected packages: blessings 20:16:34 INFO - Running setup.py install for blessings 20:16:34 INFO - Successfully installed blessings 20:16:34 INFO - Cleaning up... 20:16:34 INFO - Return code: 0 20:16:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:16:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:35 INFO - Reading from file tmpfile_stdout 20:16:35 INFO - Current package versions: 20:16:35 INFO - argparse == 1.2.1 20:16:35 INFO - blessings == 1.6 20:16:35 INFO - blobuploader == 1.2.4 20:16:35 INFO - docopt == 0.6.1 20:16:35 INFO - functools32 == 3.2.3-2 20:16:35 INFO - jsonschema == 2.5.1 20:16:35 INFO - manifestparser == 1.1 20:16:35 INFO - mozInstall == 1.12 20:16:35 INFO - mozcrash == 1.0 20:16:35 INFO - mozdebug == 0.1 20:16:35 INFO - mozdevice == 0.49 20:16:35 INFO - mozfile == 1.2 20:16:35 INFO - mozhttpd == 0.7 20:16:35 INFO - mozinfo == 0.9 20:16:35 INFO - mozleak == 0.1 20:16:35 INFO - mozlog == 3.4 20:16:35 INFO - moznetwork == 0.27 20:16:35 INFO - mozprocess == 0.23 20:16:35 INFO - mozprofile == 0.28 20:16:35 INFO - mozrunner == 6.13 20:16:35 INFO - mozscreenshot == 0.1 20:16:35 INFO - mozsystemmonitor == 0.3 20:16:35 INFO - moztest == 0.7 20:16:35 INFO - mozversion == 1.4 20:16:35 INFO - psutil == 3.1.1 20:16:35 INFO - requests == 1.2.3 20:16:35 INFO - wsgiref == 0.1.2 20:16:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:35 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')]} 20:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:35 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')]} 20:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:35 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 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:35 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 20:16:35 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 20:16:35 INFO - Using env: {'DISPLAY': ':0', 20:16:35 INFO - 'HOME': '/home/cltbld', 20:16:35 INFO - 'LANG': 'en_US.UTF-8', 20:16:35 INFO - 'LANGUAGE': 'en_US:en', 20:16:35 INFO - 'LOGNAME': 'cltbld', 20:16:35 INFO - 'MAIL': '/var/mail/cltbld', 20:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:35 INFO - 'MOZ_NO_REMOTE': '1', 20:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:35 INFO - 'NO_EM_RESTART': '1', 20:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:35 INFO - 'PWD': '/builds/slave/test', 20:16:35 INFO - 'SHELL': '/bin/bash', 20:16:35 INFO - 'SHLVL': '1', 20:16:35 INFO - 'TERM': 'linux', 20:16:35 INFO - 'TMOUT': '86400', 20:16:35 INFO - 'USER': 'cltbld', 20:16:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:35 INFO - '_': '/tools/buildbot/bin/python'} 20:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:35 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)) 20:16:35 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)) 20:16:35 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)) 20:16:35 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)) 20:16:35 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)) 20:16:35 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)) 20:16:35 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)) 20:16:35 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)) 20:16:35 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)) 20:16:35 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)) 20:16:35 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)) 20:16:35 INFO - Cleaning up... 20:16:35 INFO - Return code: 0 20:16:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:16:35 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')]} 20:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:35 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')]} 20:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:35 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 0x7fbdb5dc3e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, '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': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', '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 20:16:35 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 20:16:35 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 20:16:35 INFO - Using env: {'DISPLAY': ':0', 20:16:35 INFO - 'HOME': '/home/cltbld', 20:16:35 INFO - 'LANG': 'en_US.UTF-8', 20:16:35 INFO - 'LANGUAGE': 'en_US:en', 20:16:35 INFO - 'LOGNAME': 'cltbld', 20:16:35 INFO - 'MAIL': '/var/mail/cltbld', 20:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:35 INFO - 'MOZ_NO_REMOTE': '1', 20:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:35 INFO - 'NO_EM_RESTART': '1', 20:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:35 INFO - 'PWD': '/builds/slave/test', 20:16:35 INFO - 'SHELL': '/bin/bash', 20:16:35 INFO - 'SHLVL': '1', 20:16:35 INFO - 'TERM': 'linux', 20:16:35 INFO - 'TMOUT': '86400', 20:16:35 INFO - 'USER': 'cltbld', 20:16:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:35 INFO - '_': '/tools/buildbot/bin/python'} 20:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:16:35 INFO - Cleaning up... 20:16:35 INFO - Return code: 0 20:16:35 INFO - Running post-action listener: _resource_record_post_action 20:16:35 INFO - Running post-action listener: _start_resource_monitoring 20:16:35 INFO - Starting resource monitoring. 20:16:35 INFO - [mozharness: 2016-12-10 04:16:35.695006Z] Finished create-virtualenv step (success) 20:16:35 INFO - [mozharness: 2016-12-10 04:16:35.695468Z] Running install step. 20:16:35 INFO - Running pre-action listener: _resource_record_pre_action 20:16:35 INFO - Running main action method: install 20:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:35 INFO - Reading from file tmpfile_stdout 20:16:35 INFO - Detecting whether we're running mozinstall >=1.0... 20:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:16:35 INFO - Reading from file tmpfile_stdout 20:16:35 INFO - Output received: 20:16:35 INFO - Usage: mozinstall [options] installer 20:16:35 INFO - Options: 20:16:35 INFO - -h, --help show this help message and exit 20:16:35 INFO - -d DEST, --destination=DEST 20:16:35 INFO - Directory to install application into. [default: 20:16:35 INFO - "/builds/slave/test"] 20:16:35 INFO - --app=APP Application being installed. [default: firefox] 20:16:35 INFO - mkdir: /builds/slave/test/build/application 20:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:16:52 INFO - Reading from file tmpfile_stdout 20:16:52 INFO - Output received: 20:16:52 INFO - /builds/slave/test/build/application/firefox/firefox 20:16:52 INFO - Running post-action listener: _resource_record_post_action 20:16:52 INFO - [mozharness: 2016-12-10 04:16:52.965005Z] Finished install step (success) 20:16:52 INFO - [mozharness: 2016-12-10 04:16:52.965248Z] Running run-tests step. 20:16:52 INFO - Running pre-action listener: _resource_record_pre_action 20:16:52 INFO - Running main action method: run_tests 20:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:16:52 INFO - Python 2.7.3 20:16:52 INFO - Return code: 0 20:16:52 INFO - grabbing minidump binary from tooltool 20:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:52 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 0xfe6f20>, '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 0xf53c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf53f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:16:52 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 20:16:52 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 20:16:52 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 20:16:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:16:53 INFO - Return code: 0 20:16:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:16:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:16:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:16:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:16:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 20:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 20:16:53 INFO - Using env: {'DISPLAY': ':0', 20:16:53 INFO - 'HOME': '/home/cltbld', 20:16:53 INFO - 'LANG': 'en_US.UTF-8', 20:16:53 INFO - 'LANGUAGE': 'en_US:en', 20:16:53 INFO - 'LOGNAME': 'cltbld', 20:16:53 INFO - 'MAIL': '/var/mail/cltbld', 20:16:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:16:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:53 INFO - 'MOZ_NO_REMOTE': '1', 20:16:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:53 INFO - 'NO_EM_RESTART': '1', 20:16:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:53 INFO - 'PWD': '/builds/slave/test', 20:16:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:16:53 INFO - 'SHELL': '/bin/bash', 20:16:53 INFO - 'SHLVL': '1', 20:16:53 INFO - 'TERM': 'linux', 20:16:53 INFO - 'TMOUT': '86400', 20:16:53 INFO - 'USER': 'cltbld', 20:16:53 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779', 20:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:53 INFO - '_': '/tools/buildbot/bin/python'} 20:16:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 20:16:53 INFO - mozversion application_buildid: 20161209183558 20:16:53 INFO - mozversion application_changeset: edb24e0ff1e147e44f042f8d0dccf59eac6f6de0 20:16:53 INFO - mozversion application_display_name: Nightly 20:16:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:16:53 INFO - mozversion application_name: Firefox 20:16:53 INFO - mozversion application_remotingname: firefox 20:16:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:16:53 INFO - mozversion application_vendor: Mozilla 20:16:53 INFO - mozversion application_version: 53.0a1 20:16:53 INFO - mozversion platform_buildid: 20161209183558 20:16:53 INFO - mozversion platform_changeset: edb24e0ff1e147e44f042f8d0dccf59eac6f6de0 20:16:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:16:53 INFO - mozversion platform_version: 53.0a1 20:16:53 INFO - using testdate: 1481343413 20:16:53 INFO - actual date: 1481343413 20:16:53 INFO - starting webserver on 'localhost:42727' 20:16:53 INFO - SUITE-START | Running 2 tests 20:16:53 INFO - TEST-START | dromaeo_css 20:16:53 INFO - operating with platform_type : linux_ 20:16:53 INFO - Initialising browser for dromaeo_css test... 20:16:53 INFO - TEST-INFO | started process 3320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHWOk8h/profile http://localhost:42727/getInfo.html) 20:16:59 INFO - PROCESS | 3320 | __metrics Screen width/height:1600/1200 20:16:59 INFO - PROCESS | 3320 | colorDepth:24 20:16:59 INFO - PROCESS | 3320 | Browser inner width/height: 1024/697 20:16:59 INFO - PROCESS | 3320 | __metrics 20:17:00 INFO - PROCESS | 3320 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:17:00 INFO - PROCESS | 3320 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:17:00 INFO - PROCESS | 3320 | console.error: PushService: 20:17:00 INFO - PROCESS | 3320 | stateChangeProcessEnqueue: Error transitioning state 20:17:00 INFO - PROCESS | 3320 | UnknownError 20:17:01 INFO - TEST-INFO | 3320: exit 0 20:17:01 INFO - Browser initialized. 20:17:01 INFO - Running cycle 1/1 for dromaeo_css test... 20:17:01 INFO - TEST-INFO | started process 3409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHWOk8h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:13 INFO - PROCESS | 3409 | RSS: Main: 172777472 20:17:13 INFO - PROCESS | 3409 | 20:18:04 INFO - PROCESS | 3409 | 1481343484696 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] 20:20:16 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:42727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42727/tests/dromaeo/cssquery-ext.html) 20:20:17 INFO - PROCESS | 3409 | RSS: Main: 323555328 20:20:17 INFO - PROCESS | 3409 | 20:23:20 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:42727/tests/dromaeo/cssquery-ext.html (next: http://localhost:42727/tests/dromaeo/cssquery-jquery.html) 20:23:21 INFO - PROCESS | 3409 | RSS: Main: 278937600 20:23:21 INFO - PROCESS | 3409 | 20:26:23 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:42727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42727/tests/dromaeo/cssquery-mootools.html) 20:26:23 INFO - PROCESS | 3409 | RSS: Main: 262406144 20:26:23 INFO - PROCESS | 3409 | 20:29:25 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:42727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42727/tests/dromaeo/cssquery-prototype.html) 20:29:26 INFO - PROCESS | 3409 | RSS: Main: 221990912 20:29:26 INFO - PROCESS | 3409 | 20:32:29 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:42727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42727/tests/dromaeo/cssquery-yui.html) 20:32:29 INFO - PROCESS | 3409 | RSS: Main: 225333248 20:32:29 INFO - PROCESS | 3409 | 20:35:32 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:42727/tests/dromaeo/cssquery-yui.html (next: http://localhost:42727/tests/dromaeo/cssquery-dojo.html) 20:35:33 INFO - PROCESS | 3409 | RSS: Main: 324501504 20:35:33 INFO - PROCESS | 3409 | 20:35:33 INFO - PROCESS | 3409 | __start_tp_report 20:35:33 INFO - PROCESS | 3409 | _x_x_mozilla_page_load 20:35:33 INFO - PROCESS | 3409 | _x_x_mozilla_page_load_details 20:35:33 INFO - PROCESS | 3409 | |i|pagename|runs| 20:35:33 INFO - PROCESS | 3409 | |0;dojo.html;3184.5064015077664;3232.272738633806;3238.5627940228064;3259.7718159728815;3294.7034766870975;5127.487251274871;5191.844244672666;5255.054090263756;5352.9197062044;5356.223347614594;5218;5231.947680523193;5233.581313494921;5234.371875374951;5239.921401178985;4750.548697873696;4773.331733557287;4779.761011949406;4797.424309082898;4809.615230781529;4887.218045112782;4891.6331275154325;4906.043321552299;4919.803207871681;4926.852194434173;4797.18447863864;4850.248211527219;4852.8544143675745;4855.077535268288;4917.901641967159;4904.803807847682;4906.779194936236;4925.162722337212;4926;4969.925451118236;4740.312654665088;4740.786664600101;4782.760861956888;4843.982763619644;4885.56029957302;5161.7161056141895;5208.427073021964;5211.270422140903;5230.529252367305;5285.68285902847;5526.806561770319;5574.386817450078;5577.358603760579;5581.107022876361;5648.519875810561;5517.531009864167;5633.380328163898;5638.154276858504;5647.181158731961;5654.773809047633;5344.331958505187;5354.785808567653;5381.9461805382225;5395.568354531667;5405.243265942771;5809.82570522885;5810.099434587646;5820.70896455184;5821.563382746311;5824.621399609012;5413.2692086568595;5511.476409741068;5598.888022239533;5601.467860553241;5613.101903695389;5602.85992850182;5611.3266408031295;5618.4662457066515;5621.156826476062;5681.971590142023;5552.056150454352;5595.8880822384135;5602.215689803431;5602.747876345574;5613.46672066153;5387.3804512481565;5597.244372009808;5599.552035837123;5608.971955140199;5617.129344951539;4235.23765722173;4274.850380236739;4288.142371525707;4288.50682171548;4289.335153051282;3923.0780766519847;3926;3944.15200731844;3948.249832531867;3956.584558621361;5209.166533354645;5212.765425555859;5222.582193424517;5222.817201397933;5224.190250511177;5518.089515230023;5519.227308176858;5522.641028333145;5527.060399732055;5527.53015993645;5206.140986737221;5262.947370526323;5268.552173065255;5271.288376069181;5273.894522109536;4824.782884770194;4830.8309209178215;4830.95169048305;4831.396075490564;4831.855044348676;5707.972564938268;5715.485606295453;5728.169415434739;5786.450287222707;5792.420757924174;5571.0807716726285;5576.553875690016;5577.832665020056;5579.721013949367;5582.33012038558;5623.999999999836;5650.943490565041;5762.481376676119;5773.393793651606;5850.473457388855;5575.776968921197;5577.721113944205;5590.161475778666;5621.297337832771;5627.718614069198;5621.325440947113;5653.830385088454;5657;5661.980843448219;5663.830085097454;5393.110136827379;5431.94077154951;5471.37079235893;5523.917141242804;5526.751296191601;5474.698891561003;5511.448855114617;5523.834284971457;5529.889402211853;5561.610687252015;5491.450854914477;5501.724913754377;5504.697241651747;5509.393966663583;5518.255035570307;5428.294321738149;5468.261784659179;5543.3902270751;5551.056320425457;5611.775528978795;5343.385510666323;5373.194020896741;5377.435369286169;5381.623286369917;5433.918491222714 20:35:33 INFO - PROCESS | 3409 | |1;ext.html;549.2091388400703;551.253052114385;562.7945799783078;573.546897950619;574.5174053794811;30658;34039.319213615716;34269.65730342696;34357.31285374291;34361.140971475725;34119;35005;39885.60114398855;41968.37047444283;42065.78967105168;8592.183742544465;8744.912550874473;8747.606357713918;8750.299976001936;8751;8580.099089595597;8670.132986701343;8683.305335573139;8686.174813392749;8687.652493900236;7903.683852645887;8117.512949223065;8702.390832641686;10128.544215510283;10356.326838755494;10280.383177009366;10400.895991040106;10410.11514021309;10416.739581510446;10421.426821524814;10262.230332725001;10336.89663103367;10340.896591034143;10355.482225888676;10369.533370998322;40416;40567.7971610143;40687.796561017305;40750.79624601858;40780.59219407827;3502.859885604573;3546.131197856516;3596.8741094061843;3937.370020796659;3983.3029219886694;29948.101556953327;30689.846550767103;30794.53808192879;30894.536581951288;31839.52240716391;4134.200528044325;4199.958000419987;4270.466191726035;4319.67602429819;4333.111712099012;213252;214118.71762564816;214242.92878535663;214323;214393.99999999843;55632.72183639137;55959.44040559624;56083.719581401834;56085;56189.157162642594;58352;58921.705391472766;59006.70496647489;59159;59182.70408648015;15309.923450382677;15512;15544.300506477235;15555.30001149951;15557.922210388875;11702.414879256003;11748.647540573797;11748.941255293668;11749.412529373669;11755.823662645067;14935.253237338307;16467.752983705253;16495.587610309598;16531.43762716781;16601.169941502878;4776.421281912859;5536.7785288588;5567;5726.885462290731;5814.360420353758;757.8560073586001;827.2596026556198;828.7886588919787;986.4081551069445;1005.7586179317058;30775.149643753186;32351.676483235336;32387.51418728721;32406;32887;1042.1975079188983;1080.8432777247256;1133.4672703829187;1161.1697636190165;1198.4487135917575;15727.844323291987;16701.91649041747;16798.412055577995;16820.74768878468;16951.237194326284;448661;451715;452658;452823;452832;55397.1690424644;55707.442925571035;55721;55746.16380754292;55806.44193558094;1178.5698220149584;1201.645514573203;1221.969450763738;1272.8663490333568;1274.0826604844497;29894.548348587;32739.672603274616;32869.34261314713;32992.67007329896;33354.97597666636;48229.28331466948;48855;48955.75522122366;48967.26549101838;48994.265086024454;353581;353982;355919;356696;358633;23665;25815.741842581334;25882.223533294033;26248.73751262463;26286.342841429116;39362.409563855996;40028.399574006995;40857.38713919353;41099.58900410958;43808.78095609502;34727;34885.30229395347;35096;35576.64423355733;35931;35061.12347191341;35072.824635876656;35353.29293414169;35487.645123548435;35681.82159089188;35362.29275414529;36191;36469;36484;36808.81595592112;30301.696983029888;32936.34127317488;32978.17554561155;33013;33198.502022470166;25203.495930080928;25425.49149017046;25495.872520637276;25585;25930.740692592834 20:35:33 INFO - PROCESS | 3409 | |2;jquery.html;356.9625189355119;366.7927620894193;380.1168139660673;383.1494083135439;406.1369589622053;14063.367148478317;17669.29322827087;17726.468205953825;18279.634407311845;19193.424197274067;17226.138693065328;17315.39396121136;17580.033098179596;17744.378946736866;18384;4879.048585525815;5109.642325037249;5115.360579927509;5117.334746482952;5120.103981803189;3821.5605205401316;3992.800359982004;5002.924956125661;5030.647854650176;5033.320501732274;5453.2092846537225;5515.889682206373;5537.944620553803;5547.861303467405;5626.521745651625;5352.785888564453;5468.72656367184;5515.917261241085;5521.834344969638;5542.11326187808;5335.039692855285;5347.037533244014;5356.491133342326;5357.678539287616;5361.303030605996;12312.692182695504;18245.63157763173;18439.631207375776;22050.33848984533;22226.88886555573;2194.9561008779897;2377.8929948152204;2437.2810021043656;2506.020244007232;2624.3307956470976;9702.563384647709;10201.540930658064;10249.282550221487;10985.835212471819;14197.78703319451;1833.6607727570442;1866.766654168229;1906.6377388296319;1909.7421848050612;1935.94192174235;77450.61274693647;80859.5957020217;81115.18884811136;81279.18720812835;83525.58237208775;10480.947595261974;10547.314424562379;10833.079188268928;10854.837177442345;10858.891411085946;14828.629284267763;14955.476558320624;15089.924550377178;15100.093994360373;15105.39578416873;7579.885571945658;7775.1447340792465;7803.68785248595;8036.83926321482;8073.555954422563;7374.705011799575;7415;7648.120466146464;7672.578008209491;7678.692852285958;4242.642354446609;4317.697761156752;4501.122281155143;4573.588377046081;4689.390379250675;1679.9076050817323;1863.6459072776129;1923.278770461077;1935.2162374238455;1938.2150229157214;779.4777499075633;875.7285241575005;958.166395236149;990.4206039466992;1005.100435110572;17289.320155375935;18617.441476755717;18714;18749.437516874517;19305.9381734006;894.8836651235298;956.9186619137312;959.5633986536249;969.743018100204;988.3328753091635;9821;10340.482975851328;10419.322744021614;10483.895161048444;10514.106300964351;400202;400827;402510;408735;418095;76037.23962760413;76901.23098769052;78273.60863195761;82183.5890820554;83609.58195208985;964.6382606522554;1003.3578509753618;1019.3476175247847;1044.6030508406757;1057.3074636113358;16016.759748603547;16265.756013659568;16962;17009.234584443977;17019.48941531756;38128.61871381251;38720.41919371268;39439.80280098581;39632;41260;52743.47256527539;53130.20304695355;53175.734121329144;55387.72306138444;56025.71987140038;6616.470682345497;6623.205215373993;7558.924410756042;7664.080310362792;7947.642356094106;9573;11802.350870702194;11862;12518.12373133872;12632.2420654761;10439.739006524898;10511.421871797125;10711.678649640524;10886.78226435451;11191.048760855418;10327.48362581853;10538.789224215627;10546.472676366304;10632.25574209798;10738.409387483764;10569.26015178961;10597;10716.571337146426;11192.496337664987;11474.885251147716;7628.80927976805;7670.42471814605;7685.385169186564;7689;7957.602119894098;10571.2600117991;10944.124470042536;10967.616133435291;10986.450677466255;11271 20:35:33 INFO - PROCESS | 3409 | |3;mootools.html;1269.765093457711;1338.7322535492901;1356.3286173344195;1465.868071873531;1679.9580010499744;7034.120734908137;7676.309132178103;7950.880736788953;7965.522068675884;7966.044074711028;7691.923080769191;7829.17793631669;7841.372690184786;8008;8035.075966263881;1922.5482011727233;1981.276833955603;2136.0601335412407;2169.4467910682833;2172.1528603844436;2101.831853451728;2124.5538436928186;2131.3073251193423;2138.2943628602525;2158.686990386393;2060.9896950515304;2090.770015298316;2099.496120930973;2100.28590279305;2165.8050775430206;2127.7446706395176;2144.8176904963098;2145.0668959002883;2145.3671167005773;2145.452909508081;2103.1272022110807;2155.6766485027215;2160.91356345746;2168.056895250571;2173.4240426286888;7913;8080.71717489885;8094.554799486026;8105.797355066112;8120.147384524658;4822.107910036654;4955.0833095877015;4970.925436118461;4975.328330675348;4977.651564390494;3065.662777094518;3235.2558911450265;3254.9511757323658;3268.477043673001;3277.8197199154038;1003.7942221844577;1065.6696424108475;1084.4577711144427;1093.6718984304678;1103.6082190822224;10761.62334318303;11051.392173430539;11056.502457389437;11066.336019838835;11157.72105697364;4316.762578058237;4330.155619654137;4337.284348082531;4368.322909948963;4410.25025745624;9509.476978766095;9516.23870090391;9519.666811661697;9520.619175232912;9531.094546018117;4834;4922.8769280768265;4934.407871055425;4937.136001199776;4942.827001054946;3902.102516421239;4150.771707556113;4539.046800172001;4555.681102322806;4562.84030058953;3585.6952159066773;3637.3452778500123;3668.0646435158865;3674.0998455378067;3747.9625203747614;1153.6366044695894;1174.8179032250016;1189.9881001190051;1192.761447710444;1196.5692350753895;819.8975128108987;843.8649816029406;858.7810108422437;859.1365677494078;880.7489865388334;4995.550400463903;5095.210242412432;5113.795448182031;5131.153359695683;5307.655002424907;359.40339037198123;363.3895056305432;369.7171663677289;370.829418467508;372.3818461354139;3364.848581813775;3444.913877153091;3456.0668619472603;3469.2367679110557;3520.612732599412;9235.353525253167;9799.216062714966;9803.607855685836;9823.115919567274;9823.557939892722;9270.860937085949;9785.510724463891;9788.168005719452;9797.853032204523;9801.11789938909;7062.258462861429;7523.172451030382;7539.246075392527;7540.321371076519;7557.848843023219;5157.123289040797;5192.922106168335;5233.738313084406;5235.136202526541;5472.151816468454;8871.556422178994;9017.413868098552;9019.188273055457;9045.954770226106;9113.134252246025;9045.547722613712;9191.494467804336;9274.44353338802;9381;9391.906080939376;6324.905126423016;6371.426571608577;6380.234371875405;7002.7899163025195;7227.674754636159;6996.580205187705;7150.249223831423;7465.216152304147;7602.049743782028;7628.313451789366;6753.425958793361;6901.309869013058;6941.444684425335;6950.895736564057;7003.719851205895;6602.867942641216;6614.5039122067;6693.966530167513;6719.798406047827;6833.45332373399;5860.2967643883;5882.970585147218;5886.20536227621;5903.144044113666;5925.111233315038;4350.042990542076;4451.443569553806;4452.4211852458975;4464.687471876938;4581.427321584802;4358.4769827620885;4450.532694067077;4494.70784399013;4603.447586289667;4678.742669153229 20:35:33 INFO - PROCESS | 3409 | |4;prototype.html;365.1983895349708;367.32779014403644;370.57384008390363;372.4729507746538;380.6897378636411;5053.2925390445325;5056.710538812597;5091.912315950461;5126.5642420394315;5135.640505164631;4991.226359914219;4994.825181118662;5041.143005689032;5070.847874563759;5133.9229911551265;3957.643812056914;4119.57874533287;4144.357624568197;4145.129522800215;4166.541680415152;4049.5343035550995;4082.3468245080794;4152.2733521633745;4167.4790651168605;4172.374143878412;4127.236461254663;4134.855280065199;4136.544980052192;4141.295979683461;4151.854685086023;4141.730787498833;4162.313218318974;4163.292240319138;4167.958320416802;4170.77060761658;3584.5877724061806;3718.7954662493553;3736.1406876418305;3746.1571146492092;3752;5019.749012549394;5023.2214006829;5057.772400241998;5064.797408103672;5073.518015788494;4739.137602853663;4757.311154540158;4758.428988521365;4771.23660214364;4776.116418462596;5295.087701764014;5389.110796718537;5419.864503387407;5421.376541697716;5459.727013649342;4116.735795312567;4120.381942708617;4121.990112422475;4140.254754144253;4140.91718165635;5576.944230557683;5596;5643;5649.4633009864;5664.348599911022;4134.64855487281;4145.66834653227;4182.665386769051;4192.538820729717;4248.915021699549;4234.87295381139;4238.724482908601;4245.726282115353;4248.553901840262;4253.170631726845;4729.36153619257;4732.100900828831;4747.596454301423;4757.5718185363485;4758.547937945889;5213;5339.385970613352;5387.730613469311;5387.895481426298;5437.700926449004;1406.2476575032308;1408.3521580073077;1417.433026789272;1419.9219042952736;1419.9574012779426;996.7807082441851;1024.329064462778;1030.6650338639972;1033.421284080902;1034.9805441639978;5058.822941197041;5094.872628184251;5095.159298715745;5118.948810511922;5134.5635620972635;5345.893082138413;5390.730463476889;5412.323459567554;5417.702026388508;5419.268398766195;4942.5304596063315;5063.8480845574695;5092.541671249532;5133.6919784813035;5136.614753893473;2842.91969051759;2845.701201373867;2860.4136152089186;2871.3539453623184;2881.6109825173753;5525.944740552623;5533.446655334435;5554.722563748844;5562.415946325577;5589.273394458694;5315.973420132952;5457.590680698963;5646.124850648156;5647.407022262603;5648.5763567731765;5735.1684005818925;5740.799072032542;5763.596548241667;5784.7107644618445;5802.796902108406;5472.425395333433;5517.36550296721;5578.972105139448;5636.830895073154;5640.633358831663;5510.752016159202;5532.778688852401;5539.639923405127;5558.749856256559;5562.249096371938;5554.1946417770005;5758.280214973129;5765.423457654201;5799.768009279582;5814.651120932757;3840.30874442603;3858.1897801462005;3929.92140157201;3941.4876066111224;3963.780283041506;5514.503694667499;5517.172424136412;5549.694766787866;5554.222408862844;5601.691906945157;5306.469353064663;5383.600263931327;5438.483344082306;5448.346198456052;5452.26394436746;5355.196720491957;5371.785128594813;5384.300040994645;5384.569234461155;5397.541208997279;5372.328458942632;5382.865428364165;5384.730763461733;5390.51485366319;5406.486383793534;5174.97412512935;5401.648892821954;5413.9427017733005;5444.1017232156255;5444.482774136451;5314.697899014766;5317.8404647860625;5325.946740532545;5337.599680023936;5337.6797392156595 20:35:33 INFO - PROCESS | 3409 | |5;yui.html;717.3257138290007;725.9455540834438;747.756978981831;793.6745934166993;798.2895223251304;15450.922745386271;16305.103219322933;16342.75485867713;16355.182240887967;16356.836431635695;14977.176255305954;15022.924885375585;15130.697386052272;15131.092134471939;15138;646.0309535696455;663.863907898882;747.4879707400448;760.4562737642584;775.0312109862672;767.6814122139306;770.8304173081913;772.3319328780592;774.5855967057626;774.6978678315434;822.4325215601216;823.9217274358926;824.2499325613693;824.8102936324649;825.4345773145385;811.7970507373157;817.1868990354576;817.2767101115496;818.378032695153;818.5007145641155;499.65274134476556;507.5685667182902;577.3995045153035;593.2673148661399;595.312414161644;13822.447102115902;13845.16928984254;13869.722605547933;13871.306434678225;13876.58370248884;13484;13799.862001379957;13806;13928.791068133985;13938.303084845717;12384.938075309656;12423.44094515749;12469.314187719672;12683.74632507354;12870.22778633285;4188.706790524665;4190;4274.914501709979;4290;4296.183725092223;75744.31917606201;79482;79811;80769.59615201945;82282;10191.286609937382;10272.734496046925;10321.884013777159;10368.429736364422;10398;18997.62004759897;19465.80534194668;19813;20698.896505517376;20900.37298881036;7987.32107770846;8100.270975612223;8257.38069644779;8326.958365208257;8366.37252206087;4220.240356735817;4340.088581397878;4436.245838207513;4441.911161776747;4530.70550414222;3279.950800737991;3321.1697075731067;3381.932361352759;3388.796672199676;3421.863125474953;580.8054301808942;585.88868115058;594.93753155918;597.5667640960269;605.3764622438895;542.3843937131305;602.5926423936402;611.0589691874463;656.7734131724548;670.3631550027493;7231.45764067697;9186.40288381253;9709.320347575744;9891.308136205927;9999.550155196446;645.4865367126649;653.3270731146927;672.1989232919871;685.5817951049855;693.5145398221265;4240.801606409632;4531.478879928784;4566.5337173720545;4588.564086411786;4639.791209395586;73002;74991;75289;76392;77544;63020.68489657614;65668.77299910928;67539.66230168915;69409.65295173593;69546.65226673834;52931.735341323045;54272.45727542674;55260.72369638126;57791.71104144453;59508;8707.608157633049;8813.383063185773;9058.637654493747;9382.67160649374;9511.239100872051;39371.409428858016;40183.3972490407;41039.589604103574;41520.377194341505;42681.57318426776;40652.39021414622;41821;52289;54116.72941635267;56605.433945660014;12063.276203427822;12394.81407778902;12475;12625.305608191638;12773.23360598367;12864.356782160667;12886.574823746369;13035.608931732064;13172;13384.130031547918;11668.299902005907;12057.216280942062;12733.55432559856;12884.420201090787;13206.537771177962;11961.461734221806;12046.879531204575;12393.256404615751;12508.249505029728;12899.613011609667;11864.584739534075;11982.70043248891;12251.08116891219;12410.5656302029;12525.436355363849;10428.478576071318;10494.737631559272;10636.787264254517;10641.840372394576;10677.412742299248;9970.750731231486;10007.699769006942;10007.849882251918;10029.548670309707;10069.647562335284 20:35:33 INFO - PROCESS | 3409 | __end_tp_report 20:35:33 INFO - PROCESS | 3409 | __start_cc_report 20:35:33 INFO - PROCESS | 3409 | _x_x_mozilla_cycle_collect,1385 20:35:33 INFO - PROCESS | 3409 | __end_cc_report 20:35:33 INFO - PROCESS | 3409 | __startTimestamp1481344533151__endTimestamp 20:35:33 INFO - PROCESS | 3409 | 20:35:33 INFO - PROCESS | 3409 | ------- Summary: start ------- 20:35:33 INFO - PROCESS | 3409 | Number of tests: 6 20:35:33 INFO - PROCESS | 3409 | 20:35:33 INFO - PROCESS | 3409 | [#0] dojo.html Cycles:165 Average:5232.96 Median:5428.29 stddev:551.47 (10.2%) stddev-sans-first:529.24 20:35:33 INFO - PROCESS | 3409 | Values: 3184.5 3232.3 3238.6 3259.8 3294.7 5127.5 5191.8 5255.1 5352.9 5356.2 5218.0 5231.9 5233.6 5234.4 5239.9 4750.5 4773.3 4779.8 4797.4 4809.6 4887.2 4891.6 4906.0 4919.8 4926.9 4797.2 4850.2 4852.9 4855.1 4917.9 4904.8 4906.8 4925.2 4926.0 4969.9 4740.3 4740.8 4782.8 4844.0 4885.6 5161.7 5208.4 5211.3 5230.5 5285.7 5526.8 5574.4 5577.4 5581.1 5648.5 5517.5 5633.4 5638.2 5647.2 5654.8 5344.3 5354.8 5381.9 5395.6 5405.2 5809.8 5810.1 5820.7 5821.6 5824.6 5413.3 5511.5 5598.9 5601.5 5613.1 5602.9 5611.3 5618.5 5621.2 5682.0 5552.1 5595.9 5602.2 5602.7 5613.5 5387.4 5597.2 5599.6 5609.0 5617.1 4235.2 4274.9 4288.1 4288.5 4289.3 3923.1 3926.0 3944.2 3948.2 3956.6 5209.2 5212.8 5222.6 5222.8 5224.2 5518.1 5519.2 5522.6 5527.1 5527.5 5206.1 5262.9 5268.6 5271.3 5273.9 4824.8 4830.8 4831.0 4831.4 4831.9 5708.0 5715.5 5728.2 5786.5 5792.4 5571.1 5576.6 5577.8 5579.7 5582.3 5624.0 5650.9 5762.5 5773.4 5850.5 5575.8 5577.7 5590.2 5621.3 5627.7 5621.3 5653.8 5657.0 5662.0 5663.8 5393.1 5431.9 5471.4 5523.9 5526.8 5474.7 5511.4 5523.8 5529.9 5561.6 5491.5 5501.7 5504.7 5509.4 5518.3 5428.3 5468.3 5543.4 5551.1 5611.8 5343.4 5373.2 5377.4 5381.6 5433.9 20:35:33 INFO - PROCESS | 3409 | 20:35:33 INFO - PROCESS | 3409 | [#1] ext.html Cycles:180 Average:50138.84 Median:35224.65 stddev:93750.94 (266.2%) stddev-sans-first:93940.00 20:35:33 INFO - PROCESS | 3409 | Values: 549.2 551.3 562.8 573.5 574.5 30658.0 34039.3 34269.7 34357.3 34361.1 34119.0 35005.0 39885.6 41968.4 42065.8 8592.2 8744.9 8747.6 8750.3 8751.0 8580.1 8670.1 8683.3 8686.2 8687.7 7903.7 8117.5 8702.4 10128.5 10356.3 10280.4 10400.9 10410.1 10416.7 10421.4 10262.2 10336.9 10340.9 10355.5 10369.5 40416.0 40567.8 40687.8 40750.8 40780.6 3502.9 3546.1 3596.9 3937.4 3983.3 29948.1 30689.8 30794.5 30894.5 31839.5 4134.2 4200.0 4270.5 4319.7 4333.1 213252.0 214118.7 214242.9 214323.0 214394.0 55632.7 55959.4 56083.7 56085.0 56189.2 58352.0 58921.7 59006.7 59159.0 59182.7 15309.9 15512.0 15544.3 15555.3 15557.9 11702.4 11748.6 11748.9 11749.4 11755.8 14935.3 16467.8 16495.6 16531.4 16601.2 4776.4 5536.8 5567.0 5726.9 5814.4 757.9 827.3 828.8 986.4 1005.8 30775.1 32351.7 32387.5 32406.0 32887.0 1042.2 1080.8 1133.5 1161.2 1198.4 15727.8 16701.9 16798.4 16820.7 16951.2 448661.0 451715.0 452658.0 452823.0 452832.0 55397.2 55707.4 55721.0 55746.2 55806.4 1178.6 1201.6 1222.0 1272.9 1274.1 29894.5 32739.7 32869.3 32992.7 33355.0 48229.3 48855.0 48955.8 48967.3 48994.3 353581.0 353982.0 355919.0 356696.0 358633.0 23665.0 25815.7 25882.2 26248.7 26286.3 39362.4 40028.4 40857.4 41099.6 43808.8 34727.0 34885.3 35096.0 35576.6 35931.0 35061.1 35072.8 35353.3 35487.6 35681.8 35362.3 36191.0 36469.0 36484.0 36808.8 30301.7 32936.3 32978.2 33013.0 33198.5 25203.5 25425.5 25495.9 25585.0 25930.7 20:35:33 INFO - PROCESS | 3409 | 20:35:33 INFO - PROCESS | 3409 | [#2] jquery.html Cycles:180 Average:25584.50 Median:20975.09 stddev:67247.03 (320.6%) stddev-sans-first:67409.00 20:35:33 INFO - PROCESS | 3409 | Values: 357.0 366.8 380.1 383.1 406.1 14063.4 17669.3 17726.5 18279.6 19193.4 17226.1 17315.4 17580.0 17744.4 18384.0 4879.0 5109.6 5115.4 5117.3 5120.1 3821.6 3992.8 5002.9 5030.6 5033.3 5453.2 5515.9 5537.9 5547.9 5626.5 5352.8 5468.7 5515.9 5521.8 5542.1 5335.0 5347.0 5356.5 5357.7 5361.3 12312.7 18245.6 18439.6 22050.3 22226.9 2195.0 2377.9 2437.3 2506.0 2624.3 9702.6 10201.5 10249.3 10985.8 14197.8 1833.7 1866.8 1906.6 1909.7 1935.9 77450.6 80859.6 81115.2 81279.2 83525.6 10480.9 10547.3 10833.1 10854.8 10858.9 14828.6 14955.5 15089.9 15100.1 15105.4 7579.9 7775.1 7803.7 8036.8 8073.6 7374.7 7415.0 7648.1 7672.6 7678.7 4242.6 4317.7 4501.1 4573.6 4689.4 1679.9 1863.6 1923.3 1935.2 1938.2 779.5 875.7 958.2 990.4 1005.1 17289.3 18617.4 18714.0 18749.4 19305.9 894.9 956.9 959.6 969.7 988.3 9821.0 10340.5 10419.3 10483.9 10514.1 400202.0 400827.0 402510.0 408735.0 418095.0 76037.2 76901.2 78273.6 82183.6 83609.6 964.6 1003.4 1019.3 1044.6 1057.3 16016.8 16265.8 16962.0 17009.2 17019.5 38128.6 38720.4 39439.8 39632.0 41260.0 52743.5 53130.2 53175.7 55387.7 56025.7 6616.5 6623.2 7558.9 7664.1 7947.6 9573.0 11802.4 11862.0 12518.1 12632.2 10439.7 10511.4 10711.7 10886.8 11191.0 10327.5 10538.8 10546.5 10632.3 10738.4 10569.3 10597.0 10716.6 11192.5 11474.9 7628.8 7670.4 7685.4 7689.0 7957.6 10571.3 10944.1 10967.6 10986.5 11271.0 20:35:33 INFO - PROCESS | 3409 | 20:35:33 INFO - PROCESS | 3409 | [#3] mootools.html Cycles:180 Average:5182.54 Median:4948.96 stddev:2956.53 (59.7%) stddev-sans-first:2950.20 20:35:33 INFO - PROCESS | 3409 | Values: 1269.8 1338.7 1356.3 1465.9 1680.0 7034.1 7676.3 7950.9 7965.5 7966.0 7691.9 7829.2 7841.4 8008.0 8035.1 1922.5 1981.3 2136.1 2169.4 2172.2 2101.8 2124.6 2131.3 2138.3 2158.7 2061.0 2090.8 2099.5 2100.3 2165.8 2127.7 2144.8 2145.1 2145.4 2145.5 2103.1 2155.7 2160.9 2168.1 2173.4 7913.0 8080.7 8094.6 8105.8 8120.1 4822.1 4955.1 4970.9 4975.3 4977.7 3065.7 3235.3 3255.0 3268.5 3277.8 1003.8 1065.7 1084.5 1093.7 1103.6 10761.6 11051.4 11056.5 11066.3 11157.7 4316.8 4330.2 4337.3 4368.3 4410.3 9509.5 9516.2 9519.7 9520.6 9531.1 4834.0 4922.9 4934.4 4937.1 4942.8 3902.1 4150.8 4539.0 4555.7 4562.8 3585.7 3637.3 3668.1 3674.1 3748.0 1153.6 1174.8 1190.0 1192.8 1196.6 819.9 843.9 858.8 859.1 880.7 4995.6 5095.2 5113.8 5131.2 5307.7 359.4 363.4 369.7 370.8 372.4 3364.8 3444.9 3456.1 3469.2 3520.6 9235.4 9799.2 9803.6 9823.1 9823.6 9270.9 9785.5 9788.2 9797.9 9801.1 7062.3 7523.2 7539.2 7540.3 7557.8 5157.1 5192.9 5233.7 5235.1 5472.2 8871.6 9017.4 9019.2 9046.0 9113.1 9045.5 9191.5 9274.4 9381.0 9391.9 6324.9 6371.4 6380.2 7002.8 7227.7 6996.6 7150.2 7465.2 7602.0 7628.3 6753.4 6901.3 6941.4 6950.9 7003.7 6602.9 6614.5 6694.0 6719.8 6833.5 5860.3 5883.0 5886.2 5903.1 5925.1 4350.0 4451.4 4452.4 4464.7 4581.4 4358.5 4450.5 4494.7 4603.4 4678.7 20:35:33 INFO - PROCESS | 3409 | 20:35:33 INFO - PROCESS | 3409 | [#4] prototype.html Cycles:180 Average:4587.25 Median:5095.02 stddev:1303.59 (25.6%) stddev-sans-first:1268.15 20:35:33 INFO - PROCESS | 3409 | Values: 365.2 367.3 370.6 372.5 380.7 5053.3 5056.7 5091.9 5126.6 5135.6 4991.2 4994.8 5041.1 5070.8 5133.9 3957.6 4119.6 4144.4 4145.1 4166.5 4049.5 4082.3 4152.3 4167.5 4172.4 4127.2 4134.9 4136.5 4141.3 4151.9 4141.7 4162.3 4163.3 4168.0 4170.8 3584.6 3718.8 3736.1 3746.2 3752.0 5019.7 5023.2 5057.8 5064.8 5073.5 4739.1 4757.3 4758.4 4771.2 4776.1 5295.1 5389.1 5419.9 5421.4 5459.7 4116.7 4120.4 4122.0 4140.3 4140.9 5576.9 5596.0 5643.0 5649.5 5664.3 4134.6 4145.7 4182.7 4192.5 4248.9 4234.9 4238.7 4245.7 4248.6 4253.2 4729.4 4732.1 4747.6 4757.6 4758.5 5213.0 5339.4 5387.7 5387.9 5437.7 1406.2 1408.4 1417.4 1419.9 1420.0 996.8 1024.3 1030.7 1033.4 1035.0 5058.8 5094.9 5095.2 5118.9 5134.6 5345.9 5390.7 5412.3 5417.7 5419.3 4942.5 5063.8 5092.5 5133.7 5136.6 2842.9 2845.7 2860.4 2871.4 2881.6 5525.9 5533.4 5554.7 5562.4 5589.3 5316.0 5457.6 5646.1 5647.4 5648.6 5735.2 5740.8 5763.6 5784.7 5802.8 5472.4 5517.4 5579.0 5636.8 5640.6 5510.8 5532.8 5539.6 5558.7 5562.2 5554.2 5758.3 5765.4 5799.8 5814.7 3840.3 3858.2 3929.9 3941.5 3963.8 5514.5 5517.2 5549.7 5554.2 5601.7 5306.5 5383.6 5438.5 5448.3 5452.3 5355.2 5371.8 5384.3 5384.6 5397.5 5372.3 5382.9 5384.7 5390.5 5406.5 5175.0 5401.6 5413.9 5444.1 5444.5 5314.7 5317.8 5325.9 5337.6 5337.7 20:35:33 INFO - PROCESS | 3409 | 20:35:33 INFO - PROCESS | 3409 | [#5] yui.html Cycles:180 Average:16733.30 Median:4486.31 stddev:21512.83 (479.5%) stddev-sans-first:21539.56 20:35:33 INFO - PROCESS | 3409 | Values: 717.3 725.9 747.8 793.7 798.3 15450.9 16305.1 16342.8 16355.2 16356.8 14977.2 15022.9 15130.7 15131.1 15138.0 646.0 663.9 747.5 760.5 775.0 767.7 770.8 772.3 774.6 774.7 822.4 823.9 824.2 824.8 825.4 811.8 817.2 817.3 818.4 818.5 499.7 507.6 577.4 593.3 595.3 13822.4 13845.2 13869.7 13871.3 13876.6 13484.0 13799.9 13806.0 13928.8 13938.3 12384.9 12423.4 12469.3 12683.7 12870.2 4188.7 4190.0 4274.9 4290.0 4296.2 75744.3 79482.0 79811.0 80769.6 82282.0 10191.3 10272.7 10321.9 10368.4 10398.0 18997.6 19465.8 19813.0 20698.9 20900.4 7987.3 8100.3 8257.4 8327.0 8366.4 4220.2 4340.1 4436.2 4441.9 4530.7 3280.0 3321.2 3381.9 3388.8 3421.9 580.8 585.9 594.9 597.6 605.4 542.4 602.6 611.1 656.8 670.4 7231.5 9186.4 9709.3 9891.3 9999.6 645.5 653.3 672.2 685.6 693.5 4240.8 4531.5 4566.5 4588.6 4639.8 73002.0 74991.0 75289.0 76392.0 77544.0 63020.7 65668.8 67539.7 69409.7 69546.7 52931.7 54272.5 55260.7 57791.7 59508.0 8707.6 8813.4 9058.6 9382.7 9511.2 39371.4 40183.4 41039.6 41520.4 42681.6 40652.4 41821.0 52289.0 54116.7 56605.4 12063.3 12394.8 12475.0 12625.3 12773.2 12864.4 12886.6 13035.6 13172.0 13384.1 11668.3 12057.2 12733.6 12884.4 13206.5 11961.5 12046.9 12393.3 12508.2 12899.6 11864.6 11982.7 12251.1 12410.6 12525.4 10428.5 10494.7 10636.8 10641.8 10677.4 9970.8 10007.7 10007.8 10029.5 10069.6 20:35:33 INFO - PROCESS | 3409 | -------- Summary: end -------- 20:35:33 INFO - PROCESS | 3409 | 20:35:34 INFO - TEST-INFO | 3409: exit 0 20:35:34 INFO - TEST-OK | dromaeo_css | took 1120754ms 20:35:34 INFO - TEST-START | kraken 20:35:34 INFO - operating with platform_type : linux_ 20:35:34 INFO - Initialising browser for kraken test... 20:35:34 INFO - TEST-INFO | started process 3719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9v2Oai/profile http://localhost:42727/getInfo.html) 20:35:38 INFO - PROCESS | 3719 | __metrics Screen width/height:1600/1200 20:35:38 INFO - PROCESS | 3719 | colorDepth:24 20:35:38 INFO - PROCESS | 3719 | Browser inner width/height: 1024/697 20:35:38 INFO - PROCESS | 3719 | __metrics 20:35:38 INFO - PROCESS | 3719 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:35:38 INFO - PROCESS | 3719 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:35:39 INFO - PROCESS | 3719 | console.error: PushService: 20:35:39 INFO - PROCESS | 3719 | stateChangeProcessEnqueue: Error transitioning state 20:35:39 INFO - PROCESS | 3719 | UnknownError 20:35:40 INFO - TEST-INFO | 3719: exit 0 20:35:40 INFO - Browser initialized. 20:35:40 INFO - Running cycle 1/1 for kraken test... 20:35:40 INFO - TEST-INFO | started process 3807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9v2Oai/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:52 INFO - PROCESS | 3807 | RSS: Main: 172982272 20:35:52 INFO - PROCESS | 3807 | 20:35:54 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42727/tests/kraken/driver.html?testName=audio-beat-detection) 20:35:55 INFO - PROCESS | 3807 | RSS: Main: 234389504 20:35:55 INFO - PROCESS | 3807 | 20:35:58 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42727/tests/kraken/driver.html?testName=audio-dft) 20:35:59 INFO - PROCESS | 3807 | RSS: Main: 217542656 20:35:59 INFO - PROCESS | 3807 | 20:36:02 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42727/tests/kraken/driver.html?testName=audio-fft) 20:36:02 INFO - PROCESS | 3807 | RSS: Main: 298967040 20:36:02 INFO - PROCESS | 3807 | 20:36:04 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42727/tests/kraken/driver.html?testName=audio-oscillator) 20:36:05 INFO - PROCESS | 3807 | RSS: Main: 211103744 20:36:05 INFO - PROCESS | 3807 | 20:36:07 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:36:08 INFO - PROCESS | 3807 | RSS: Main: 214388736 20:36:08 INFO - PROCESS | 3807 | 20:36:11 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42727/tests/kraken/driver.html?testName=imaging-darkroom) 20:36:11 INFO - PROCESS | 3807 | RSS: Main: 252841984 20:36:11 INFO - PROCESS | 3807 | 20:36:15 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42727/tests/kraken/driver.html?testName=imaging-desaturate) 20:36:15 INFO - PROCESS | 3807 | RSS: Main: 253132800 20:36:15 INFO - PROCESS | 3807 | 20:36:18 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42727/tests/kraken/driver.html?testName=json-parse-financial) 20:36:19 INFO - PROCESS | 3807 | RSS: Main: 251703296 20:36:19 INFO - PROCESS | 3807 | 20:36:20 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:36:21 INFO - PROCESS | 3807 | RSS: Main: 214306816 20:36:21 INFO - PROCESS | 3807 | 20:36:22 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42727/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:36:23 INFO - PROCESS | 3807 | RSS: Main: 221642752 20:36:23 INFO - PROCESS | 3807 | 20:36:25 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:36:26 INFO - PROCESS | 3807 | RSS: Main: 230957056 20:36:26 INFO - PROCESS | 3807 | 20:36:29 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:36:29 INFO - PROCESS | 3807 | RSS: Main: 238915584 20:36:29 INFO - PROCESS | 3807 | 20:36:32 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:36:33 INFO - PROCESS | 3807 | RSS: Main: 236650496 20:36:33 INFO - PROCESS | 3807 | 20:36:34 INFO - PROCESS | 3807 | Cycle 1(1): loaded http://localhost:42727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42727/tests/kraken/driver.html?testName=ai-astar) 20:36:35 INFO - PROCESS | 3807 | RSS: Main: 287899648 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | __start_tp_report 20:36:35 INFO - PROCESS | 3807 | _x_x_mozilla_page_load 20:36:35 INFO - PROCESS | 3807 | _x_x_mozilla_page_load_details 20:36:35 INFO - PROCESS | 3807 | |i|pagename|runs| 20:36:35 INFO - PROCESS | 3807 | |0;ai-astar;110;116;112;111;114;112;112;110;111;110 20:36:35 INFO - PROCESS | 3807 | |1;audio-beat-detection;160;125;125;164;127;126;124;124;144;125 20:36:35 INFO - PROCESS | 3807 | |2;audio-dft;161;160;162;160;160;162;160;160;161;162 20:36:35 INFO - PROCESS | 3807 | |3;audio-fft;75;76;74;109;77;75;77;76;92;75 20:36:35 INFO - PROCESS | 3807 | |4;audio-oscillator;84;83;112;83;84;84;97;84;84;101 20:36:35 INFO - PROCESS | 3807 | |5;imaging-gaussian-blur;128;128;128;127;127;127;126;127;127;127 20:36:35 INFO - PROCESS | 3807 | |6;imaging-darkroom;145;146;146;146;146;146;145;145;146;146 20:36:35 INFO - PROCESS | 3807 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;98;95 20:36:35 INFO - PROCESS | 3807 | |8;json-parse-financial;53;52;52;52;53;55;52;54;53;56 20:36:35 INFO - PROCESS | 3807 | |9;json-stringify-tinderbox;62;63;63;63;63;62;62;63;66;63 20:36:35 INFO - PROCESS | 3807 | |10;stanford-crypto-aes;82;81;80;89;84;90;83;81;79;86 20:36:35 INFO - PROCESS | 3807 | |11;stanford-crypto-ccm;135;134;130;140;131;131;131;130;172;129 20:36:35 INFO - PROCESS | 3807 | |12;stanford-crypto-pbkdf2;173;173;174;174;172;172;176;176;173;174 20:36:35 INFO - PROCESS | 3807 | |13;stanford-crypto-sha256-iterative;66;64;64;65;65;70;64;64;63;63 20:36:35 INFO - PROCESS | 3807 | __end_tp_report 20:36:35 INFO - PROCESS | 3807 | __start_cc_report 20:36:35 INFO - PROCESS | 3807 | _x_x_mozilla_cycle_collect,1691 20:36:35 INFO - PROCESS | 3807 | __end_cc_report 20:36:35 INFO - PROCESS | 3807 | __startTimestamp1481344595216__endTimestamp 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | ------- Summary: start ------- 20:36:35 INFO - PROCESS | 3807 | Number of tests: 14 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.93 (1.7%) stddev-sans-first:1.94 20:36:35 INFO - PROCESS | 3807 | Values: 110.0 116.0 112.0 111.0 114.0 112.0 112.0 110.0 111.0 110.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:126.50 stddev:15.74 (12.4%) stddev-sans-first:13.70 20:36:35 INFO - PROCESS | 3807 | Values: 160.0 125.0 125.0 164.0 127.0 126.0 124.0 124.0 144.0 125.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 20:36:35 INFO - PROCESS | 3807 | Values: 161.0 160.0 162.0 160.0 160.0 162.0 160.0 160.0 161.0 162.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:11.27 (14.8%) stddev-sans-first:11.77 20:36:35 INFO - PROCESS | 3807 | Values: 75.0 76.0 74.0 109.0 77.0 75.0 77.0 76.0 92.0 75.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:84.00 stddev:10.17 (12.1%) stddev-sans-first:10.58 20:36:35 INFO - PROCESS | 3807 | Values: 84.0 83.0 112.0 83.0 84.0 84.0 97.0 84.0 84.0 101.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#5] imaging-gaussian-blur Cycles:10 Average:127.20 Median:127.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 20:36:35 INFO - PROCESS | 3807 | Values: 128.0 128.0 128.0 127.0 127.0 127.0 126.0 127.0 127.0 127.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:36:35 INFO - PROCESS | 3807 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 20:36:35 INFO - PROCESS | 3807 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 98.0 95.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.40 (2.6%) stddev-sans-first:1.48 20:36:35 INFO - PROCESS | 3807 | Values: 53.0 52.0 52.0 52.0 53.0 55.0 52.0 54.0 53.0 56.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:1.15 (1.8%) stddev-sans-first:1.17 20:36:35 INFO - PROCESS | 3807 | Values: 62.0 63.0 63.0 63.0 63.0 62.0 62.0 63.0 66.0 63.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:3.75 (4.5%) stddev-sans-first:3.94 20:36:35 INFO - PROCESS | 3807 | Values: 82.0 81.0 80.0 89.0 84.0 90.0 83.0 81.0 79.0 86.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:132.50 stddev:12.96 (9.8%) stddev-sans-first:13.74 20:36:35 INFO - PROCESS | 3807 | Values: 135.0 134.0 130.0 140.0 131.0 131.0 131.0 130.0 172.0 129.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.00 stddev:1.42 (0.8%) stddev-sans-first:1.48 20:36:35 INFO - PROCESS | 3807 | Values: 173.0 173.0 174.0 174.0 172.0 172.0 176.0 176.0 173.0 174.0 20:36:35 INFO - PROCESS | 3807 | 20:36:35 INFO - PROCESS | 3807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.50 stddev:2.04 (3.2%) stddev-sans-first:2.12 20:36:35 INFO - PROCESS | 3807 | Values: 66.0 64.0 64.0 65.0 65.0 70.0 64.0 64.0 63.0 63.0 20:36:35 INFO - PROCESS | 3807 | -------- Summary: end -------- 20:36:35 INFO - PROCESS | 3807 | 20:36:36 INFO - TEST-INFO | 3807: exit 0 20:36:36 INFO - TEST-OK | kraken | took 62381ms 20:36:36 INFO - SUITE-END | took 1183s 20:36:36 INFO - Completed test suite (00:19:43) 20:36:36 INFO - javascript benchmark 20:36:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3184.5064015077664, 3232.272738633806, 3238.5627940228064, 3259.7718159728815, 3294.7034766870975, 5127.487251274871, 5191.844244672666, 5255.054090263756, 5352.9197062044, 5356.223347614594, 5218.0, 5231.947680523193, 5233.581313494921, 5234.371875374951, 5239.921401178985, 4750.548697873696, 4773.331733557287, 4779.761011949406, 4797.424309082898, 4809.615230781529, 4887.218045112782, 4891.6331275154325, 4906.043321552299, 4919.803207871681, 4926.852194434173, 4797.18447863864, 4850.248211527219, 4852.8544143675745, 4855.077535268288, 4917.901641967159, 4904.803807847682, 4906.779194936236, 4925.162722337212, 4926.0, 4969.925451118236, 4740.312654665088, 4740.786664600101, 4782.760861956888, 4843.982763619644, 4885.56029957302, 5161.7161056141895, 5208.427073021964, 5211.270422140903, 5230.529252367305, 5285.68285902847, 5526.806561770319, 5574.386817450078, 5577.358603760579, 5581.107022876361, 5648.519875810561, 5517.531009864167, 5633.380328163898, 5638.154276858504, 5647.181158731961, 5654.773809047633, 5344.331958505187, 5354.785808567653, 5381.9461805382225, 5395.568354531667, 5405.243265942771, 5809.82570522885, 5810.099434587646, 5820.70896455184, 5821.563382746311, 5824.621399609012, 5413.2692086568595, 5511.476409741068, 5598.888022239533, 5601.467860553241, 5613.101903695389, 5602.85992850182, 5611.3266408031295, 5618.4662457066515, 5621.156826476062, 5681.971590142023, 5552.056150454352, 5595.8880822384135, 5602.215689803431, 5602.747876345574, 5613.46672066153, 5387.3804512481565, 5597.244372009808, 5599.552035837123, 5608.971955140199, 5617.129344951539, 4235.23765722173, 4274.850380236739, 4288.142371525707, 4288.50682171548, 4289.335153051282, 3923.0780766519847, 3926.0, 3944.15200731844, 3948.249832531867, 3956.584558621361, 5209.166533354645, 5212.765425555859, 5222.582193424517, 5222.817201397933, 5224.190250511177, 5518.089515230023, 5519.227308176858, 5522.641028333145, 5527.060399732055, 5527.53015993645, 5206.140986737221, 5262.947370526323, 5268.552173065255, 5271.288376069181, 5273.894522109536, 4824.782884770194, 4830.8309209178215, 4830.95169048305, 4831.396075490564, 4831.855044348676, 5707.972564938268, 5715.485606295453, 5728.169415434739, 5786.450287222707, 5792.420757924174, 5571.0807716726285, 5576.553875690016, 5577.832665020056, 5579.721013949367, 5582.33012038558, 5623.999999999836, 5650.943490565041, 5762.481376676119, 5773.393793651606, 5850.473457388855, 5575.776968921197, 5577.721113944205, 5590.161475778666, 5621.297337832771, 5627.718614069198, 5621.325440947113, 5653.830385088454, 5657.0, 5661.980843448219, 5663.830085097454, 5393.110136827379, 5431.94077154951, 5471.37079235893, 5523.917141242804, 5526.751296191601, 5474.698891561003, 5511.448855114617, 5523.834284971457, 5529.889402211853, 5561.610687252015, 5491.450854914477, 5501.724913754377, 5504.697241651747, 5509.393966663583, 5518.255035570307, 5428.294321738149, 5468.261784659179, 5543.3902270751, 5551.056320425457, 5611.775528978795, 5343.385510666323, 5373.194020896741, 5377.435369286169, 5381.623286369917, 5433.918491222714], "value": 5199.091116030422, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.2091388400703, 551.253052114385, 562.7945799783078, 573.546897950619, 574.5174053794811, 30658.0, 34039.319213615716, 34269.65730342696, 34357.31285374291, 34361.140971475725, 34119.0, 35005.0, 39885.60114398855, 41968.37047444283, 42065.78967105168, 8592.183742544465, 8744.912550874473, 8747.606357713918, 8750.299976001936, 8751.0, 8580.099089595597, 8670.132986701343, 8683.305335573139, 8686.174813392749, 8687.652493900236, 7903.683852645887, 8117.512949223065, 8702.390832641686, 10128.544215510283, 10356.326838755494, 10280.383177009366, 10400.895991040106, 10410.11514021309, 10416.739581510446, 10421.426821524814, 10262.230332725001, 10336.89663103367, 10340.896591034143, 10355.482225888676, 10369.533370998322, 40416.0, 40567.7971610143, 40687.796561017305, 40750.79624601858, 40780.59219407827, 3502.859885604573, 3546.131197856516, 3596.8741094061843, 3937.370020796659, 3983.3029219886694, 29948.101556953327, 30689.846550767103, 30794.53808192879, 30894.536581951288, 31839.52240716391, 4134.200528044325, 4199.958000419987, 4270.466191726035, 4319.67602429819, 4333.111712099012, 213252.0, 214118.71762564816, 214242.92878535663, 214323.0, 214393.99999999843, 55632.72183639137, 55959.44040559624, 56083.719581401834, 56085.0, 56189.157162642594, 58352.0, 58921.705391472766, 59006.70496647489, 59159.0, 59182.70408648015, 15309.923450382677, 15512.0, 15544.300506477235, 15555.30001149951, 15557.922210388875, 11702.414879256003, 11748.647540573797, 11748.941255293668, 11749.412529373669, 11755.823662645067, 14935.253237338307, 16467.752983705253, 16495.587610309598, 16531.43762716781, 16601.169941502878, 4776.421281912859, 5536.7785288588, 5567.0, 5726.885462290731, 5814.360420353758, 757.8560073586001, 827.2596026556198, 828.7886588919787, 986.4081551069445, 1005.7586179317058, 30775.149643753186, 32351.676483235336, 32387.51418728721, 32406.0, 32887.0, 1042.1975079188983, 1080.8432777247256, 1133.4672703829187, 1161.1697636190165, 1198.4487135917575, 15727.844323291987, 16701.91649041747, 16798.412055577995, 16820.74768878468, 16951.237194326284, 448661.0, 451715.0, 452658.0, 452823.0, 452832.0, 55397.1690424644, 55707.442925571035, 55721.0, 55746.16380754292, 55806.44193558094, 1178.5698220149584, 1201.645514573203, 1221.969450763738, 1272.8663490333568, 1274.0826604844497, 29894.548348587, 32739.672603274616, 32869.34261314713, 32992.67007329896, 33354.97597666636, 48229.28331466948, 48855.0, 48955.75522122366, 48967.26549101838, 48994.265086024454, 353581.0, 353982.0, 355919.0, 356696.0, 358633.0, 23665.0, 25815.741842581334, 25882.223533294033, 26248.73751262463, 26286.342841429116, 39362.409563855996, 40028.399574006995, 40857.38713919353, 41099.58900410958, 43808.78095609502, 34727.0, 34885.30229395347, 35096.0, 35576.64423355733, 35931.0, 35061.12347191341, 35072.824635876656, 35353.29293414169, 35487.645123548435, 35681.82159089188, 35362.29275414529, 36191.0, 36469.0, 36484.0, 36808.81595592112, 30301.696983029888, 32936.34127317488, 32978.17554561155, 33013.0, 33198.502022470166, 25203.495930080928, 25425.49149017046, 25495.872520637276, 25585.0, 25930.740692592834], "value": 18526.488354279743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.9625189355119, 366.7927620894193, 380.1168139660673, 383.1494083135439, 406.1369589622053, 14063.367148478317, 17669.29322827087, 17726.468205953825, 18279.634407311845, 19193.424197274067, 17226.138693065328, 17315.39396121136, 17580.033098179596, 17744.378946736866, 18384.0, 4879.048585525815, 5109.642325037249, 5115.360579927509, 5117.334746482952, 5120.103981803189, 3821.5605205401316, 3992.800359982004, 5002.924956125661, 5030.647854650176, 5033.320501732274, 5453.2092846537225, 5515.889682206373, 5537.944620553803, 5547.861303467405, 5626.521745651625, 5352.785888564453, 5468.72656367184, 5515.917261241085, 5521.834344969638, 5542.11326187808, 5335.039692855285, 5347.037533244014, 5356.491133342326, 5357.678539287616, 5361.303030605996, 12312.692182695504, 18245.63157763173, 18439.631207375776, 22050.33848984533, 22226.88886555573, 2194.9561008779897, 2377.8929948152204, 2437.2810021043656, 2506.020244007232, 2624.3307956470976, 9702.563384647709, 10201.540930658064, 10249.282550221487, 10985.835212471819, 14197.78703319451, 1833.6607727570442, 1866.766654168229, 1906.6377388296319, 1909.7421848050612, 1935.94192174235, 77450.61274693647, 80859.5957020217, 81115.18884811136, 81279.18720812835, 83525.58237208775, 10480.947595261974, 10547.314424562379, 10833.079188268928, 10854.837177442345, 10858.891411085946, 14828.629284267763, 14955.476558320624, 15089.924550377178, 15100.093994360373, 15105.39578416873, 7579.885571945658, 7775.1447340792465, 7803.68785248595, 8036.83926321482, 8073.555954422563, 7374.705011799575, 7415.0, 7648.120466146464, 7672.578008209491, 7678.692852285958, 4242.642354446609, 4317.697761156752, 4501.122281155143, 4573.588377046081, 4689.390379250675, 1679.9076050817323, 1863.6459072776129, 1923.278770461077, 1935.2162374238455, 1938.2150229157214, 779.4777499075633, 875.7285241575005, 958.166395236149, 990.4206039466992, 1005.100435110572, 17289.320155375935, 18617.441476755717, 18714.0, 18749.437516874517, 19305.9381734006, 894.8836651235298, 956.9186619137312, 959.5633986536249, 969.743018100204, 988.3328753091635, 9821.0, 10340.482975851328, 10419.322744021614, 10483.895161048444, 10514.106300964351, 400202.0, 400827.0, 402510.0, 408735.0, 418095.0, 76037.23962760413, 76901.23098769052, 78273.60863195761, 82183.5890820554, 83609.58195208985, 964.6382606522554, 1003.3578509753618, 1019.3476175247847, 1044.6030508406757, 1057.3074636113358, 16016.759748603547, 16265.756013659568, 16962.0, 17009.234584443977, 17019.48941531756, 38128.61871381251, 38720.41919371268, 39439.80280098581, 39632.0, 41260.0, 52743.47256527539, 53130.20304695355, 53175.734121329144, 55387.72306138444, 56025.71987140038, 6616.470682345497, 6623.205215373993, 7558.924410756042, 7664.080310362792, 7947.642356094106, 9573.0, 11802.350870702194, 11862.0, 12518.12373133872, 12632.2420654761, 10439.739006524898, 10511.421871797125, 10711.678649640524, 10886.78226435451, 11191.048760855418, 10327.48362581853, 10538.789224215627, 10546.472676366304, 10632.25574209798, 10738.409387483764, 10569.26015178961, 10597.0, 10716.571337146426, 11192.496337664987, 11474.885251147716, 7628.80927976805, 7670.42471814605, 7685.385169186564, 7689.0, 7957.602119894098, 10571.2600117991, 10944.124470042536, 10967.616133435291, 10986.450677466255, 11271.0], "value": 8616.049943418566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.765093457711, 1338.7322535492901, 1356.3286173344195, 1465.868071873531, 1679.9580010499744, 7034.120734908137, 7676.309132178103, 7950.880736788953, 7965.522068675884, 7966.044074711028, 7691.923080769191, 7829.17793631669, 7841.372690184786, 8008.0, 8035.075966263881, 1922.5482011727233, 1981.276833955603, 2136.0601335412407, 2169.4467910682833, 2172.1528603844436, 2101.831853451728, 2124.5538436928186, 2131.3073251193423, 2138.2943628602525, 2158.686990386393, 2060.9896950515304, 2090.770015298316, 2099.496120930973, 2100.28590279305, 2165.8050775430206, 2127.7446706395176, 2144.8176904963098, 2145.0668959002883, 2145.3671167005773, 2145.452909508081, 2103.1272022110807, 2155.6766485027215, 2160.91356345746, 2168.056895250571, 2173.4240426286888, 7913.0, 8080.71717489885, 8094.554799486026, 8105.797355066112, 8120.147384524658, 4822.107910036654, 4955.0833095877015, 4970.925436118461, 4975.328330675348, 4977.651564390494, 3065.662777094518, 3235.2558911450265, 3254.9511757323658, 3268.477043673001, 3277.8197199154038, 1003.7942221844577, 1065.6696424108475, 1084.4577711144427, 1093.6718984304678, 1103.6082190822224, 10761.62334318303, 11051.392173430539, 11056.502457389437, 11066.336019838835, 11157.72105697364, 4316.762578058237, 4330.155619654137, 4337.284348082531, 4368.322909948963, 4410.25025745624, 9509.476978766095, 9516.23870090391, 9519.666811661697, 9520.619175232912, 9531.094546018117, 4834.0, 4922.8769280768265, 4934.407871055425, 4937.136001199776, 4942.827001054946, 3902.102516421239, 4150.771707556113, 4539.046800172001, 4555.681102322806, 4562.84030058953, 3585.6952159066773, 3637.3452778500123, 3668.0646435158865, 3674.0998455378067, 3747.9625203747614, 1153.6366044695894, 1174.8179032250016, 1189.9881001190051, 1192.761447710444, 1196.5692350753895, 819.8975128108987, 843.8649816029406, 858.7810108422437, 859.1365677494078, 880.7489865388334, 4995.550400463903, 5095.210242412432, 5113.795448182031, 5131.153359695683, 5307.655002424907, 359.40339037198123, 363.3895056305432, 369.7171663677289, 370.829418467508, 372.3818461354139, 3364.848581813775, 3444.913877153091, 3456.0668619472603, 3469.2367679110557, 3520.612732599412, 9235.353525253167, 9799.216062714966, 9803.607855685836, 9823.115919567274, 9823.557939892722, 9270.860937085949, 9785.510724463891, 9788.168005719452, 9797.853032204523, 9801.11789938909, 7062.258462861429, 7523.172451030382, 7539.246075392527, 7540.321371076519, 7557.848843023219, 5157.123289040797, 5192.922106168335, 5233.738313084406, 5235.136202526541, 5472.151816468454, 8871.556422178994, 9017.413868098552, 9019.188273055457, 9045.954770226106, 9113.134252246025, 9045.547722613712, 9191.494467804336, 9274.44353338802, 9381.0, 9391.906080939376, 6324.905126423016, 6371.426571608577, 6380.234371875405, 7002.7899163025195, 7227.674754636159, 6996.580205187705, 7150.249223831423, 7465.216152304147, 7602.049743782028, 7628.313451789366, 6753.425958793361, 6901.309869013058, 6941.444684425335, 6950.895736564057, 7003.719851205895, 6602.867942641216, 6614.5039122067, 6693.966530167513, 6719.798406047827, 6833.45332373399, 5860.2967643883, 5882.970585147218, 5886.20536227621, 5903.144044113666, 5925.111233315038, 4350.042990542076, 4451.443569553806, 4452.4211852458975, 4464.687471876938, 4581.427321584802, 4358.4769827620885, 4450.532694067077, 4494.70784399013, 4603.447586289667, 4678.742669153229], "value": 4082.8883406170353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.1983895349708, 367.32779014403644, 370.57384008390363, 372.4729507746538, 380.6897378636411, 5053.2925390445325, 5056.710538812597, 5091.912315950461, 5126.5642420394315, 5135.640505164631, 4991.226359914219, 4994.825181118662, 5041.143005689032, 5070.847874563759, 5133.9229911551265, 3957.643812056914, 4119.57874533287, 4144.357624568197, 4145.129522800215, 4166.541680415152, 4049.5343035550995, 4082.3468245080794, 4152.2733521633745, 4167.4790651168605, 4172.374143878412, 4127.236461254663, 4134.855280065199, 4136.544980052192, 4141.295979683461, 4151.854685086023, 4141.730787498833, 4162.313218318974, 4163.292240319138, 4167.958320416802, 4170.77060761658, 3584.5877724061806, 3718.7954662493553, 3736.1406876418305, 3746.1571146492092, 3752.0, 5019.749012549394, 5023.2214006829, 5057.772400241998, 5064.797408103672, 5073.518015788494, 4739.137602853663, 4757.311154540158, 4758.428988521365, 4771.23660214364, 4776.116418462596, 5295.087701764014, 5389.110796718537, 5419.864503387407, 5421.376541697716, 5459.727013649342, 4116.735795312567, 4120.381942708617, 4121.990112422475, 4140.254754144253, 4140.91718165635, 5576.944230557683, 5596.0, 5643.0, 5649.4633009864, 5664.348599911022, 4134.64855487281, 4145.66834653227, 4182.665386769051, 4192.538820729717, 4248.915021699549, 4234.87295381139, 4238.724482908601, 4245.726282115353, 4248.553901840262, 4253.170631726845, 4729.36153619257, 4732.100900828831, 4747.596454301423, 4757.5718185363485, 4758.547937945889, 5213.0, 5339.385970613352, 5387.730613469311, 5387.895481426298, 5437.700926449004, 1406.2476575032308, 1408.3521580073077, 1417.433026789272, 1419.9219042952736, 1419.9574012779426, 996.7807082441851, 1024.329064462778, 1030.6650338639972, 1033.421284080902, 1034.9805441639978, 5058.822941197041, 5094.872628184251, 5095.159298715745, 5118.948810511922, 5134.5635620972635, 5345.893082138413, 5390.730463476889, 5412.323459567554, 5417.702026388508, 5419.268398766195, 4942.5304596063315, 5063.8480845574695, 5092.541671249532, 5133.6919784813035, 5136.614753893473, 2842.91969051759, 2845.701201373867, 2860.4136152089186, 2871.3539453623184, 2881.6109825173753, 5525.944740552623, 5533.446655334435, 5554.722563748844, 5562.415946325577, 5589.273394458694, 5315.973420132952, 5457.590680698963, 5646.124850648156, 5647.407022262603, 5648.5763567731765, 5735.1684005818925, 5740.799072032542, 5763.596548241667, 5784.7107644618445, 5802.796902108406, 5472.425395333433, 5517.36550296721, 5578.972105139448, 5636.830895073154, 5640.633358831663, 5510.752016159202, 5532.778688852401, 5539.639923405127, 5558.749856256559, 5562.249096371938, 5554.1946417770005, 5758.280214973129, 5765.423457654201, 5799.768009279582, 5814.651120932757, 3840.30874442603, 3858.1897801462005, 3929.92140157201, 3941.4876066111224, 3963.780283041506, 5514.503694667499, 5517.172424136412, 5549.694766787866, 5554.222408862844, 5601.691906945157, 5306.469353064663, 5383.600263931327, 5438.483344082306, 5448.346198456052, 5452.26394436746, 5355.196720491957, 5371.785128594813, 5384.300040994645, 5384.569234461155, 5397.541208997279, 5372.328458942632, 5382.865428364165, 5384.730763461733, 5390.51485366319, 5406.486383793534, 5174.97412512935, 5401.648892821954, 5413.9427017733005, 5444.1017232156255, 5444.482774136451, 5314.697899014766, 5317.8404647860625, 5325.946740532545, 5337.599680023936, 5337.6797392156595], "value": 4188.738905796908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.3257138290007, 725.9455540834438, 747.756978981831, 793.6745934166993, 798.2895223251304, 15450.922745386271, 16305.103219322933, 16342.75485867713, 16355.182240887967, 16356.836431635695, 14977.176255305954, 15022.924885375585, 15130.697386052272, 15131.092134471939, 15138.0, 646.0309535696455, 663.863907898882, 747.4879707400448, 760.4562737642584, 775.0312109862672, 767.6814122139306, 770.8304173081913, 772.3319328780592, 774.5855967057626, 774.6978678315434, 822.4325215601216, 823.9217274358926, 824.2499325613693, 824.8102936324649, 825.4345773145385, 811.7970507373157, 817.1868990354576, 817.2767101115496, 818.378032695153, 818.5007145641155, 499.65274134476556, 507.5685667182902, 577.3995045153035, 593.2673148661399, 595.312414161644, 13822.447102115902, 13845.16928984254, 13869.722605547933, 13871.306434678225, 13876.58370248884, 13484.0, 13799.862001379957, 13806.0, 13928.791068133985, 13938.303084845717, 12384.938075309656, 12423.44094515749, 12469.314187719672, 12683.74632507354, 12870.22778633285, 4188.706790524665, 4190.0, 4274.914501709979, 4290.0, 4296.183725092223, 75744.31917606201, 79482.0, 79811.0, 80769.59615201945, 82282.0, 10191.286609937382, 10272.734496046925, 10321.884013777159, 10368.429736364422, 10398.0, 18997.62004759897, 19465.80534194668, 19813.0, 20698.896505517376, 20900.37298881036, 7987.32107770846, 8100.270975612223, 8257.38069644779, 8326.958365208257, 8366.37252206087, 4220.240356735817, 4340.088581397878, 4436.245838207513, 4441.911161776747, 4530.70550414222, 3279.950800737991, 3321.1697075731067, 3381.932361352759, 3388.796672199676, 3421.863125474953, 580.8054301808942, 585.88868115058, 594.93753155918, 597.5667640960269, 605.3764622438895, 542.3843937131305, 602.5926423936402, 611.0589691874463, 656.7734131724548, 670.3631550027493, 7231.45764067697, 9186.40288381253, 9709.320347575744, 9891.308136205927, 9999.550155196446, 645.4865367126649, 653.3270731146927, 672.1989232919871, 685.5817951049855, 693.5145398221265, 4240.801606409632, 4531.478879928784, 4566.5337173720545, 4588.564086411786, 4639.791209395586, 73002.0, 74991.0, 75289.0, 76392.0, 77544.0, 63020.68489657614, 65668.77299910928, 67539.66230168915, 69409.65295173593, 69546.65226673834, 52931.735341323045, 54272.45727542674, 55260.72369638126, 57791.71104144453, 59508.0, 8707.608157633049, 8813.383063185773, 9058.637654493747, 9382.67160649374, 9511.239100872051, 39371.409428858016, 40183.3972490407, 41039.589604103574, 41520.377194341505, 42681.57318426776, 40652.39021414622, 41821.0, 52289.0, 54116.72941635267, 56605.433945660014, 12063.276203427822, 12394.81407778902, 12475.0, 12625.305608191638, 12773.23360598367, 12864.356782160667, 12886.574823746369, 13035.608931732064, 13172.0, 13384.130031547918, 11668.299902005907, 12057.216280942062, 12733.55432559856, 12884.420201090787, 13206.537771177962, 11961.461734221806, 12046.879531204575, 12393.256404615751, 12508.249505029728, 12899.613011609667, 11864.584739534075, 11982.70043248891, 12251.08116891219, 12410.5656302029, 12525.436355363849, 10428.478576071318, 10494.737631559272, 10636.787264254517, 10641.840372394576, 10677.412742299248, 9970.750731231486, 10007.699769006942, 10007.849882251918, 10029.548670309707, 10069.647562335284], "value": 6868.745840041852, "unit": "score"}], "name": "dromaeo_css", "value": 6784.23041568663, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 112.0, 111.0, 114.0, 112.0, 112.0, 110.0, 111.0, 110.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 125.0, 164.0, 127.0, 126.0, 124.0, 124.0, 144.0, 125.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 160.0, 162.0, 160.0, 160.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 109.0, 77.0, 75.0, 77.0, 76.0, 92.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 83.0, 84.0, 84.0, 97.0, 84.0, 84.0, 101.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 128.0, 127.0, 127.0, 127.0, 126.0, 127.0, 127.0, 127.0], "value": 127.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 98.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 53.0, 55.0, 52.0, 54.0, 53.0, 56.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 66.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 80.0, 89.0, 84.0, 90.0, 83.0, 81.0, 79.0, 86.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 130.0, 140.0, 131.0, 131.0, 131.0, 130.0, 172.0, 129.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 174.0, 174.0, 172.0, 172.0, 176.0, 176.0, 173.0, 174.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 65.0, 65.0, 70.0, 64.0, 64.0, 63.0, 63.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1520.1000000000001, "alertThreshold": 2.0}]} 20:36:36 INFO - Return code: 0 20:36:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:36:37 INFO - # TBPL SUCCESS # 20:36:37 INFO - Running post-action listener: _resource_record_post_action 20:36:37 INFO - [mozharness: 2016-12-10 04:36:37.016481Z] Finished run-tests step (success) 20:36:37 INFO - Running post-run listener: _resource_record_post_run 20:36:37 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 9711616; Write bytes: 416030720; Read time: 1876; Write time: 347636 20:36:37 INFO - TinderboxPrint: CPU usage
13.2% 20:36:37 INFO - TinderboxPrint: I/O read bytes / time
9,711,616 / 1,876 20:36:37 INFO - TinderboxPrint: I/O write bytes / time
416,030,720 / 347,636 20:36:37 INFO - TinderboxPrint: CPU idle
8,319.6 (86.8%) 20:36:37 INFO - TinderboxPrint: CPU user
1,207.0 (12.6%) 20:36:37 INFO - TinderboxPrint: Swap in / out
0 / 0 20:36:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98435072; Read time: 20; Write time: 93740 20:36:37 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5840896; Write bytes: 317595648; Read time: 1620; Write time: 253896 20:36:37 INFO - Running post-run listener: _upload_blobber_files 20:36:37 INFO - Blob upload gear active. 20:36:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:36:37 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 20:36:37 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:36:37 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:36:38 INFO - (blobuploader) - INFO - Open directory for files ... 20:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:41 INFO - (blobuploader) - INFO - Done attempting. 20:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:36:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:42 INFO - (blobuploader) - INFO - Done attempting. 20:36:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:36:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:36:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:43 INFO - (blobuploader) - INFO - Done attempting. 20:36:43 INFO - (blobuploader) - INFO - Iteration through files over. 20:36:43 INFO - Return code: 0 20:36:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:36:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:36:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85321a420edd602c552f161c88202fe2b61b04970cf69f537d351899a3a9fcaa126e0bdb9c5578f70c701fbceacfad886b5ccc4f76fe5b3b3757c826547679d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e11e0f52456453282d5f95223adc87411b2d4b1f01635c6784ec9c7a42d861e530286a4ebafc58cb8f74ceda0f5374fcf4ed270008a039a204853af4f67e1d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fca0a3f4d09b06e6c9c184e4b7af4c6c0d24258a387585b8b648c75dfc5318a7aae2e944d02210b3e6e2dc78b21d816da32ced42926418f7258715ff22dd6f60"} 20:36:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:36:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:36:43 INFO - Contents: 20:36:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85321a420edd602c552f161c88202fe2b61b04970cf69f537d351899a3a9fcaa126e0bdb9c5578f70c701fbceacfad886b5ccc4f76fe5b3b3757c826547679d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e11e0f52456453282d5f95223adc87411b2d4b1f01635c6784ec9c7a42d861e530286a4ebafc58cb8f74ceda0f5374fcf4ed270008a039a204853af4f67e1d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fca0a3f4d09b06e6c9c184e4b7af4c6c0d24258a387585b8b648c75dfc5318a7aae2e944d02210b3e6e2dc78b21d816da32ced42926418f7258715ff22dd6f60"} 20:36:43 INFO - Running post-run listener: copy_logs_to_upload_dir 20:36:43 INFO - Copying logs to upload dir... 20:36:43 INFO - mkdir: /builds/slave/test/build/upload/logs 20:36:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.808967 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-09 20:36:43.319998) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 20:36:43.323961) ========= 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=1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779 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-Inbound/sha512/85321a420edd602c552f161c88202fe2b61b04970cf69f537d351899a3a9fcaa126e0bdb9c5578f70c701fbceacfad886b5ccc4f76fe5b3b3757c826547679d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e11e0f52456453282d5f95223adc87411b2d4b1f01635c6784ec9c7a42d861e530286a4ebafc58cb8f74ceda0f5374fcf4ed270008a039a204853af4f67e1d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fca0a3f4d09b06e6c9c184e4b7af4c6c0d24258a387585b8b648c75dfc5318a7aae2e944d02210b3e6e2dc78b21d816da32ced42926418f7258715ff22dd6f60"} build_url:https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/VavSM2RDTQ6WNZatjNx0pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85321a420edd602c552f161c88202fe2b61b04970cf69f537d351899a3a9fcaa126e0bdb9c5578f70c701fbceacfad886b5ccc4f76fe5b3b3757c826547679d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e11e0f52456453282d5f95223adc87411b2d4b1f01635c6784ec9c7a42d861e530286a4ebafc58cb8f74ceda0f5374fcf4ed270008a039a204853af4f67e1d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fca0a3f4d09b06e6c9c184e4b7af4c6c0d24258a387585b8b648c75dfc5318a7aae2e944d02210b3e6e2dc78b21d816da32ced42926418f7258715ff22dd6f60"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 20:36:43.349632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 20:36:43.349967) ========= 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=1f5564757af27664ca02d71f000001b0-1481342411.202310-1484158779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 20:36:43.433745) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 20:36:43.434064) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 20:36:43.434351) ========= ========= Total master_lag: 0.17 =========