builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1484015889.22 results: success (0) buildid: 20170109165508 builduid: 31c1edda307f41ee95db2a6b86426d0c revision: ce55e4d276031458f0730d481acff05d7c797038 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:09.218972) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:09.219443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:09.219716) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:09.235181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:09.235549) ========= 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=af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 18:38:09-- 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.3M=0s 2017-01-09 18:38:09 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:09.386042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:09.386367) ========= 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=af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013791 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:09.436568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:09.436918) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ce55e4d276031458f0730d481acff05d7c797038 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ce55e4d276031458f0730d481acff05d7c797038 --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=af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 18:38:09,813 truncating revision to first 12 chars 2017-01-09 18:38:09,814 Setting DEBUG logging. 2017-01-09 18:38:09,814 attempt 1/10 2017-01-09 18:38:09,814 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ce55e4d27603?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 18:38:10,123 unpacking tar archive at: mozilla-beta-ce55e4d27603/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:10.093939) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:10.094264) ========= script_repo_revision: ce55e4d276031458f0730d481acff05d7c797038 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:10.094706) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:10.094965) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 18:38:10.108040) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-01-09 18:38:10.108336) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:38:10 INFO - MultiFileLogger online at 20170109 18:38:10 in /builds/slave/test 18:38:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:38:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:38:10 INFO - {'append_to_log': False, 18:38:10 INFO - 'base_work_dir': '/builds/slave/test', 18:38:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:38:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:38:10 INFO - 'branch': 'Mozilla-Beta', 18:38:10 INFO - 'buildbot_json_path': 'buildprops.json', 18:38:10 INFO - 'config_files': ('talos/linux_config.py',), 18:38:10 INFO - 'default_actions': ('clobber', 18:38:10 INFO - 'read-buildbot-config', 18:38:10 INFO - 'download-and-extract', 18:38:10 INFO - 'populate-webroot', 18:38:10 INFO - 'create-virtualenv', 18:38:10 INFO - 'install', 18:38:10 INFO - 'run-tests'), 18:38:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:38:10 INFO - 'download_minidump_stackwalk': True, 18:38:10 INFO - 'download_symbols': 'ondemand', 18:38:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:38:10 INFO - 'tooltool.py': '/tools/tooltool.py', 18:38:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:38:10 INFO - '/tools/misc-python/virtualenv.py')}, 18:38:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:38:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:38:10 INFO - 'installer_path': 'installer.exe', 18:38:10 INFO - 'log_level': 'info', 18:38:10 INFO - 'log_name': 'talos', 18:38:10 INFO - 'log_to_console': True, 18:38:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:38:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:38:10 INFO - 'opt_config_files': (), 18:38:10 INFO - 'pip_index': False, 18:38:10 INFO - 'sps_profile': False, 18:38:10 INFO - 'sps_profile_interval': 0, 18:38:10 INFO - 'suite': 'dromaeojs', 18:38:10 INFO - 'system_bits': '32', 18:38:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:38:10 INFO - 'title': 'talos-linux64-ix-020', 18:38:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:38:10 INFO - 'use_talos_json': True, 18:38:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:38:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:38:10 INFO - 'work_dir': 'build'} 18:38:10 INFO - [mozharness: 2017-01-10 02:38:10.584372Z] Running clobber step. 18:38:10 INFO - Running pre-action listener: _resource_record_pre_action 18:38:10 INFO - Running main action method: clobber 18:38:10 INFO - rmtree: /builds/slave/test/build 18:38:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:38:11 INFO - Running post-action listener: _resource_record_post_action 18:38:11 INFO - [mozharness: 2017-01-10 02:38:11.565963Z] Finished clobber step (success) 18:38:11 INFO - [mozharness: 2017-01-10 02:38:11.566063Z] Running read-buildbot-config step. 18:38:11 INFO - Running pre-action listener: _resource_record_pre_action 18:38:11 INFO - Running main action method: read_buildbot_config 18:38:11 INFO - Using buildbot properties: 18:38:11 INFO - { 18:38:11 INFO - "project": "", 18:38:11 INFO - "product": "firefox", 18:38:11 INFO - "script_repo_revision": "production", 18:38:11 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 18:38:11 INFO - "repository": "", 18:38:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 18:38:11 INFO - "buildid": "20170109165508", 18:38:11 INFO - "pgo_build": "True", 18:38:11 INFO - "basedir": "/builds/slave/test", 18:38:11 INFO - "buildnumber": 83, 18:38:11 INFO - "slavename": "talos-linux64-ix-020", 18:38:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:38:11 INFO - "platform": "ubuntu64_hw", 18:38:11 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:38:11 INFO - "branch": "mozilla-beta", 18:38:11 INFO - "repo_path": "releases/mozilla-beta", 18:38:11 INFO - "revision": "ce55e4d276031458f0730d481acff05d7c797038", 18:38:11 INFO - "stage_platform": "linux64-pgo", 18:38:11 INFO - "builduid": "31c1edda307f41ee95db2a6b86426d0c", 18:38:11 INFO - "slavebuilddir": "test" 18:38:11 INFO - } 18:38:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 18:38:11 INFO - Running post-action listener: _resource_record_post_action 18:38:11 INFO - [mozharness: 2017-01-10 02:38:11.568516Z] Finished read-buildbot-config step (success) 18:38:11 INFO - [mozharness: 2017-01-10 02:38:11.568605Z] Running download-and-extract step. 18:38:11 INFO - Running pre-action listener: _resource_record_pre_action 18:38:11 INFO - Running main action method: download_and_extract 18:38:11 INFO - mkdir: /builds/slave/test/build/tests 18:38:11 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')]} 18:38:11 INFO - trying https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 18:38:11 INFO - Downloading https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 18:38:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:38:12 INFO - Downloaded 1327 bytes. 18:38:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 18:38:12 INFO - Using the following test package requirements: 18:38:12 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 18:38:12 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:38:12 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:38:12 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:38:12 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 18:38:12 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:38:12 INFO - u'jsshell-linux-x86_64.zip'], 18:38:12 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:38:12 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:38:12 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 18:38:12 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:38:12 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 18:38:12 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:38:12 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 18:38:12 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:38:12 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:38:12 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 18:38:12 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:38:12 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:38:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 18:38:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:38:12 INFO - Fetch https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 18:38:12 INFO - Expected file size: 21971041 18:38:17 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:38:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 18:38:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:38:17 INFO - Fetch https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 18:38:17 INFO - Expected file size: 21971041 18:38:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 18:38:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:38:22 INFO - Fetch https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 18:38:22 INFO - Expected file size: 14414089 18:38:23 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')]} 18:38:23 INFO - trying https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:38:23 INFO - Downloading https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:38:25 INFO - Downloaded 57032269 bytes. 18:38:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:38:25 INFO - mkdir: /builds/slave/test/properties 18:38:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:38:25 INFO - Writing to file /builds/slave/test/properties/build_url 18:38:25 INFO - Contents: 18:38:25 INFO - build_url:https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 18:38:26 INFO - Running post-action listener: _resource_record_post_action 18:38:26 INFO - Running post-action listener: set_extra_try_arguments 18:38:26 INFO - [mozharness: 2017-01-10 02:38:26.370558Z] Finished download-and-extract step (success) 18:38:26 INFO - [mozharness: 2017-01-10 02:38:26.370787Z] Running populate-webroot step. 18:38:26 INFO - Running pre-action listener: _resource_record_pre_action 18:38:26 INFO - Running main action method: populate_webroot 18:38:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:38:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:38:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:38:26 INFO - '--tppagecycles', 18:38:26 INFO - '7'], 18:38:26 INFO - 'tests': ['tsvgm']}}, 18:38:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:38:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:38:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:38:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:38:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:26 INFO - 'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:26 INFO - 'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['damp', 'tps']}, 18:38:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:26 INFO - 'tests': ['damp', 'tps']}, 18:38:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['dromaeo_dom']}, 18:38:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:38:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['basic_compositor_video']}, 18:38:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:38:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['a11yr', 18:38:26 INFO - 'ts_paint', 18:38:26 INFO - 'tpaint', 18:38:26 INFO - 'sessionrestore', 18:38:26 INFO - 'sessionrestore_no_auto_restore', 18:38:26 INFO - 'tabpaint']}, 18:38:26 INFO - 'other-e10s': {'tests': ['a11yr', 18:38:26 INFO - 'ts_paint', 18:38:26 INFO - 'tpaint', 18:38:26 INFO - 'sessionrestore', 18:38:26 INFO - 'sessionrestore_no_auto_restore', 18:38:26 INFO - 'tabpaint']}, 18:38:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:38:26 INFO - 'ts_paint', 18:38:26 INFO - 'tpaint', 18:38:26 INFO - 'sessionrestore', 18:38:26 INFO - 'sessionrestore_no_auto_restore', 18:38:26 INFO - 'tabpaint']}, 18:38:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:38:26 INFO - 'ts_paint', 18:38:26 INFO - 'tpaint', 18:38:26 INFO - 'sessionrestore', 18:38:26 INFO - 'sessionrestore_no_auto_restore', 18:38:26 INFO - 'tabpaint']}, 18:38:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['a11yr', 18:38:26 INFO - 'ts_paint', 18:38:26 INFO - 'tpaint', 18:38:26 INFO - 'sessionrestore', 18:38:26 INFO - 'sessionrestore_no_auto_restore', 18:38:26 INFO - 'tabpaint']}, 18:38:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['a11yr', 18:38:26 INFO - 'ts_paint', 18:38:26 INFO - 'tpaint', 18:38:26 INFO - 'sessionrestore', 18:38:26 INFO - 'sessionrestore_no_auto_restore', 18:38:26 INFO - 'tabpaint']}, 18:38:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['tsvgx', 18:38:26 INFO - 'tsvgr_opacity', 18:38:26 INFO - 'tart', 18:38:26 INFO - 'tscrollx', 18:38:26 INFO - 'cart']}, 18:38:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:38:26 INFO - 'tsvgr_opacity', 18:38:26 INFO - 'tart', 18:38:26 INFO - 'tscrollx', 18:38:26 INFO - 'cart']}, 18:38:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:26 INFO - 'talos_options': ['--disable-e10s'], 18:38:26 INFO - 'tests': ['tp5o']}, 18:38:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:26 INFO - 'tests': ['tp5o']}, 18:38:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:26 INFO - 'talos_options': ['--disable-e10s', 18:38:26 INFO - '--xperf_path', 18:38:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:26 INFO - 'tests': ['tp5n']}, 18:38:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:26 INFO - 'talos_options': ['--xperf_path', 18:38:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:26 INFO - 'tests': ['tp5n']}}, 18:38:26 INFO - 'talos.zip': {'path': '', 18:38:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:38:26 INFO - Running post-action listener: _resource_record_post_action 18:38:26 INFO - [mozharness: 2017-01-10 02:38:26.386976Z] Finished populate-webroot step (success) 18:38:26 INFO - [mozharness: 2017-01-10 02:38:26.387086Z] Running create-virtualenv step. 18:38:26 INFO - Running pre-action listener: _resource_record_pre_action 18:38:26 INFO - Running main action method: create_virtualenv 18:38:26 INFO - Creating virtualenv /builds/slave/test/build/venv 18:38:26 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 18:38:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:38:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:38:26 INFO - Using real prefix '/usr' 18:38:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:38:26 INFO - Installing distribute.............................................................................................................................................................................................done. 18:38:28 INFO - Installing pip.................done. 18:38:28 INFO - Return code: 0 18:38:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:38: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')]} 18:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38: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')]} 18:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:38:28 INFO - Using env: {'DISPLAY': ':0', 18:38:28 INFO - 'HOME': '/home/cltbld', 18:38:28 INFO - 'LANG': 'en_US.UTF-8', 18:38:28 INFO - 'LANGUAGE': 'en_US:en', 18:38:28 INFO - 'LOGNAME': 'cltbld', 18:38:28 INFO - 'MAIL': '/var/mail/cltbld', 18:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:28 INFO - 'MOZ_NO_REMOTE': '1', 18:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:28 INFO - 'NO_EM_RESTART': '1', 18:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:28 INFO - 'PWD': '/builds/slave/test', 18:38:28 INFO - 'SHELL': '/bin/bash', 18:38:28 INFO - 'SHLVL': '1', 18:38:28 INFO - 'TERM': 'linux', 18:38:28 INFO - 'TMOUT': '86400', 18:38:28 INFO - 'USER': 'cltbld', 18:38:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:28 INFO - '_': '/tools/buildbot/bin/python'} 18:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:29 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 18:38:29 INFO - Cleaning up... 18:38:29 INFO - Return code: 0 18:38:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:38:29 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')]} 18:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:29 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')]} 18:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:29 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 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:29 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 18:38:29 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 18:38:29 INFO - Using env: {'DISPLAY': ':0', 18:38:29 INFO - 'HOME': '/home/cltbld', 18:38:29 INFO - 'LANG': 'en_US.UTF-8', 18:38:29 INFO - 'LANGUAGE': 'en_US:en', 18:38:29 INFO - 'LOGNAME': 'cltbld', 18:38:29 INFO - 'MAIL': '/var/mail/cltbld', 18:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:29 INFO - 'MOZ_NO_REMOTE': '1', 18:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:29 INFO - 'NO_EM_RESTART': '1', 18:38:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:29 INFO - 'PWD': '/builds/slave/test', 18:38:29 INFO - 'SHELL': '/bin/bash', 18:38:29 INFO - 'SHLVL': '1', 18:38:29 INFO - 'TERM': 'linux', 18:38:29 INFO - 'TMOUT': '86400', 18:38:29 INFO - 'USER': 'cltbld', 18:38:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:29 INFO - '_': '/tools/buildbot/bin/python'} 18:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:29 INFO - Downloading/unpacking psutil>=3.1.1 18:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:38:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:31 INFO - Installing collected packages: psutil 18:38:31 INFO - Running setup.py install for psutil 18:38:31 INFO - building 'psutil._psutil_linux' extension 18:38:31 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 18:38:31 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 18:38:31 INFO - building 'psutil._psutil_posix' extension 18:38:31 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 18:38:31 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 18:38:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:31 INFO - Successfully installed psutil 18:38:31 INFO - Cleaning up... 18:38:32 INFO - Return code: 0 18:38:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:38:32 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')]} 18:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:32 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')]} 18:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:32 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 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:32 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 18:38:32 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 18:38:32 INFO - Using env: {'DISPLAY': ':0', 18:38:32 INFO - 'HOME': '/home/cltbld', 18:38:32 INFO - 'LANG': 'en_US.UTF-8', 18:38:32 INFO - 'LANGUAGE': 'en_US:en', 18:38:32 INFO - 'LOGNAME': 'cltbld', 18:38:32 INFO - 'MAIL': '/var/mail/cltbld', 18:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:32 INFO - 'MOZ_NO_REMOTE': '1', 18:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:32 INFO - 'NO_EM_RESTART': '1', 18:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:32 INFO - 'PWD': '/builds/slave/test', 18:38:32 INFO - 'SHELL': '/bin/bash', 18:38:32 INFO - 'SHLVL': '1', 18:38:32 INFO - 'TERM': 'linux', 18:38:32 INFO - 'TMOUT': '86400', 18:38:32 INFO - 'USER': 'cltbld', 18:38:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:32 INFO - '_': '/tools/buildbot/bin/python'} 18:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:38:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:38:34 INFO - Installing collected packages: mozsystemmonitor 18:38:34 INFO - Running setup.py install for mozsystemmonitor 18:38:34 INFO - Successfully installed mozsystemmonitor 18:38:34 INFO - Cleaning up... 18:38:34 INFO - Return code: 0 18:38:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:34 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 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:34 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 18:38:34 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 18:38:34 INFO - Using env: {'DISPLAY': ':0', 18:38:34 INFO - 'HOME': '/home/cltbld', 18:38:34 INFO - 'LANG': 'en_US.UTF-8', 18:38:34 INFO - 'LANGUAGE': 'en_US:en', 18:38:34 INFO - 'LOGNAME': 'cltbld', 18:38:34 INFO - 'MAIL': '/var/mail/cltbld', 18:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:34 INFO - 'MOZ_NO_REMOTE': '1', 18:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:34 INFO - 'NO_EM_RESTART': '1', 18:38:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:34 INFO - 'PWD': '/builds/slave/test', 18:38:34 INFO - 'SHELL': '/bin/bash', 18:38:34 INFO - 'SHLVL': '1', 18:38:34 INFO - 'TERM': 'linux', 18:38:34 INFO - 'TMOUT': '86400', 18:38:34 INFO - 'USER': 'cltbld', 18:38:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:34 INFO - '_': '/tools/buildbot/bin/python'} 18:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:34 INFO - Downloading/unpacking jsonschema==2.5.1 18:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:38:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:36 INFO - Downloading functools32-3.2.3-2.tar.gz 18:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:38:36 INFO - warning: no files found matching '*.txt' 18:38:36 INFO - no previously-included directories found matching 'build' 18:38:36 INFO - no previously-included directories found matching 'dist' 18:38:36 INFO - no previously-included directories found matching '.git*' 18:38:36 INFO - Installing collected packages: jsonschema, functools32 18:38:36 INFO - Running setup.py install for functools32 18:38:37 INFO - warning: no files found matching '*.txt' 18:38:37 INFO - no previously-included directories found matching 'build' 18:38:37 INFO - no previously-included directories found matching 'dist' 18:38:37 INFO - no previously-included directories found matching '.git*' 18:38:37 INFO - Successfully installed jsonschema functools32 18:38:37 INFO - Cleaning up... 18:38:37 INFO - Return code: 0 18:38:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:38:37 INFO - Using env: {'DISPLAY': ':0', 18:38:37 INFO - 'HOME': '/home/cltbld', 18:38:37 INFO - 'LANG': 'en_US.UTF-8', 18:38:37 INFO - 'LANGUAGE': 'en_US:en', 18:38:37 INFO - 'LOGNAME': 'cltbld', 18:38:37 INFO - 'MAIL': '/var/mail/cltbld', 18:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:37 INFO - 'MOZ_NO_REMOTE': '1', 18:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:37 INFO - 'NO_EM_RESTART': '1', 18:38:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:37 INFO - 'PWD': '/builds/slave/test', 18:38:37 INFO - 'SHELL': '/bin/bash', 18:38:37 INFO - 'SHLVL': '1', 18:38:37 INFO - 'TERM': 'linux', 18:38:37 INFO - 'TMOUT': '86400', 18:38:37 INFO - 'USER': 'cltbld', 18:38:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:37 INFO - '_': '/tools/buildbot/bin/python'} 18:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:38:37 INFO - Cleaning up... 18:38:37 INFO - Return code: 0 18:38:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:38:37 INFO - Using env: {'DISPLAY': ':0', 18:38:37 INFO - 'HOME': '/home/cltbld', 18:38:37 INFO - 'LANG': 'en_US.UTF-8', 18:38:37 INFO - 'LANGUAGE': 'en_US:en', 18:38:37 INFO - 'LOGNAME': 'cltbld', 18:38:37 INFO - 'MAIL': '/var/mail/cltbld', 18:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:37 INFO - 'MOZ_NO_REMOTE': '1', 18:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:37 INFO - 'NO_EM_RESTART': '1', 18:38:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:37 INFO - 'PWD': '/builds/slave/test', 18:38:37 INFO - 'SHELL': '/bin/bash', 18:38:37 INFO - 'SHLVL': '1', 18:38:37 INFO - 'TERM': 'linux', 18:38:37 INFO - 'TMOUT': '86400', 18:38:37 INFO - 'USER': 'cltbld', 18:38:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:37 INFO - '_': '/tools/buildbot/bin/python'} 18:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:37 INFO - Downloading/unpacking blobuploader==1.2.4 18:38:37 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 18:38:37 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 18:38:37 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 18:38:37 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 18:38:37 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 18:38:37 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 18:38:39 INFO - Downloading blobuploader-1.2.4.tar.gz 18:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:38:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:38:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:38:40 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 18:38:40 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 18:38:40 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 18:38:40 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 18:38:40 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 18:38:40 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 18:38:40 INFO - Downloading docopt-0.6.1.tar.gz 18:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:38:40 INFO - Installing collected packages: blobuploader, requests, docopt 18:38:40 INFO - Running setup.py install for blobuploader 18:38:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:38:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:38:40 INFO - Running setup.py install for requests 18:38:40 INFO - Running setup.py install for docopt 18:38:40 INFO - Successfully installed blobuploader requests docopt 18:38:40 INFO - Cleaning up... 18:38:40 INFO - Return code: 0 18:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:40 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 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:40 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 18:38:40 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 18:38:40 INFO - Using env: {'DISPLAY': ':0', 18:38:40 INFO - 'HOME': '/home/cltbld', 18:38:40 INFO - 'LANG': 'en_US.UTF-8', 18:38:40 INFO - 'LANGUAGE': 'en_US:en', 18:38:40 INFO - 'LOGNAME': 'cltbld', 18:38:40 INFO - 'MAIL': '/var/mail/cltbld', 18:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:40 INFO - 'MOZ_NO_REMOTE': '1', 18:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:40 INFO - 'NO_EM_RESTART': '1', 18:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:40 INFO - 'PWD': '/builds/slave/test', 18:38:40 INFO - 'SHELL': '/bin/bash', 18:38:40 INFO - 'SHLVL': '1', 18:38:40 INFO - 'TERM': 'linux', 18:38:40 INFO - 'TMOUT': '86400', 18:38:40 INFO - 'USER': 'cltbld', 18:38:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:40 INFO - '_': '/tools/buildbot/bin/python'} 18:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:41 INFO - Running setup.py (path:/tmp/pip-Kuvhli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:41 INFO - Running setup.py (path:/tmp/pip-fKqZAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:41 INFO - Running setup.py (path:/tmp/pip-OETl46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:41 INFO - Running setup.py (path:/tmp/pip-9scQfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:41 INFO - Running setup.py (path:/tmp/pip-GD_QX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:41 INFO - Running setup.py (path:/tmp/pip-Ocr9N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:41 INFO - Running setup.py (path:/tmp/pip-ZDfaCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:41 INFO - Running setup.py (path:/tmp/pip-CRJlpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:41 INFO - Running setup.py (path:/tmp/pip-DwgPTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:41 INFO - Running setup.py (path:/tmp/pip-s9RsgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:41 INFO - Running setup.py (path:/tmp/pip-kaTrDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:42 INFO - Running setup.py (path:/tmp/pip-QeIiOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:42 INFO - Running setup.py (path:/tmp/pip-_ZWgpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:42 INFO - Running setup.py (path:/tmp/pip-VRfOPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:42 INFO - Running setup.py (path:/tmp/pip-xXlqsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:42 INFO - Running setup.py (path:/tmp/pip-pszKBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:42 INFO - Running setup.py (path:/tmp/pip-wtgyuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:38:42 INFO - Running setup.py install for manifestparser 18:38:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:38:42 INFO - Running setup.py install for mozcrash 18:38:42 INFO - Running setup.py install for mozdebug 18:38:42 INFO - Running setup.py install for mozdevice 18:38:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:38:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:38:42 INFO - Running setup.py install for mozfile 18:38:42 INFO - Running setup.py install for mozhttpd 18:38:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Running setup.py install for mozinfo 18:38:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Running setup.py install for mozInstall 18:38:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Running setup.py install for mozleak 18:38:43 INFO - Running setup.py install for mozlog 18:38:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Running setup.py install for moznetwork 18:38:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Running setup.py install for mozprocess 18:38:43 INFO - Running setup.py install for mozprofile 18:38:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Running setup.py install for mozrunner 18:38:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:38:43 INFO - Running setup.py install for mozscreenshot 18:38:43 INFO - Running setup.py install for moztest 18:38:44 INFO - Running setup.py install for mozversion 18:38:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:38:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:38:44 INFO - Cleaning up... 18:38:44 INFO - Return code: 0 18:38:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:44 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 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:44 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 18:38:44 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 18:38:44 INFO - Using env: {'DISPLAY': ':0', 18:38:44 INFO - 'HOME': '/home/cltbld', 18:38:44 INFO - 'LANG': 'en_US.UTF-8', 18:38:44 INFO - 'LANGUAGE': 'en_US:en', 18:38:44 INFO - 'LOGNAME': 'cltbld', 18:38:44 INFO - 'MAIL': '/var/mail/cltbld', 18:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:44 INFO - 'MOZ_NO_REMOTE': '1', 18:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:44 INFO - 'NO_EM_RESTART': '1', 18:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:44 INFO - 'PWD': '/builds/slave/test', 18:38:44 INFO - 'SHELL': '/bin/bash', 18:38:44 INFO - 'SHLVL': '1', 18:38:44 INFO - 'TERM': 'linux', 18:38:44 INFO - 'TMOUT': '86400', 18:38:44 INFO - 'USER': 'cltbld', 18:38:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:44 INFO - '_': '/tools/buildbot/bin/python'} 18:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:44 INFO - Running setup.py (path:/tmp/pip-aqINJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:44 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)) 18:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:44 INFO - Running setup.py (path:/tmp/pip-JestEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:44 INFO - Running setup.py (path:/tmp/pip-ICy7C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:44 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)) 18:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:44 INFO - Running setup.py (path:/tmp/pip-pL16sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:44 INFO - Running setup.py (path:/tmp/pip-3vFptQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:44 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)) 18:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:44 INFO - Running setup.py (path:/tmp/pip-hliLuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:44 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)) 18:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:44 INFO - Running setup.py (path:/tmp/pip-spP8dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:44 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)) 18:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:44 INFO - Running setup.py (path:/tmp/pip-0wkLfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:45 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)) 18:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:45 INFO - Running setup.py (path:/tmp/pip-aim8iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:45 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)) 18:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:45 INFO - Running setup.py (path:/tmp/pip-_Clhlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:45 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)) 18:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:45 INFO - Running setup.py (path:/tmp/pip-VEEe2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:45 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)) 18:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:45 INFO - Running setup.py (path:/tmp/pip-rm2rTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:45 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)) 18:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:45 INFO - Running setup.py (path:/tmp/pip-GpIUVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:45 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)) 18:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:45 INFO - Running setup.py (path:/tmp/pip-vxGzNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:45 INFO - Running setup.py (path:/tmp/pip-LcJGAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:45 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)) 18:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:45 INFO - Running setup.py (path:/tmp/pip-pf6hd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:45 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)) 18:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:45 INFO - Running setup.py (path:/tmp/pip-XwAzVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:45 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)) 18:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38:45 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)) 18:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:38:45 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 18:38:45 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 18:38:45 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 18:38:45 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 18:38:45 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 18:38:45 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 18:38:47 INFO - Downloading blessings-1.6.tar.gz 18:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:38:47 INFO - Installing collected packages: blessings 18:38:47 INFO - Running setup.py install for blessings 18:38:47 INFO - Successfully installed blessings 18:38:47 INFO - Cleaning up... 18:38:47 INFO - Return code: 0 18:38:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:38:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:48 INFO - Reading from file tmpfile_stdout 18:38:48 INFO - Current package versions: 18:38:48 INFO - argparse == 1.2.1 18:38:48 INFO - blessings == 1.6 18:38:48 INFO - blobuploader == 1.2.4 18:38:48 INFO - docopt == 0.6.1 18:38:48 INFO - functools32 == 3.2.3-2 18:38:48 INFO - jsonschema == 2.5.1 18:38:48 INFO - manifestparser == 1.1 18:38:48 INFO - mozInstall == 1.12 18:38:48 INFO - mozcrash == 0.17 18:38:48 INFO - mozdebug == 0.1 18:38:48 INFO - mozdevice == 0.48 18:38:48 INFO - mozfile == 1.2 18:38:48 INFO - mozhttpd == 0.7 18:38:48 INFO - mozinfo == 0.9 18:38:48 INFO - mozleak == 0.1 18:38:48 INFO - mozlog == 3.4 18:38:48 INFO - moznetwork == 0.27 18:38:48 INFO - mozprocess == 0.23 18:38:48 INFO - mozprofile == 0.28 18:38:48 INFO - mozrunner == 6.12 18:38:48 INFO - mozscreenshot == 0.1 18:38:48 INFO - mozsystemmonitor == 0.3 18:38:48 INFO - moztest == 0.7 18:38:48 INFO - mozversion == 1.4 18:38:48 INFO - psutil == 3.1.1 18:38:48 INFO - requests == 1.2.3 18:38:48 INFO - wsgiref == 0.1.2 18:38:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:48 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')]} 18:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:48 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')]} 18:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:48 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 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:48 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 18:38:48 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 18:38:48 INFO - Using env: {'DISPLAY': ':0', 18:38:48 INFO - 'HOME': '/home/cltbld', 18:38:48 INFO - 'LANG': 'en_US.UTF-8', 18:38:48 INFO - 'LANGUAGE': 'en_US:en', 18:38:48 INFO - 'LOGNAME': 'cltbld', 18:38:48 INFO - 'MAIL': '/var/mail/cltbld', 18:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:48 INFO - 'MOZ_NO_REMOTE': '1', 18:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:48 INFO - 'NO_EM_RESTART': '1', 18:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:48 INFO - 'PWD': '/builds/slave/test', 18:38:48 INFO - 'SHELL': '/bin/bash', 18:38:48 INFO - 'SHLVL': '1', 18:38:48 INFO - 'TERM': 'linux', 18:38:48 INFO - 'TMOUT': '86400', 18:38:48 INFO - 'USER': 'cltbld', 18:38:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:48 INFO - '_': '/tools/buildbot/bin/python'} 18:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:48 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)) 18:38:48 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)) 18:38:48 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)) 18:38:48 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)) 18:38:48 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)) 18:38:48 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)) 18:38:48 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)) 18:38:48 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)) 18:38:48 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)) 18:38:48 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)) 18:38:48 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)) 18:38:48 INFO - Cleaning up... 18:38:48 INFO - Return code: 0 18:38:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:38:48 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')]} 18:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:48 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')]} 18:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:48 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 0x7f75c4d94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', '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 18:38:48 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 18:38:48 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 18:38:48 INFO - Using env: {'DISPLAY': ':0', 18:38:48 INFO - 'HOME': '/home/cltbld', 18:38:48 INFO - 'LANG': 'en_US.UTF-8', 18:38:48 INFO - 'LANGUAGE': 'en_US:en', 18:38:48 INFO - 'LOGNAME': 'cltbld', 18:38:48 INFO - 'MAIL': '/var/mail/cltbld', 18:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:48 INFO - 'MOZ_NO_REMOTE': '1', 18:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:48 INFO - 'NO_EM_RESTART': '1', 18:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:48 INFO - 'PWD': '/builds/slave/test', 18:38:48 INFO - 'SHELL': '/bin/bash', 18:38:48 INFO - 'SHLVL': '1', 18:38:48 INFO - 'TERM': 'linux', 18:38:48 INFO - 'TMOUT': '86400', 18:38:48 INFO - 'USER': 'cltbld', 18:38:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:48 INFO - '_': '/tools/buildbot/bin/python'} 18:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:38:48 INFO - Cleaning up... 18:38:48 INFO - Return code: 0 18:38:48 INFO - Running post-action listener: _resource_record_post_action 18:38:48 INFO - Running post-action listener: _start_resource_monitoring 18:38:48 INFO - Starting resource monitoring. 18:38:48 INFO - [mozharness: 2017-01-10 02:38:48.604106Z] Finished create-virtualenv step (success) 18:38:48 INFO - [mozharness: 2017-01-10 02:38:48.604555Z] Running install step. 18:38:48 INFO - Running pre-action listener: _resource_record_pre_action 18:38:48 INFO - Running main action method: install 18:38:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:48 INFO - Reading from file tmpfile_stdout 18:38:48 INFO - Detecting whether we're running mozinstall >=1.0... 18:38:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:38:48 INFO - Reading from file tmpfile_stdout 18:38:48 INFO - Output received: 18:38:48 INFO - Usage: mozinstall [options] installer 18:38:48 INFO - Options: 18:38:48 INFO - -h, --help show this help message and exit 18:38:48 INFO - -d DEST, --destination=DEST 18:38:48 INFO - Directory to install application into. [default: 18:38:48 INFO - "/builds/slave/test"] 18:38:48 INFO - --app=APP Application being installed. [default: firefox] 18:38:48 INFO - mkdir: /builds/slave/test/build/application 18:38:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:39:02 INFO - Reading from file tmpfile_stdout 18:39:02 INFO - Output received: 18:39:02 INFO - /builds/slave/test/build/application/firefox/firefox 18:39:02 INFO - Running post-action listener: _resource_record_post_action 18:39:02 INFO - [mozharness: 2017-01-10 02:39:02.419317Z] Finished install step (success) 18:39:02 INFO - [mozharness: 2017-01-10 02:39:02.419561Z] Running run-tests step. 18:39:02 INFO - Running pre-action listener: _resource_record_pre_action 18:39:02 INFO - Running main action method: run_tests 18:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:39:02 INFO - Python 2.7.3 18:39:02 INFO - Return code: 0 18:39:02 INFO - grabbing minidump binary from tooltool 18:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:02 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 0x106ff60>, '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 0x1070d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10711d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:39:02 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 18:39:02 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 18:39:02 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 18:39:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:39:02 INFO - Return code: 0 18:39:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:39:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:39:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:39:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:39:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 18:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 18:39:02 INFO - Using env: {'DISPLAY': ':0', 18:39:02 INFO - 'HOME': '/home/cltbld', 18:39:02 INFO - 'LANG': 'en_US.UTF-8', 18:39:02 INFO - 'LANGUAGE': 'en_US:en', 18:39:02 INFO - 'LOGNAME': 'cltbld', 18:39:02 INFO - 'MAIL': '/var/mail/cltbld', 18:39:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:39:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:02 INFO - 'MOZ_NO_REMOTE': '1', 18:39:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:02 INFO - 'NO_EM_RESTART': '1', 18:39:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:02 INFO - 'PWD': '/builds/slave/test', 18:39:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:39:02 INFO - 'SHELL': '/bin/bash', 18:39:02 INFO - 'SHLVL': '1', 18:39:02 INFO - 'TERM': 'linux', 18:39:02 INFO - 'TMOUT': '86400', 18:39:02 INFO - 'USER': 'cltbld', 18:39:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862', 18:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:02 INFO - '_': '/tools/buildbot/bin/python'} 18:39:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 18:39:02 INFO - mozversion application_buildid: 20170109165508 18:39:02 INFO - mozversion application_changeset: ce55e4d276031458f0730d481acff05d7c797038 18:39:02 INFO - mozversion application_display_name: Firefox 18:39:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:39:02 INFO - mozversion application_name: Firefox 18:39:02 INFO - mozversion application_remotingname: firefox 18:39:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:39:02 INFO - mozversion application_vendor: Mozilla 18:39:02 INFO - mozversion application_version: 51.0 18:39:02 INFO - mozversion platform_buildid: 20170109165508 18:39:02 INFO - mozversion platform_changeset: ce55e4d276031458f0730d481acff05d7c797038 18:39:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:39:02 INFO - mozversion platform_version: 51.0 18:39:02 INFO - using testdate: 1484015942 18:39:02 INFO - actual date: 1484015942 18:39:02 INFO - starting webserver on 'localhost:49616' 18:39:02 INFO - SUITE-START | Running 2 tests 18:39:02 INFO - TEST-START | dromaeo_css 18:39:02 INFO - operating with platform_type : linux_ 18:39:02 INFO - Initialising browser for dromaeo_css test... 18:39:02 INFO - TEST-INFO | started process 2341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn02G1a/profile http://localhost:49616/getInfo.html) 18:39:07 INFO - PROCESS | 2341 | __metrics Screen width/height:1600/1200 18:39:07 INFO - PROCESS | 2341 | colorDepth:24 18:39:07 INFO - PROCESS | 2341 | Browser inner width/height: 1024/697 18:39:07 INFO - PROCESS | 2341 | __metrics 18:39:07 INFO - PROCESS | 2341 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:39:07 INFO - PROCESS | 2341 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:39:08 INFO - PROCESS | 2341 | console.error: PushService: 18:39:08 INFO - PROCESS | 2341 | stateChangeProcessEnqueue: Error transitioning state 18:39:08 INFO - PROCESS | 2341 | UnknownError 18:39:08 INFO - TEST-INFO | 2341: exit 0 18:39:08 INFO - Browser initialized. 18:39:08 INFO - Running cycle 1/1 for dromaeo_css test... 18:39:08 INFO - TEST-INFO | started process 2505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn02G1a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:20 INFO - PROCESS | 2505 | RSS: Main: 143265792 18:39:20 INFO - PROCESS | 2505 | 18:40:11 INFO - PROCESS | 2505 | 1484016011832 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] 18:42:20 INFO - PROCESS | 2505 | Cycle 1(1): loaded http://localhost:49616/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49616/tests/dromaeo/cssquery-ext.html) 18:42:22 INFO - PROCESS | 2505 | RSS: Main: 239804416 18:42:22 INFO - PROCESS | 2505 | 18:45:24 INFO - PROCESS | 2505 | Cycle 1(1): loaded http://localhost:49616/tests/dromaeo/cssquery-ext.html (next: http://localhost:49616/tests/dromaeo/cssquery-jquery.html) 18:45:24 INFO - PROCESS | 2505 | RSS: Main: 231636992 18:45:24 INFO - PROCESS | 2505 | 18:48:26 INFO - PROCESS | 2505 | Cycle 1(1): loaded http://localhost:49616/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49616/tests/dromaeo/cssquery-mootools.html) 18:48:27 INFO - PROCESS | 2505 | RSS: Main: 176402432 18:48:27 INFO - PROCESS | 2505 | 18:51:29 INFO - PROCESS | 2505 | Cycle 1(1): loaded http://localhost:49616/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49616/tests/dromaeo/cssquery-prototype.html) 18:51:29 INFO - PROCESS | 2505 | RSS: Main: 175300608 18:51:29 INFO - PROCESS | 2505 | 18:54:32 INFO - PROCESS | 2505 | Cycle 1(1): loaded http://localhost:49616/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49616/tests/dromaeo/cssquery-yui.html) 18:54:32 INFO - PROCESS | 2505 | RSS: Main: 176300032 18:54:32 INFO - PROCESS | 2505 | 18:57:35 INFO - PROCESS | 2505 | Cycle 1(1): loaded http://localhost:49616/tests/dromaeo/cssquery-yui.html (next: http://localhost:49616/tests/dromaeo/cssquery-dojo.html) 18:57:35 INFO - PROCESS | 2505 | RSS: Main: 265027584 18:57:35 INFO - PROCESS | 2505 | 18:57:35 INFO - PROCESS | 2505 | __start_tp_report 18:57:35 INFO - PROCESS | 2505 | _x_x_mozilla_page_load 18:57:35 INFO - PROCESS | 2505 | _x_x_mozilla_page_load_details 18:57:35 INFO - PROCESS | 2505 | |i|pagename|runs| 18:57:35 INFO - PROCESS | 2505 | |0;dojo.html;3064.5403189521576;3093.7989030713;3108.5026395776667;3128.0772172209195;3146.968530314696;5455.481729235721;5553;5567.749451274693;5573.33120025597;5590.74841632126;5422.349318081826;5467.425920278363;5483.890322193563;5498.615096943216;5533.280673512448;4942.184539550979;4949.604031677457;4976.601871850261;5020.39755229373;5074.594032477393;4930.80276788928;5001.499850015006;5054.064997975368;5059.266406371074;5060.316857224265;4912;4939.629527785412;4968.70187788732;4978.850634480971;4980.178270585349;4986.551210391064;5011.498850114977;5014.774335154891;5091.338126043591;5103.515166059218;4979.676321039121;5006.048850718352;5039.798408063673;5050.318207042039;5069.974650126763;5244.763985620618;5377.542908852753;5393.622446428752;5396.676199428047;5465.726713664301;5851.795187168471;5872.530197584226;5881.323647780518;5956.0172571525645;5968.343482216953;5999.6700181490005;6005.879882402372;6015.488683461911;6016.308124565688;6023.126646636257;5415.891682166334;5447.836564903059;5466.398696143421;5510.256115424367;5580.218769372291;6069.939300607026;6070.908936365958;6077.817665470043;6080.0575910733905;6089.360617135226;5817.040188368872;5828.271466066742;5832.979228634972;5833.095870140135;5833.679147646835;5747.540196784247;5798.420157984252;5820.505257053198;5864.501517371071;5919.881602368015;5877.5591830612875;5907.054871220584;5910.231669882888;5927.703614819242;5941.316748573883;5834.883302334015;5886.293644762656;5893.793717219876;5911.615744976562;5939.970300148471;4418.447694038246;4427.158839820424;4463.35281384204;4521;4521.59305662492;3984.163325701635;3985.900352491211;3988.581198974124;4003.599640035973;4025.4163146343617;5587.329520457572;5597.132444471114;5597.496225339739;5600.859978500489;5603.635763675348;5820.214271073435;5868.119782032729;5915.911261331084;5922.911156332659;5926.940730592725;5593.272874526367;5709.371969083398;5709.65742055478;5714.714264286769;5741.397153298927;5069.264956581275;5075.8984820303385;5079.8984020319385;5082.567981721595;5086.92369614456;5827.271591051119;5871.530277577698;6197.81406557804;6205.720742566505;6212.378762123752;5858.7070646466655;5900.203472531325;5914.4381283777975;5925.496332811759;5964.433378829004;6057.061155520725;6102.908456373069;6106.664133472702;6111.388861113853;6120.724567394567;5651.745671444713;5775.306963164448;5828.708564571839;5828.737706803119;5836.854078648068;5735.025045742317;5908.556858235564;5910.024845900378;5910.290765108214;6051.4553690168095;5886.499647530008;5895.351511333664;5895.852603684943;5898.498627616701;5900.64596124234;5869.647821130746;5873.353931067493;5881.911771323348;5883.235179426647;5887.882242355215;5608.971955140199;5610.298712660918;5614.719264036864;5635.436456354331;5674;5753.453421924911;5805.448482394166;5811.302643682616;5814.883702326015;5831.591788574759;5511.834644960658;5659.745311460912;5666.206731057738;5670.064439367458;5674.205611214351 18:57:35 INFO - PROCESS | 2505 | |1;ext.html;598.2611474828586;611.6238513314311;617.6232498176112;638.3074364314718;651.8337823854916;33655.663443365556;45735.77132114339;46703.76648116763;46709.5329046709;51119.23321150186;48333.275000875015;48694.75652621741;48762.26856597145;48777.268340974915;48862;8409.537475438849;9312.30157738169;9467.384619999713;9469.053094690546;9470.52647367629;8416.284615807665;10893.727656808564;11202.607908723196;11214.046806021497;11690.649280521598;11270.549178032868;11274.661760147208;11330.490127944262;11331.320120792738;11331.433428328592;11191.216614836965;11242.887571124265;11255.493502792395;11257.211995160342;11267.323960562351;10981.505832237568;11028.613998510014;11051.889481105167;11106.111511079094;11175.329480231212;45516.3172552412;45908;45927.31109033367;46306.76846615779;46412.767936160104;3531.770434921722;3546.3261980223933;3608.6030536640947;3639.6724294813594;3670.761400508985;33893.83053084744;33929.83035084809;34194.65805341939;34508.13729656779;34682;4645.396098507173;4689.601383882374;4724.622030237572;4745.335653008581;4778.283257511401;351911;352416;352519;353906.99999999744;356017;63787.6810615944;64115.679421602596;64205;64240.036399454046;64242;39998.40002399966;40967.1806563873;41212.38181427281;43801;43867.341989870176;19959.101840417217;20082.799172008094;20192.899035504728;20218.19127234894;20222.19111235534;12610.306433146081;12953.093283470067;13343.66640833987;15324.846751532565;15494.690106197813;20361.287354942506;21260.468488287916;21279.361619151452;21345.89327053386;21386.465338366666;7253.419726421874;7490.962545187348;7604.049493813273;7632.885506717404;7835.255650713173;1064.2869277584036;1069.769999450122;1079.3362082319318;1118.1278602689915;1212.030375699437;34095.82952085224;34390.312193755984;34445.655543444744;34748.30503389918;35031.4745278821;1141.4692168141853;1171.8593768747805;1177.8645455772526;1231.205872212418;1239.0768877186554;18033;18237.544061398305;18282.90858545699;18339.358122465917;18358.908205458887;559515;560240;563485;565234;566535;42059.36910946338;42185.36721949173;42193.78903105465;42304.78847605742;42453.57546424496;1344.7243315120572;1380.171896861895;1435.978460323096;1448.7464693678564;1450.7026059657744;32600.34799304048;34862.82568587141;35021.64978350184;35464.64535354613;35745.642543574235;55061.449385505635;55495.722521387135;55781.163282549984;55822.44177558173;55845;431551;432412;439114;452258;462938;30564;31178.688213117577;31191.84404077965;32730.50904236391;32788;51818.48181518287;51859.48140518546;51982.74008629932;52167;53115.734421327645;43670.56329436792;44872.55127448684;45012;45446;46096.07807843891;43544.56455435405;44351.77824110859;44466.55533444624;44751.77624111858;45226.32160517529;43653;44577.33134003057;44892.77553612211;44909;45072.323915140645;35873.46189807207;38730.80634596809;39081.218375632896;39095.609043910335;39376.60623393844;27178.592321114804;27618;27643.447131056862;27832.721672783013;27876.16371508858 18:57:35 INFO - PROCESS | 2505 | |2;jquery.html;391.18438056651877;393.43542017205294;402.72815849301725;406.3254996705468;413.3569062974674;18592;20002.69995950062;20137.29519466819;20193.596128077446;20249.797502024976;18601.534961625934;19262.807371926276;20336.491587710316;20444.182232710675;20565.897170514127;5484.040292948728;5716.914246286309;5976.432238937294;6005.099235114724;6010.519158467312;5897.705114744267;5920.082387229964;5977.790777322794;5979.910301345483;5980.910286345708;5692.487676109149;5756.913646295309;5788.768449262025;5810.82567522975;5818.883622327551;5636.15457681347;5829;5867.853303667443;5870.060790273557;5875.529957603381;5280.471952804727;5282.630215884889;5320.042392369372;5327.946720532784;5329.733513324319;16366.181690915406;22494.10023599054;23235;23268.534629307487;23668.17161399343;2368.0438093065077;2448.7673671001226;2475.987620061906;2916.8833246670106;2972.7919045666813;10843.51204195813;11076.224664273504;11617.128715346384;11638.941805291004;12246.989240358307;1964.6168997045581;1987.592543528573;1996.5707372914892;2019.5859848730975;2092.257248676713;84589;85223.5738821302;86461.56769216113;87649;89136.66295005644;11851.940740296242;11868.881311186778;11934.820977685342;12153.756924861453;12207.206531575419;17118.914405428142;17146.485605431855;17171.914140429468;17173;17185.31258749661;8624.827503449897;8723.345749068845;8781.2535934445;8851.867221991675;8866;8394.286485648667;8435.873461898076;8454.66181352739;8665.870011949826;8670.95664521686;5088.109580823341;5222.947770522323;5236.3716354037;5249.816256431083;5314.096603577401;2033.745781777278;2089.0494824854654;2136.8931553422267;2155.07331847304;2164.383150802014;916.8578870275118;1001.4341896828269;1003.7239759066169;1049.6641074856125;1056.3872953686844;20335.18659253643;20518.79481205169;20811.79188208129;21030.474238143863;21088;1013.5844303835393;1036.2435422141878;1041.8489319048695;1058.364981011387;1070.0690399352613;10982.945085274523;11593.657645527095;11638.476268567765;11642.53429862813;11824.586139485076;526203;531885;536196;544869;549335;69352.71265774254;71693.641531792;97294.51352743333;98741;105247.4737626307;945.4658118163215;1019.8215312320463;1038.4651904269308;1048.5858086055964;1057.349729916096;17904.28382864671;18326.450206493828;18555.443336699922;18606.720899186796;18781.96699181558;43149.13701726011;43320.56679433292;43407.56592434035;43416.56583434252;43623;55890.441095588525;58317;61328.69335653293;61858.381416185264;63167.368326317985;9024.557361746929;9217.308701847522;9237.399569027992;9419.058094190526;9654.420734755937;12269.386530673251;12339.197952133083;12462.127651064338;12511.374431278218;12924.935375323063;10199.235057370579;10212.744681383025;10792.35245885218;10989.61536346224;11381.487833047699;10817;11102.222844401138;11106.777864442827;11163.609273675382;11202.271852329572;11093.278936869077;11612.303261804318;11650.30098194111;11701.2979221247;11771.352575608424;8989;9073.364864459425;9099.54502274897;9257.35198536096;9343.252539796937;9190.724278271662;11323.943380283046;11527.481263343001;11905.166638335233;12052.397380131133 18:57:35 INFO - PROCESS | 2505 | |3;mootools.html;1526.6565022869856;1564.327339244125;1712.1867113121261;1825.379371013855;1861.0508640593303;9115.680951166702;9764.902350976488;9773.511324433777;9775.657851975191;9779.070988256104;8440.957795211016;8639.136086391358;8814.86777698335;9009.324300677443;9541.379810312324;2532.4808414275076;2551.8851651675627;2552.9361765955814;2556.514262290159;2558.1302357198547;2483.639872218527;2572.961405578918;2573.5367633825904;2576.1627471071884;2581.819272650915;2485.2047344849657;2501.9124330648433;2506.724260331362;2508.7240403555593;2509.987450062747;2408.1451084864884;2416.0456619635147;2422.34596658902;2454.3005243505695;2457.680501534789;2418.8548687078833;2420.9636855447184;2427.7450867658995;2428.5871401861727;2468.6297055441646;9400.482973436458;9494.382865113745;9504.334696571243;9532.666356677551;9620.470874101922;5518.061929471999;5676.3188417389765;5676.801311954103;5698.8290351289525;5698.886022279531;3491.3890069238037;3630.963690363089;3661.9450708239397;3671.155634204148;3672.8697355533727;1100.5945397784894;1175.723704929341;1189.6133756529075;1199.0407673860877;1201.1471854982972;13654;13844.584662460142;13885.4445822167;13885.58343249694;13912.721745565032;4884.535969083003;4918;4927.852164435073;5024.572911302507;5107.259447380109;11570.19008669402;11599;11599.246049006788;11628.127890408085;11637.185397022296;5716.228309178291;5728.283964504437;5733.426657334233;5737.713114344266;5741.684207368551;4674.088552732184;4752.833650822205;4844.878878028077;5015.598752099823;5262.763250636098;4304.526502084768;4323.1785960668;4369.126174764996;4420.557944205554;4436.933445998313;1225.0934308611563;1226.172333674766;1255.7990721484518;1276.8276282701902;1300.1419063418098;972.7227740094039;999.4702807511885;1005.5525291245326;1020.5305559442592;1036.3056751976194;6208.937910620836;6293.527985401113;6325.936740632626;6394.296627370985;6420.133282006963;486.60584926209884;488.16523744396767;494.1821285772053;499.62278479747556;500.27709959109467;4132.566080561558;4220.0293932395725;4228.682848786292;4229.492460904711;4259.1268789897995;11555.480003399867;11970.700732481584;12049.337286449154;12054.276743395425;12067.698307542381;11193.49629266685;11855.644330669922;11914;11939.701507462209;11960.342181180118;8632.395732298804;9023.774405639911;9033.77415564616;9034.774130646654;9046.095390461032;6424.38968298011;6532.9346706534225;6559.212894452697;6643.833904152435;6710.798676039727;10743.677689669323;11010.339379637247;11052.281601695864;11234.101271898066;11235.494402751732;11337.26307789991;11427.314361138026;11462.541498339973;11480.770384592095;11575;7835.921640783519;7890.329322007694;8296.37777166727;8446.535440550828;8581.65673373058;8989.41568798026;9443.622255109718;9453.574589143367;9473.810523789623;9474.194693450858;8129.349652027942;8179.631916563888;8234.958825205835;8410.579471026302;8541.316694664536;7995.360371170176;8036.758897233092;8175.427720059776;8246.175382461706;8294.294984926108;7316.414686825147;7426.4058875288765;7479.952806606971;7505.962470187614;7559.848803024019;5696.259486266758;5757.309122905278;5775.48020678141;5837.09525023622;5944.762209511571;5682.971585142048;5739.942600573941;5768.53851691872;5899.439553242435;6009.369016253405 18:57:35 INFO - PROCESS | 2505 | |4;prototype.html;336.4230344958396;340.280307150377;346.16056064044693;350.78251484079874;351.70808229169774;5499.285092937917;5520.757829488363;5546.389897111315;5573.6098473106895;5588.748506317215;5458.833876351717;5518.889622207564;5522.1776813651495;5533.142362933751;5551.278333816608;3961.6236457536634;4112.321466957948;4225.7253278536955;4305.67707421943;4314.395984562164;4295;4301.763403012833;4309.965608254028;4318.568143185687;4326.437563116806;4294.4202532658;4305.461817272841;4331.133773245364;4345.826166953318;4363.149185908733;4216.57834216579;4329.826806927719;4356.934645980328;4361;4367.3448982652535;3847.8460861565504;3851.7096772581217;3861.474717486605;3871.728978971473;3907.772569635309;5308.5487733542695;5318.149096144598;5329.44186790339;5335.599830012765;5392.1911713242935;4670.626349892001;4954.331165292675;4964.131277026506;4980.203167493184;4994.875128121826;5673.886522269531;5675;5675.914861277043;5679.858003549903;5698.772049118031;4093.672506199497;4151.14901445203;4163.937540936889;4166.270902592065;4194.182134483777;5546.223528705944;5598.1602759585985;5998.97000514999;6041.939580604182;6066.939330606681;4196.748195108304;4216.9789151054665;4226.112516371535;4226.852060177879;4239.364095385655;4302.741835489881;4303.268444364466;4308.332208507686;4329.393884856123;4330.761808100522;4668.4631267404;4928.975355123202;4936.580390666762;4943.134951383494;4951.133551628451;5784.8719499698;5839.737211825478;5842.824715258549;5847.26909136358;5931.73307201177;1487.970240595182;1503.7819516170093;1510.4713350327297;1518.5140754958306;1520.6882589069214;929.6513807322254;955.9522023898777;962.556165751373;965.2374624047064;976.6581696406344;4915.705057696549;4933.840547471413;4939.431965323962;4945.604351651859;4954.677945933503;5218.191180367049;5220.843374698765;5223.738813059332;5230.3985041719925;5231.503007214308;4585.679002469795;4910.312556242129;4946.1312438786135;4965.379327584052;4989.55094041538;2721.319670082479;2727.4545090981487;2745.32739478825;2753.8072334936364;2760.6135141080263;5285.995660824431;5350.91973620396;5352.0366334060245;5379.462053794589;5397.271368365299;5311.344327836082;5327.0145023170835;5590.91613625796;6020.187274717945;6099.725512351954;6094.481969032682;6119.848278136763;6127.509799216141;6130.816075517741;6142.232220972379;5688;5968.403159683997;5994.220751302303;6019.729112189874;6026.548008899263;5839.445252700986;5871.794487192928;5912.793052243151;5914.408559144051;5921.851953701192;5891.617044892068;6011;6031.939680603138;6120.724567394567;6173.32093469727;4279.5606504292255;4314.546972567835;4318.898680836367;4322.135572885372;4362.978185109054;5796.275465566804;6022.879542409215;6070.512724382378;6073.939260607337;6105.023196288573;5771.336296325976;5795.420457954339;5829.737661805314;5843.240378750906;5846.210761547137;5796.188533605215;5800.8259752207505;5802.593818432838;5803.448672376117;5826.446487583673;5503;5745.109508026263;5752.6836024019085;5779.682117483579;5806.44838740319;5825.417458254141;5855.970720146372;5861.208736820645;5862;5873.647581145145;5527.972360138174;5701.201831743476;5756.769729210952;5759.625624334405;5768.019436695856 18:57:35 INFO - PROCESS | 2505 | |5;yui.html;797.9521228726277;812.6302532347783;817.5176645778989;818.6725309876045;849.0745087854245;15477.535673929786;15906.284217210225;15910.602234944103;16049.759253611206;16148.515544533668;15094.16982065986;15265.084094954284;15271;15271.465498707548;15318.387264509434;735.7866218796543;756.4893696754696;861.9527274361649;863.4473936680514;876.5222953490331;890.341147550811;890.4434728294816;893.0310612984919;893.5219657483248;893.5576889439736;940.4451373689521;942.9009953954838;944.2540393089452;944.527736131934;944.5513381143936;935.1677007463363;937.5312343828018;937.5406051034978;937.6577549194529;937.9906200937971;688.1432616392573;691.4710246661308;691.4917535611322;691.9655115602206;692.0104250921181;14854.405823767036;14977;14977.026493277903;14990.47533336328;14997.17515536645;15826.046182164659;16355.859367192417;16357;16470.67058658832;17066.317347306092;13352.86647133526;13536.526221582295;13552.186868787905;13640.590782276548;13668.52160174399;4100.5489396166395;4155.958440415588;4163.417121602978;4250.468691413574;4271.145770845843;78014.21985780183;87571.56214218888;90864.54567727119;92833;92914;11840.526378944745;12435.875641243472;12554.372281385895;12578.622641320591;12804.61586152417;21474.677879831816;21476.57046859054;21498.46253843635;21502;21504;9210.907890921138;9269.67556135532;9271.443713377219;9314.673986410444;9640.71077867665;4956.553910148104;5177.663451875616;5259.500347466985;5328.120860058125;5402.648827826258;3398.966010339914;3528.347255757693;3528.6647768461953;3534.6465353464964;3537.2394935088564;638.8818068657313;642.2261175283771;645.6803882078401;653.3401264722664;669.0365873142756;735.9779206623703;759.9620018999028;774.5468900693157;784.5528049012122;792.8453951479521;10068.798624027479;10296.279260451696;10412.947935260276;10442.269041167197;10701.866581398193;645.3933302695451;713.600383785082;728.3299364584595;773.8761798112275;780.1613265739353;4891.9755401222765;5010.123228435009;5018.121828679967;5030.0694371541385;5060.468650791614;80135;80963.59518202489;81083.18916810756;98431.50784246033;127384;68524;121710;123379.76620233862;124745;125498;102918;105457.47271263748;105580;106315.46842265895;107350.48546601663;9177.724668259963;9340.439573625605;9355.719328420158;9412.15290623847;9556.95221523888;49257.507424925294;49796.00407991892;59901;60652;61258.38741612527;48789;49553.513394598216;52898.47101528935;67904.64190716059;69540.65229673819;13252;13383.665408364868;13606;13645.181289122684;13661.043726939019;14573.92713036428;14849.554513364616;14854;14903;15105.244737762849;13722.65693357674;13906.363024120208;14292.42830286777;14379.712405752036;14397.64005899861;14282.785758213427;14454.421823126957;14467.638309042359;14503.78244326357;15344.769828452805;13413.128146670435;13541.322933853071;13864.653383665489;14335.139891606537;14438.639034023814;11916.702082448008;11972.58095966637;12136.635900922987;12486;12970.675733106747;10518.526666300188;10536.473176340998;11906.464209110438;11978.281303121841;12091.334976576372 18:57:35 INFO - PROCESS | 2505 | __end_tp_report 18:57:35 INFO - PROCESS | 2505 | __start_cc_report 18:57:35 INFO - PROCESS | 2505 | _x_x_mozilla_cycle_collect,854 18:57:35 INFO - PROCESS | 2505 | __end_cc_report 18:57:35 INFO - PROCESS | 2505 | __startTimestamp1484017055650__endTimestamp 18:57:35 INFO - PROCESS | 2505 | 18:57:35 INFO - PROCESS | 2505 | ------- Summary: start ------- 18:57:35 INFO - PROCESS | 2505 | Number of tests: 6 18:57:35 INFO - PROCESS | 2505 | 18:57:35 INFO - PROCESS | 2505 | [#0] dojo.html Cycles:165 Average:5479.79 Median:5709.37 stddev:642.57 (11.3%) stddev-sans-first:615.97 18:57:35 INFO - PROCESS | 2505 | Values: 3064.5 3093.8 3108.5 3128.1 3147.0 5455.5 5553.0 5567.7 5573.3 5590.7 5422.3 5467.4 5483.9 5498.6 5533.3 4942.2 4949.6 4976.6 5020.4 5074.6 4930.8 5001.5 5054.1 5059.3 5060.3 4912.0 4939.6 4968.7 4978.9 4980.2 4986.6 5011.5 5014.8 5091.3 5103.5 4979.7 5006.0 5039.8 5050.3 5070.0 5244.8 5377.5 5393.6 5396.7 5465.7 5851.8 5872.5 5881.3 5956.0 5968.3 5999.7 6005.9 6015.5 6016.3 6023.1 5415.9 5447.8 5466.4 5510.3 5580.2 6069.9 6070.9 6077.8 6080.1 6089.4 5817.0 5828.3 5833.0 5833.1 5833.7 5747.5 5798.4 5820.5 5864.5 5919.9 5877.6 5907.1 5910.2 5927.7 5941.3 5834.9 5886.3 5893.8 5911.6 5940.0 4418.4 4427.2 4463.4 4521.0 4521.6 3984.2 3985.9 3988.6 4003.6 4025.4 5587.3 5597.1 5597.5 5600.9 5603.6 5820.2 5868.1 5915.9 5922.9 5926.9 5593.3 5709.4 5709.7 5714.7 5741.4 5069.3 5075.9 5079.9 5082.6 5086.9 5827.3 5871.5 6197.8 6205.7 6212.4 5858.7 5900.2 5914.4 5925.5 5964.4 6057.1 6102.9 6106.7 6111.4 6120.7 5651.7 5775.3 5828.7 5828.7 5836.9 5735.0 5908.6 5910.0 5910.3 6051.5 5886.5 5895.4 5895.9 5898.5 5900.6 5869.6 5873.4 5881.9 5883.2 5887.9 5609.0 5610.3 5614.7 5635.4 5674.0 5753.5 5805.4 5811.3 5814.9 5831.6 5511.8 5659.7 5666.2 5670.1 5674.2 18:57:35 INFO - PROCESS | 2505 | 18:57:35 INFO - PROCESS | 2505 | [#1] ext.html Cycles:180 Average:62172.14 Median:21200.78 stddev:122193.60 (576.4%) stddev-sans-first:122448.93 18:57:35 INFO - PROCESS | 2505 | Values: 598.3 611.6 617.6 638.3 651.8 33655.7 45735.8 46703.8 46709.5 51119.2 48333.3 48694.8 48762.3 48777.3 48862.0 8409.5 9312.3 9467.4 9469.1 9470.5 8416.3 10893.7 11202.6 11214.0 11690.6 11270.5 11274.7 11330.5 11331.3 11331.4 11191.2 11242.9 11255.5 11257.2 11267.3 10981.5 11028.6 11051.9 11106.1 11175.3 45516.3 45908.0 45927.3 46306.8 46412.8 3531.8 3546.3 3608.6 3639.7 3670.8 33893.8 33929.8 34194.7 34508.1 34682.0 4645.4 4689.6 4724.6 4745.3 4778.3 351911.0 352416.0 352519.0 353907.0 356017.0 63787.7 64115.7 64205.0 64240.0 64242.0 39998.4 40967.2 41212.4 43801.0 43867.3 19959.1 20082.8 20192.9 20218.2 20222.2 12610.3 12953.1 13343.7 15324.8 15494.7 20361.3 21260.5 21279.4 21345.9 21386.5 7253.4 7491.0 7604.0 7632.9 7835.3 1064.3 1069.8 1079.3 1118.1 1212.0 34095.8 34390.3 34445.7 34748.3 35031.5 1141.5 1171.9 1177.9 1231.2 1239.1 18033.0 18237.5 18282.9 18339.4 18358.9 559515.0 560240.0 563485.0 565234.0 566535.0 42059.4 42185.4 42193.8 42304.8 42453.6 1344.7 1380.2 1436.0 1448.7 1450.7 32600.3 34862.8 35021.6 35464.6 35745.6 55061.4 55495.7 55781.2 55822.4 55845.0 431551.0 432412.0 439114.0 452258.0 462938.0 30564.0 31178.7 31191.8 32730.5 32788.0 51818.5 51859.5 51982.7 52167.0 53115.7 43670.6 44872.6 45012.0 45446.0 46096.1 43544.6 44351.8 44466.6 44751.8 45226.3 43653.0 44577.3 44892.8 44909.0 45072.3 35873.5 38730.8 39081.2 39095.6 39376.6 27178.6 27618.0 27643.4 27832.7 27876.2 18:57:35 INFO - PROCESS | 2505 | 18:57:35 INFO - PROCESS | 2505 | [#2] jquery.html Cycles:180 Average:30724.85 Median:23251.77 stddev:88468.05 (380.5%) stddev-sans-first:88686.91 18:57:35 INFO - PROCESS | 2505 | Values: 391.2 393.4 402.7 406.3 413.4 18592.0 20002.7 20137.3 20193.6 20249.8 18601.5 19262.8 20336.5 20444.2 20565.9 5484.0 5716.9 5976.4 6005.1 6010.5 5897.7 5920.1 5977.8 5979.9 5980.9 5692.5 5756.9 5788.8 5810.8 5818.9 5636.2 5829.0 5867.9 5870.1 5875.5 5280.5 5282.6 5320.0 5327.9 5329.7 16366.2 22494.1 23235.0 23268.5 23668.2 2368.0 2448.8 2476.0 2916.9 2972.8 10843.5 11076.2 11617.1 11638.9 12247.0 1964.6 1987.6 1996.6 2019.6 2092.3 84589.0 85223.6 86461.6 87649.0 89136.7 11851.9 11868.9 11934.8 12153.8 12207.2 17118.9 17146.5 17171.9 17173.0 17185.3 8624.8 8723.3 8781.3 8851.9 8866.0 8394.3 8435.9 8454.7 8665.9 8671.0 5088.1 5222.9 5236.4 5249.8 5314.1 2033.7 2089.0 2136.9 2155.1 2164.4 916.9 1001.4 1003.7 1049.7 1056.4 20335.2 20518.8 20811.8 21030.5 21088.0 1013.6 1036.2 1041.8 1058.4 1070.1 10982.9 11593.7 11638.5 11642.5 11824.6 526203.0 531885.0 536196.0 544869.0 549335.0 69352.7 71693.6 97294.5 98741.0 105247.5 945.5 1019.8 1038.5 1048.6 1057.3 17904.3 18326.5 18555.4 18606.7 18782.0 43149.1 43320.6 43407.6 43416.6 43623.0 55890.4 58317.0 61328.7 61858.4 63167.4 9024.6 9217.3 9237.4 9419.1 9654.4 12269.4 12339.2 12462.1 12511.4 12924.9 10199.2 10212.7 10792.4 10989.6 11381.5 10817.0 11102.2 11106.8 11163.6 11202.3 11093.3 11612.3 11650.3 11701.3 11771.4 8989.0 9073.4 9099.5 9257.4 9343.3 9190.7 11323.9 11527.5 11905.2 12052.4 18:57:35 INFO - PROCESS | 2505 | 18:57:35 INFO - PROCESS | 2505 | [#3] mootools.html Cycles:180 Average:6284.81 Median:2665.74 stddev:3665.07 (137.5%) stddev-sans-first:3657.91 18:57:35 INFO - PROCESS | 2505 | Values: 1526.7 1564.3 1712.2 1825.4 1861.1 9115.7 9764.9 9773.5 9775.7 9779.1 8441.0 8639.1 8814.9 9009.3 9541.4 2532.5 2551.9 2552.9 2556.5 2558.1 2483.6 2573.0 2573.5 2576.2 2581.8 2485.2 2501.9 2506.7 2508.7 2510.0 2408.1 2416.0 2422.3 2454.3 2457.7 2418.9 2421.0 2427.7 2428.6 2468.6 9400.5 9494.4 9504.3 9532.7 9620.5 5518.1 5676.3 5676.8 5698.8 5698.9 3491.4 3631.0 3661.9 3671.2 3672.9 1100.6 1175.7 1189.6 1199.0 1201.1 13654.0 13844.6 13885.4 13885.6 13912.7 4884.5 4918.0 4927.9 5024.6 5107.3 11570.2 11599.0 11599.2 11628.1 11637.2 5716.2 5728.3 5733.4 5737.7 5741.7 4674.1 4752.8 4844.9 5015.6 5262.8 4304.5 4323.2 4369.1 4420.6 4436.9 1225.1 1226.2 1255.8 1276.8 1300.1 972.7 999.5 1005.6 1020.5 1036.3 6208.9 6293.5 6325.9 6394.3 6420.1 486.6 488.2 494.2 499.6 500.3 4132.6 4220.0 4228.7 4229.5 4259.1 11555.5 11970.7 12049.3 12054.3 12067.7 11193.5 11855.6 11914.0 11939.7 11960.3 8632.4 9023.8 9033.8 9034.8 9046.1 6424.4 6532.9 6559.2 6643.8 6710.8 10743.7 11010.3 11052.3 11234.1 11235.5 11337.3 11427.3 11462.5 11480.8 11575.0 7835.9 7890.3 8296.4 8446.5 8581.7 8989.4 9443.6 9453.6 9473.8 9474.2 8129.3 8179.6 8235.0 8410.6 8541.3 7995.4 8036.8 8175.4 8246.2 8294.3 7316.4 7426.4 7480.0 7506.0 7559.8 5696.3 5757.3 5775.5 5837.1 5944.8 5683.0 5739.9 5768.5 5899.4 6009.4 18:57:35 INFO - PROCESS | 2505 | 18:57:35 INFO - PROCESS | 2505 | [#4] prototype.html Cycles:180 Average:4781.54 Median:5332.52 stddev:1406.65 (26.4%) stddev-sans-first:1370.46 18:57:35 INFO - PROCESS | 2505 | Values: 336.4 340.3 346.2 350.8 351.7 5499.3 5520.8 5546.4 5573.6 5588.7 5458.8 5518.9 5522.2 5533.1 5551.3 3961.6 4112.3 4225.7 4305.7 4314.4 4295.0 4301.8 4310.0 4318.6 4326.4 4294.4 4305.5 4331.1 4345.8 4363.1 4216.6 4329.8 4356.9 4361.0 4367.3 3847.8 3851.7 3861.5 3871.7 3907.8 5308.5 5318.1 5329.4 5335.6 5392.2 4670.6 4954.3 4964.1 4980.2 4994.9 5673.9 5675.0 5675.9 5679.9 5698.8 4093.7 4151.1 4163.9 4166.3 4194.2 5546.2 5598.2 5999.0 6041.9 6066.9 4196.7 4217.0 4226.1 4226.9 4239.4 4302.7 4303.3 4308.3 4329.4 4330.8 4668.5 4929.0 4936.6 4943.1 4951.1 5784.9 5839.7 5842.8 5847.3 5931.7 1488.0 1503.8 1510.5 1518.5 1520.7 929.7 956.0 962.6 965.2 976.7 4915.7 4933.8 4939.4 4945.6 4954.7 5218.2 5220.8 5223.7 5230.4 5231.5 4585.7 4910.3 4946.1 4965.4 4989.6 2721.3 2727.5 2745.3 2753.8 2760.6 5286.0 5350.9 5352.0 5379.5 5397.3 5311.3 5327.0 5590.9 6020.2 6099.7 6094.5 6119.8 6127.5 6130.8 6142.2 5688.0 5968.4 5994.2 6019.7 6026.5 5839.4 5871.8 5912.8 5914.4 5921.9 5891.6 6011.0 6031.9 6120.7 6173.3 4279.6 4314.5 4318.9 4322.1 4363.0 5796.3 6022.9 6070.5 6073.9 6105.0 5771.3 5795.4 5829.7 5843.2 5846.2 5796.2 5800.8 5802.6 5803.4 5826.4 5503.0 5745.1 5752.7 5779.7 5806.4 5825.4 5856.0 5861.2 5862.0 5873.6 5528.0 5701.2 5756.8 5759.6 5768.0 18:57:35 INFO - PROCESS | 2505 | 18:57:35 INFO - PROCESS | 2505 | [#5] yui.html Cycles:180 Average:21479.14 Median:4128.25 stddev:31145.39 (754.4%) stddev-sans-first:31194.05 18:57:35 INFO - PROCESS | 2505 | Values: 798.0 812.6 817.5 818.7 849.1 15477.5 15906.3 15910.6 16049.8 16148.5 15094.2 15265.1 15271.0 15271.5 15318.4 735.8 756.5 862.0 863.4 876.5 890.3 890.4 893.0 893.5 893.6 940.4 942.9 944.3 944.5 944.6 935.2 937.5 937.5 937.7 938.0 688.1 691.5 691.5 692.0 692.0 14854.4 14977.0 14977.0 14990.5 14997.2 15826.0 16355.9 16357.0 16470.7 17066.3 13352.9 13536.5 13552.2 13640.6 13668.5 4100.5 4156.0 4163.4 4250.5 4271.1 78014.2 87571.6 90864.5 92833.0 92914.0 11840.5 12435.9 12554.4 12578.6 12804.6 21474.7 21476.6 21498.5 21502.0 21504.0 9210.9 9269.7 9271.4 9314.7 9640.7 4956.6 5177.7 5259.5 5328.1 5402.6 3399.0 3528.3 3528.7 3534.6 3537.2 638.9 642.2 645.7 653.3 669.0 736.0 760.0 774.5 784.6 792.8 10068.8 10296.3 10412.9 10442.3 10701.9 645.4 713.6 728.3 773.9 780.2 4892.0 5010.1 5018.1 5030.1 5060.5 80135.0 80963.6 81083.2 98431.5 127384.0 68524.0 121710.0 123379.8 124745.0 125498.0 102918.0 105457.5 105580.0 106315.5 107350.5 9177.7 9340.4 9355.7 9412.2 9557.0 49257.5 49796.0 59901.0 60652.0 61258.4 48789.0 49553.5 52898.5 67904.6 69540.7 13252.0 13383.7 13606.0 13645.2 13661.0 14573.9 14849.6 14854.0 14903.0 15105.2 13722.7 13906.4 14292.4 14379.7 14397.6 14282.8 14454.4 14467.6 14503.8 15344.8 13413.1 13541.3 13864.7 14335.1 14438.6 11916.7 11972.6 12136.6 12486.0 12970.7 10518.5 10536.5 11906.5 11978.3 12091.3 18:57:35 INFO - PROCESS | 2505 | -------- Summary: end -------- 18:57:35 INFO - PROCESS | 2505 | 18:57:36 INFO - TEST-INFO | 2505: exit 0 18:57:36 INFO - TEST-OK | dromaeo_css | took 1113625ms 18:57:36 INFO - TEST-START | kraken 18:57:36 INFO - operating with platform_type : linux_ 18:57:36 INFO - Initialising browser for kraken test... 18:57:36 INFO - TEST-INFO | started process 2929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptWnDO8/profile http://localhost:49616/getInfo.html) 18:57:40 INFO - PROCESS | 2929 | __metrics Screen width/height:1600/1200 18:57:40 INFO - PROCESS | 2929 | colorDepth:24 18:57:40 INFO - PROCESS | 2929 | Browser inner width/height: 1024/697 18:57:40 INFO - PROCESS | 2929 | __metrics 18:57:41 INFO - PROCESS | 2929 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:57:41 INFO - PROCESS | 2929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:57:41 INFO - PROCESS | 2929 | console.error: PushService: 18:57:41 INFO - PROCESS | 2929 | stateChangeProcessEnqueue: Error transitioning state 18:57:41 INFO - PROCESS | 2929 | UnknownError 18:57:42 INFO - TEST-INFO | 2929: exit 0 18:57:42 INFO - Browser initialized. 18:57:42 INFO - Running cycle 1/1 for kraken test... 18:57:42 INFO - TEST-INFO | started process 3024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptWnDO8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:57:53 INFO - PROCESS | 3024 | RSS: Main: 143044608 18:57:53 INFO - PROCESS | 3024 | 18:57:56 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49616/tests/kraken/driver.html?testName=audio-beat-detection) 18:57:57 INFO - PROCESS | 3024 | RSS: Main: 187314176 18:57:57 INFO - PROCESS | 3024 | 18:57:59 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49616/tests/kraken/driver.html?testName=audio-dft) 18:58:00 INFO - PROCESS | 3024 | RSS: Main: 174174208 18:58:00 INFO - PROCESS | 3024 | 18:58:03 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49616/tests/kraken/driver.html?testName=audio-fft) 18:58:03 INFO - PROCESS | 3024 | RSS: Main: 265318400 18:58:03 INFO - PROCESS | 3024 | 18:58:05 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49616/tests/kraken/driver.html?testName=audio-oscillator) 18:58:06 INFO - PROCESS | 3024 | RSS: Main: 172195840 18:58:06 INFO - PROCESS | 3024 | 18:58:08 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49616/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:58:09 INFO - PROCESS | 3024 | RSS: Main: 173527040 18:58:09 INFO - PROCESS | 3024 | 18:58:12 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49616/tests/kraken/driver.html?testName=imaging-darkroom) 18:58:12 INFO - PROCESS | 3024 | RSS: Main: 209850368 18:58:12 INFO - PROCESS | 3024 | 18:58:15 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49616/tests/kraken/driver.html?testName=imaging-desaturate) 18:58:16 INFO - PROCESS | 3024 | RSS: Main: 208855040 18:58:16 INFO - PROCESS | 3024 | 18:58:19 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49616/tests/kraken/driver.html?testName=json-parse-financial) 18:58:19 INFO - PROCESS | 3024 | RSS: Main: 208625664 18:58:19 INFO - PROCESS | 3024 | 18:58:21 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49616/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:58:21 INFO - PROCESS | 3024 | RSS: Main: 170409984 18:58:21 INFO - PROCESS | 3024 | 18:58:23 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49616/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:58:24 INFO - PROCESS | 3024 | RSS: Main: 177700864 18:58:24 INFO - PROCESS | 3024 | 18:58:26 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49616/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:26 INFO - PROCESS | 3024 | RSS: Main: 186916864 18:58:26 INFO - PROCESS | 3024 | 18:58:29 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:58:29 INFO - PROCESS | 3024 | RSS: Main: 196464640 18:58:29 INFO - PROCESS | 3024 | 18:58:32 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:58:33 INFO - PROCESS | 3024 | RSS: Main: 192765952 18:58:33 INFO - PROCESS | 3024 | 18:58:34 INFO - PROCESS | 3024 | Cycle 1(1): loaded http://localhost:49616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49616/tests/kraken/driver.html?testName=ai-astar) 18:58:35 INFO - PROCESS | 3024 | RSS: Main: 244416512 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | __start_tp_report 18:58:35 INFO - PROCESS | 3024 | _x_x_mozilla_page_load 18:58:35 INFO - PROCESS | 3024 | _x_x_mozilla_page_load_details 18:58:35 INFO - PROCESS | 3024 | |i|pagename|runs| 18:58:35 INFO - PROCESS | 3024 | |0;ai-astar;113;111;111;111;112;112;110;112;111;110 18:58:35 INFO - PROCESS | 3024 | |1;audio-beat-detection;143;122;118;151;119;122;122;117;147;117 18:58:35 INFO - PROCESS | 3024 | |2;audio-dft;161;159;161;161;162;162;160;163;161;161 18:58:35 INFO - PROCESS | 3024 | |3;audio-fft;76;75;76;112;76;75;75;76;101;75 18:58:35 INFO - PROCESS | 3024 | |4;audio-oscillator;82;82;110;81;81;82;99;81;82;111 18:58:35 INFO - PROCESS | 3024 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;118;116;117 18:58:35 INFO - PROCESS | 3024 | |6;imaging-darkroom;145;147;146;146;146;146;146;146;146;146 18:58:35 INFO - PROCESS | 3024 | |7;imaging-desaturate;96;95;96;95;95;95;95;96;96;95 18:58:35 INFO - PROCESS | 3024 | |8;json-parse-financial;49;49;51;52;50;52;49;50;50;50 18:58:35 INFO - PROCESS | 3024 | |9;json-stringify-tinderbox;59;57;58;58;58;59;58;57;59;58 18:58:35 INFO - PROCESS | 3024 | |10;stanford-crypto-aes;74;73;73;73;73;73;73;79;82;74 18:58:35 INFO - PROCESS | 3024 | |11;stanford-crypto-ccm;127;130;121;122;134;119;119;125;169;121 18:58:35 INFO - PROCESS | 3024 | |12;stanford-crypto-pbkdf2;153;156;156;156;154;154;153;155;157;154 18:58:35 INFO - PROCESS | 3024 | |13;stanford-crypto-sha256-iterative;62;61;61;62;70;63;61;63;60;61 18:58:35 INFO - PROCESS | 3024 | __end_tp_report 18:58:35 INFO - PROCESS | 3024 | __start_cc_report 18:58:35 INFO - PROCESS | 3024 | _x_x_mozilla_cycle_collect,1516 18:58:35 INFO - PROCESS | 3024 | __end_cc_report 18:58:35 INFO - PROCESS | 3024 | __startTimestamp1484017115078__endTimestamp 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | ------- Summary: start ------- 18:58:35 INFO - PROCESS | 3024 | Number of tests: 14 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:0.95 (0.9%) stddev-sans-first:0.78 18:58:35 INFO - PROCESS | 3024 | Values: 113.0 111.0 111.0 111.0 112.0 112.0 110.0 112.0 111.0 110.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:122.00 stddev:13.52 (11.1%) stddev-sans-first:13.18 18:58:35 INFO - PROCESS | 3024 | Values: 143.0 122.0 118.0 151.0 119.0 122.0 122.0 117.0 147.0 117.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 18:58:35 INFO - PROCESS | 3024 | Values: 161.0 159.0 161.0 161.0 162.0 162.0 160.0 163.0 161.0 161.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:13.33 (17.7%) stddev-sans-first:13.98 18:58:35 INFO - PROCESS | 3024 | Values: 76.0 75.0 76.0 112.0 76.0 75.0 75.0 76.0 101.0 75.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.00 stddev:12.53 (15.3%) stddev-sans-first:13.02 18:58:35 INFO - PROCESS | 3024 | Values: 82.0 82.0 110.0 81.0 81.0 82.0 99.0 81.0 82.0 111.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:58:35 INFO - PROCESS | 3024 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 18:58:35 INFO - PROCESS | 3024 | Values: 145.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 18:58:35 INFO - PROCESS | 3024 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:1.14 (2.3%) stddev-sans-first:1.12 18:58:35 INFO - PROCESS | 3024 | Values: 49.0 49.0 51.0 52.0 50.0 52.0 49.0 50.0 50.0 50.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 18:58:35 INFO - PROCESS | 3024 | Values: 59.0 57.0 58.0 58.0 58.0 59.0 58.0 57.0 59.0 58.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:73.50 stddev:3.16 (4.3%) stddev-sans-first:3.35 18:58:35 INFO - PROCESS | 3024 | Values: 74.0 73.0 73.0 73.0 73.0 73.0 73.0 79.0 82.0 74.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:126.00 stddev:14.99 (11.9%) stddev-sans-first:15.89 18:58:35 INFO - PROCESS | 3024 | Values: 127.0 130.0 121.0 122.0 134.0 119.0 119.0 125.0 169.0 121.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.50 stddev:1.40 (0.9%) stddev-sans-first:1.32 18:58:35 INFO - PROCESS | 3024 | Values: 153.0 156.0 156.0 156.0 154.0 154.0 153.0 155.0 157.0 154.0 18:58:35 INFO - PROCESS | 3024 | 18:58:35 INFO - PROCESS | 3024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:2.84 (4.6%) stddev-sans-first:3.00 18:58:35 INFO - PROCESS | 3024 | Values: 62.0 61.0 61.0 62.0 70.0 63.0 61.0 63.0 60.0 61.0 18:58:35 INFO - PROCESS | 3024 | -------- Summary: end -------- 18:58:35 INFO - PROCESS | 3024 | 18:58:36 INFO - TEST-INFO | 3024: exit 0 18:58:36 INFO - TEST-OK | kraken | took 59810ms 18:58:36 INFO - SUITE-END | took 1173s 18:58:36 INFO - Completed test suite (00:19:33) 18:58:36 INFO - javascript benchmark 18:58:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.5403189521576, 3093.7989030713, 3108.5026395776667, 3128.0772172209195, 3146.968530314696, 5455.481729235721, 5553.0, 5567.749451274693, 5573.33120025597, 5590.74841632126, 5422.349318081826, 5467.425920278363, 5483.890322193563, 5498.615096943216, 5533.280673512448, 4942.184539550979, 4949.604031677457, 4976.601871850261, 5020.39755229373, 5074.594032477393, 4930.80276788928, 5001.499850015006, 5054.064997975368, 5059.266406371074, 5060.316857224265, 4912.0, 4939.629527785412, 4968.70187788732, 4978.850634480971, 4980.178270585349, 4986.551210391064, 5011.498850114977, 5014.774335154891, 5091.338126043591, 5103.515166059218, 4979.676321039121, 5006.048850718352, 5039.798408063673, 5050.318207042039, 5069.974650126763, 5244.763985620618, 5377.542908852753, 5393.622446428752, 5396.676199428047, 5465.726713664301, 5851.795187168471, 5872.530197584226, 5881.323647780518, 5956.0172571525645, 5968.343482216953, 5999.6700181490005, 6005.879882402372, 6015.488683461911, 6016.308124565688, 6023.126646636257, 5415.891682166334, 5447.836564903059, 5466.398696143421, 5510.256115424367, 5580.218769372291, 6069.939300607026, 6070.908936365958, 6077.817665470043, 6080.0575910733905, 6089.360617135226, 5817.040188368872, 5828.271466066742, 5832.979228634972, 5833.095870140135, 5833.679147646835, 5747.540196784247, 5798.420157984252, 5820.505257053198, 5864.501517371071, 5919.881602368015, 5877.5591830612875, 5907.054871220584, 5910.231669882888, 5927.703614819242, 5941.316748573883, 5834.883302334015, 5886.293644762656, 5893.793717219876, 5911.615744976562, 5939.970300148471, 4418.447694038246, 4427.158839820424, 4463.35281384204, 4521.0, 4521.59305662492, 3984.163325701635, 3985.900352491211, 3988.581198974124, 4003.599640035973, 4025.4163146343617, 5587.329520457572, 5597.132444471114, 5597.496225339739, 5600.859978500489, 5603.635763675348, 5820.214271073435, 5868.119782032729, 5915.911261331084, 5922.911156332659, 5926.940730592725, 5593.272874526367, 5709.371969083398, 5709.65742055478, 5714.714264286769, 5741.397153298927, 5069.264956581275, 5075.8984820303385, 5079.8984020319385, 5082.567981721595, 5086.92369614456, 5827.271591051119, 5871.530277577698, 6197.81406557804, 6205.720742566505, 6212.378762123752, 5858.7070646466655, 5900.203472531325, 5914.4381283777975, 5925.496332811759, 5964.433378829004, 6057.061155520725, 6102.908456373069, 6106.664133472702, 6111.388861113853, 6120.724567394567, 5651.745671444713, 5775.306963164448, 5828.708564571839, 5828.737706803119, 5836.854078648068, 5735.025045742317, 5908.556858235564, 5910.024845900378, 5910.290765108214, 6051.4553690168095, 5886.499647530008, 5895.351511333664, 5895.852603684943, 5898.498627616701, 5900.64596124234, 5869.647821130746, 5873.353931067493, 5881.911771323348, 5883.235179426647, 5887.882242355215, 5608.971955140199, 5610.298712660918, 5614.719264036864, 5635.436456354331, 5674.0, 5753.453421924911, 5805.448482394166, 5811.302643682616, 5814.883702326015, 5831.591788574759, 5511.834644960658, 5659.745311460912, 5666.206731057738, 5670.064439367458, 5674.205611214351], "value": 5434.5421118447075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.2611474828586, 611.6238513314311, 617.6232498176112, 638.3074364314718, 651.8337823854916, 33655.663443365556, 45735.77132114339, 46703.76648116763, 46709.5329046709, 51119.23321150186, 48333.275000875015, 48694.75652621741, 48762.26856597145, 48777.268340974915, 48862.0, 8409.537475438849, 9312.30157738169, 9467.384619999713, 9469.053094690546, 9470.52647367629, 8416.284615807665, 10893.727656808564, 11202.607908723196, 11214.046806021497, 11690.649280521598, 11270.549178032868, 11274.661760147208, 11330.490127944262, 11331.320120792738, 11331.433428328592, 11191.216614836965, 11242.887571124265, 11255.493502792395, 11257.211995160342, 11267.323960562351, 10981.505832237568, 11028.613998510014, 11051.889481105167, 11106.111511079094, 11175.329480231212, 45516.3172552412, 45908.0, 45927.31109033367, 46306.76846615779, 46412.767936160104, 3531.770434921722, 3546.3261980223933, 3608.6030536640947, 3639.6724294813594, 3670.761400508985, 33893.83053084744, 33929.83035084809, 34194.65805341939, 34508.13729656779, 34682.0, 4645.396098507173, 4689.601383882374, 4724.622030237572, 4745.335653008581, 4778.283257511401, 351911.0, 352416.0, 352519.0, 353906.99999999744, 356017.0, 63787.6810615944, 64115.679421602596, 64205.0, 64240.036399454046, 64242.0, 39998.40002399966, 40967.1806563873, 41212.38181427281, 43801.0, 43867.341989870176, 19959.101840417217, 20082.799172008094, 20192.899035504728, 20218.19127234894, 20222.19111235534, 12610.306433146081, 12953.093283470067, 13343.66640833987, 15324.846751532565, 15494.690106197813, 20361.287354942506, 21260.468488287916, 21279.361619151452, 21345.89327053386, 21386.465338366666, 7253.419726421874, 7490.962545187348, 7604.049493813273, 7632.885506717404, 7835.255650713173, 1064.2869277584036, 1069.769999450122, 1079.3362082319318, 1118.1278602689915, 1212.030375699437, 34095.82952085224, 34390.312193755984, 34445.655543444744, 34748.30503389918, 35031.4745278821, 1141.4692168141853, 1171.8593768747805, 1177.8645455772526, 1231.205872212418, 1239.0768877186554, 18033.0, 18237.544061398305, 18282.90858545699, 18339.358122465917, 18358.908205458887, 559515.0, 560240.0, 563485.0, 565234.0, 566535.0, 42059.36910946338, 42185.36721949173, 42193.78903105465, 42304.78847605742, 42453.57546424496, 1344.7243315120572, 1380.171896861895, 1435.978460323096, 1448.7464693678564, 1450.7026059657744, 32600.34799304048, 34862.82568587141, 35021.64978350184, 35464.64535354613, 35745.642543574235, 55061.449385505635, 55495.722521387135, 55781.163282549984, 55822.44177558173, 55845.0, 431551.0, 432412.0, 439114.0, 452258.0, 462938.0, 30564.0, 31178.688213117577, 31191.84404077965, 32730.50904236391, 32788.0, 51818.48181518287, 51859.48140518546, 51982.74008629932, 52167.0, 53115.734421327645, 43670.56329436792, 44872.55127448684, 45012.0, 45446.0, 46096.07807843891, 43544.56455435405, 44351.77824110859, 44466.55533444624, 44751.77624111858, 45226.32160517529, 43653.0, 44577.33134003057, 44892.77553612211, 44909.0, 45072.323915140645, 35873.46189807207, 38730.80634596809, 39081.218375632896, 39095.609043910335, 39376.60623393844, 27178.592321114804, 27618.0, 27643.447131056862, 27832.721672783013, 27876.16371508858], "value": 21420.693546436654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.18438056651877, 393.43542017205294, 402.72815849301725, 406.3254996705468, 413.3569062974674, 18592.0, 20002.69995950062, 20137.29519466819, 20193.596128077446, 20249.797502024976, 18601.534961625934, 19262.807371926276, 20336.491587710316, 20444.182232710675, 20565.897170514127, 5484.040292948728, 5716.914246286309, 5976.432238937294, 6005.099235114724, 6010.519158467312, 5897.705114744267, 5920.082387229964, 5977.790777322794, 5979.910301345483, 5980.910286345708, 5692.487676109149, 5756.913646295309, 5788.768449262025, 5810.82567522975, 5818.883622327551, 5636.15457681347, 5829.0, 5867.853303667443, 5870.060790273557, 5875.529957603381, 5280.471952804727, 5282.630215884889, 5320.042392369372, 5327.946720532784, 5329.733513324319, 16366.181690915406, 22494.10023599054, 23235.0, 23268.534629307487, 23668.17161399343, 2368.0438093065077, 2448.7673671001226, 2475.987620061906, 2916.8833246670106, 2972.7919045666813, 10843.51204195813, 11076.224664273504, 11617.128715346384, 11638.941805291004, 12246.989240358307, 1964.6168997045581, 1987.592543528573, 1996.5707372914892, 2019.5859848730975, 2092.257248676713, 84589.0, 85223.5738821302, 86461.56769216113, 87649.0, 89136.66295005644, 11851.940740296242, 11868.881311186778, 11934.820977685342, 12153.756924861453, 12207.206531575419, 17118.914405428142, 17146.485605431855, 17171.914140429468, 17173.0, 17185.31258749661, 8624.827503449897, 8723.345749068845, 8781.2535934445, 8851.867221991675, 8866.0, 8394.286485648667, 8435.873461898076, 8454.66181352739, 8665.870011949826, 8670.95664521686, 5088.109580823341, 5222.947770522323, 5236.3716354037, 5249.816256431083, 5314.096603577401, 2033.745781777278, 2089.0494824854654, 2136.8931553422267, 2155.07331847304, 2164.383150802014, 916.8578870275118, 1001.4341896828269, 1003.7239759066169, 1049.6641074856125, 1056.3872953686844, 20335.18659253643, 20518.79481205169, 20811.79188208129, 21030.474238143863, 21088.0, 1013.5844303835393, 1036.2435422141878, 1041.8489319048695, 1058.364981011387, 1070.0690399352613, 10982.945085274523, 11593.657645527095, 11638.476268567765, 11642.53429862813, 11824.586139485076, 526203.0, 531885.0, 536196.0, 544869.0, 549335.0, 69352.71265774254, 71693.641531792, 97294.51352743333, 98741.0, 105247.4737626307, 945.4658118163215, 1019.8215312320463, 1038.4651904269308, 1048.5858086055964, 1057.349729916096, 17904.28382864671, 18326.450206493828, 18555.443336699922, 18606.720899186796, 18781.96699181558, 43149.13701726011, 43320.56679433292, 43407.56592434035, 43416.56583434252, 43623.0, 55890.441095588525, 58317.0, 61328.69335653293, 61858.381416185264, 63167.368326317985, 9024.557361746929, 9217.308701847522, 9237.399569027992, 9419.058094190526, 9654.420734755937, 12269.386530673251, 12339.197952133083, 12462.127651064338, 12511.374431278218, 12924.935375323063, 10199.235057370579, 10212.744681383025, 10792.35245885218, 10989.61536346224, 11381.487833047699, 10817.0, 11102.222844401138, 11106.777864442827, 11163.609273675382, 11202.271852329572, 11093.278936869077, 11612.303261804318, 11650.30098194111, 11701.2979221247, 11771.352575608424, 8989.0, 9073.364864459425, 9099.54502274897, 9257.35198536096, 9343.252539796937, 9190.724278271662, 11323.943380283046, 11527.481263343001, 11905.166638335233, 12052.397380131133], "value": 9542.62508648444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.6565022869856, 1564.327339244125, 1712.1867113121261, 1825.379371013855, 1861.0508640593303, 9115.680951166702, 9764.902350976488, 9773.511324433777, 9775.657851975191, 9779.070988256104, 8440.957795211016, 8639.136086391358, 8814.86777698335, 9009.324300677443, 9541.379810312324, 2532.4808414275076, 2551.8851651675627, 2552.9361765955814, 2556.514262290159, 2558.1302357198547, 2483.639872218527, 2572.961405578918, 2573.5367633825904, 2576.1627471071884, 2581.819272650915, 2485.2047344849657, 2501.9124330648433, 2506.724260331362, 2508.7240403555593, 2509.987450062747, 2408.1451084864884, 2416.0456619635147, 2422.34596658902, 2454.3005243505695, 2457.680501534789, 2418.8548687078833, 2420.9636855447184, 2427.7450867658995, 2428.5871401861727, 2468.6297055441646, 9400.482973436458, 9494.382865113745, 9504.334696571243, 9532.666356677551, 9620.470874101922, 5518.061929471999, 5676.3188417389765, 5676.801311954103, 5698.8290351289525, 5698.886022279531, 3491.3890069238037, 3630.963690363089, 3661.9450708239397, 3671.155634204148, 3672.8697355533727, 1100.5945397784894, 1175.723704929341, 1189.6133756529075, 1199.0407673860877, 1201.1471854982972, 13654.0, 13844.584662460142, 13885.4445822167, 13885.58343249694, 13912.721745565032, 4884.535969083003, 4918.0, 4927.852164435073, 5024.572911302507, 5107.259447380109, 11570.19008669402, 11599.0, 11599.246049006788, 11628.127890408085, 11637.185397022296, 5716.228309178291, 5728.283964504437, 5733.426657334233, 5737.713114344266, 5741.684207368551, 4674.088552732184, 4752.833650822205, 4844.878878028077, 5015.598752099823, 5262.763250636098, 4304.526502084768, 4323.1785960668, 4369.126174764996, 4420.557944205554, 4436.933445998313, 1225.0934308611563, 1226.172333674766, 1255.7990721484518, 1276.8276282701902, 1300.1419063418098, 972.7227740094039, 999.4702807511885, 1005.5525291245326, 1020.5305559442592, 1036.3056751976194, 6208.937910620836, 6293.527985401113, 6325.936740632626, 6394.296627370985, 6420.133282006963, 486.60584926209884, 488.16523744396767, 494.1821285772053, 499.62278479747556, 500.27709959109467, 4132.566080561558, 4220.0293932395725, 4228.682848786292, 4229.492460904711, 4259.1268789897995, 11555.480003399867, 11970.700732481584, 12049.337286449154, 12054.276743395425, 12067.698307542381, 11193.49629266685, 11855.644330669922, 11914.0, 11939.701507462209, 11960.342181180118, 8632.395732298804, 9023.774405639911, 9033.77415564616, 9034.774130646654, 9046.095390461032, 6424.38968298011, 6532.9346706534225, 6559.212894452697, 6643.833904152435, 6710.798676039727, 10743.677689669323, 11010.339379637247, 11052.281601695864, 11234.101271898066, 11235.494402751732, 11337.26307789991, 11427.314361138026, 11462.541498339973, 11480.770384592095, 11575.0, 7835.921640783519, 7890.329322007694, 8296.37777166727, 8446.535440550828, 8581.65673373058, 8989.41568798026, 9443.622255109718, 9453.574589143367, 9473.810523789623, 9474.194693450858, 8129.349652027942, 8179.631916563888, 8234.958825205835, 8410.579471026302, 8541.316694664536, 7995.360371170176, 8036.758897233092, 8175.427720059776, 8246.175382461706, 8294.294984926108, 7316.414686825147, 7426.4058875288765, 7479.952806606971, 7505.962470187614, 7559.848803024019, 5696.259486266758, 5757.309122905278, 5775.48020678141, 5837.09525023622, 5944.762209511571, 5682.971585142048, 5739.942600573941, 5768.53851691872, 5899.439553242435, 6009.369016253405], "value": 4904.144741746366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.4230344958396, 340.280307150377, 346.16056064044693, 350.78251484079874, 351.70808229169774, 5499.285092937917, 5520.757829488363, 5546.389897111315, 5573.6098473106895, 5588.748506317215, 5458.833876351717, 5518.889622207564, 5522.1776813651495, 5533.142362933751, 5551.278333816608, 3961.6236457536634, 4112.321466957948, 4225.7253278536955, 4305.67707421943, 4314.395984562164, 4295.0, 4301.763403012833, 4309.965608254028, 4318.568143185687, 4326.437563116806, 4294.4202532658, 4305.461817272841, 4331.133773245364, 4345.826166953318, 4363.149185908733, 4216.57834216579, 4329.826806927719, 4356.934645980328, 4361.0, 4367.3448982652535, 3847.8460861565504, 3851.7096772581217, 3861.474717486605, 3871.728978971473, 3907.772569635309, 5308.5487733542695, 5318.149096144598, 5329.44186790339, 5335.599830012765, 5392.1911713242935, 4670.626349892001, 4954.331165292675, 4964.131277026506, 4980.203167493184, 4994.875128121826, 5673.886522269531, 5675.0, 5675.914861277043, 5679.858003549903, 5698.772049118031, 4093.672506199497, 4151.14901445203, 4163.937540936889, 4166.270902592065, 4194.182134483777, 5546.223528705944, 5598.1602759585985, 5998.97000514999, 6041.939580604182, 6066.939330606681, 4196.748195108304, 4216.9789151054665, 4226.112516371535, 4226.852060177879, 4239.364095385655, 4302.741835489881, 4303.268444364466, 4308.332208507686, 4329.393884856123, 4330.761808100522, 4668.4631267404, 4928.975355123202, 4936.580390666762, 4943.134951383494, 4951.133551628451, 5784.8719499698, 5839.737211825478, 5842.824715258549, 5847.26909136358, 5931.73307201177, 1487.970240595182, 1503.7819516170093, 1510.4713350327297, 1518.5140754958306, 1520.6882589069214, 929.6513807322254, 955.9522023898777, 962.556165751373, 965.2374624047064, 976.6581696406344, 4915.705057696549, 4933.840547471413, 4939.431965323962, 4945.604351651859, 4954.677945933503, 5218.191180367049, 5220.843374698765, 5223.738813059332, 5230.3985041719925, 5231.503007214308, 4585.679002469795, 4910.312556242129, 4946.1312438786135, 4965.379327584052, 4989.55094041538, 2721.319670082479, 2727.4545090981487, 2745.32739478825, 2753.8072334936364, 2760.6135141080263, 5285.995660824431, 5350.91973620396, 5352.0366334060245, 5379.462053794589, 5397.271368365299, 5311.344327836082, 5327.0145023170835, 5590.91613625796, 6020.187274717945, 6099.725512351954, 6094.481969032682, 6119.848278136763, 6127.509799216141, 6130.816075517741, 6142.232220972379, 5688.0, 5968.403159683997, 5994.220751302303, 6019.729112189874, 6026.548008899263, 5839.445252700986, 5871.794487192928, 5912.793052243151, 5914.408559144051, 5921.851953701192, 5891.617044892068, 6011.0, 6031.939680603138, 6120.724567394567, 6173.32093469727, 4279.5606504292255, 4314.546972567835, 4318.898680836367, 4322.135572885372, 4362.978185109054, 5796.275465566804, 6022.879542409215, 6070.512724382378, 6073.939260607337, 6105.023196288573, 5771.336296325976, 5795.420457954339, 5829.737661805314, 5843.240378750906, 5846.210761547137, 5796.188533605215, 5800.8259752207505, 5802.593818432838, 5803.448672376117, 5826.446487583673, 5503.0, 5745.109508026263, 5752.6836024019085, 5779.682117483579, 5806.44838740319, 5825.417458254141, 5855.970720146372, 5861.208736820645, 5862.0, 5873.647581145145, 5527.972360138174, 5701.201831743476, 5756.769729210952, 5759.625624334405, 5768.019436695856], "value": 4335.222170421427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.9521228726277, 812.6302532347783, 817.5176645778989, 818.6725309876045, 849.0745087854245, 15477.535673929786, 15906.284217210225, 15910.602234944103, 16049.759253611206, 16148.515544533668, 15094.16982065986, 15265.084094954284, 15271.0, 15271.465498707548, 15318.387264509434, 735.7866218796543, 756.4893696754696, 861.9527274361649, 863.4473936680514, 876.5222953490331, 890.341147550811, 890.4434728294816, 893.0310612984919, 893.5219657483248, 893.5576889439736, 940.4451373689521, 942.9009953954838, 944.2540393089452, 944.527736131934, 944.5513381143936, 935.1677007463363, 937.5312343828018, 937.5406051034978, 937.6577549194529, 937.9906200937971, 688.1432616392573, 691.4710246661308, 691.4917535611322, 691.9655115602206, 692.0104250921181, 14854.405823767036, 14977.0, 14977.026493277903, 14990.47533336328, 14997.17515536645, 15826.046182164659, 16355.859367192417, 16357.0, 16470.67058658832, 17066.317347306092, 13352.86647133526, 13536.526221582295, 13552.186868787905, 13640.590782276548, 13668.52160174399, 4100.5489396166395, 4155.958440415588, 4163.417121602978, 4250.468691413574, 4271.145770845843, 78014.21985780183, 87571.56214218888, 90864.54567727119, 92833.0, 92914.0, 11840.526378944745, 12435.875641243472, 12554.372281385895, 12578.622641320591, 12804.61586152417, 21474.677879831816, 21476.57046859054, 21498.46253843635, 21502.0, 21504.0, 9210.907890921138, 9269.67556135532, 9271.443713377219, 9314.673986410444, 9640.71077867665, 4956.553910148104, 5177.663451875616, 5259.500347466985, 5328.120860058125, 5402.648827826258, 3398.966010339914, 3528.347255757693, 3528.6647768461953, 3534.6465353464964, 3537.2394935088564, 638.8818068657313, 642.2261175283771, 645.6803882078401, 653.3401264722664, 669.0365873142756, 735.9779206623703, 759.9620018999028, 774.5468900693157, 784.5528049012122, 792.8453951479521, 10068.798624027479, 10296.279260451696, 10412.947935260276, 10442.269041167197, 10701.866581398193, 645.3933302695451, 713.600383785082, 728.3299364584595, 773.8761798112275, 780.1613265739353, 4891.9755401222765, 5010.123228435009, 5018.121828679967, 5030.0694371541385, 5060.468650791614, 80135.0, 80963.59518202489, 81083.18916810756, 98431.50784246033, 127384.0, 68524.0, 121710.0, 123379.76620233862, 124745.0, 125498.0, 102918.0, 105457.47271263748, 105580.0, 106315.46842265895, 107350.48546601663, 9177.724668259963, 9340.439573625605, 9355.719328420158, 9412.15290623847, 9556.95221523888, 49257.507424925294, 49796.00407991892, 59901.0, 60652.0, 61258.38741612527, 48789.0, 49553.513394598216, 52898.47101528935, 67904.64190716059, 69540.65229673819, 13252.0, 13383.665408364868, 13606.0, 13645.181289122684, 13661.043726939019, 14573.92713036428, 14849.554513364616, 14854.0, 14903.0, 15105.244737762849, 13722.65693357674, 13906.363024120208, 14292.42830286777, 14379.712405752036, 14397.64005899861, 14282.785758213427, 14454.421823126957, 14467.638309042359, 14503.78244326357, 15344.769828452805, 13413.128146670435, 13541.322933853071, 13864.653383665489, 14335.139891606537, 14438.639034023814, 11916.702082448008, 11972.58095966637, 12136.635900922987, 12486.0, 12970.675733106747, 10518.526666300188, 10536.473176340998, 11906.464209110438, 11978.281303121841, 12091.334976576372], "value": 7952.025006163166, "unit": "score"}], "name": "dromaeo_css", "value": 7567.636066634616, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 111.0, 112.0, 112.0, 110.0, 112.0, 111.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 118.0, 151.0, 119.0, 122.0, 122.0, 117.0, 147.0, 117.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 161.0, 162.0, 162.0, 160.0, 163.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 112.0, 76.0, 75.0, 75.0, 76.0, 101.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 81.0, 81.0, 82.0, 99.0, 81.0, 82.0, 111.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 51.0, 52.0, 50.0, 52.0, 49.0, 50.0, 50.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 57.0, 59.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 79.0, 82.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 130.0, 121.0, 122.0, 134.0, 119.0, 119.0, 125.0, 169.0, 121.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 156.0, 156.0, 156.0, 154.0, 154.0, 153.0, 155.0, 157.0, 154.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 70.0, 63.0, 61.0, 63.0, 60.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1458.2, "alertThreshold": 2.0}]} 18:58:36 INFO - Return code: 0 18:58:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:58:36 INFO - # TBPL SUCCESS # 18:58:36 INFO - Running post-action listener: _resource_record_post_action 18:58:36 INFO - [mozharness: 2017-01-10 02:58:36.365916Z] Finished run-tests step (success) 18:58:36 INFO - Running post-run listener: _resource_record_post_run 18:58:36 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 1867776; Write bytes: 335130624; Read time: 896; Write time: 240948 18:58:36 INFO - TinderboxPrint: CPU usage
12.9% 18:58:36 INFO - TinderboxPrint: I/O read bytes / time
1,867,776 / 896 18:58:36 INFO - TinderboxPrint: I/O write bytes / time
335,130,624 / 240,948 18:58:36 INFO - TinderboxPrint: CPU idle
8,248.3 (87.0%) 18:58:36 INFO - TinderboxPrint: CPU user
1,183.0 (12.5%) 18:58:36 INFO - TinderboxPrint: Swap in / out
0 / 0 18:58:36 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 105664512; Read time: 0; Write time: 111924 18:58:36 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217874432; Read time: 12; Write time: 127156 18:58:36 INFO - Running post-run listener: _upload_blobber_files 18:58:37 INFO - Blob upload gear active. 18:58:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:58: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 18:58: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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:58: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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:58:37 INFO - (blobuploader) - INFO - Open directory for files ... 18:58:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:58:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:58:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:40 INFO - (blobuploader) - INFO - Done attempting. 18:58:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:58:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:58:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:41 INFO - (blobuploader) - INFO - Done attempting. 18:58:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:58:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:58:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:42 INFO - (blobuploader) - INFO - Done attempting. 18:58:42 INFO - (blobuploader) - INFO - Iteration through files over. 18:58:42 INFO - Return code: 0 18:58:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:58:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:58:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7ac8239089dda2181091b0bd0d0e8d0f497eebad1a501feac9ac55f32b167e2ccfda156d20accb19b95570bda5f0502fe9cbeb6ec65343a885f65c776bb4c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84d87e0f15d85786cb2358877b703ef610f6445d7c52bfcd809fb3483be47fc245ab98d8343921fbf0ddd4b112ef1be45f3963b11810fde2e0a2ffa2f79425b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f6744cbeb28ef55d730e12884abb142e5fcecc1e68556bbea0daab37372d740f181183dcbdeb7be1fb28b31a60aeb6d552433017a14ab257937ddd7bc0e228b"} 18:58:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:58:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:58:42 INFO - Contents: 18:58:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7ac8239089dda2181091b0bd0d0e8d0f497eebad1a501feac9ac55f32b167e2ccfda156d20accb19b95570bda5f0502fe9cbeb6ec65343a885f65c776bb4c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84d87e0f15d85786cb2358877b703ef610f6445d7c52bfcd809fb3483be47fc245ab98d8343921fbf0ddd4b112ef1be45f3963b11810fde2e0a2ffa2f79425b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f6744cbeb28ef55d730e12884abb142e5fcecc1e68556bbea0daab37372d740f181183dcbdeb7be1fb28b31a60aeb6d552433017a14ab257937ddd7bc0e228b"} 18:58:42 INFO - Running post-run listener: copy_logs_to_upload_dir 18:58:42 INFO - Copying logs to upload dir... 18:58:42 INFO - mkdir: /builds/slave/test/build/upload/logs 18:58:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.206280 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-01-09 18:58:42.342783) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 18:58:42.346634) ========= 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=af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7ac8239089dda2181091b0bd0d0e8d0f497eebad1a501feac9ac55f32b167e2ccfda156d20accb19b95570bda5f0502fe9cbeb6ec65343a885f65c776bb4c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84d87e0f15d85786cb2358877b703ef610f6445d7c52bfcd809fb3483be47fc245ab98d8343921fbf0ddd4b112ef1be45f3963b11810fde2e0a2ffa2f79425b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f6744cbeb28ef55d730e12884abb142e5fcecc1e68556bbea0daab37372d740f181183dcbdeb7be1fb28b31a60aeb6d552433017a14ab257937ddd7bc0e228b"} build_url:https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/BODTSpxxTamHM8vAMvbmDg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7ac8239089dda2181091b0bd0d0e8d0f497eebad1a501feac9ac55f32b167e2ccfda156d20accb19b95570bda5f0502fe9cbeb6ec65343a885f65c776bb4c56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84d87e0f15d85786cb2358877b703ef610f6445d7c52bfcd809fb3483be47fc245ab98d8343921fbf0ddd4b112ef1be45f3963b11810fde2e0a2ffa2f79425b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f6744cbeb28ef55d730e12884abb142e5fcecc1e68556bbea0daab37372d740f181183dcbdeb7be1fb28b31a60aeb6d552433017a14ab257937ddd7bc0e228b"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 18:58:42.409567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 18:58:42.409940) ========= 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=af724c981e2a0f424dbabf99000001e7-1484015464.465271-726825862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 18:58:42.458962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 18:58:42.460352) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 18:58:42.460649) ========= ========= Total master_lag: 0.19 =========