builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1480476406.02 results: success (0) buildid: 20161129163426 builduid: 3e7aad7cda1146f5b6a2458ef57eb1f6 revision: c736f46410bfef32acf9f38adaa930a9684b28c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:46.016360) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:46.016870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:46.017215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:46.032194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:46.032619) ========= 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=20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 19:26:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.1M=0s 2016-11-29 19:26:46 (42.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081504 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:46.128455) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:46.128811) ========= 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=20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016755 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:46.179194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 19:26:46.179597) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c736f46410bfef32acf9f38adaa930a9684b28c1 --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 c736f46410bfef32acf9f38adaa930a9684b28c1 --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=20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 19:26:46,327 truncating revision to first 12 chars 2016-11-29 19:26:46,327 Setting DEBUG logging. 2016-11-29 19:26:46,327 attempt 1/10 2016-11-29 19:26:46,327 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c736f46410bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 19:26:47,040 unpacking tar archive at: mozilla-beta-c736f46410bf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.025624 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 19:26:47.220739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:47.221128) ========= script_repo_revision: c736f46410bfef32acf9f38adaa930a9684b28c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:47.221593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:47.221912) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 19:26:47.232427) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-11-29 19:26:47.232750) ========= /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=20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:26:47 INFO - MultiFileLogger online at 20161129 19:26:47 in /builds/slave/test 19:26:47 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 19:26:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:26:47 INFO - {'append_to_log': False, 19:26:47 INFO - 'base_work_dir': '/builds/slave/test', 19:26:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:26:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:26:47 INFO - 'branch': 'Mozilla-Beta', 19:26:47 INFO - 'buildbot_json_path': 'buildprops.json', 19:26:47 INFO - 'config_files': ('talos/linux_config.py',), 19:26:47 INFO - 'default_actions': ('clobber', 19:26:47 INFO - 'read-buildbot-config', 19:26:47 INFO - 'download-and-extract', 19:26:47 INFO - 'populate-webroot', 19:26:47 INFO - 'create-virtualenv', 19:26:47 INFO - 'install', 19:26:47 INFO - 'run-tests'), 19:26:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:26:47 INFO - 'download_minidump_stackwalk': True, 19:26:47 INFO - 'download_symbols': 'ondemand', 19:26:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:26:47 INFO - 'tooltool.py': '/tools/tooltool.py', 19:26:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:26:47 INFO - '/tools/misc-python/virtualenv.py')}, 19:26:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:26:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:26:47 INFO - 'installer_path': 'installer.exe', 19:26:47 INFO - 'log_level': 'info', 19:26:47 INFO - 'log_name': 'talos', 19:26:47 INFO - 'log_to_console': True, 19:26:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:26:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:26:47 INFO - 'opt_config_files': (), 19:26:47 INFO - 'pip_index': False, 19:26:47 INFO - 'sps_profile': False, 19:26:47 INFO - 'sps_profile_interval': 0, 19:26:47 INFO - 'suite': 'dromaeojs', 19:26:47 INFO - 'system_bits': '32', 19:26:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:26:47 INFO - 'title': 'talos-linux64-ix-015', 19:26:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:26:47 INFO - 'use_talos_json': True, 19:26:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:26:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:26:47 INFO - 'work_dir': 'build'} 19:26:47 INFO - [mozharness: 2016-11-30 03:26:47.479727Z] Running clobber step. 19:26:47 INFO - Running pre-action listener: _resource_record_pre_action 19:26:47 INFO - Running main action method: clobber 19:26:47 INFO - rmtree: /builds/slave/test/build 19:26:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:26:48 INFO - Running post-action listener: _resource_record_post_action 19:26:48 INFO - [mozharness: 2016-11-30 03:26:48.527646Z] Finished clobber step (success) 19:26:48 INFO - [mozharness: 2016-11-30 03:26:48.527745Z] Running read-buildbot-config step. 19:26:48 INFO - Running pre-action listener: _resource_record_pre_action 19:26:48 INFO - Running main action method: read_buildbot_config 19:26:48 INFO - Using buildbot properties: 19:26:48 INFO - { 19:26:48 INFO - "project": "", 19:26:48 INFO - "product": "firefox", 19:26:48 INFO - "script_repo_revision": "production", 19:26:48 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 19:26:48 INFO - "repository": "", 19:26:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 19:26:48 INFO - "buildid": "20161129163426", 19:26:48 INFO - "pgo_build": "True", 19:26:48 INFO - "basedir": "/builds/slave/test", 19:26:48 INFO - "buildnumber": 36, 19:26:48 INFO - "slavename": "talos-linux64-ix-015", 19:26:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:26:48 INFO - "platform": "ubuntu64_hw", 19:26:48 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:26:48 INFO - "branch": "mozilla-beta", 19:26:48 INFO - "repo_path": "releases/mozilla-beta", 19:26:48 INFO - "revision": "c736f46410bfef32acf9f38adaa930a9684b28c1", 19:26:48 INFO - "stage_platform": "linux64-pgo", 19:26:48 INFO - "builduid": "3e7aad7cda1146f5b6a2458ef57eb1f6", 19:26:48 INFO - "slavebuilddir": "test" 19:26:48 INFO - } 19:26:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 19:26:48 INFO - Running post-action listener: _resource_record_post_action 19:26:48 INFO - [mozharness: 2016-11-30 03:26:48.530186Z] Finished read-buildbot-config step (success) 19:26:48 INFO - [mozharness: 2016-11-30 03:26:48.530276Z] Running download-and-extract step. 19:26:48 INFO - Running pre-action listener: _resource_record_pre_action 19:26:48 INFO - Running main action method: download_and_extract 19:26:48 INFO - mkdir: /builds/slave/test/build/tests 19:26: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')]} 19:26:48 INFO - trying https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 19:26:48 INFO - Downloading https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/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 19:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/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 19:26:49 INFO - Downloaded 1327 bytes. 19:26:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 19:26:49 INFO - Using the following test package requirements: 19:26:49 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 19:26:49 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 19:26:49 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:26:49 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 19:26:49 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 19:26:49 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 19:26:49 INFO - u'jsshell-linux-x86_64.zip'], 19:26:49 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 19:26:49 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:26:49 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 19:26:49 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 19:26:49 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 19:26:49 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 19:26:49 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 19:26:49 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 19:26:49 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:26:49 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 19:26:49 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:26:49 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:26:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 19:26:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:26:49 INFO - Fetch https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 19:26:49 INFO - Expected file size: 21962327 19:26:54 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 19:26:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 19:26:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:26:54 INFO - Fetch https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 19:26:54 INFO - Expected file size: 21962327 19:26:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 19:26:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:26:59 INFO - Fetch https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 19:26:59 INFO - Expected file size: 14414089 19:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:00 INFO - trying https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 19:27:00 INFO - Downloading https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/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 19:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/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 19:27:01 INFO - Downloaded 56987808 bytes. 19:27:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 19:27:01 INFO - mkdir: /builds/slave/test/properties 19:27:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:27:01 INFO - Writing to file /builds/slave/test/properties/build_url 19:27:01 INFO - Contents: 19:27:01 INFO - build_url:https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 19:27:01 INFO - Running post-action listener: _resource_record_post_action 19:27:01 INFO - Running post-action listener: set_extra_try_arguments 19:27:01 INFO - [mozharness: 2016-11-30 03:27:01.983463Z] Finished download-and-extract step (success) 19:27:01 INFO - [mozharness: 2016-11-30 03:27:01.983690Z] Running populate-webroot step. 19:27:01 INFO - Running pre-action listener: _resource_record_pre_action 19:27:01 INFO - Running main action method: populate_webroot 19:27:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:27:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:27:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:27:01 INFO - '--tppagecycles', 19:27:01 INFO - '7'], 19:27:01 INFO - 'tests': ['tsvgm']}}, 19:27:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:27:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:27:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:27:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:27:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:27:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:27:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:01 INFO - 'talos_options': ['--disable-e10s'], 19:27:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:02 INFO - 'talos_options': ['--disable-e10s'], 19:27:02 INFO - 'tests': ['damp', 'tps']}, 19:27:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:02 INFO - 'tests': ['damp', 'tps']}, 19:27:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:27:02 INFO - 'tests': ['dromaeo_dom']}, 19:27:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:27:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:27:02 INFO - 'tests': ['basic_compositor_video']}, 19:27:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:27:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:27:02 INFO - 'tests': ['a11yr', 19:27:02 INFO - 'ts_paint', 19:27:02 INFO - 'tpaint', 19:27:02 INFO - 'sessionrestore', 19:27:02 INFO - 'sessionrestore_no_auto_restore', 19:27:02 INFO - 'tabpaint']}, 19:27:02 INFO - 'other-e10s': {'tests': ['a11yr', 19:27:02 INFO - 'ts_paint', 19:27:02 INFO - 'tpaint', 19:27:02 INFO - 'sessionrestore', 19:27:02 INFO - 'sessionrestore_no_auto_restore', 19:27:02 INFO - 'tabpaint']}, 19:27:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:27:02 INFO - 'ts_paint', 19:27:02 INFO - 'tpaint', 19:27:02 INFO - 'sessionrestore', 19:27:02 INFO - 'sessionrestore_no_auto_restore', 19:27:02 INFO - 'tabpaint']}, 19:27:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:27:02 INFO - 'ts_paint', 19:27:02 INFO - 'tpaint', 19:27:02 INFO - 'sessionrestore', 19:27:02 INFO - 'sessionrestore_no_auto_restore', 19:27:02 INFO - 'tabpaint']}, 19:27:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:27:02 INFO - 'tests': ['a11yr', 19:27:02 INFO - 'ts_paint', 19:27:02 INFO - 'tpaint', 19:27:02 INFO - 'sessionrestore', 19:27:02 INFO - 'sessionrestore_no_auto_restore', 19:27:02 INFO - 'tabpaint']}, 19:27:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:27:02 INFO - 'tests': ['a11yr', 19:27:02 INFO - 'ts_paint', 19:27:02 INFO - 'tpaint', 19:27:02 INFO - 'sessionrestore', 19:27:02 INFO - 'sessionrestore_no_auto_restore', 19:27:02 INFO - 'tabpaint']}, 19:27:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:27:02 INFO - 'tests': ['tsvgx', 19:27:02 INFO - 'tsvgr_opacity', 19:27:02 INFO - 'tart', 19:27:02 INFO - 'tscrollx', 19:27:02 INFO - 'cart']}, 19:27:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:27:02 INFO - 'tsvgr_opacity', 19:27:02 INFO - 'tart', 19:27:02 INFO - 'tscrollx', 19:27:02 INFO - 'cart']}, 19:27:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:02 INFO - 'talos_options': ['--disable-e10s'], 19:27:02 INFO - 'tests': ['tp5o']}, 19:27:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:02 INFO - 'tests': ['tp5o']}, 19:27:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:02 INFO - 'talos_options': ['--disable-e10s', 19:27:02 INFO - '--xperf_path', 19:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:02 INFO - 'tests': ['tp5n']}, 19:27:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:02 INFO - 'talos_options': ['--xperf_path', 19:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:02 INFO - 'tests': ['tp5n']}}, 19:27:02 INFO - 'talos.zip': {'path': '', 19:27:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:27:02 INFO - Running post-action listener: _resource_record_post_action 19:27:02 INFO - [mozharness: 2016-11-30 03:27:02.006399Z] Finished populate-webroot step (success) 19:27:02 INFO - [mozharness: 2016-11-30 03:27:02.006502Z] Running create-virtualenv step. 19:27:02 INFO - Running pre-action listener: _resource_record_pre_action 19:27:02 INFO - Running main action method: create_virtualenv 19:27:02 INFO - Creating virtualenv /builds/slave/test/build/venv 19:27:02 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 19:27:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:27:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:27:02 INFO - Using real prefix '/usr' 19:27:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:27:02 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:04 INFO - Installing pip.................done. 19:27:04 INFO - Return code: 0 19:27:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27:04 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')]} 19:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:04 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')]} 19:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:04 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 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:04 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 19:27:04 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 19:27:04 INFO - Using env: {'DISPLAY': ':0', 19:27:04 INFO - 'HOME': '/home/cltbld', 19:27:04 INFO - 'LANG': 'en_US.UTF-8', 19:27:04 INFO - 'LANGUAGE': 'en_US:en', 19:27:04 INFO - 'LOGNAME': 'cltbld', 19:27:04 INFO - 'MAIL': '/var/mail/cltbld', 19:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:04 INFO - 'MOZ_NO_REMOTE': '1', 19:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:04 INFO - 'NO_EM_RESTART': '1', 19:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:04 INFO - 'PWD': '/builds/slave/test', 19:27:04 INFO - 'SHELL': '/bin/bash', 19:27:04 INFO - 'SHLVL': '1', 19:27:04 INFO - 'TERM': 'linux', 19:27:04 INFO - 'TMOUT': '86400', 19:27:04 INFO - 'USER': 'cltbld', 19:27:04 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:04 INFO - '_': '/tools/buildbot/bin/python'} 19:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:04 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 19:27:04 INFO - Cleaning up... 19:27:04 INFO - Return code: 0 19:27:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:27:04 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')]} 19:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:04 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')]} 19:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:04 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 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:04 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 19:27:04 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 19:27:04 INFO - Using env: {'DISPLAY': ':0', 19:27:04 INFO - 'HOME': '/home/cltbld', 19:27:04 INFO - 'LANG': 'en_US.UTF-8', 19:27:04 INFO - 'LANGUAGE': 'en_US:en', 19:27:04 INFO - 'LOGNAME': 'cltbld', 19:27:04 INFO - 'MAIL': '/var/mail/cltbld', 19:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:04 INFO - 'MOZ_NO_REMOTE': '1', 19:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:04 INFO - 'NO_EM_RESTART': '1', 19:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:04 INFO - 'PWD': '/builds/slave/test', 19:27:04 INFO - 'SHELL': '/bin/bash', 19:27:04 INFO - 'SHLVL': '1', 19:27:04 INFO - 'TERM': 'linux', 19:27:04 INFO - 'TMOUT': '86400', 19:27:04 INFO - 'USER': 'cltbld', 19:27:04 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:04 INFO - '_': '/tools/buildbot/bin/python'} 19:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:05 INFO - Downloading/unpacking psutil>=3.1.1 19:27:05 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 19:27:05 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 19:27:05 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 19:27:05 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 19:27:05 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 19:27:05 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 19:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:07 INFO - Installing collected packages: psutil 19:27:07 INFO - Running setup.py install for psutil 19:27:07 INFO - building 'psutil._psutil_linux' extension 19:27:07 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 19:27:07 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 19:27:07 INFO - building 'psutil._psutil_posix' extension 19:27:07 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 19:27:07 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 19:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:07 INFO - Successfully installed psutil 19:27:07 INFO - Cleaning up... 19:27:07 INFO - Return code: 0 19:27:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:27:07 INFO - Using env: {'DISPLAY': ':0', 19:27:07 INFO - 'HOME': '/home/cltbld', 19:27:07 INFO - 'LANG': 'en_US.UTF-8', 19:27:07 INFO - 'LANGUAGE': 'en_US:en', 19:27:07 INFO - 'LOGNAME': 'cltbld', 19:27:07 INFO - 'MAIL': '/var/mail/cltbld', 19:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:07 INFO - 'MOZ_NO_REMOTE': '1', 19:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:07 INFO - 'NO_EM_RESTART': '1', 19:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:07 INFO - 'PWD': '/builds/slave/test', 19:27:07 INFO - 'SHELL': '/bin/bash', 19:27:07 INFO - 'SHLVL': '1', 19:27:07 INFO - 'TERM': 'linux', 19:27:07 INFO - 'TMOUT': '86400', 19:27:07 INFO - 'USER': 'cltbld', 19:27:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:07 INFO - '_': '/tools/buildbot/bin/python'} 19:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:27:09 INFO - Installing collected packages: mozsystemmonitor 19:27:09 INFO - Running setup.py install for mozsystemmonitor 19:27:09 INFO - Successfully installed mozsystemmonitor 19:27:09 INFO - Cleaning up... 19:27:10 INFO - Return code: 0 19:27:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:27:10 INFO - Using env: {'DISPLAY': ':0', 19:27:10 INFO - 'HOME': '/home/cltbld', 19:27:10 INFO - 'LANG': 'en_US.UTF-8', 19:27:10 INFO - 'LANGUAGE': 'en_US:en', 19:27:10 INFO - 'LOGNAME': 'cltbld', 19:27:10 INFO - 'MAIL': '/var/mail/cltbld', 19:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:10 INFO - 'MOZ_NO_REMOTE': '1', 19:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:10 INFO - 'NO_EM_RESTART': '1', 19:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:10 INFO - 'PWD': '/builds/slave/test', 19:27:10 INFO - 'SHELL': '/bin/bash', 19:27:10 INFO - 'SHLVL': '1', 19:27:10 INFO - 'TERM': 'linux', 19:27:10 INFO - 'TMOUT': '86400', 19:27:10 INFO - 'USER': 'cltbld', 19:27:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:10 INFO - '_': '/tools/buildbot/bin/python'} 19:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:10 INFO - Downloading/unpacking jsonschema==2.5.1 19:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:12 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:12 INFO - warning: no files found matching '*.txt' 19:27:12 INFO - no previously-included directories found matching 'build' 19:27:12 INFO - no previously-included directories found matching 'dist' 19:27:12 INFO - no previously-included directories found matching '.git*' 19:27:12 INFO - Installing collected packages: jsonschema, functools32 19:27:12 INFO - Running setup.py install for functools32 19:27:12 INFO - warning: no files found matching '*.txt' 19:27:12 INFO - no previously-included directories found matching 'build' 19:27:12 INFO - no previously-included directories found matching 'dist' 19:27:12 INFO - no previously-included directories found matching '.git*' 19:27:12 INFO - Successfully installed jsonschema functools32 19:27:12 INFO - Cleaning up... 19:27:12 INFO - Return code: 0 19:27:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:27:12 INFO - Using env: {'DISPLAY': ':0', 19:27:12 INFO - 'HOME': '/home/cltbld', 19:27:12 INFO - 'LANG': 'en_US.UTF-8', 19:27:12 INFO - 'LANGUAGE': 'en_US:en', 19:27:12 INFO - 'LOGNAME': 'cltbld', 19:27:12 INFO - 'MAIL': '/var/mail/cltbld', 19:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:12 INFO - 'MOZ_NO_REMOTE': '1', 19:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:12 INFO - 'NO_EM_RESTART': '1', 19:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:12 INFO - 'PWD': '/builds/slave/test', 19:27:12 INFO - 'SHELL': '/bin/bash', 19:27:12 INFO - 'SHLVL': '1', 19:27:12 INFO - 'TERM': 'linux', 19:27:12 INFO - 'TMOUT': '86400', 19:27:12 INFO - 'USER': 'cltbld', 19:27:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:12 INFO - '_': '/tools/buildbot/bin/python'} 19:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:27:12 INFO - Cleaning up... 19:27:12 INFO - Return code: 0 19:27:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:27:12 INFO - Using env: {'DISPLAY': ':0', 19:27:12 INFO - 'HOME': '/home/cltbld', 19:27:12 INFO - 'LANG': 'en_US.UTF-8', 19:27:12 INFO - 'LANGUAGE': 'en_US:en', 19:27:12 INFO - 'LOGNAME': 'cltbld', 19:27:12 INFO - 'MAIL': '/var/mail/cltbld', 19:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:12 INFO - 'MOZ_NO_REMOTE': '1', 19:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:12 INFO - 'NO_EM_RESTART': '1', 19:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:12 INFO - 'PWD': '/builds/slave/test', 19:27:12 INFO - 'SHELL': '/bin/bash', 19:27:12 INFO - 'SHLVL': '1', 19:27:12 INFO - 'TERM': 'linux', 19:27:12 INFO - 'TMOUT': '86400', 19:27:12 INFO - 'USER': 'cltbld', 19:27:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:12 INFO - '_': '/tools/buildbot/bin/python'} 19:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:13 INFO - Downloading/unpacking blobuploader==1.2.4 19:27:13 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 19:27:13 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 19:27:13 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 19:27:13 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 19:27:13 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 19:27:13 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 19:27:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:15 INFO - Downloading docopt-0.6.1.tar.gz 19:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:15 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:15 INFO - Running setup.py install for blobuploader 19:27:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:15 INFO - Running setup.py install for requests 19:27:16 INFO - Running setup.py install for docopt 19:27:16 INFO - Successfully installed blobuploader requests docopt 19:27:16 INFO - Cleaning up... 19:27:16 INFO - Return code: 0 19:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:16 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')]} 19:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:16 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')]} 19:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:16 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 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:16 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 19:27:16 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 19:27:16 INFO - Using env: {'DISPLAY': ':0', 19:27:16 INFO - 'HOME': '/home/cltbld', 19:27:16 INFO - 'LANG': 'en_US.UTF-8', 19:27:16 INFO - 'LANGUAGE': 'en_US:en', 19:27:16 INFO - 'LOGNAME': 'cltbld', 19:27:16 INFO - 'MAIL': '/var/mail/cltbld', 19:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:16 INFO - 'MOZ_NO_REMOTE': '1', 19:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:16 INFO - 'NO_EM_RESTART': '1', 19:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:16 INFO - 'PWD': '/builds/slave/test', 19:27:16 INFO - 'SHELL': '/bin/bash', 19:27:16 INFO - 'SHLVL': '1', 19:27:16 INFO - 'TERM': 'linux', 19:27:16 INFO - 'TMOUT': '86400', 19:27:16 INFO - 'USER': 'cltbld', 19:27:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:16 INFO - '_': '/tools/buildbot/bin/python'} 19:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:16 INFO - Running setup.py (path:/tmp/pip-kk3uq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:16 INFO - Running setup.py (path:/tmp/pip-M9HlN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:16 INFO - Running setup.py (path:/tmp/pip-Q8V_2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:16 INFO - Running setup.py (path:/tmp/pip-SrpPgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:17 INFO - Running setup.py (path:/tmp/pip-LU_Lvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:17 INFO - Running setup.py (path:/tmp/pip-COID_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:17 INFO - Running setup.py (path:/tmp/pip-2MHxxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:17 INFO - Running setup.py (path:/tmp/pip-hSNFYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:17 INFO - Running setup.py (path:/tmp/pip-fde1PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:17 INFO - Running setup.py (path:/tmp/pip-TsJKBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:17 INFO - Running setup.py (path:/tmp/pip-m2RQNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:17 INFO - Running setup.py (path:/tmp/pip-Z2p68U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:17 INFO - Running setup.py (path:/tmp/pip-ldNmlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:17 INFO - Running setup.py (path:/tmp/pip-zqkhT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:17 INFO - Running setup.py (path:/tmp/pip-k_9k2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:17 INFO - Running setup.py (path:/tmp/pip-c7WvI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:17 INFO - Running setup.py (path:/tmp/pip-nncbrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:17 INFO - Running setup.py install for manifestparser 19:27:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Running setup.py install for mozcrash 19:27:18 INFO - Running setup.py install for mozdebug 19:27:18 INFO - Running setup.py install for mozdevice 19:27:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Running setup.py install for mozfile 19:27:18 INFO - Running setup.py install for mozhttpd 19:27:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Running setup.py install for mozinfo 19:27:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Running setup.py install for mozInstall 19:27:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Running setup.py install for mozleak 19:27:18 INFO - Running setup.py install for mozlog 19:27:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Running setup.py install for moznetwork 19:27:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:19 INFO - Running setup.py install for mozprocess 19:27:19 INFO - Running setup.py install for mozprofile 19:27:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:19 INFO - Running setup.py install for mozrunner 19:27:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:19 INFO - Running setup.py install for mozscreenshot 19:27:19 INFO - Running setup.py install for moztest 19:27:19 INFO - Running setup.py install for mozversion 19:27:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:19 INFO - Cleaning up... 19:27:19 INFO - Return code: 0 19:27:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:19 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 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:19 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 19:27:19 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 19:27:19 INFO - Using env: {'DISPLAY': ':0', 19:27:19 INFO - 'HOME': '/home/cltbld', 19:27:19 INFO - 'LANG': 'en_US.UTF-8', 19:27:19 INFO - 'LANGUAGE': 'en_US:en', 19:27:19 INFO - 'LOGNAME': 'cltbld', 19:27:19 INFO - 'MAIL': '/var/mail/cltbld', 19:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:19 INFO - 'MOZ_NO_REMOTE': '1', 19:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:19 INFO - 'NO_EM_RESTART': '1', 19:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:19 INFO - 'PWD': '/builds/slave/test', 19:27:19 INFO - 'SHELL': '/bin/bash', 19:27:19 INFO - 'SHLVL': '1', 19:27:19 INFO - 'TERM': 'linux', 19:27:19 INFO - 'TMOUT': '86400', 19:27:19 INFO - 'USER': 'cltbld', 19:27:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:19 INFO - '_': '/tools/buildbot/bin/python'} 19:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:19 INFO - Running setup.py (path:/tmp/pip-n3_Dj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:20 INFO - Running setup.py (path:/tmp/pip-MWdFU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:20 INFO - Running setup.py (path:/tmp/pip-r2V5av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:20 INFO - Running setup.py (path:/tmp/pip-sqmV2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:20 INFO - Running setup.py (path:/tmp/pip-KmXKdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:20 INFO - Running setup.py (path:/tmp/pip-Dr0Aqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:20 INFO - Running setup.py (path:/tmp/pip-yQm8Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:20 INFO - Running setup.py (path:/tmp/pip-ttIe7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:20 INFO - Running setup.py (path:/tmp/pip-jFs1e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:20 INFO - Running setup.py (path:/tmp/pip-xFAjkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:20 INFO - Running setup.py (path:/tmp/pip-5Ii9mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:20 INFO - Running setup.py (path:/tmp/pip-uxxct9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:20 INFO - Running setup.py (path:/tmp/pip-eXxuFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:20 INFO - Running setup.py (path:/tmp/pip-GGlJ6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:21 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)) 19:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:21 INFO - Running setup.py (path:/tmp/pip-J2MSOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:21 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)) 19:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:21 INFO - Running setup.py (path:/tmp/pip-ZJh5IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:21 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)) 19:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:21 INFO - Running setup.py (path:/tmp/pip-FuywKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:21 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)) 19:27:21 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)) 19:27:21 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)) 19:27:21 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)) 19:27:21 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)) 19:27:21 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)) 19:27:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:23 INFO - Downloading blessings-1.6.tar.gz 19:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:27:23 INFO - Installing collected packages: blessings 19:27:23 INFO - Running setup.py install for blessings 19:27:23 INFO - Successfully installed blessings 19:27:23 INFO - Cleaning up... 19:27:23 INFO - Return code: 0 19:27:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:23 INFO - Reading from file tmpfile_stdout 19:27:23 INFO - Current package versions: 19:27:23 INFO - argparse == 1.2.1 19:27:23 INFO - blessings == 1.6 19:27:23 INFO - blobuploader == 1.2.4 19:27:23 INFO - docopt == 0.6.1 19:27:23 INFO - functools32 == 3.2.3-2 19:27:23 INFO - jsonschema == 2.5.1 19:27:23 INFO - manifestparser == 1.1 19:27:23 INFO - mozInstall == 1.12 19:27:23 INFO - mozcrash == 0.17 19:27:23 INFO - mozdebug == 0.1 19:27:23 INFO - mozdevice == 0.48 19:27:23 INFO - mozfile == 1.2 19:27:23 INFO - mozhttpd == 0.7 19:27:23 INFO - mozinfo == 0.9 19:27:23 INFO - mozleak == 0.1 19:27:23 INFO - mozlog == 3.4 19:27:23 INFO - moznetwork == 0.27 19:27:23 INFO - mozprocess == 0.23 19:27:23 INFO - mozprofile == 0.28 19:27:23 INFO - mozrunner == 6.12 19:27:23 INFO - mozscreenshot == 0.1 19:27:23 INFO - mozsystemmonitor == 0.3 19:27:23 INFO - moztest == 0.7 19:27:23 INFO - mozversion == 1.4 19:27:23 INFO - psutil == 3.1.1 19:27:23 INFO - requests == 1.2.3 19:27:23 INFO - wsgiref == 0.1.2 19:27:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:23 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 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:23 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 19:27:23 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 19:27:23 INFO - Using env: {'DISPLAY': ':0', 19:27:23 INFO - 'HOME': '/home/cltbld', 19:27:23 INFO - 'LANG': 'en_US.UTF-8', 19:27:23 INFO - 'LANGUAGE': 'en_US:en', 19:27:23 INFO - 'LOGNAME': 'cltbld', 19:27:23 INFO - 'MAIL': '/var/mail/cltbld', 19:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:23 INFO - 'MOZ_NO_REMOTE': '1', 19:27:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:23 INFO - 'NO_EM_RESTART': '1', 19:27:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:23 INFO - 'PWD': '/builds/slave/test', 19:27:23 INFO - 'SHELL': '/bin/bash', 19:27:23 INFO - 'SHLVL': '1', 19:27:23 INFO - 'TERM': 'linux', 19:27:23 INFO - 'TMOUT': '86400', 19:27:23 INFO - 'USER': 'cltbld', 19:27:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:23 INFO - '_': '/tools/buildbot/bin/python'} 19:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:23 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)) 19:27:23 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)) 19:27:23 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)) 19:27:23 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)) 19:27:23 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)) 19:27:23 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)) 19:27:23 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)) 19:27:23 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)) 19:27:23 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)) 19:27:23 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)) 19:27:23 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)) 19:27:23 INFO - Cleaning up... 19:27:23 INFO - Return code: 0 19:27:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:23 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 0x7f62eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', '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 19:27:23 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 19:27:23 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 19:27:23 INFO - Using env: {'DISPLAY': ':0', 19:27:23 INFO - 'HOME': '/home/cltbld', 19:27:23 INFO - 'LANG': 'en_US.UTF-8', 19:27:23 INFO - 'LANGUAGE': 'en_US:en', 19:27:23 INFO - 'LOGNAME': 'cltbld', 19:27:23 INFO - 'MAIL': '/var/mail/cltbld', 19:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:23 INFO - 'MOZ_NO_REMOTE': '1', 19:27:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:23 INFO - 'NO_EM_RESTART': '1', 19:27:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:23 INFO - 'PWD': '/builds/slave/test', 19:27:23 INFO - 'SHELL': '/bin/bash', 19:27:23 INFO - 'SHLVL': '1', 19:27:23 INFO - 'TERM': 'linux', 19:27:23 INFO - 'TMOUT': '86400', 19:27:23 INFO - 'USER': 'cltbld', 19:27:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:23 INFO - '_': '/tools/buildbot/bin/python'} 19:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:27:24 INFO - Cleaning up... 19:27:24 INFO - Return code: 0 19:27:24 INFO - Running post-action listener: _resource_record_post_action 19:27:24 INFO - Running post-action listener: _start_resource_monitoring 19:27:24 INFO - Starting resource monitoring. 19:27:24 INFO - [mozharness: 2016-11-30 03:27:24.130767Z] Finished create-virtualenv step (success) 19:27:24 INFO - [mozharness: 2016-11-30 03:27:24.131280Z] Running install step. 19:27:24 INFO - Running pre-action listener: _resource_record_pre_action 19:27:24 INFO - Running main action method: install 19:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:24 INFO - Reading from file tmpfile_stdout 19:27:24 INFO - Detecting whether we're running mozinstall >=1.0... 19:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:27:24 INFO - Reading from file tmpfile_stdout 19:27:24 INFO - Output received: 19:27:24 INFO - Usage: mozinstall [options] installer 19:27:24 INFO - Options: 19:27:24 INFO - -h, --help show this help message and exit 19:27:24 INFO - -d DEST, --destination=DEST 19:27:24 INFO - Directory to install application into. [default: 19:27:24 INFO - "/builds/slave/test"] 19:27:24 INFO - --app=APP Application being installed. [default: firefox] 19:27:24 INFO - mkdir: /builds/slave/test/build/application 19:27:24 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'] 19:27:24 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 19:27:38 INFO - Reading from file tmpfile_stdout 19:27:38 INFO - Output received: 19:27:38 INFO - /builds/slave/test/build/application/firefox/firefox 19:27:38 INFO - Running post-action listener: _resource_record_post_action 19:27:38 INFO - [mozharness: 2016-11-30 03:27:38.009831Z] Finished install step (success) 19:27:38 INFO - [mozharness: 2016-11-30 03:27:38.010079Z] Running run-tests step. 19:27:38 INFO - Running pre-action listener: _resource_record_pre_action 19:27:38 INFO - Running main action method: run_tests 19:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:27:38 INFO - Python 2.7.3 19:27:38 INFO - Return code: 0 19:27:38 INFO - grabbing minidump binary from tooltool 19:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:38 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 0xf40f60>, '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 0xf41d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf421d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:27:38 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 19:27:38 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 19:27:38 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 19:27:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:27:38 INFO - Return code: 0 19:27:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:27:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:27:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:27:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:27:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:27:38 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/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 19:27:38 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/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 19:27:38 INFO - Using env: {'DISPLAY': ':0', 19:27:38 INFO - 'HOME': '/home/cltbld', 19:27:38 INFO - 'LANG': 'en_US.UTF-8', 19:27:38 INFO - 'LANGUAGE': 'en_US:en', 19:27:38 INFO - 'LOGNAME': 'cltbld', 19:27:38 INFO - 'MAIL': '/var/mail/cltbld', 19:27:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:27:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:38 INFO - 'MOZ_NO_REMOTE': '1', 19:27:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:38 INFO - 'NO_EM_RESTART': '1', 19:27:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:38 INFO - 'PWD': '/builds/slave/test', 19:27:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:27:38 INFO - 'SHELL': '/bin/bash', 19:27:38 INFO - 'SHLVL': '1', 19:27:38 INFO - 'TERM': 'linux', 19:27:38 INFO - 'TMOUT': '86400', 19:27:38 INFO - 'USER': 'cltbld', 19:27:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938', 19:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:38 INFO - '_': '/tools/buildbot/bin/python'} 19:27:38 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/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 19:27:38 INFO - mozversion application_buildid: 20161129163426 19:27:38 INFO - mozversion application_changeset: c736f46410bfef32acf9f38adaa930a9684b28c1 19:27:38 INFO - mozversion application_display_name: Firefox 19:27:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:27:38 INFO - mozversion application_name: Firefox 19:27:38 INFO - mozversion application_remotingname: firefox 19:27:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:27:38 INFO - mozversion application_vendor: Mozilla 19:27:38 INFO - mozversion application_version: 51.0 19:27:38 INFO - mozversion platform_buildid: 20161129163426 19:27:38 INFO - mozversion platform_changeset: c736f46410bfef32acf9f38adaa930a9684b28c1 19:27:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:27:38 INFO - mozversion platform_version: 51.0 19:27:38 INFO - using testdate: 1480476458 19:27:38 INFO - actual date: 1480476458 19:27:38 INFO - starting webserver on 'localhost:53981' 19:27:38 INFO - SUITE-START | Running 2 tests 19:27:38 INFO - TEST-START | dromaeo_css 19:27:38 INFO - operating with platform_type : linux_ 19:27:38 INFO - Initialising browser for dromaeo_css test... 19:27:38 INFO - TEST-INFO | started process 17725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljKNT3/profile http://localhost:53981/getInfo.html) 19:27:42 INFO - PROCESS | 17725 | __metrics Screen width/height:1600/1200 19:27:42 INFO - PROCESS | 17725 | colorDepth:24 19:27:42 INFO - PROCESS | 17725 | Browser inner width/height: 1024/697 19:27:42 INFO - PROCESS | 17725 | __metrics 19:27:42 INFO - PROCESS | 17725 | 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" 19:27:42 INFO - PROCESS | 17725 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:27:43 INFO - PROCESS | 17725 | console.error: PushService: 19:27:43 INFO - PROCESS | 17725 | stateChangeProcessEnqueue: Error transitioning state 19:27:43 INFO - PROCESS | 17725 | UnknownError 19:27:43 INFO - TEST-INFO | 17725: exit 0 19:27:43 INFO - Browser initialized. 19:27:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:27:43 INFO - TEST-INFO | started process 17821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljKNT3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:55 INFO - PROCESS | 17821 | RSS: Main: 143421440 19:27:55 INFO - PROCESS | 17821 | 19:28:46 INFO - PROCESS | 17821 | 1480476526643 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] 19:30:55 INFO - PROCESS | 17821 | Cycle 1(1): loaded http://localhost:53981/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53981/tests/dromaeo/cssquery-ext.html) 19:30:57 INFO - PROCESS | 17821 | RSS: Main: 247758848 19:30:57 INFO - PROCESS | 17821 | 19:33:59 INFO - PROCESS | 17821 | Cycle 1(1): loaded http://localhost:53981/tests/dromaeo/cssquery-ext.html (next: http://localhost:53981/tests/dromaeo/cssquery-jquery.html) 19:33:59 INFO - PROCESS | 17821 | RSS: Main: 235642880 19:33:59 INFO - PROCESS | 17821 | 19:37:01 INFO - PROCESS | 17821 | Cycle 1(1): loaded http://localhost:53981/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53981/tests/dromaeo/cssquery-mootools.html) 19:37:02 INFO - PROCESS | 17821 | RSS: Main: 232853504 19:37:02 INFO - PROCESS | 17821 | 19:40:04 INFO - PROCESS | 17821 | Cycle 1(1): loaded http://localhost:53981/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53981/tests/dromaeo/cssquery-prototype.html) 19:40:04 INFO - PROCESS | 17821 | RSS: Main: 230457344 19:40:04 INFO - PROCESS | 17821 | 19:43:07 INFO - PROCESS | 17821 | Cycle 1(1): loaded http://localhost:53981/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53981/tests/dromaeo/cssquery-yui.html) 19:43:08 INFO - PROCESS | 17821 | RSS: Main: 176848896 19:43:08 INFO - PROCESS | 17821 | 19:46:10 INFO - PROCESS | 17821 | Cycle 1(1): loaded http://localhost:53981/tests/dromaeo/cssquery-yui.html (next: http://localhost:53981/tests/dromaeo/cssquery-dojo.html) 19:46:10 INFO - PROCESS | 17821 | RSS: Main: 271351808 19:46:10 INFO - PROCESS | 17821 | 19:46:10 INFO - PROCESS | 17821 | __start_tp_report 19:46:10 INFO - PROCESS | 17821 | _x_x_mozilla_page_load 19:46:10 INFO - PROCESS | 17821 | _x_x_mozilla_page_load_details 19:46:10 INFO - PROCESS | 17821 | |i|pagename|runs| 19:46:10 INFO - PROCESS | 17821 | |0;dojo.html;3173.174974506628;3214.8392580370974;3223.210313473199;3225.7903236289626;3256.527803468497;5675.631083979543;5750.309962804464;5758.99217636914;5786.1610066540325;5796.884062318751;5743.597948143632;5770.221020162277;5810.709464526767;5818.243628328322;5826.475617194452;5218.165093585037;5235.528802407783;5266.34170728659;5319.946800531984;5325.680459172462;5096.643234973553;5295.364556253255;5305.761240744157;5309.256704061435;5315.760790764425;5097.413797413289;5161.74191290434;5177.715225662587;5213.635045546814;5225.79096836128;5191.818286359978;5225.059489291945;5232.581393488512;5299.894002119936;5302.496262855023;5146.073706732786;5173.508516690908;5257.1588545832865;5265.86835329116;5276.81531146408;5534.861628459281;5559.054960656698;5592.86017849553;5627.971860140714;5629.8311050668135;6086.330503644595;6101.816945491642;6111.419415155598;6185.87628247437;6195.690215489208;6228.844278893019;6229.6573688447115;6243.219597550306;6245.281792593864;6246.281677607088;5555.083411237141;5589.273394458694;5616.578756593312;5641.464060914206;5678.0915053591225;6275.874482510324;6277.3241770307195;6301.558890877686;6307.905381419282;6311.116443697886;6051.546134039964;6059.242594675666;6060.484858787053;6061.969690151521;6098.969505152446;5853.180554722342;5868.794592189253;5891.587588868738;5946.345901950782;5959.255093113361;6016.969915150484;6019.036954087325;6022.126791615191;6028.939710602838;6040.577159598786;5981.611195272293;6032.487238584682;6039.54703397247;6046.395360463918;6068.484178844759;4461.843835465743;4511.323301504801;4519.480259770168;4583.472900616405;4583.54164583539;4141.171765646883;4152.937705934413;4161.438205842233;4189.036521600049;4198.328267477189;5808.854778630483;5826.155207494974;5843.707814609253;5852.239208902901;5864.296284445893;5919.1713160157615;5924.7926322578505;5977.641341519523;6051.636901785907;6244.344343843922;5780.450857168562;5785.537157027427;5788.160716696056;5803.564732645069;5842.824715258549;5164.586833053347;5181.248718935809;5182.948170518322;5183.326167598264;5223.981323641853;6010.098485227251;6156.07658851167;6252;6323.683815809191;6353.714082866282;6108.053251745987;6228.065790131335;6259.812205633838;6267.874642507216;6274.74901003973;6431.903521447276;6437.163168788027;6438.549301548846;6440.033994900802;6452.387023232785;5711.086226203787;5829.271341082364;6117.0824376342125;6119.541034422525;6125.785597504066;6067.150598916243;6109.053096770008;6111.480524155497;6181.938180618136;6190.7523699051535;6019.307779605227;6033.9252847834005;6066.878662426815;6067.969660151671;6069.696515174312;5803.448672376117;5994.610350327215;6049.274087109399;6063.181470501426;6065.332813390435;5822.534197264294;5965.313988891333;6003.609765365237;6016.819495414969;6110.2550082019825;6141.631502109888;6144.969275153596;6145.10895920098;6147.631142131308;6153.784617538365;5646.71766411686;5689.544836412994;5992.0498356600565;6013.158157857991;6045.425684559959 19:46:10 INFO - PROCESS | 17821 | |1;ext.html;592.3543337761841;634.0742515926747;634.1597383466906;651.9543631945762;654.0548906829628;34136.65863341366;34953.825230873845;37581.624183758155;37617;37656.62343376566;37556.624433755656;38664.42003369952;46724;47833.76083119588;47931.281030784565;9283.4429934204;9404.905950940505;9414.905850941506;9432.764180895463;9433.858492122623;9248.213901818353;9392.671256506024;9404.200642945358;9406.670766523173;9414.670486532972;8728.127187281285;8933.196012358887;11091;11308.03881670059;11318.830217546743;11380.601678941239;11392.08863290943;11458.828117578243;11459.140564457657;11481.540738370455;11240.775184496264;11314.886851131465;11315.886841131565;11322.547098116065;11323.150763692674;45133.774331128465;45546.08907821858;45578;45583.54416455826;45604.54395456036;3901.804909754501;3958.9802050989847;3992.6007399260134;4319.740815551046;4446.021875187454;34054.48918266228;34135.48796768051;34304.828475857714;34447.827760861284;36005.81997090024;4740.597049250818;4771.737554434505;4809.302651115569;4812.951870481285;4814.325994360793;360181;360395;360840;361460;362687;64153;64376;64427.67786161039;64462.6776866122;64527;40788.18423631511;41146.794266028475;41428.585714143075;43375.78312108419;67654.66172669204;18654.067296635112;18820.717689234672;18829.058547072593;18833.434996950113;18911.810881891004;14977.925110374379;15058.548243552492;15105.622359441102;15106.622334441727;15108.39566417353;18453.446396608124;18884.81115188858;20484.897575512026;20969.580608387747;21127.577448450946;7393.48245622812;7526.32263096324;7635.053061469401;7674.654640541189;7737.806554836174;1068.1454836131063;1074.2372915230274;1092.5575142067476;1125.8930401611833;1173.8708742038368;29986.700132998827;30112.698873011428;30462.70262765101;30521.38957220843;30687;1161.901238394729;1201.9459124339426;1202.8977536909285;1228.3796682675193;1232.8103380238113;16615.252313645917;17049.573760655836;17102.48692539226;17184.484465466056;17276.13619319029;541407;542861;543320;544786;544839;62854.68572657107;63351;63357.68321158457;63464;63507.6824615874;1227.5274019502556;1273.2742336867896;1283.8972882169403;1290.9419076141596;1393.0318428691962;27924.162275131777;28948.42103157967;29912.55131173078;29940.70059299379;30555;54862;55048.17427738507;55226.171607426724;55298.72350638221;55343;466715;470812;472560;472640;473141;27786.722132778414;28432.43135137327;31904.68095319017;32347;46590.534094659975;46114.538854612365;49478.50521494739;53119.20321195263;57441.71279143578;57985.420145798;45134.77432612816;45737.542624573325;45804;46137.30794038025;46688.766556167;43367.34948975705;44810.77594612006;45171.548284516735;45322.09355812799;45833.312500313186;46064.309035365164;49922.75193120201;50062.249066263306;51151;51297.743511282206;39179.608203917596;42036.789816050725;42049;42065.369019465346;42344.153116936875;29877.402451950406;30747.385052299276;31558;31615.525767113053;32074.67925320717 19:46:10 INFO - PROCESS | 17821 | |2;jquery.html;389.6609949344071;410.96095870892253;419.31651408204624;419.66217195157896;434.8738865728937;14519.854801451982;16450.58873528161;19990.20039198434;20549.897250513764;20981.265655702053;19675.21299148036;19828.60342793147;19863.900680496576;20519.38441846743;21027.894860525677;5891.764329426818;5903.4391732785425;6112.969435152818;6127.938720612781;6174.043023331391;4075.87772366828;6185.907211391833;6202.4417802397775;6205.596636218654;6208.6585237811905;4210.978945105286;4296.763677997709;6787.219469760967;6871.14110736158;6874.3469370409985;6106.786262480792;6265.87468250637;6849.623270720133;6849.897251541231;6866.313368663144;5967.313758917737;5993.61041532299;5995.700214989233;5998.700064996733;6001.729922153513;14758.114513129247;14774.852251477456;14842.332095055748;14866.702665946728;15003.249837508081;2494.1519883239785;3014.668386477486;3106.2389714520086;3142.5600415941785;3145.5910731604745;10710.41092739899;10881.945590272077;11041.613543526018;11042.889571104266;11139.944300278528;1923.1153669312134;1946.4744518979796;1953.990230048855;1955;1962.6467235897533;78915.6054219731;84443.57778211069;84513.57743211306;85240.57379713186;85599.57200214021;11428.714282143013;11528.250663706833;11545.595904143483;11635.952764251258;11706.94146529279;16643.41748038813;16649.750253746202;16656.167191640612;16685.24916378766;16705.248263828158;8815.647374105092;8875.511846848485;8886;9220.49287289192;9294.442333460014;8301.8339633207;8305.543195124326;8332.541710205996;8445.239928406472;8537.317014638815;5148.407933087743;5202.531772140525;5207.479252074762;5227.738613069408;5268.92096618551;2087.244836815389;2111.6832475128854;2118.163325486455;2147.6778483227326;2186.486175748698;944.990550094504;975.5024937282037;1009.2077718990557;1013.4476710192963;1039.927205095636;19029.904850475938;20189.60639301125;20614.690779638317;20828.58342833165;20960.685589716166;1008.6318493749875;1015.6292953072076;1073.3291692692067;1091.3615534912008;1102.9779404412027;10725.30285531438;11560.30638161713;11640.825387619192;11655.650330490098;11706.590269340531;394199;509251;514092;515022;516239;77023.61488192523;77727;95618.52190739002;100566.49716751369;106650.46674766732;1057.1278695076592;1071.6999240212754;1099.4173088263233;1102.0467295789085;1113.4655365424642;17896.642067158846;18063.458096257134;18431.907840460713;18583.16375763121;18863.528411789815;36202;43950;44386;44495;45164.32253516265;59327.40672593219;64038.67980660067;65004.67497662482;65771;65936.67031664812;9014.32392570573;9213;9271.258299336172;9339.906600933904;9639.807203855744;10279.486025698834;13548.187108773505;13971.650708732363;13991.300434978008;14151.363188656329;11563.6530904073;12058.15592908488;12249;12488.313142777235;12589.055820813292;11847.466863990969;11917.702057448632;12241.510339586317;12550.1842380245;12691.048171386998;12360.25838449696;12428.502859885864;12440.19138755978;12524.937375313066;12630.368481576068;8806.471611703319;9220.124088211609;9273.907260927574;9303.72088837336;9477.194438472807;9033.909660903308;11043.392613406018;11185.608503702331;11390.25963312382;11412.358759163926 19:46:10 INFO - PROCESS | 17821 | |3;mootools.html;1447.3920953199658;1493.186213513635;1622.578129686282;1779.1193359287154;1798.919048642811;8221;8420.368472364567;9130.863037054449;9853.359531630447;9877.802443951117;9148.817023659523;9444;9445.716628501139;9766.804663906718;9775.266854985868;2530.4306531030556;2563.884625191871;2563.987180064097;2564.9743502565016;2567.2169988153605;2509.887055082526;2566.845989240642;2568.7174410814796;2570.3959569501153;2573.086554273225;2550.7066687331007;2554.6168074788743;2585.8060645451574;2589.249117755858;2590.7409259074034;2538.7842033427273;2553.872306384683;2557.795376369886;2564.8589327586974;2568.691756989155;2504.022725918277;2518.7733104020544;2529.4308780524234;2547.46503234321;2549.222487141421;9608.951955240249;9707.174890134347;9712.320137590372;9857.802843943153;9873.851892221623;5778.162166485836;5924.052151655715;5931.614445061057;5936.257967754031;5951.642901425928;3587.9282414351565;3690.7231957603285;3742.607026262258;3783.205526839367;3790.77255364679;1179.2334982261514;1250.0499620288647;1250.3873102179866;1266.1010682415497;1279.795232762763;13807.930960345235;13834.100783449043;14017.64955876101;14019.299035048207;14027.789583156364;5144.254083157921;5210.505002024802;5385.9730701347025;5394.622376433612;5417.945820541823;11463.770724585462;11497.885021149848;11505.309681419141;11512.079033677453;11519;5975.67133807636;5977.282726072899;5988.401159884064;5990.161377407167;5993.130996005642;4775.641826863;4949.90100197994;5348.411674715778;5416.214648875891;5482.013237617267;4355.760433176142;4455.509893911667;4507.842225522091;4539.205639013159;4581.770911454414;1383.6540864783803;1405.3956798576505;1412.0821466046946;1424.1170474305998;1430.5636780781754;1012.1396812709286;1013.3008224325192;1031.28841099641;1032.3444612671008;1033.850091736694;6153.661548614779;6429.357064293533;6437.324080971524;6517.250516190604;6772.255051944282;498.14568015852984;503.41855157293384;507.51532286666145;518.3080587415767;525.4115390762371;4124.566920473367;4237.982884107853;4458.888527786831;4532.0709254602725;4673.509281525459;12111.031117510578;12242.938785306194;12319.507219711111;12370.690732731753;12417.44121514534;11448.599299024494;12193.207441516273;12260.81608775869;12281;12281.140320177681;8665.913340866511;9130.452172869649;9143.862842057375;9145.268378529701;9149.954250228706;6147.938520614736;6268.811935641938;6313.96843015782;6392.87214255703;6402.199725034371;11175.27360721583;11359.716007099889;11374.374409407563;11466.598669046876;11479.08167346627;11151.107911367233;11636.650900473;11637.709057273298;11640.185187036826;11653.6503904883;7684.077910650758;7828.452008359588;8171.264586187272;8468.745937621881;8623.698170564001;9148.679796207367;9589.520523973913;9603;9605.423674579548;9613;8421.87367189505;8459.450135741157;8471;8657.826843463221;8723.08407617191;8272.710455134042;8276.255137037695;8290.212429819157;8394.45436046655;8437.493750374751;7764.844703105793;7844.960775196316;7882.763517094496;7886.250806173404;7939.0870049945;5452.182172674131;5517.117261238182;5541.722913854372;5622.522085622768;5680.857978550569;5643.633163844337;5690.203371527907;5732.484076432974;5769.624974376652;5834.533237340917 19:46:10 INFO - PROCESS | 17821 | |4;prototype.html;335.73309219170756;340.0054839594187;348.3711900020464;348.8221007286284;352.78114115730153;5487.917681234785;5656.179853921179;5678.205051292817;5719.942800571998;5741.4832665060185;5422.240886275925;5477.4663094333555;5510.842723028169;5512.924979628974;5569.275994120759;4380.934285985712;4391.64866810656;4397.538258482861;4401.691881568276;4403.6256918162;4142.2543942090415;4312.137572485515;4373.912521749563;4375.8249670013165;4411.845585404511;4279.315309550472;4288.69979101463;4311.568843115695;4326.870193894189;4337.392765012901;4285.207236661212;4286;4319.157764235975;4319.848805291831;4365.476142862877;3714.647108524686;3789.8673546425744;3793.6016718244464;3808.371618682914;3860.7297489175767;5419.512243898029;5423.701696406735;5442.91835622466;5448.291722076105;5451.945480545223;4953.405591329064;4964;4966.900661986776;4971.384300102445;4977.776000080005;5537.750801213955;5766.769329226826;5791.536677065825;5808.950301091918;5829.912551311733;4107.178564287155;4118.155778065489;4121.319982202933;4129.236091323085;4135.97932010341;6066.908996365058;6084.269887613515;6114.724837382329;6121.693915304217;6136.509079273692;4098.590140985937;4254.744715317091;4291.699581029298;4300.204462174508;4301.268784306675;4343.19650864591;4371;4374.343848422762;4388.4733831940375;4391.912161756747;4978.755311172207;4997.825076122318;5005.599552035828;5007.12375334315;5013.323201367842;5575.609707320448;5614.354349249807;5873.383294754075;5903.439173278532;5946.613470124428;1448.5726710620393;1466.948656797007;1469.9632509187356;1477.7857210704387;1486.8996942262647;985.7929834734642;1002.2132625888643;1010.2019404670228;1018.3177271228295;1027.7256202309231;5567.524605979419;5582.33012038558;5601.579881508903;5628.549716022791;5632.943670563324;5939.524838012949;5960.393961653137;5974.341418068918;5996.490298324604;6053.545984051214;5415.945840541544;5660.264165658438;5684.147377893349;5699.546615612992;5727.742251598688;3204.83975801209;3221.1624977506017;3226;3227.499737540685;3229.951550726741;6080.270367555921;6239.005277466841;6272.087013460939;6307.842303942438;6317.557770956081;6023;6110.847228819226;6166.537509686791;6171.259448866164;6182.567220294626;6202.28673702521;6204.565680402328;6227.564070515021;6265.994881637832;6315.55791094619;5853.678047707417;5990.191324171181;6004.849878753066;6051.727672254671;6055.848603784941;5924.200232968494;5938.228030356199;5942.58401911862;5982.551308651781;5998.0103282957825;5937.584369094122;6145.8156255312415;6147.969260153671;6150.200473938359;6197.380261973766;4312.197071903288;4329.567043295771;4332.328489084197;4334.739915605074;4346.456692913386;5686.350958222235;6030.638161710312;6034.849128771641;6061.363556826646;6063.423974722395;5722.284714410699;5762.683052432157;5884.352721200579;5887.764489420375;5904.468597826216;5860.970695146497;5863.17915491823;5869.911951320648;5878.735456904364;5889.499392551681;5646.322441306905;5827.82383600947;5853.473187412983;5862.589618726648;5866.853328666817;5893.263342082239;5900.586958912835;5924.259467566554;5930.733117009659;5937.287525496968;5635.577331700057;5761.740721667619;5788.189653448437;5799.710014499343;5816.651000939957 19:46:10 INFO - PROCESS | 17821 | |5;yui.html;790.8892755014296;794.5669610062519;805.6133056133052;861.9396642235042;902.4810733828047;16532.58668533286;17595.824041759577;17655.91172044138;17658.205380757863;17679.64640707187;15964.920175399107;16316.510504684878;16322.020678759283;16847;17463.476095717117;734.3354264390734;751.5866273549526;854.2781349759443;866.7529754020105;879.1867522541655;880.3793325705394;880.5773228850156;883.3507372081515;883.3904605821995;883.514067263006;926.420986883198;929.502716046915;931.0549791961165;931.2038207332735;931.6040682709855;924.9630014799467;926.115559640545;926.5228407370209;926.6015613286318;926.8331700293944;684.4182444921777;684.490054909091;684.7706018483814;685.6297599296374;685.6640246279287;16943;16960.236789344508;16987.74518382225;16994.405195818086;16996.745048824276;13267.73464530704;14132.858671413258;14965.625859353495;15149.545513634608;15825.366985320574;13194.934025329909;13363.274046755054;13511.932440337736;13516.729665406638;13830.37763300654;4123.257813593552;4162.334026555736;4218.367244913287;4227.302495088337;4250.681198910094;91667;93105.5344723272;94268.52865735696;97411.51294243483;98864.50567747187;11836.70408239801;11920.642380728419;12064.75870482603;12214.26714397139;12408.81386779199;23423.297301080653;23828.523429531313;23874;23899.52200955971;23913.641295380236;7972.681092756225;8044.758657240175;8244.917550824535;8438.831223375499;8843.867341989875;5079.771410286546;5152.6650767699975;5244.449332820075;5246.7638956247065;5434.510894019557;3471.0801637566065;3586.55168103987;3586.910327241788;3593.3531964246686;3598.9100272493397;650.8210242183343;661.0480907493194;661.1603263854973;663.3896814930275;688.8656711941223;693.230514129316;762.6758627583255;797.4497596658288;803.6704950970075;824.9216324449168;10514.106300964504;10560.894391056145;10602.575896964036;10616.63902434176;10984.725381865517;750.6284389227259;777.7161336112391;786.6695987685185;798.0901771979948;803.8713805791162;5314.468553144732;5320.2817619620855;5334.333208348957;5357.517823395913;5422.322209723785;84319.5784021076;97627;123348.38325808314;129197;134975.32512337377;113831.43084284525;113868;114789;115965.4201728986;116551.41724291493;96857.51571242239;100876.49561752145;103044;103183;105246.99999999847;9936.354136981074;10242;10423.322484038514;10455.268131230741;10631.787364252517;59191.70404147952;59243.40756592551;60392;62282;63501.68249158725;48843;49954.75022624864;61357;86701.56649216714;88821.55589222013;12662.113652044269;12705.428255728699;13002.414891330101;13002.479900803863;13371.26458044778;13692.178469291874;14123.576292711236;14319.212443315717;14488.927555362156;14741.55775326742;13354.465821367037;13437.126586771828;13449.663758406117;13530.391132398869;13633.659158521117;13378.112517636602;13693;14327.498537551135;14479.565613031626;14791.260436978324;12755;13152.605421837361;13381.732365352833;14050.297485125908;14339.928300358431;11020.834687479855;11377.601783937522;11681.88318116808;11689.357085360387;12231.694207644525;11334.773304534028;11798.882011179778;12167.87832121703;12197.51209951592;12331.630051098482 19:46:10 INFO - PROCESS | 17821 | __end_tp_report 19:46:10 INFO - PROCESS | 17821 | __start_cc_report 19:46:10 INFO - PROCESS | 17821 | _x_x_mozilla_cycle_collect,878 19:46:10 INFO - PROCESS | 17821 | __end_cc_report 19:46:10 INFO - PROCESS | 17821 | __startTimestamp1480477570781__endTimestamp 19:46:10 INFO - PROCESS | 17821 | 19:46:10 INFO - PROCESS | 17821 | ------- Summary: start ------- 19:46:10 INFO - PROCESS | 17821 | Number of tests: 6 19:46:10 INFO - PROCESS | 17821 | 19:46:10 INFO - PROCESS | 17821 | [#0] dojo.html Cycles:165 Average:5680.66 Median:5868.79 stddev:667.54 (11.4%) stddev-sans-first:639.95 19:46:10 INFO - PROCESS | 17821 | Values: 3173.2 3214.8 3223.2 3225.8 3256.5 5675.6 5750.3 5759.0 5786.2 5796.9 5743.6 5770.2 5810.7 5818.2 5826.5 5218.2 5235.5 5266.3 5319.9 5325.7 5096.6 5295.4 5305.8 5309.3 5315.8 5097.4 5161.7 5177.7 5213.6 5225.8 5191.8 5225.1 5232.6 5299.9 5302.5 5146.1 5173.5 5257.2 5265.9 5276.8 5534.9 5559.1 5592.9 5628.0 5629.8 6086.3 6101.8 6111.4 6185.9 6195.7 6228.8 6229.7 6243.2 6245.3 6246.3 5555.1 5589.3 5616.6 5641.5 5678.1 6275.9 6277.3 6301.6 6307.9 6311.1 6051.5 6059.2 6060.5 6062.0 6099.0 5853.2 5868.8 5891.6 5946.3 5959.3 6017.0 6019.0 6022.1 6028.9 6040.6 5981.6 6032.5 6039.5 6046.4 6068.5 4461.8 4511.3 4519.5 4583.5 4583.5 4141.2 4152.9 4161.4 4189.0 4198.3 5808.9 5826.2 5843.7 5852.2 5864.3 5919.2 5924.8 5977.6 6051.6 6244.3 5780.5 5785.5 5788.2 5803.6 5842.8 5164.6 5181.2 5182.9 5183.3 5224.0 6010.1 6156.1 6252.0 6323.7 6353.7 6108.1 6228.1 6259.8 6267.9 6274.7 6431.9 6437.2 6438.5 6440.0 6452.4 5711.1 5829.3 6117.1 6119.5 6125.8 6067.2 6109.1 6111.5 6181.9 6190.8 6019.3 6033.9 6066.9 6068.0 6069.7 5803.4 5994.6 6049.3 6063.2 6065.3 5822.5 5965.3 6003.6 6016.8 6110.3 6141.6 6145.0 6145.1 6147.6 6153.8 5646.7 5689.5 5992.0 6013.2 6045.4 19:46:10 INFO - PROCESS | 17821 | 19:46:10 INFO - PROCESS | 17821 | [#1] ext.html Cycles:180 Average:63010.26 Median:41732.69 stddev:123023.10 (294.8%) stddev-sans-first:123278.95 19:46:10 INFO - PROCESS | 17821 | Values: 592.4 634.1 634.2 652.0 654.1 34136.7 34953.8 37581.6 37617.0 37656.6 37556.6 38664.4 46724.0 47833.8 47931.3 9283.4 9404.9 9414.9 9432.8 9433.9 9248.2 9392.7 9404.2 9406.7 9414.7 8728.1 8933.2 11091.0 11308.0 11318.8 11380.6 11392.1 11458.8 11459.1 11481.5 11240.8 11314.9 11315.9 11322.5 11323.2 45133.8 45546.1 45578.0 45583.5 45604.5 3901.8 3959.0 3992.6 4319.7 4446.0 34054.5 34135.5 34304.8 34447.8 36005.8 4740.6 4771.7 4809.3 4813.0 4814.3 360181.0 360395.0 360840.0 361460.0 362687.0 64153.0 64376.0 64427.7 64462.7 64527.0 40788.2 41146.8 41428.6 43375.8 67654.7 18654.1 18820.7 18829.1 18833.4 18911.8 14977.9 15058.5 15105.6 15106.6 15108.4 18453.4 18884.8 20484.9 20969.6 21127.6 7393.5 7526.3 7635.1 7674.7 7737.8 1068.1 1074.2 1092.6 1125.9 1173.9 29986.7 30112.7 30462.7 30521.4 30687.0 1161.9 1201.9 1202.9 1228.4 1232.8 16615.3 17049.6 17102.5 17184.5 17276.1 541407.0 542861.0 543320.0 544786.0 544839.0 62854.7 63351.0 63357.7 63464.0 63507.7 1227.5 1273.3 1283.9 1290.9 1393.0 27924.2 28948.4 29912.6 29940.7 30555.0 54862.0 55048.2 55226.2 55298.7 55343.0 466715.0 470812.0 472560.0 472640.0 473141.0 27786.7 28432.4 31904.7 32347.0 46590.5 46114.5 49478.5 53119.2 57441.7 57985.4 45134.8 45737.5 45804.0 46137.3 46688.8 43367.3 44810.8 45171.5 45322.1 45833.3 46064.3 49922.8 50062.2 51151.0 51297.7 39179.6 42036.8 42049.0 42065.4 42344.2 29877.4 30747.4 31558.0 31615.5 32074.7 19:46:10 INFO - PROCESS | 17821 | 19:46:10 INFO - PROCESS | 17821 | [#2] jquery.html Cycles:180 Average:29378.41 Median:2114.92 stddev:81238.49 (3841.2%) stddev-sans-first:81437.22 19:46:10 INFO - PROCESS | 17821 | Values: 389.7 411.0 419.3 419.7 434.9 14519.9 16450.6 19990.2 20549.9 20981.3 19675.2 19828.6 19863.9 20519.4 21027.9 5891.8 5903.4 6113.0 6127.9 6174.0 4075.9 6185.9 6202.4 6205.6 6208.7 4211.0 4296.8 6787.2 6871.1 6874.3 6106.8 6265.9 6849.6 6849.9 6866.3 5967.3 5993.6 5995.7 5998.7 6001.7 14758.1 14774.9 14842.3 14866.7 15003.2 2494.2 3014.7 3106.2 3142.6 3145.6 10710.4 10881.9 11041.6 11042.9 11139.9 1923.1 1946.5 1954.0 1955.0 1962.6 78915.6 84443.6 84513.6 85240.6 85599.6 11428.7 11528.3 11545.6 11636.0 11706.9 16643.4 16649.8 16656.2 16685.2 16705.2 8815.6 8875.5 8886.0 9220.5 9294.4 8301.8 8305.5 8332.5 8445.2 8537.3 5148.4 5202.5 5207.5 5227.7 5268.9 2087.2 2111.7 2118.2 2147.7 2186.5 945.0 975.5 1009.2 1013.4 1039.9 19029.9 20189.6 20614.7 20828.6 20960.7 1008.6 1015.6 1073.3 1091.4 1103.0 10725.3 11560.3 11640.8 11655.7 11706.6 394199.0 509251.0 514092.0 515022.0 516239.0 77023.6 77727.0 95618.5 100566.5 106650.5 1057.1 1071.7 1099.4 1102.0 1113.5 17896.6 18063.5 18431.9 18583.2 18863.5 36202.0 43950.0 44386.0 44495.0 45164.3 59327.4 64038.7 65004.7 65771.0 65936.7 9014.3 9213.0 9271.3 9339.9 9639.8 10279.5 13548.2 13971.7 13991.3 14151.4 11563.7 12058.2 12249.0 12488.3 12589.1 11847.5 11917.7 12241.5 12550.2 12691.0 12360.3 12428.5 12440.2 12524.9 12630.4 8806.5 9220.1 9273.9 9303.7 9477.2 9033.9 11043.4 11185.6 11390.3 11412.4 19:46:10 INFO - PROCESS | 17821 | 19:46:10 INFO - PROCESS | 17821 | [#3] mootools.html Cycles:180 Average:6395.44 Median:4862.77 stddev:3705.69 (76.2%) stddev-sans-first:3697.42 19:46:10 INFO - PROCESS | 17821 | Values: 1447.4 1493.2 1622.6 1779.1 1798.9 8221.0 8420.4 9130.9 9853.4 9877.8 9148.8 9444.0 9445.7 9766.8 9775.3 2530.4 2563.9 2564.0 2565.0 2567.2 2509.9 2566.8 2568.7 2570.4 2573.1 2550.7 2554.6 2585.8 2589.2 2590.7 2538.8 2553.9 2557.8 2564.9 2568.7 2504.0 2518.8 2529.4 2547.5 2549.2 9609.0 9707.2 9712.3 9857.8 9873.9 5778.2 5924.1 5931.6 5936.3 5951.6 3587.9 3690.7 3742.6 3783.2 3790.8 1179.2 1250.0 1250.4 1266.1 1279.8 13807.9 13834.1 14017.6 14019.3 14027.8 5144.3 5210.5 5386.0 5394.6 5417.9 11463.8 11497.9 11505.3 11512.1 11519.0 5975.7 5977.3 5988.4 5990.2 5993.1 4775.6 4949.9 5348.4 5416.2 5482.0 4355.8 4455.5 4507.8 4539.2 4581.8 1383.7 1405.4 1412.1 1424.1 1430.6 1012.1 1013.3 1031.3 1032.3 1033.9 6153.7 6429.4 6437.3 6517.3 6772.3 498.1 503.4 507.5 518.3 525.4 4124.6 4238.0 4458.9 4532.1 4673.5 12111.0 12242.9 12319.5 12370.7 12417.4 11448.6 12193.2 12260.8 12281.0 12281.1 8665.9 9130.5 9143.9 9145.3 9150.0 6147.9 6268.8 6314.0 6392.9 6402.2 11175.3 11359.7 11374.4 11466.6 11479.1 11151.1 11636.7 11637.7 11640.2 11653.7 7684.1 7828.5 8171.3 8468.7 8623.7 9148.7 9589.5 9603.0 9605.4 9613.0 8421.9 8459.5 8471.0 8657.8 8723.1 8272.7 8276.3 8290.2 8394.5 8437.5 7764.8 7845.0 7882.8 7886.3 7939.1 5452.2 5517.1 5541.7 5622.5 5680.9 5643.6 5690.2 5732.5 5769.6 5834.5 19:46:10 INFO - PROCESS | 17821 | 19:46:10 INFO - PROCESS | 17821 | [#4] prototype.html Cycles:180 Average:4931.33 Median:5607.97 stddev:1453.15 (25.9%) stddev-sans-first:1415.69 19:46:10 INFO - PROCESS | 17821 | Values: 335.7 340.0 348.4 348.8 352.8 5487.9 5656.2 5678.2 5719.9 5741.5 5422.2 5477.5 5510.8 5512.9 5569.3 4380.9 4391.6 4397.5 4401.7 4403.6 4142.3 4312.1 4373.9 4375.8 4411.8 4279.3 4288.7 4311.6 4326.9 4337.4 4285.2 4286.0 4319.2 4319.8 4365.5 3714.6 3789.9 3793.6 3808.4 3860.7 5419.5 5423.7 5442.9 5448.3 5451.9 4953.4 4964.0 4966.9 4971.4 4977.8 5537.8 5766.8 5791.5 5809.0 5829.9 4107.2 4118.2 4121.3 4129.2 4136.0 6066.9 6084.3 6114.7 6121.7 6136.5 4098.6 4254.7 4291.7 4300.2 4301.3 4343.2 4371.0 4374.3 4388.5 4391.9 4978.8 4997.8 5005.6 5007.1 5013.3 5575.6 5614.4 5873.4 5903.4 5946.6 1448.6 1466.9 1470.0 1477.8 1486.9 985.8 1002.2 1010.2 1018.3 1027.7 5567.5 5582.3 5601.6 5628.5 5632.9 5939.5 5960.4 5974.3 5996.5 6053.5 5415.9 5660.3 5684.1 5699.5 5727.7 3204.8 3221.2 3226.0 3227.5 3230.0 6080.3 6239.0 6272.1 6307.8 6317.6 6023.0 6110.8 6166.5 6171.3 6182.6 6202.3 6204.6 6227.6 6266.0 6315.6 5853.7 5990.2 6004.8 6051.7 6055.8 5924.2 5938.2 5942.6 5982.6 5998.0 5937.6 6145.8 6148.0 6150.2 6197.4 4312.2 4329.6 4332.3 4334.7 4346.5 5686.4 6030.6 6034.8 6061.4 6063.4 5722.3 5762.7 5884.4 5887.8 5904.5 5861.0 5863.2 5869.9 5878.7 5889.5 5646.3 5827.8 5853.5 5862.6 5866.9 5893.3 5900.6 5924.3 5930.7 5937.3 5635.6 5761.7 5788.2 5799.7 5816.7 19:46:10 INFO - PROCESS | 17821 | 19:46:10 INFO - PROCESS | 17821 | [#5] yui.html Cycles:180 Average:22659.80 Median:13692.36 stddev:33266.26 (243.0%) stddev-sans-first:33319.06 19:46:10 INFO - PROCESS | 17821 | Values: 790.9 794.6 805.6 861.9 902.5 16532.6 17595.8 17655.9 17658.2 17679.6 15964.9 16316.5 16322.0 16847.0 17463.5 734.3 751.6 854.3 866.8 879.2 880.4 880.6 883.4 883.4 883.5 926.4 929.5 931.1 931.2 931.6 925.0 926.1 926.5 926.6 926.8 684.4 684.5 684.8 685.6 685.7 16943.0 16960.2 16987.7 16994.4 16996.7 13267.7 14132.9 14965.6 15149.5 15825.4 13194.9 13363.3 13511.9 13516.7 13830.4 4123.3 4162.3 4218.4 4227.3 4250.7 91667.0 93105.5 94268.5 97411.5 98864.5 11836.7 11920.6 12064.8 12214.3 12408.8 23423.3 23828.5 23874.0 23899.5 23913.6 7972.7 8044.8 8244.9 8438.8 8843.9 5079.8 5152.7 5244.4 5246.8 5434.5 3471.1 3586.6 3586.9 3593.4 3598.9 650.8 661.0 661.2 663.4 688.9 693.2 762.7 797.4 803.7 824.9 10514.1 10560.9 10602.6 10616.6 10984.7 750.6 777.7 786.7 798.1 803.9 5314.5 5320.3 5334.3 5357.5 5422.3 84319.6 97627.0 123348.4 129197.0 134975.3 113831.4 113868.0 114789.0 115965.4 116551.4 96857.5 100876.5 103044.0 103183.0 105247.0 9936.4 10242.0 10423.3 10455.3 10631.8 59191.7 59243.4 60392.0 62282.0 63501.7 48843.0 49954.8 61357.0 86701.6 88821.6 12662.1 12705.4 13002.4 13002.5 13371.3 13692.2 14123.6 14319.2 14488.9 14741.6 13354.5 13437.1 13449.7 13530.4 13633.7 13378.1 13693.0 14327.5 14479.6 14791.3 12755.0 13152.6 13381.7 14050.3 14339.9 11020.8 11377.6 11681.9 11689.4 12231.7 11334.8 11798.9 12167.9 12197.5 12331.6 19:46:10 INFO - PROCESS | 17821 | -------- Summary: end -------- 19:46:10 INFO - PROCESS | 17821 | 19:46:11 INFO - TEST-INFO | 17821: exit 0 19:46:11 INFO - TEST-OK | dromaeo_css | took 1113215ms 19:46:11 INFO - TEST-START | kraken 19:46:11 INFO - operating with platform_type : linux_ 19:46:11 INFO - Initialising browser for kraken test... 19:46:11 INFO - TEST-INFO | started process 18124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuzVyhF/profile http://localhost:53981/getInfo.html) 19:46:15 INFO - PROCESS | 18124 | __metrics Screen width/height:1600/1200 19:46:15 INFO - PROCESS | 18124 | colorDepth:24 19:46:15 INFO - PROCESS | 18124 | Browser inner width/height: 1024/697 19:46:15 INFO - PROCESS | 18124 | __metrics 19:46:15 INFO - PROCESS | 18124 | 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" 19:46:15 INFO - PROCESS | 18124 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:46:16 INFO - PROCESS | 18124 | console.error: PushService: 19:46:16 INFO - PROCESS | 18124 | stateChangeProcessEnqueue: Error transitioning state 19:46:16 INFO - PROCESS | 18124 | UnknownError 19:46:16 INFO - TEST-INFO | 18124: exit 0 19:46:16 INFO - Browser initialized. 19:46:16 INFO - Running cycle 1/1 for kraken test... 19:46:16 INFO - TEST-INFO | started process 18217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuzVyhF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:46:28 INFO - PROCESS | 18217 | RSS: Main: 143372288 19:46:28 INFO - PROCESS | 18217 | 19:46:31 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53981/tests/kraken/driver.html?testName=audio-beat-detection) 19:46:31 INFO - PROCESS | 18217 | RSS: Main: 187076608 19:46:31 INFO - PROCESS | 18217 | 19:46:34 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53981/tests/kraken/driver.html?testName=audio-dft) 19:46:35 INFO - PROCESS | 18217 | RSS: Main: 174194688 19:46:35 INFO - PROCESS | 18217 | 19:46:37 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53981/tests/kraken/driver.html?testName=audio-fft) 19:46:38 INFO - PROCESS | 18217 | RSS: Main: 265474048 19:46:38 INFO - PROCESS | 18217 | 19:46:40 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53981/tests/kraken/driver.html?testName=audio-oscillator) 19:46:41 INFO - PROCESS | 18217 | RSS: Main: 172281856 19:46:41 INFO - PROCESS | 18217 | 19:46:43 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53981/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:46:43 INFO - PROCESS | 18217 | RSS: Main: 174505984 19:46:43 INFO - PROCESS | 18217 | 19:46:46 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53981/tests/kraken/driver.html?testName=imaging-darkroom) 19:46:47 INFO - PROCESS | 18217 | RSS: Main: 209592320 19:46:47 INFO - PROCESS | 18217 | 19:46:50 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53981/tests/kraken/driver.html?testName=imaging-desaturate) 19:46:51 INFO - PROCESS | 18217 | RSS: Main: 208822272 19:46:51 INFO - PROCESS | 18217 | 19:46:53 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53981/tests/kraken/driver.html?testName=json-parse-financial) 19:46:54 INFO - PROCESS | 18217 | RSS: Main: 208707584 19:46:54 INFO - PROCESS | 18217 | 19:46:56 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53981/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:46:56 INFO - PROCESS | 18217 | RSS: Main: 169914368 19:46:56 INFO - PROCESS | 18217 | 19:46:58 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53981/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:46:58 INFO - PROCESS | 18217 | RSS: Main: 178589696 19:46:58 INFO - PROCESS | 18217 | 19:47:00 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53981/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:01 INFO - PROCESS | 18217 | RSS: Main: 187031552 19:47:01 INFO - PROCESS | 18217 | 19:47:03 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:47:04 INFO - PROCESS | 18217 | RSS: Main: 196173824 19:47:04 INFO - PROCESS | 18217 | 19:47:07 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:47:07 INFO - PROCESS | 18217 | RSS: Main: 192229376 19:47:07 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | Cycle 1(1): loaded http://localhost:53981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53981/tests/kraken/driver.html?testName=ai-astar) 19:47:09 INFO - PROCESS | 18217 | RSS: Main: 243548160 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | __start_tp_report 19:47:09 INFO - PROCESS | 18217 | _x_x_mozilla_page_load 19:47:09 INFO - PROCESS | 18217 | _x_x_mozilla_page_load_details 19:47:09 INFO - PROCESS | 18217 | |i|pagename|runs| 19:47:09 INFO - PROCESS | 18217 | |0;ai-astar;111;113;111;110;112;111;110;110;112;110 19:47:09 INFO - PROCESS | 18217 | |1;audio-beat-detection;143;117;117;160;116;121;115;115;160;118 19:47:09 INFO - PROCESS | 18217 | |2;audio-dft;161;160;160;160;160;162;160;159;162;162 19:47:09 INFO - PROCESS | 18217 | |3;audio-fft;76;74;76;108;74;75;75;74;96;75 19:47:09 INFO - PROCESS | 18217 | |4;audio-oscillator;81;82;110;81;81;82;99;81;82;110 19:47:09 INFO - PROCESS | 18217 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;116 19:47:09 INFO - PROCESS | 18217 | |6;imaging-darkroom;151;145;145;147;146;146;146;146;147;146 19:47:09 INFO - PROCESS | 18217 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;94;95 19:47:09 INFO - PROCESS | 18217 | |8;json-parse-financial;51;49;49;48;48;49;51;49;48;49 19:47:09 INFO - PROCESS | 18217 | |9;json-stringify-tinderbox;57;59;58;58;58;60;58;59;58;59 19:47:09 INFO - PROCESS | 18217 | |10;stanford-crypto-aes;74;77;74;74;74;74;74;74;76;74 19:47:09 INFO - PROCESS | 18217 | |11;stanford-crypto-ccm;130;121;132;121;127;129;124;122;159;124 19:47:09 INFO - PROCESS | 18217 | |12;stanford-crypto-pbkdf2;157;165;158;156;157;157;161;162;155;154 19:47:09 INFO - PROCESS | 18217 | |13;stanford-crypto-sha256-iterative;62;62;62;65;62;61;63;61;61;60 19:47:09 INFO - PROCESS | 18217 | __end_tp_report 19:47:09 INFO - PROCESS | 18217 | __start_cc_report 19:47:09 INFO - PROCESS | 18217 | _x_x_mozilla_cycle_collect,1566 19:47:09 INFO - PROCESS | 18217 | __end_cc_report 19:47:09 INFO - PROCESS | 18217 | __startTimestamp1480477629778__endTimestamp 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | ------- Summary: start ------- 19:47:09 INFO - PROCESS | 18217 | Number of tests: 14 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.05 (0.9%) stddev-sans-first:1.12 19:47:09 INFO - PROCESS | 18217 | Values: 111.0 113.0 111.0 110.0 112.0 111.0 110.0 110.0 112.0 110.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:119.50 stddev:18.70 (15.6%) stddev-sans-first:19.05 19:47:09 INFO - PROCESS | 18217 | Values: 143.0 117.0 117.0 160.0 116.0 121.0 115.0 115.0 160.0 118.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 19:47:09 INFO - PROCESS | 18217 | Values: 161.0 160.0 160.0 160.0 160.0 162.0 160.0 159.0 162.0 162.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:11.80 (15.7%) stddev-sans-first:12.42 19:47:09 INFO - PROCESS | 18217 | Values: 76.0 74.0 76.0 108.0 74.0 75.0 75.0 74.0 96.0 75.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:81.50 stddev:12.40 (15.2%) stddev-sans-first:12.82 19:47:09 INFO - PROCESS | 18217 | Values: 81.0 82.0 110.0 81.0 81.0 82.0 99.0 81.0 82.0 110.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:47:09 INFO - PROCESS | 18217 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:1.72 (1.2%) stddev-sans-first:0.71 19:47:09 INFO - PROCESS | 18217 | Values: 151.0 145.0 145.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:47:09 INFO - PROCESS | 18217 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.00 stddev:1.10 (2.2%) stddev-sans-first:0.93 19:47:09 INFO - PROCESS | 18217 | Values: 51.0 49.0 49.0 48.0 48.0 49.0 51.0 49.0 48.0 49.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 19:47:09 INFO - PROCESS | 18217 | Values: 57.0 59.0 58.0 58.0 58.0 60.0 58.0 59.0 58.0 59.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:1.08 (1.5%) stddev-sans-first:1.13 19:47:09 INFO - PROCESS | 18217 | Values: 74.0 77.0 74.0 74.0 74.0 74.0 74.0 74.0 76.0 74.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:128.00 stddev:11.26 (8.8%) stddev-sans-first:11.94 19:47:09 INFO - PROCESS | 18217 | Values: 130.0 121.0 132.0 121.0 127.0 129.0 124.0 122.0 159.0 124.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:157.50 stddev:3.43 (2.2%) stddev-sans-first:3.61 19:47:09 INFO - PROCESS | 18217 | Values: 157.0 165.0 158.0 156.0 157.0 157.0 161.0 162.0 155.0 154.0 19:47:09 INFO - PROCESS | 18217 | 19:47:09 INFO - PROCESS | 18217 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:1.45 19:47:09 INFO - PROCESS | 18217 | Values: 62.0 62.0 62.0 65.0 62.0 61.0 63.0 61.0 61.0 60.0 19:47:09 INFO - PROCESS | 18217 | -------- Summary: end -------- 19:47:09 INFO - PROCESS | 18217 | 19:47:10 INFO - TEST-INFO | 18217: exit 0 19:47:10 INFO - TEST-OK | kraken | took 59168ms 19:47:10 INFO - SUITE-END | took 1172s 19:47:10 INFO - Completed test suite (00:19:32) 19:47:10 INFO - javascript benchmark 19:47:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3173.174974506628, 3214.8392580370974, 3223.210313473199, 3225.7903236289626, 3256.527803468497, 5675.631083979543, 5750.309962804464, 5758.99217636914, 5786.1610066540325, 5796.884062318751, 5743.597948143632, 5770.221020162277, 5810.709464526767, 5818.243628328322, 5826.475617194452, 5218.165093585037, 5235.528802407783, 5266.34170728659, 5319.946800531984, 5325.680459172462, 5096.643234973553, 5295.364556253255, 5305.761240744157, 5309.256704061435, 5315.760790764425, 5097.413797413289, 5161.74191290434, 5177.715225662587, 5213.635045546814, 5225.79096836128, 5191.818286359978, 5225.059489291945, 5232.581393488512, 5299.894002119936, 5302.496262855023, 5146.073706732786, 5173.508516690908, 5257.1588545832865, 5265.86835329116, 5276.81531146408, 5534.861628459281, 5559.054960656698, 5592.86017849553, 5627.971860140714, 5629.8311050668135, 6086.330503644595, 6101.816945491642, 6111.419415155598, 6185.87628247437, 6195.690215489208, 6228.844278893019, 6229.6573688447115, 6243.219597550306, 6245.281792593864, 6246.281677607088, 5555.083411237141, 5589.273394458694, 5616.578756593312, 5641.464060914206, 5678.0915053591225, 6275.874482510324, 6277.3241770307195, 6301.558890877686, 6307.905381419282, 6311.116443697886, 6051.546134039964, 6059.242594675666, 6060.484858787053, 6061.969690151521, 6098.969505152446, 5853.180554722342, 5868.794592189253, 5891.587588868738, 5946.345901950782, 5959.255093113361, 6016.969915150484, 6019.036954087325, 6022.126791615191, 6028.939710602838, 6040.577159598786, 5981.611195272293, 6032.487238584682, 6039.54703397247, 6046.395360463918, 6068.484178844759, 4461.843835465743, 4511.323301504801, 4519.480259770168, 4583.472900616405, 4583.54164583539, 4141.171765646883, 4152.937705934413, 4161.438205842233, 4189.036521600049, 4198.328267477189, 5808.854778630483, 5826.155207494974, 5843.707814609253, 5852.239208902901, 5864.296284445893, 5919.1713160157615, 5924.7926322578505, 5977.641341519523, 6051.636901785907, 6244.344343843922, 5780.450857168562, 5785.537157027427, 5788.160716696056, 5803.564732645069, 5842.824715258549, 5164.586833053347, 5181.248718935809, 5182.948170518322, 5183.326167598264, 5223.981323641853, 6010.098485227251, 6156.07658851167, 6252.0, 6323.683815809191, 6353.714082866282, 6108.053251745987, 6228.065790131335, 6259.812205633838, 6267.874642507216, 6274.74901003973, 6431.903521447276, 6437.163168788027, 6438.549301548846, 6440.033994900802, 6452.387023232785, 5711.086226203787, 5829.271341082364, 6117.0824376342125, 6119.541034422525, 6125.785597504066, 6067.150598916243, 6109.053096770008, 6111.480524155497, 6181.938180618136, 6190.7523699051535, 6019.307779605227, 6033.9252847834005, 6066.878662426815, 6067.969660151671, 6069.696515174312, 5803.448672376117, 5994.610350327215, 6049.274087109399, 6063.181470501426, 6065.332813390435, 5822.534197264294, 5965.313988891333, 6003.609765365237, 6016.819495414969, 6110.2550082019825, 6141.631502109888, 6144.969275153596, 6145.10895920098, 6147.631142131308, 6153.784617538365, 5646.71766411686, 5689.544836412994, 5992.0498356600565, 6013.158157857991, 6045.425684559959], "value": 5633.674688620686, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.3543337761841, 634.0742515926747, 634.1597383466906, 651.9543631945762, 654.0548906829628, 34136.65863341366, 34953.825230873845, 37581.624183758155, 37617.0, 37656.62343376566, 37556.624433755656, 38664.42003369952, 46724.0, 47833.76083119588, 47931.281030784565, 9283.4429934204, 9404.905950940505, 9414.905850941506, 9432.764180895463, 9433.858492122623, 9248.213901818353, 9392.671256506024, 9404.200642945358, 9406.670766523173, 9414.670486532972, 8728.127187281285, 8933.196012358887, 11091.0, 11308.03881670059, 11318.830217546743, 11380.601678941239, 11392.08863290943, 11458.828117578243, 11459.140564457657, 11481.540738370455, 11240.775184496264, 11314.886851131465, 11315.886841131565, 11322.547098116065, 11323.150763692674, 45133.774331128465, 45546.08907821858, 45578.0, 45583.54416455826, 45604.54395456036, 3901.804909754501, 3958.9802050989847, 3992.6007399260134, 4319.740815551046, 4446.021875187454, 34054.48918266228, 34135.48796768051, 34304.828475857714, 34447.827760861284, 36005.81997090024, 4740.597049250818, 4771.737554434505, 4809.302651115569, 4812.951870481285, 4814.325994360793, 360181.0, 360395.0, 360840.0, 361460.0, 362687.0, 64153.0, 64376.0, 64427.67786161039, 64462.6776866122, 64527.0, 40788.18423631511, 41146.794266028475, 41428.585714143075, 43375.78312108419, 67654.66172669204, 18654.067296635112, 18820.717689234672, 18829.058547072593, 18833.434996950113, 18911.810881891004, 14977.925110374379, 15058.548243552492, 15105.622359441102, 15106.622334441727, 15108.39566417353, 18453.446396608124, 18884.81115188858, 20484.897575512026, 20969.580608387747, 21127.577448450946, 7393.48245622812, 7526.32263096324, 7635.053061469401, 7674.654640541189, 7737.806554836174, 1068.1454836131063, 1074.2372915230274, 1092.5575142067476, 1125.8930401611833, 1173.8708742038368, 29986.700132998827, 30112.698873011428, 30462.70262765101, 30521.38957220843, 30687.0, 1161.901238394729, 1201.9459124339426, 1202.8977536909285, 1228.3796682675193, 1232.8103380238113, 16615.252313645917, 17049.573760655836, 17102.48692539226, 17184.484465466056, 17276.13619319029, 541407.0, 542861.0, 543320.0, 544786.0, 544839.0, 62854.68572657107, 63351.0, 63357.68321158457, 63464.0, 63507.6824615874, 1227.5274019502556, 1273.2742336867896, 1283.8972882169403, 1290.9419076141596, 1393.0318428691962, 27924.162275131777, 28948.42103157967, 29912.55131173078, 29940.70059299379, 30555.0, 54862.0, 55048.17427738507, 55226.171607426724, 55298.72350638221, 55343.0, 466715.0, 470812.0, 472560.0, 472640.0, 473141.0, 27786.722132778414, 28432.43135137327, 31904.68095319017, 32347.0, 46590.534094659975, 46114.538854612365, 49478.50521494739, 53119.20321195263, 57441.71279143578, 57985.420145798, 45134.77432612816, 45737.542624573325, 45804.0, 46137.30794038025, 46688.766556167, 43367.34948975705, 44810.77594612006, 45171.548284516735, 45322.09355812799, 45833.312500313186, 46064.309035365164, 49922.75193120201, 50062.249066263306, 51151.0, 51297.743511282206, 39179.608203917596, 42036.789816050725, 42049.0, 42065.369019465346, 42344.153116936875, 29877.402451950406, 30747.385052299276, 31558.0, 31615.525767113053, 32074.67925320717], "value": 21513.770105433472, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.6609949344071, 410.96095870892253, 419.31651408204624, 419.66217195157896, 434.8738865728937, 14519.854801451982, 16450.58873528161, 19990.20039198434, 20549.897250513764, 20981.265655702053, 19675.21299148036, 19828.60342793147, 19863.900680496576, 20519.38441846743, 21027.894860525677, 5891.764329426818, 5903.4391732785425, 6112.969435152818, 6127.938720612781, 6174.043023331391, 4075.87772366828, 6185.907211391833, 6202.4417802397775, 6205.596636218654, 6208.6585237811905, 4210.978945105286, 4296.763677997709, 6787.219469760967, 6871.14110736158, 6874.3469370409985, 6106.786262480792, 6265.87468250637, 6849.623270720133, 6849.897251541231, 6866.313368663144, 5967.313758917737, 5993.61041532299, 5995.700214989233, 5998.700064996733, 6001.729922153513, 14758.114513129247, 14774.852251477456, 14842.332095055748, 14866.702665946728, 15003.249837508081, 2494.1519883239785, 3014.668386477486, 3106.2389714520086, 3142.5600415941785, 3145.5910731604745, 10710.41092739899, 10881.945590272077, 11041.613543526018, 11042.889571104266, 11139.944300278528, 1923.1153669312134, 1946.4744518979796, 1953.990230048855, 1955.0, 1962.6467235897533, 78915.6054219731, 84443.57778211069, 84513.57743211306, 85240.57379713186, 85599.57200214021, 11428.714282143013, 11528.250663706833, 11545.595904143483, 11635.952764251258, 11706.94146529279, 16643.41748038813, 16649.750253746202, 16656.167191640612, 16685.24916378766, 16705.248263828158, 8815.647374105092, 8875.511846848485, 8886.0, 9220.49287289192, 9294.442333460014, 8301.8339633207, 8305.543195124326, 8332.541710205996, 8445.239928406472, 8537.317014638815, 5148.407933087743, 5202.531772140525, 5207.479252074762, 5227.738613069408, 5268.92096618551, 2087.244836815389, 2111.6832475128854, 2118.163325486455, 2147.6778483227326, 2186.486175748698, 944.990550094504, 975.5024937282037, 1009.2077718990557, 1013.4476710192963, 1039.927205095636, 19029.904850475938, 20189.60639301125, 20614.690779638317, 20828.58342833165, 20960.685589716166, 1008.6318493749875, 1015.6292953072076, 1073.3291692692067, 1091.3615534912008, 1102.9779404412027, 10725.30285531438, 11560.30638161713, 11640.825387619192, 11655.650330490098, 11706.590269340531, 394199.0, 509251.0, 514092.0, 515022.0, 516239.0, 77023.61488192523, 77727.0, 95618.52190739002, 100566.49716751369, 106650.46674766732, 1057.1278695076592, 1071.6999240212754, 1099.4173088263233, 1102.0467295789085, 1113.4655365424642, 17896.642067158846, 18063.458096257134, 18431.907840460713, 18583.16375763121, 18863.528411789815, 36202.0, 43950.0, 44386.0, 44495.0, 45164.32253516265, 59327.40672593219, 64038.67980660067, 65004.67497662482, 65771.0, 65936.67031664812, 9014.32392570573, 9213.0, 9271.258299336172, 9339.906600933904, 9639.807203855744, 10279.486025698834, 13548.187108773505, 13971.650708732363, 13991.300434978008, 14151.363188656329, 11563.6530904073, 12058.15592908488, 12249.0, 12488.313142777235, 12589.055820813292, 11847.466863990969, 11917.702057448632, 12241.510339586317, 12550.1842380245, 12691.048171386998, 12360.25838449696, 12428.502859885864, 12440.19138755978, 12524.937375313066, 12630.368481576068, 8806.471611703319, 9220.124088211609, 9273.907260927574, 9303.72088837336, 9477.194438472807, 9033.909660903308, 11043.392613406018, 11185.608503702331, 11390.25963312382, 11412.358759163926], "value": 9587.41355203226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.3920953199658, 1493.186213513635, 1622.578129686282, 1779.1193359287154, 1798.919048642811, 8221.0, 8420.368472364567, 9130.863037054449, 9853.359531630447, 9877.802443951117, 9148.817023659523, 9444.0, 9445.716628501139, 9766.804663906718, 9775.266854985868, 2530.4306531030556, 2563.884625191871, 2563.987180064097, 2564.9743502565016, 2567.2169988153605, 2509.887055082526, 2566.845989240642, 2568.7174410814796, 2570.3959569501153, 2573.086554273225, 2550.7066687331007, 2554.6168074788743, 2585.8060645451574, 2589.249117755858, 2590.7409259074034, 2538.7842033427273, 2553.872306384683, 2557.795376369886, 2564.8589327586974, 2568.691756989155, 2504.022725918277, 2518.7733104020544, 2529.4308780524234, 2547.46503234321, 2549.222487141421, 9608.951955240249, 9707.174890134347, 9712.320137590372, 9857.802843943153, 9873.851892221623, 5778.162166485836, 5924.052151655715, 5931.614445061057, 5936.257967754031, 5951.642901425928, 3587.9282414351565, 3690.7231957603285, 3742.607026262258, 3783.205526839367, 3790.77255364679, 1179.2334982261514, 1250.0499620288647, 1250.3873102179866, 1266.1010682415497, 1279.795232762763, 13807.930960345235, 13834.100783449043, 14017.64955876101, 14019.299035048207, 14027.789583156364, 5144.254083157921, 5210.505002024802, 5385.9730701347025, 5394.622376433612, 5417.945820541823, 11463.770724585462, 11497.885021149848, 11505.309681419141, 11512.079033677453, 11519.0, 5975.67133807636, 5977.282726072899, 5988.401159884064, 5990.161377407167, 5993.130996005642, 4775.641826863, 4949.90100197994, 5348.411674715778, 5416.214648875891, 5482.013237617267, 4355.760433176142, 4455.509893911667, 4507.842225522091, 4539.205639013159, 4581.770911454414, 1383.6540864783803, 1405.3956798576505, 1412.0821466046946, 1424.1170474305998, 1430.5636780781754, 1012.1396812709286, 1013.3008224325192, 1031.28841099641, 1032.3444612671008, 1033.850091736694, 6153.661548614779, 6429.357064293533, 6437.324080971524, 6517.250516190604, 6772.255051944282, 498.14568015852984, 503.41855157293384, 507.51532286666145, 518.3080587415767, 525.4115390762371, 4124.566920473367, 4237.982884107853, 4458.888527786831, 4532.0709254602725, 4673.509281525459, 12111.031117510578, 12242.938785306194, 12319.507219711111, 12370.690732731753, 12417.44121514534, 11448.599299024494, 12193.207441516273, 12260.81608775869, 12281.0, 12281.140320177681, 8665.913340866511, 9130.452172869649, 9143.862842057375, 9145.268378529701, 9149.954250228706, 6147.938520614736, 6268.811935641938, 6313.96843015782, 6392.87214255703, 6402.199725034371, 11175.27360721583, 11359.716007099889, 11374.374409407563, 11466.598669046876, 11479.08167346627, 11151.107911367233, 11636.650900473, 11637.709057273298, 11640.185187036826, 11653.6503904883, 7684.077910650758, 7828.452008359588, 8171.264586187272, 8468.745937621881, 8623.698170564001, 9148.679796207367, 9589.520523973913, 9603.0, 9605.423674579548, 9613.0, 8421.87367189505, 8459.450135741157, 8471.0, 8657.826843463221, 8723.08407617191, 8272.710455134042, 8276.255137037695, 8290.212429819157, 8394.45436046655, 8437.493750374751, 7764.844703105793, 7844.960775196316, 7882.763517094496, 7886.250806173404, 7939.0870049945, 5452.182172674131, 5517.117261238182, 5541.722913854372, 5622.522085622768, 5680.857978550569, 5643.633163844337, 5690.203371527907, 5732.484076432974, 5769.624974376652, 5834.533237340917], "value": 5011.69590789368, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.73309219170756, 340.0054839594187, 348.3711900020464, 348.8221007286284, 352.78114115730153, 5487.917681234785, 5656.179853921179, 5678.205051292817, 5719.942800571998, 5741.4832665060185, 5422.240886275925, 5477.4663094333555, 5510.842723028169, 5512.924979628974, 5569.275994120759, 4380.934285985712, 4391.64866810656, 4397.538258482861, 4401.691881568276, 4403.6256918162, 4142.2543942090415, 4312.137572485515, 4373.912521749563, 4375.8249670013165, 4411.845585404511, 4279.315309550472, 4288.69979101463, 4311.568843115695, 4326.870193894189, 4337.392765012901, 4285.207236661212, 4286.0, 4319.157764235975, 4319.848805291831, 4365.476142862877, 3714.647108524686, 3789.8673546425744, 3793.6016718244464, 3808.371618682914, 3860.7297489175767, 5419.512243898029, 5423.701696406735, 5442.91835622466, 5448.291722076105, 5451.945480545223, 4953.405591329064, 4964.0, 4966.900661986776, 4971.384300102445, 4977.776000080005, 5537.750801213955, 5766.769329226826, 5791.536677065825, 5808.950301091918, 5829.912551311733, 4107.178564287155, 4118.155778065489, 4121.319982202933, 4129.236091323085, 4135.97932010341, 6066.908996365058, 6084.269887613515, 6114.724837382329, 6121.693915304217, 6136.509079273692, 4098.590140985937, 4254.744715317091, 4291.699581029298, 4300.204462174508, 4301.268784306675, 4343.19650864591, 4371.0, 4374.343848422762, 4388.4733831940375, 4391.912161756747, 4978.755311172207, 4997.825076122318, 5005.599552035828, 5007.12375334315, 5013.323201367842, 5575.609707320448, 5614.354349249807, 5873.383294754075, 5903.439173278532, 5946.613470124428, 1448.5726710620393, 1466.948656797007, 1469.9632509187356, 1477.7857210704387, 1486.8996942262647, 985.7929834734642, 1002.2132625888643, 1010.2019404670228, 1018.3177271228295, 1027.7256202309231, 5567.524605979419, 5582.33012038558, 5601.579881508903, 5628.549716022791, 5632.943670563324, 5939.524838012949, 5960.393961653137, 5974.341418068918, 5996.490298324604, 6053.545984051214, 5415.945840541544, 5660.264165658438, 5684.147377893349, 5699.546615612992, 5727.742251598688, 3204.83975801209, 3221.1624977506017, 3226.0, 3227.499737540685, 3229.951550726741, 6080.270367555921, 6239.005277466841, 6272.087013460939, 6307.842303942438, 6317.557770956081, 6023.0, 6110.847228819226, 6166.537509686791, 6171.259448866164, 6182.567220294626, 6202.28673702521, 6204.565680402328, 6227.564070515021, 6265.994881637832, 6315.55791094619, 5853.678047707417, 5990.191324171181, 6004.849878753066, 6051.727672254671, 6055.848603784941, 5924.200232968494, 5938.228030356199, 5942.58401911862, 5982.551308651781, 5998.0103282957825, 5937.584369094122, 6145.8156255312415, 6147.969260153671, 6150.200473938359, 6197.380261973766, 4312.197071903288, 4329.567043295771, 4332.328489084197, 4334.739915605074, 4346.456692913386, 5686.350958222235, 6030.638161710312, 6034.849128771641, 6061.363556826646, 6063.423974722395, 5722.284714410699, 5762.683052432157, 5884.352721200579, 5887.764489420375, 5904.468597826216, 5860.970695146497, 5863.17915491823, 5869.911951320648, 5878.735456904364, 5889.499392551681, 5646.322441306905, 5827.82383600947, 5853.473187412983, 5862.589618726648, 5866.853328666817, 5893.263342082239, 5900.586958912835, 5924.259467566554, 5930.733117009659, 5937.287525496968, 5635.577331700057, 5761.740721667619, 5788.189653448437, 5799.710014499343, 5816.651000939957], "value": 4466.515697142151, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.8892755014296, 794.5669610062519, 805.6133056133052, 861.9396642235042, 902.4810733828047, 16532.58668533286, 17595.824041759577, 17655.91172044138, 17658.205380757863, 17679.64640707187, 15964.920175399107, 16316.510504684878, 16322.020678759283, 16847.0, 17463.476095717117, 734.3354264390734, 751.5866273549526, 854.2781349759443, 866.7529754020105, 879.1867522541655, 880.3793325705394, 880.5773228850156, 883.3507372081515, 883.3904605821995, 883.514067263006, 926.420986883198, 929.502716046915, 931.0549791961165, 931.2038207332735, 931.6040682709855, 924.9630014799467, 926.115559640545, 926.5228407370209, 926.6015613286318, 926.8331700293944, 684.4182444921777, 684.490054909091, 684.7706018483814, 685.6297599296374, 685.6640246279287, 16943.0, 16960.236789344508, 16987.74518382225, 16994.405195818086, 16996.745048824276, 13267.73464530704, 14132.858671413258, 14965.625859353495, 15149.545513634608, 15825.366985320574, 13194.934025329909, 13363.274046755054, 13511.932440337736, 13516.729665406638, 13830.37763300654, 4123.257813593552, 4162.334026555736, 4218.367244913287, 4227.302495088337, 4250.681198910094, 91667.0, 93105.5344723272, 94268.52865735696, 97411.51294243483, 98864.50567747187, 11836.70408239801, 11920.642380728419, 12064.75870482603, 12214.26714397139, 12408.81386779199, 23423.297301080653, 23828.523429531313, 23874.0, 23899.52200955971, 23913.641295380236, 7972.681092756225, 8044.758657240175, 8244.917550824535, 8438.831223375499, 8843.867341989875, 5079.771410286546, 5152.6650767699975, 5244.449332820075, 5246.7638956247065, 5434.510894019557, 3471.0801637566065, 3586.55168103987, 3586.910327241788, 3593.3531964246686, 3598.9100272493397, 650.8210242183343, 661.0480907493194, 661.1603263854973, 663.3896814930275, 688.8656711941223, 693.230514129316, 762.6758627583255, 797.4497596658288, 803.6704950970075, 824.9216324449168, 10514.106300964504, 10560.894391056145, 10602.575896964036, 10616.63902434176, 10984.725381865517, 750.6284389227259, 777.7161336112391, 786.6695987685185, 798.0901771979948, 803.8713805791162, 5314.468553144732, 5320.2817619620855, 5334.333208348957, 5357.517823395913, 5422.322209723785, 84319.5784021076, 97627.0, 123348.38325808314, 129197.0, 134975.32512337377, 113831.43084284525, 113868.0, 114789.0, 115965.4201728986, 116551.41724291493, 96857.51571242239, 100876.49561752145, 103044.0, 103183.0, 105246.99999999847, 9936.354136981074, 10242.0, 10423.322484038514, 10455.268131230741, 10631.787364252517, 59191.70404147952, 59243.40756592551, 60392.0, 62282.0, 63501.68249158725, 48843.0, 49954.75022624864, 61357.0, 86701.56649216714, 88821.55589222013, 12662.113652044269, 12705.428255728699, 13002.414891330101, 13002.479900803863, 13371.26458044778, 13692.178469291874, 14123.576292711236, 14319.212443315717, 14488.927555362156, 14741.55775326742, 13354.465821367037, 13437.126586771828, 13449.663758406117, 13530.391132398869, 13633.659158521117, 13378.112517636602, 13693.0, 14327.498537551135, 14479.565613031626, 14791.260436978324, 12755.0, 13152.605421837361, 13381.732365352833, 14050.297485125908, 14339.928300358431, 11020.834687479855, 11377.601783937522, 11681.88318116808, 11689.357085360387, 12231.694207644525, 11334.773304534028, 11798.882011179778, 12167.87832121703, 12197.51209951592, 12331.630051098482], "value": 8109.685954529488, "unit": "score"}], "name": "dromaeo_css", "value": 7715.574576820949, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 111.0, 110.0, 112.0, 111.0, 110.0, 110.0, 112.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 117.0, 160.0, 116.0, 121.0, 115.0, 115.0, 160.0, 118.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 160.0, 159.0, 162.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 108.0, 74.0, 75.0, 75.0, 74.0, 96.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 110.0, 81.0, 81.0, 82.0, 99.0, 81.0, 82.0, 110.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 49.0, 48.0, 48.0, 49.0, 51.0, 49.0, 48.0, 49.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 58.0, 58.0, 60.0, 58.0, 59.0, 58.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 74.0, 74.0, 74.0, 74.0, 74.0, 76.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 121.0, 132.0, 121.0, 127.0, 129.0, 124.0, 122.0, 159.0, 124.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 165.0, 158.0, 156.0, 157.0, 157.0, 161.0, 162.0, 155.0, 154.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 65.0, 62.0, 61.0, 63.0, 61.0, 61.0, 60.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1458.1000000000001, "alertThreshold": 2.0}]} 19:47:11 INFO - Return code: 0 19:47:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:47:11 INFO - # TBPL SUCCESS # 19:47:11 INFO - Running post-action listener: _resource_record_post_action 19:47:11 INFO - [mozharness: 2016-11-30 03:47:11.110260Z] Finished run-tests step (success) 19:47:11 INFO - Running post-run listener: _resource_record_post_run 19:47:11 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 308211712; Read time: 44; Write time: 190040 19:47:11 INFO - TinderboxPrint: CPU usage
12.9% 19:47:11 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 44 19:47:11 INFO - TinderboxPrint: I/O write bytes / time
308,211,712 / 190,040 19:47:11 INFO - TinderboxPrint: CPU idle
8,244.3 (87.1%) 19:47:11 INFO - TinderboxPrint: CPU user
1,183.1 (12.5%) 19:47:11 INFO - TinderboxPrint: Swap in / out
0 / 0 19:47:11 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100577280; Read time: 0; Write time: 53628 19:47:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 207634432; Read time: 12; Write time: 136412 19:47:11 INFO - Running post-run listener: _upload_blobber_files 19:47:11 INFO - Blob upload gear active. 19:47:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:47:11 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 19:47:11 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'] 19:47:11 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 19:47:12 INFO - (blobuploader) - INFO - Open directory for files ... 19:47:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:47:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:47:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:15 INFO - (blobuploader) - INFO - Done attempting. 19:47:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:47:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:16 INFO - (blobuploader) - INFO - Done attempting. 19:47:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:47:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:16 INFO - (blobuploader) - INFO - Done attempting. 19:47:16 INFO - (blobuploader) - INFO - Iteration through files over. 19:47:16 INFO - Return code: 0 19:47:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:47:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:47:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4e9218f91406015391545a32c1709322e46945283c315e4dc96fae943064c385701d57cbed4963bef0fe34d51b1ecf2b261f76e314356fd428da2092eacfb09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d38e0cb49c61aa1eef82b365f2c130104105faaa77776ae95b386b6edabf7d5fd6444967a5ce730535d815cfe98f48db85a227e5c8aa86c6c156dd416ebfe48e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b065d9cac5834c28acd6bffff71cdbea75449a89f54f93da4f0e893bdc39edc1366d77f03abb56349d18278d56bf4b5fb601d746019e239d6a83f95936ac382c"} 19:47:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:47:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:47:16 INFO - Contents: 19:47:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4e9218f91406015391545a32c1709322e46945283c315e4dc96fae943064c385701d57cbed4963bef0fe34d51b1ecf2b261f76e314356fd428da2092eacfb09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d38e0cb49c61aa1eef82b365f2c130104105faaa77776ae95b386b6edabf7d5fd6444967a5ce730535d815cfe98f48db85a227e5c8aa86c6c156dd416ebfe48e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b065d9cac5834c28acd6bffff71cdbea75449a89f54f93da4f0e893bdc39edc1366d77f03abb56349d18278d56bf4b5fb601d746019e239d6a83f95936ac382c"} 19:47:16 INFO - Running post-run listener: copy_logs_to_upload_dir 19:47:16 INFO - Copying logs to upload dir... 19:47:16 INFO - mkdir: /builds/slave/test/build/upload/logs 19:47:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.537607 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-11-29 19:47:16.799254) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 19:47:16.802345) ========= 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=20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938 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/a4e9218f91406015391545a32c1709322e46945283c315e4dc96fae943064c385701d57cbed4963bef0fe34d51b1ecf2b261f76e314356fd428da2092eacfb09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d38e0cb49c61aa1eef82b365f2c130104105faaa77776ae95b386b6edabf7d5fd6444967a5ce730535d815cfe98f48db85a227e5c8aa86c6c156dd416ebfe48e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b065d9cac5834c28acd6bffff71cdbea75449a89f54f93da4f0e893bdc39edc1366d77f03abb56349d18278d56bf4b5fb601d746019e239d6a83f95936ac382c"} build_url:https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011604 build_url: 'https://queue.taskcluster.net/v1/task/RcNBzXOpQ0GnKNdiZGAD_A/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/a4e9218f91406015391545a32c1709322e46945283c315e4dc96fae943064c385701d57cbed4963bef0fe34d51b1ecf2b261f76e314356fd428da2092eacfb09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d38e0cb49c61aa1eef82b365f2c130104105faaa77776ae95b386b6edabf7d5fd6444967a5ce730535d815cfe98f48db85a227e5c8aa86c6c156dd416ebfe48e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b065d9cac5834c28acd6bffff71cdbea75449a89f54f93da4f0e893bdc39edc1366d77f03abb56349d18278d56bf4b5fb601d746019e239d6a83f95936ac382c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 19:47:16.827943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:47:16.828494) ========= 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=20e666a3d4cfbb71505a330e000001b4-1480476405.122587-499239938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:47:16.916006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 19:47:16.916671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 19:47:16.916998) ========= ========= Total master_lag: 0.19 =========