builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1477517820.41 results: success (0) buildid: 20161010141523 builduid: 8a8b986c697f4016a91ebaa5ad5406f4 revision: 6031d730c46ae3b3db353a8d35c99e82117f6479 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:00.405944) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:00.406435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:00.406730) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:00.421449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:00.421874) ========= 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=bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 14:37:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-26 14:37:01 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119733 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:00.555458) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:00.555789) ========= 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=bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018247 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:00.605268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:37:00.605655) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6031d730c46ae3b3db353a8d35c99e82117f6479 --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-aurora --rev 6031d730c46ae3b3db353a8d35c99e82117f6479 --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=bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 14:37:01,269 truncating revision to first 12 chars 2016-10-26 14:37:01,269 Setting DEBUG logging. 2016-10-26 14:37:01,269 attempt 1/10 2016-10-26 14:37:01,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6031d730c46a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 14:37:01,995 unpacking tar archive at: mozilla-aurora-6031d730c46a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.052733 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:37:01.671878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:01.672223) ========= script_repo_revision: 6031d730c46ae3b3db353a8d35c99e82117f6479 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:01.672660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:01.672948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:37:01.682188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-26 14:37:01.682502) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:37:02 INFO - MultiFileLogger online at 20161026 14:37:02 in /builds/slave/test 14:37:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:37:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:37:02 INFO - {'append_to_log': False, 14:37:02 INFO - 'base_work_dir': '/builds/slave/test', 14:37:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:37:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:37:02 INFO - 'branch': 'Mozilla-Aurora', 14:37:02 INFO - 'buildbot_json_path': 'buildprops.json', 14:37:02 INFO - 'config_files': ('talos/linux_config.py',), 14:37:02 INFO - 'default_actions': ('clobber', 14:37:02 INFO - 'read-buildbot-config', 14:37:02 INFO - 'download-and-extract', 14:37:02 INFO - 'populate-webroot', 14:37:02 INFO - 'create-virtualenv', 14:37:02 INFO - 'install', 14:37:02 INFO - 'run-tests'), 14:37:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:37:02 INFO - 'download_minidump_stackwalk': True, 14:37:02 INFO - 'download_symbols': 'ondemand', 14:37:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:37:02 INFO - 'tooltool.py': '/tools/tooltool.py', 14:37:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:37:02 INFO - '/tools/misc-python/virtualenv.py')}, 14:37:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:37:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:37:02 INFO - 'installer_path': 'installer.exe', 14:37:02 INFO - 'log_level': 'info', 14:37:02 INFO - 'log_name': 'talos', 14:37:02 INFO - 'log_to_console': True, 14:37:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:37:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:37:02 INFO - 'opt_config_files': (), 14:37:02 INFO - 'pip_index': False, 14:37:02 INFO - 'sps_profile': False, 14:37:02 INFO - 'sps_profile_interval': 0, 14:37:02 INFO - 'suite': 'dromaeojs', 14:37:02 INFO - 'system_bits': '32', 14:37:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:37:02 INFO - 'title': 'talos-linux64-ix-055', 14:37:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:37:02 INFO - 'use_talos_json': True, 14:37:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:37:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:37:02 INFO - 'work_dir': 'build'} 14:37:02 INFO - [mozharness: 2016-10-26 21:37:02.457864Z] Running clobber step. 14:37:02 INFO - Running pre-action listener: _resource_record_pre_action 14:37:02 INFO - Running main action method: clobber 14:37:02 INFO - rmtree: /builds/slave/test/build 14:37:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:37:03 INFO - Running post-action listener: _resource_record_post_action 14:37:03 INFO - [mozharness: 2016-10-26 21:37:03.429925Z] Finished clobber step (success) 14:37:03 INFO - [mozharness: 2016-10-26 21:37:03.430025Z] Running read-buildbot-config step. 14:37:03 INFO - Running pre-action listener: _resource_record_pre_action 14:37:03 INFO - Running main action method: read_buildbot_config 14:37:03 INFO - Using buildbot properties: 14:37:03 INFO - { 14:37:03 INFO - "project": "", 14:37:03 INFO - "product": "firefox", 14:37:03 INFO - "script_repo_revision": "production", 14:37:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:37:03 INFO - "repository": "", 14:37:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:37:03 INFO - "buildid": "20161010141523", 14:37:03 INFO - "pgo_build": "True", 14:37:03 INFO - "basedir": "/builds/slave/test", 14:37:03 INFO - "buildnumber": 552, 14:37:03 INFO - "slavename": "talos-linux64-ix-055", 14:37:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:37:03 INFO - "platform": "ubuntu64_hw", 14:37:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:37:03 INFO - "branch": "mozilla-aurora", 14:37:03 INFO - "repo_path": "releases/mozilla-aurora", 14:37:03 INFO - "revision": "6031d730c46ae3b3db353a8d35c99e82117f6479", 14:37:03 INFO - "stage_platform": "linux64-pgo", 14:37:03 INFO - "builduid": "8a8b986c697f4016a91ebaa5ad5406f4", 14:37:03 INFO - "slavebuilddir": "test" 14:37:03 INFO - } 14:37:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 14:37:03 INFO - Running post-action listener: _resource_record_post_action 14:37:03 INFO - [mozharness: 2016-10-26 21:37:03.432461Z] Finished read-buildbot-config step (success) 14:37:03 INFO - [mozharness: 2016-10-26 21:37:03.432551Z] Running download-and-extract step. 14:37:03 INFO - Running pre-action listener: _resource_record_pre_action 14:37:03 INFO - Running main action method: download_and_extract 14:37:03 INFO - mkdir: /builds/slave/test/build/tests 14:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:03 INFO - trying https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:37:03 INFO - Downloading https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:37:04 INFO - Downloaded 1361 bytes. 14:37:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:37:04 INFO - Using the following test package requirements: 14:37:04 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:37:04 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:37:04 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:37:04 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:04 INFO - u'jsshell-linux-x86_64.zip'], 14:37:04 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:37:04 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:37:04 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:37:04 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:37:04 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:37:04 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:37:04 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:37:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:37:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:37:04 INFO - Fetch https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:37:04 INFO - Expected file size: 21907280 14:37:08 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:37:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:37:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:37:08 INFO - Fetch https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:37:09 INFO - Expected file size: 21907280 14:37:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 14:37:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:37:14 INFO - Fetch https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:37:14 INFO - Expected file size: 14414059 14:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:15 INFO - trying https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:37:15 INFO - Downloading https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:37:16 INFO - Downloaded 63982674 bytes. 14:37:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:37:16 INFO - mkdir: /builds/slave/test/properties 14:37:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:37:16 INFO - Writing to file /builds/slave/test/properties/build_url 14:37:16 INFO - Contents: 14:37:16 INFO - build_url:https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:37:16 INFO - Running post-action listener: _resource_record_post_action 14:37:16 INFO - Running post-action listener: set_extra_try_arguments 14:37:16 INFO - [mozharness: 2016-10-26 21:37:16.963074Z] Finished download-and-extract step (success) 14:37:16 INFO - [mozharness: 2016-10-26 21:37:16.963301Z] Running populate-webroot step. 14:37:16 INFO - Running pre-action listener: _resource_record_pre_action 14:37:16 INFO - Running main action method: populate_webroot 14:37:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:37:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:37:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:37:16 INFO - '--tppagecycles', 14:37:16 INFO - '7'], 14:37:16 INFO - 'tests': ['tsvgm']}}, 14:37:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:37:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:37:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:37:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:37:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:16 INFO - 'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:16 INFO - 'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['damp', 'tps']}, 14:37:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:16 INFO - 'tests': ['damp', 'tps']}, 14:37:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['dromaeo_dom']}, 14:37:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:37:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['basic_compositor_video']}, 14:37:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:37:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['a11yr', 14:37:16 INFO - 'ts_paint', 14:37:16 INFO - 'tpaint', 14:37:16 INFO - 'sessionrestore', 14:37:16 INFO - 'sessionrestore_no_auto_restore', 14:37:16 INFO - 'tabpaint']}, 14:37:16 INFO - 'other-e10s': {'tests': ['a11yr', 14:37:16 INFO - 'ts_paint', 14:37:16 INFO - 'tpaint', 14:37:16 INFO - 'sessionrestore', 14:37:16 INFO - 'sessionrestore_no_auto_restore', 14:37:16 INFO - 'tabpaint']}, 14:37:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:37:16 INFO - 'ts_paint', 14:37:16 INFO - 'tpaint', 14:37:16 INFO - 'sessionrestore', 14:37:16 INFO - 'sessionrestore_no_auto_restore', 14:37:16 INFO - 'tabpaint']}, 14:37:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:37:16 INFO - 'ts_paint', 14:37:16 INFO - 'tpaint', 14:37:16 INFO - 'sessionrestore', 14:37:16 INFO - 'sessionrestore_no_auto_restore', 14:37:16 INFO - 'tabpaint']}, 14:37:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['a11yr', 14:37:16 INFO - 'ts_paint', 14:37:16 INFO - 'tpaint', 14:37:16 INFO - 'sessionrestore', 14:37:16 INFO - 'sessionrestore_no_auto_restore', 14:37:16 INFO - 'tabpaint']}, 14:37:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['a11yr', 14:37:16 INFO - 'ts_paint', 14:37:16 INFO - 'tpaint', 14:37:16 INFO - 'sessionrestore', 14:37:16 INFO - 'sessionrestore_no_auto_restore', 14:37:16 INFO - 'tabpaint']}, 14:37:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['tsvgx', 14:37:16 INFO - 'tsvgr_opacity', 14:37:16 INFO - 'tart', 14:37:16 INFO - 'tscrollx', 14:37:16 INFO - 'cart']}, 14:37:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:37:16 INFO - 'tsvgr_opacity', 14:37:16 INFO - 'tart', 14:37:16 INFO - 'tscrollx', 14:37:16 INFO - 'cart']}, 14:37:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:16 INFO - 'talos_options': ['--disable-e10s'], 14:37:16 INFO - 'tests': ['tp5o']}, 14:37:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:16 INFO - 'tests': ['tp5o']}, 14:37:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:16 INFO - 'talos_options': ['--disable-e10s', 14:37:16 INFO - '--xperf_path', 14:37:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:16 INFO - 'tests': ['tp5n']}, 14:37:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:16 INFO - 'talos_options': ['--xperf_path', 14:37:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:16 INFO - 'tests': ['tp5n']}}, 14:37:16 INFO - 'talos.zip': {'path': '', 14:37:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:37:16 INFO - Running post-action listener: _resource_record_post_action 14:37:16 INFO - [mozharness: 2016-10-26 21:37:16.985422Z] Finished populate-webroot step (success) 14:37:16 INFO - [mozharness: 2016-10-26 21:37:16.985509Z] Running create-virtualenv step. 14:37:16 INFO - Running pre-action listener: _resource_record_pre_action 14:37:16 INFO - Running main action method: create_virtualenv 14:37:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:37:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:37:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:37:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:37:17 INFO - Using real prefix '/usr' 14:37:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:37:17 INFO - Installing distribute.............................................................................................................................................................................................done. 14:37:19 INFO - Installing pip.................done. 14:37:19 INFO - Return code: 0 14:37:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:37:19 INFO - Using env: {'DISPLAY': ':0', 14:37:19 INFO - 'HOME': '/home/cltbld', 14:37:19 INFO - 'LANG': 'en_US.UTF-8', 14:37:19 INFO - 'LANGUAGE': 'en_US:en', 14:37:19 INFO - 'LOGNAME': 'cltbld', 14:37:19 INFO - 'MAIL': '/var/mail/cltbld', 14:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:19 INFO - 'MOZ_NO_REMOTE': '1', 14:37:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:19 INFO - 'NO_EM_RESTART': '1', 14:37:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:19 INFO - 'PWD': '/builds/slave/test', 14:37:19 INFO - 'SHELL': '/bin/bash', 14:37:19 INFO - 'SHLVL': '1', 14:37:19 INFO - 'TERM': 'linux', 14:37:19 INFO - 'TMOUT': '86400', 14:37:19 INFO - 'USER': 'cltbld', 14:37:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:19 INFO - '_': '/tools/buildbot/bin/python'} 14:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:37:19 INFO - Cleaning up... 14:37:19 INFO - Return code: 0 14:37:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:37:19 INFO - Using env: {'DISPLAY': ':0', 14:37:19 INFO - 'HOME': '/home/cltbld', 14:37:19 INFO - 'LANG': 'en_US.UTF-8', 14:37:19 INFO - 'LANGUAGE': 'en_US:en', 14:37:19 INFO - 'LOGNAME': 'cltbld', 14:37:19 INFO - 'MAIL': '/var/mail/cltbld', 14:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:19 INFO - 'MOZ_NO_REMOTE': '1', 14:37:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:19 INFO - 'NO_EM_RESTART': '1', 14:37:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:19 INFO - 'PWD': '/builds/slave/test', 14:37:19 INFO - 'SHELL': '/bin/bash', 14:37:19 INFO - 'SHLVL': '1', 14:37:19 INFO - 'TERM': 'linux', 14:37:19 INFO - 'TMOUT': '86400', 14:37:19 INFO - 'USER': 'cltbld', 14:37:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:19 INFO - '_': '/tools/buildbot/bin/python'} 14:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:20 INFO - Downloading/unpacking psutil>=3.1.1 14:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:22 INFO - Installing collected packages: psutil 14:37:22 INFO - Running setup.py install for psutil 14:37:22 INFO - building 'psutil._psutil_linux' extension 14:37:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:37:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:37:22 INFO - building 'psutil._psutil_posix' extension 14:37:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:37:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:22 INFO - Successfully installed psutil 14:37:22 INFO - Cleaning up... 14:37:22 INFO - Return code: 0 14:37:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:37:22 INFO - Using env: {'DISPLAY': ':0', 14:37:22 INFO - 'HOME': '/home/cltbld', 14:37:22 INFO - 'LANG': 'en_US.UTF-8', 14:37:22 INFO - 'LANGUAGE': 'en_US:en', 14:37:22 INFO - 'LOGNAME': 'cltbld', 14:37:22 INFO - 'MAIL': '/var/mail/cltbld', 14:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:22 INFO - 'MOZ_NO_REMOTE': '1', 14:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:22 INFO - 'NO_EM_RESTART': '1', 14:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:22 INFO - 'PWD': '/builds/slave/test', 14:37:22 INFO - 'SHELL': '/bin/bash', 14:37:22 INFO - 'SHLVL': '1', 14:37:22 INFO - 'TERM': 'linux', 14:37:22 INFO - 'TMOUT': '86400', 14:37:22 INFO - 'USER': 'cltbld', 14:37:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:22 INFO - '_': '/tools/buildbot/bin/python'} 14:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:37:25 INFO - Installing collected packages: mozsystemmonitor 14:37:25 INFO - Running setup.py install for mozsystemmonitor 14:37:25 INFO - Successfully installed mozsystemmonitor 14:37:25 INFO - Cleaning up... 14:37:25 INFO - Return code: 0 14:37:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:37:25 INFO - Using env: {'DISPLAY': ':0', 14:37:25 INFO - 'HOME': '/home/cltbld', 14:37:25 INFO - 'LANG': 'en_US.UTF-8', 14:37:25 INFO - 'LANGUAGE': 'en_US:en', 14:37:25 INFO - 'LOGNAME': 'cltbld', 14:37:25 INFO - 'MAIL': '/var/mail/cltbld', 14:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:25 INFO - 'MOZ_NO_REMOTE': '1', 14:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:25 INFO - 'NO_EM_RESTART': '1', 14:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:25 INFO - 'PWD': '/builds/slave/test', 14:37:25 INFO - 'SHELL': '/bin/bash', 14:37:25 INFO - 'SHLVL': '1', 14:37:25 INFO - 'TERM': 'linux', 14:37:25 INFO - 'TMOUT': '86400', 14:37:25 INFO - 'USER': 'cltbld', 14:37:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:25 INFO - '_': '/tools/buildbot/bin/python'} 14:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:37:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:37:27 INFO - warning: no files found matching '*.txt' 14:37:27 INFO - no previously-included directories found matching 'build' 14:37:27 INFO - no previously-included directories found matching 'dist' 14:37:27 INFO - no previously-included directories found matching '.git*' 14:37:27 INFO - Installing collected packages: jsonschema, functools32 14:37:27 INFO - Running setup.py install for functools32 14:37:27 INFO - warning: no files found matching '*.txt' 14:37:27 INFO - no previously-included directories found matching 'build' 14:37:27 INFO - no previously-included directories found matching 'dist' 14:37:27 INFO - no previously-included directories found matching '.git*' 14:37:27 INFO - Successfully installed jsonschema functools32 14:37:27 INFO - Cleaning up... 14:37:27 INFO - Return code: 0 14:37:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:37:27 INFO - Using env: {'DISPLAY': ':0', 14:37:27 INFO - 'HOME': '/home/cltbld', 14:37:27 INFO - 'LANG': 'en_US.UTF-8', 14:37:27 INFO - 'LANGUAGE': 'en_US:en', 14:37:27 INFO - 'LOGNAME': 'cltbld', 14:37:27 INFO - 'MAIL': '/var/mail/cltbld', 14:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:27 INFO - 'MOZ_NO_REMOTE': '1', 14:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:27 INFO - 'NO_EM_RESTART': '1', 14:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:27 INFO - 'PWD': '/builds/slave/test', 14:37:27 INFO - 'SHELL': '/bin/bash', 14:37:27 INFO - 'SHLVL': '1', 14:37:27 INFO - 'TERM': 'linux', 14:37:27 INFO - 'TMOUT': '86400', 14:37:27 INFO - 'USER': 'cltbld', 14:37:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:27 INFO - '_': '/tools/buildbot/bin/python'} 14:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:37:27 INFO - Cleaning up... 14:37:27 INFO - Return code: 0 14:37:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:37:27 INFO - Using env: {'DISPLAY': ':0', 14:37:27 INFO - 'HOME': '/home/cltbld', 14:37:27 INFO - 'LANG': 'en_US.UTF-8', 14:37:27 INFO - 'LANGUAGE': 'en_US:en', 14:37:27 INFO - 'LOGNAME': 'cltbld', 14:37:27 INFO - 'MAIL': '/var/mail/cltbld', 14:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:27 INFO - 'MOZ_NO_REMOTE': '1', 14:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:27 INFO - 'NO_EM_RESTART': '1', 14:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:27 INFO - 'PWD': '/builds/slave/test', 14:37:27 INFO - 'SHELL': '/bin/bash', 14:37:27 INFO - 'SHLVL': '1', 14:37:27 INFO - 'TERM': 'linux', 14:37:27 INFO - 'TMOUT': '86400', 14:37:27 INFO - 'USER': 'cltbld', 14:37:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:27 INFO - '_': '/tools/buildbot/bin/python'} 14:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:37:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:37:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:30 INFO - Downloading docopt-0.6.1.tar.gz 14:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:37:30 INFO - Installing collected packages: blobuploader, requests, docopt 14:37:30 INFO - Running setup.py install for blobuploader 14:37:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:37:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:37:30 INFO - Running setup.py install for requests 14:37:31 INFO - Running setup.py install for docopt 14:37:31 INFO - Successfully installed blobuploader requests docopt 14:37:31 INFO - Cleaning up... 14:37:31 INFO - Return code: 0 14:37:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:31 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 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:37:31 INFO - Using env: {'DISPLAY': ':0', 14:37:31 INFO - 'HOME': '/home/cltbld', 14:37:31 INFO - 'LANG': 'en_US.UTF-8', 14:37:31 INFO - 'LANGUAGE': 'en_US:en', 14:37:31 INFO - 'LOGNAME': 'cltbld', 14:37:31 INFO - 'MAIL': '/var/mail/cltbld', 14:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:31 INFO - 'MOZ_NO_REMOTE': '1', 14:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:31 INFO - 'NO_EM_RESTART': '1', 14:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:31 INFO - 'PWD': '/builds/slave/test', 14:37:31 INFO - 'SHELL': '/bin/bash', 14:37:31 INFO - 'SHLVL': '1', 14:37:31 INFO - 'TERM': 'linux', 14:37:31 INFO - 'TMOUT': '86400', 14:37:31 INFO - 'USER': 'cltbld', 14:37:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:31 INFO - '_': '/tools/buildbot/bin/python'} 14:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:31 INFO - Running setup.py (path:/tmp/pip-_Lh_2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:31 INFO - Running setup.py (path:/tmp/pip-8PjyAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:31 INFO - Running setup.py (path:/tmp/pip-ptnXlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:31 INFO - Running setup.py (path:/tmp/pip-WNQO8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:31 INFO - Running setup.py (path:/tmp/pip-h0vnAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:32 INFO - Running setup.py (path:/tmp/pip-78Z87A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:32 INFO - Running setup.py (path:/tmp/pip-4mjKZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:32 INFO - Running setup.py (path:/tmp/pip-Kl6SUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:32 INFO - Running setup.py (path:/tmp/pip-0ZQQKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:32 INFO - Running setup.py (path:/tmp/pip-9XFgOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:32 INFO - Running setup.py (path:/tmp/pip-ldpyLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:32 INFO - Running setup.py (path:/tmp/pip-g0WYCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:32 INFO - Running setup.py (path:/tmp/pip-M1IQwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:32 INFO - Running setup.py (path:/tmp/pip-UY20Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:32 INFO - Running setup.py (path:/tmp/pip-o_G9ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:32 INFO - Running setup.py (path:/tmp/pip-Pqsu4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:32 INFO - Running setup.py (path:/tmp/pip-Bla3aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:37:32 INFO - Running setup.py install for manifestparser 14:37:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:37:32 INFO - Running setup.py install for mozcrash 14:37:33 INFO - Running setup.py install for mozdebug 14:37:33 INFO - Running setup.py install for mozdevice 14:37:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:37:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:37:33 INFO - Running setup.py install for mozfile 14:37:33 INFO - Running setup.py install for mozhttpd 14:37:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:37:33 INFO - Running setup.py install for mozinfo 14:37:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:37:33 INFO - Running setup.py install for mozInstall 14:37:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:37:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:37:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:37:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:37:33 INFO - Running setup.py install for mozleak 14:37:33 INFO - Running setup.py install for mozlog 14:37:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:37:33 INFO - Running setup.py install for moznetwork 14:37:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:37:34 INFO - Running setup.py install for mozprocess 14:37:34 INFO - Running setup.py install for mozprofile 14:37:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:37:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:37:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:37:34 INFO - Running setup.py install for mozrunner 14:37:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:37:34 INFO - Running setup.py install for mozscreenshot 14:37:34 INFO - Running setup.py install for moztest 14:37:34 INFO - Running setup.py install for mozversion 14:37:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:37:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:37:34 INFO - Cleaning up... 14:37:34 INFO - Return code: 0 14:37:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:34 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 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:37:34 INFO - Using env: {'DISPLAY': ':0', 14:37:34 INFO - 'HOME': '/home/cltbld', 14:37:34 INFO - 'LANG': 'en_US.UTF-8', 14:37:34 INFO - 'LANGUAGE': 'en_US:en', 14:37:34 INFO - 'LOGNAME': 'cltbld', 14:37:34 INFO - 'MAIL': '/var/mail/cltbld', 14:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:34 INFO - 'MOZ_NO_REMOTE': '1', 14:37:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:34 INFO - 'NO_EM_RESTART': '1', 14:37:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:34 INFO - 'PWD': '/builds/slave/test', 14:37:34 INFO - 'SHELL': '/bin/bash', 14:37:34 INFO - 'SHLVL': '1', 14:37:34 INFO - 'TERM': 'linux', 14:37:34 INFO - 'TMOUT': '86400', 14:37:34 INFO - 'USER': 'cltbld', 14:37:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:34 INFO - '_': '/tools/buildbot/bin/python'} 14:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:34 INFO - Running setup.py (path:/tmp/pip-bhj7nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:34 INFO - Running setup.py (path:/tmp/pip-Vt_Fda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:35 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)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:35 INFO - Running setup.py (path:/tmp/pip-KVHTmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:35 INFO - Running setup.py (path:/tmp/pip-mVWkTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:35 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)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:35 INFO - Running setup.py (path:/tmp/pip-cH8vx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:35 INFO - Running setup.py (path:/tmp/pip-9uK5Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:35 INFO - Running setup.py (path:/tmp/pip-WIZ2iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:35 INFO - Running setup.py (path:/tmp/pip-e8Dic1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:35 INFO - Running setup.py (path:/tmp/pip-95DA1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:35 INFO - Running setup.py (path:/tmp/pip-edPAIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:35 INFO - Running setup.py (path:/tmp/pip-KfJ1p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:35 INFO - Running setup.py (path:/tmp/pip-1XIoMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:35 INFO - Running setup.py (path:/tmp/pip-VlO62_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:35 INFO - Running setup.py (path:/tmp/pip-2X13Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:35 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)) 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:35 INFO - Running setup.py (path:/tmp/pip-VyKl1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:36 INFO - Running setup.py (path:/tmp/pip-wpq10d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:36 INFO - Running setup.py (path:/tmp/pip-xZwzjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:37:36 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)) 14:37:36 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)) 14:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:37:36 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)) 14:37:36 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)) 14:37:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:38 INFO - Downloading blessings-1.6.tar.gz 14:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:37:38 INFO - Installing collected packages: blessings 14:37:38 INFO - Running setup.py install for blessings 14:37:38 INFO - Successfully installed blessings 14:37:38 INFO - Cleaning up... 14:37:38 INFO - Return code: 0 14:37:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:37:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:38 INFO - Reading from file tmpfile_stdout 14:37:38 INFO - Current package versions: 14:37:38 INFO - argparse == 1.2.1 14:37:38 INFO - blessings == 1.6 14:37:38 INFO - blobuploader == 1.2.4 14:37:38 INFO - docopt == 0.6.1 14:37:38 INFO - functools32 == 3.2.3-2 14:37:38 INFO - jsonschema == 2.5.1 14:37:38 INFO - manifestparser == 1.1 14:37:38 INFO - mozInstall == 1.12 14:37:38 INFO - mozcrash == 0.17 14:37:38 INFO - mozdebug == 0.1 14:37:38 INFO - mozdevice == 0.48 14:37:38 INFO - mozfile == 1.2 14:37:38 INFO - mozhttpd == 0.7 14:37:38 INFO - mozinfo == 0.9 14:37:38 INFO - mozleak == 0.1 14:37:38 INFO - mozlog == 3.4 14:37:38 INFO - moznetwork == 0.27 14:37:38 INFO - mozprocess == 0.23 14:37:38 INFO - mozprofile == 0.28 14:37:38 INFO - mozrunner == 6.12 14:37:38 INFO - mozscreenshot == 0.1 14:37:38 INFO - mozsystemmonitor == 0.3 14:37:38 INFO - moztest == 0.7 14:37:38 INFO - mozversion == 1.4 14:37:38 INFO - psutil == 3.1.1 14:37:38 INFO - requests == 1.2.3 14:37:38 INFO - wsgiref == 0.1.2 14:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:38 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 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:37:38 INFO - Using env: {'DISPLAY': ':0', 14:37:38 INFO - 'HOME': '/home/cltbld', 14:37:38 INFO - 'LANG': 'en_US.UTF-8', 14:37:38 INFO - 'LANGUAGE': 'en_US:en', 14:37:38 INFO - 'LOGNAME': 'cltbld', 14:37:38 INFO - 'MAIL': '/var/mail/cltbld', 14:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:38 INFO - 'MOZ_NO_REMOTE': '1', 14:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:38 INFO - 'NO_EM_RESTART': '1', 14:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:38 INFO - 'PWD': '/builds/slave/test', 14:37:38 INFO - 'SHELL': '/bin/bash', 14:37:38 INFO - 'SHLVL': '1', 14:37:38 INFO - 'TERM': 'linux', 14:37:38 INFO - 'TMOUT': '86400', 14:37:38 INFO - 'USER': 'cltbld', 14:37:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:38 INFO - '_': '/tools/buildbot/bin/python'} 14:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:37:38 INFO - Cleaning up... 14:37:38 INFO - Return code: 0 14:37:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:38 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 0x7fb6d72ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f92ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:37:38 INFO - Using env: {'DISPLAY': ':0', 14:37:38 INFO - 'HOME': '/home/cltbld', 14:37:38 INFO - 'LANG': 'en_US.UTF-8', 14:37:38 INFO - 'LANGUAGE': 'en_US:en', 14:37:38 INFO - 'LOGNAME': 'cltbld', 14:37:38 INFO - 'MAIL': '/var/mail/cltbld', 14:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:38 INFO - 'MOZ_NO_REMOTE': '1', 14:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:38 INFO - 'NO_EM_RESTART': '1', 14:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:38 INFO - 'PWD': '/builds/slave/test', 14:37:38 INFO - 'SHELL': '/bin/bash', 14:37:38 INFO - 'SHLVL': '1', 14:37:38 INFO - 'TERM': 'linux', 14:37:38 INFO - 'TMOUT': '86400', 14:37:38 INFO - 'USER': 'cltbld', 14:37:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:38 INFO - '_': '/tools/buildbot/bin/python'} 14:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:37:38 INFO - Cleaning up... 14:37:38 INFO - Return code: 0 14:37:38 INFO - Running post-action listener: _resource_record_post_action 14:37:38 INFO - Running post-action listener: _start_resource_monitoring 14:37:39 INFO - Starting resource monitoring. 14:37:39 INFO - [mozharness: 2016-10-26 21:37:39.023607Z] Finished create-virtualenv step (success) 14:37:39 INFO - [mozharness: 2016-10-26 21:37:39.024107Z] Running install step. 14:37:39 INFO - Running pre-action listener: _resource_record_pre_action 14:37:39 INFO - Running main action method: install 14:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:39 INFO - Reading from file tmpfile_stdout 14:37:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:37:39 INFO - Reading from file tmpfile_stdout 14:37:39 INFO - Output received: 14:37:39 INFO - Usage: mozinstall [options] installer 14:37:39 INFO - Options: 14:37:39 INFO - -h, --help show this help message and exit 14:37:39 INFO - -d DEST, --destination=DEST 14:37:39 INFO - Directory to install application into. [default: 14:37:39 INFO - "/builds/slave/test"] 14:37:39 INFO - --app=APP Application being installed. [default: firefox] 14:37:39 INFO - mkdir: /builds/slave/test/build/application 14:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:37:55 INFO - Reading from file tmpfile_stdout 14:37:55 INFO - Output received: 14:37:55 INFO - /builds/slave/test/build/application/firefox/firefox 14:37:55 INFO - Running post-action listener: _resource_record_post_action 14:37:55 INFO - [mozharness: 2016-10-26 21:37:55.282198Z] Finished install step (success) 14:37:55 INFO - [mozharness: 2016-10-26 21:37:55.282444Z] Running run-tests step. 14:37:55 INFO - Running pre-action listener: _resource_record_pre_action 14:37:55 INFO - Running main action method: run_tests 14:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:37:55 INFO - Python 2.7.3 14:37:55 INFO - Return code: 0 14:37:55 INFO - grabbing minidump binary from tooltool 14:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:55 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 0x1f8ff60>, '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 0x1f90d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f911d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:37:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:37:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:37:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:37:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:37:55 INFO - Return code: 0 14:37:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:37:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:37:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:37:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:37:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:37:55 INFO - Using env: {'DISPLAY': ':0', 14:37:55 INFO - 'HOME': '/home/cltbld', 14:37:55 INFO - 'LANG': 'en_US.UTF-8', 14:37:55 INFO - 'LANGUAGE': 'en_US:en', 14:37:55 INFO - 'LOGNAME': 'cltbld', 14:37:55 INFO - 'MAIL': '/var/mail/cltbld', 14:37:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:37:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:55 INFO - 'MOZ_NO_REMOTE': '1', 14:37:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:55 INFO - 'NO_EM_RESTART': '1', 14:37:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:55 INFO - 'PWD': '/builds/slave/test', 14:37:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:37:55 INFO - 'SHELL': '/bin/bash', 14:37:55 INFO - 'SHLVL': '1', 14:37:55 INFO - 'TERM': 'linux', 14:37:55 INFO - 'TMOUT': '86400', 14:37:55 INFO - 'USER': 'cltbld', 14:37:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156', 14:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:55 INFO - '_': '/tools/buildbot/bin/python'} 14:37:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:37:55 INFO - mozversion application_buildid: 20161010141523 14:37:55 INFO - mozversion application_changeset: 6031d730c46ae3b3db353a8d35c99e82117f6479 14:37:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:37:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:37:55 INFO - mozversion application_name: Firefox 14:37:55 INFO - mozversion application_remotingname: firefox-dev 14:37:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:37:55 INFO - mozversion application_vendor: Mozilla 14:37:55 INFO - mozversion application_version: 51.0a2 14:37:55 INFO - mozversion platform_buildid: 20161010141523 14:37:55 INFO - mozversion platform_changeset: 6031d730c46ae3b3db353a8d35c99e82117f6479 14:37:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:37:55 INFO - mozversion platform_version: 51.0a2 14:37:55 INFO - using testdate: 1477517875 14:37:55 INFO - actual date: 1477517875 14:37:55 INFO - starting webserver on 'localhost:54271' 14:37:55 INFO - SUITE-START | Running 2 tests 14:37:55 INFO - TEST-START | dromaeo_css 14:37:55 INFO - operating with platform_type : linux_ 14:37:55 INFO - Initialising browser for dromaeo_css test... 14:37:55 INFO - TEST-INFO | started process 16799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvz70nW/profile http://localhost:54271/getInfo.html) 14:37:59 INFO - PROCESS | 16799 | __metrics Screen width/height:1600/1200 14:37:59 INFO - PROCESS | 16799 | colorDepth:24 14:37:59 INFO - PROCESS | 16799 | Browser inner width/height: 1024/697 14:37:59 INFO - PROCESS | 16799 | __metrics 14:38:00 INFO - PROCESS | 16799 | 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" 14:38:00 INFO - PROCESS | 16799 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:38:00 INFO - PROCESS | 16799 | console.error: PushService: 14:38:00 INFO - PROCESS | 16799 | stateChangeProcessEnqueue: Error transitioning state 14:38:00 INFO - PROCESS | 16799 | UnknownError 14:38:01 INFO - TEST-INFO | 16799: exit 0 14:38:01 INFO - Browser initialized. 14:38:01 INFO - Running cycle 1/1 for dromaeo_css test... 14:38:01 INFO - TEST-INFO | started process 16889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvz70nW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:12 INFO - PROCESS | 16889 | RSS: Main: 144642048 14:38:12 INFO - PROCESS | 16889 | 14:39:03 INFO - PROCESS | 16889 | 1477517943932 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:41:13 INFO - PROCESS | 16889 | Cycle 1(1): loaded http://localhost:54271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54271/tests/dromaeo/cssquery-ext.html) 14:41:14 INFO - PROCESS | 16889 | RSS: Main: 238977024 14:41:14 INFO - PROCESS | 16889 | 14:44:16 INFO - PROCESS | 16889 | Cycle 1(1): loaded http://localhost:54271/tests/dromaeo/cssquery-ext.html (next: http://localhost:54271/tests/dromaeo/cssquery-jquery.html) 14:44:16 INFO - PROCESS | 16889 | RSS: Main: 237756416 14:44:16 INFO - PROCESS | 16889 | 14:47:18 INFO - PROCESS | 16889 | Cycle 1(1): loaded http://localhost:54271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54271/tests/dromaeo/cssquery-mootools.html) 14:47:19 INFO - PROCESS | 16889 | RSS: Main: 176033792 14:47:19 INFO - PROCESS | 16889 | 14:50:21 INFO - PROCESS | 16889 | Cycle 1(1): loaded http://localhost:54271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54271/tests/dromaeo/cssquery-prototype.html) 14:50:22 INFO - PROCESS | 16889 | RSS: Main: 217927680 14:50:22 INFO - PROCESS | 16889 | 14:53:24 INFO - PROCESS | 16889 | Cycle 1(1): loaded http://localhost:54271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54271/tests/dromaeo/cssquery-yui.html) 14:53:25 INFO - PROCESS | 16889 | RSS: Main: 178155520 14:53:25 INFO - PROCESS | 16889 | 14:56:27 INFO - PROCESS | 16889 | Cycle 1(1): loaded http://localhost:54271/tests/dromaeo/cssquery-yui.html (next: http://localhost:54271/tests/dromaeo/cssquery-dojo.html) 14:56:28 INFO - PROCESS | 16889 | RSS: Main: 267571200 14:56:28 INFO - PROCESS | 16889 | 14:56:28 INFO - PROCESS | 16889 | __start_tp_report 14:56:28 INFO - PROCESS | 16889 | _x_x_mozilla_page_load 14:56:28 INFO - PROCESS | 16889 | _x_x_mozilla_page_load_details 14:56:28 INFO - PROCESS | 16889 | |i|pagename|runs| 14:56:28 INFO - PROCESS | 16889 | |0;dojo.html;3135.7177853993135;3186.299014216873;3199.056278397874;3222.8388580570995;3242.8054316740995;5636.239107720457;5685.914711279334;5726.7422965966525;5733.369329373765;5748.109043098321;5601.859953501154;5677.48902598766;5682.403347648499;5690.658560486363;5732.770689172428;5079.085764562386;5104.948950510503;5121.564667003309;5142.228665700138;5196.350456192976;4959.553640172384;5190.740462976855;5191.558717509016;5191.870203244911;5209.531142197202;4977.328060711812;5083.923741143886;5103.821366252182;5148.227765835118;5157.226416037605;5151.587872970172;5190.169572868361;5194.27280180775;5233.555147812441;5248.370195576517;5084.694918304914;5121.82073627425;5204.583633309327;5206.271122042917;5224.660397074178;5419.729013549346;5490.6431081979545;5491.615586908918;5585.078462053756;5597.916031259534;6050.485708714765;6089.756409743605;6136.6011209271255;6144.631322120687;6146.108814221912;6141.048137538689;6144.170536977495;6153.876922461571;6155.569110162291;6158.507319414436;5541.0580201365465;5576.1356989666665;5589.133684278902;5662.462066103713;5665.915011274834;6187.041008643668;6213.96893015532;6214.378562143749;6224.37756224374;6224.782132625427;5960.970195148997;5970.641761494324;5974.551908606872;5983.551233657406;5986.132010858401;5838.2702162229725;5880.735366908414;6018.277806663141;6075.392460753889;6081.209442772411;6088.786892458743;6095.969520152459;6104.969475152596;6113.358097399709;6127.172831667668;6042.093685947143;6110.694465276719;6116.5718399711595;6122.663253521099;6123.08153776937;4487.910241795211;4539.5460453955;4566.566176213254;4583.4041574595085;4674.462436819741;4094.385842123705;4099.344104943195;4111.691623128278;4115.506139263308;4120.793960301973;5733.88532229353;5760;5762.337331206881;5766.250387449605;5776.277965254343;5867.14926335679;5944.316403613553;6054.878902421927;6098.390160983955;6106.145139680449;5771.134329850556;5837.737301821428;5873.030949893306;5878.676672782953;5880.117982302689;5310.123829568155;5310.522053015247;5318.813841515605;5325.627206095536;5329.733513324396;5939.584229103922;6245.313015568284;6340.524460665469;6352.396522330464;6364.64994425311;5824.94175058244;5916.55625828056;5928.614640048383;5935.2877654681715;6006.729697163725;6138.048602466625;6138.693065346804;6144.109104179958;6144.38556144382;6144.600600960924;5863.736131874161;5878.823635290948;5881.029630110984;5883.117532370179;5891.3224979127945;5838.562107842014;5943.881122377615;6019.127226552213;6037.75848966054;6076.361981991828;5989.4310040547825;5992.04127339641;5992.760289588542;5993.460588547052;6000.729967151401;5965.850853728692;5970;5975.521958243417;5986.6707331097205;5986.760529578768;5578.832635020955;5740.942590574041;5769.653820770767;5815.912761308499;5935.376785437467;5964.910526342195;5973.820785376446;5979.4917432018765;5990.820275391745;5991.880162396815;5802.593818432838;5813.186153938536;5840.415958404125;5845.240118784531;5846.152307915243 14:56:28 INFO - PROCESS | 16889 | |1;ext.html;594.8572342637766;603.8762053778976;631.1227393922449;637.2639601260544;644.233362298864;35153;38230.42654360187;38238.23523529531;38249.23501529968;38296.80851595745;38735.61264387355;38969.61030389695;48211.276830847564;49283;49576.752116239455;9239.168474837263;9372.859407108865;9380.24958003358;9383.530823458834;9384;9235.261179105655;9315.76710582234;9334.766630834216;9335.019822918597;9336;8541.743747687548;8807.207351338378;8814.382993190478;9019.45883247004;10883.727906802314;10780;11108.555657773679;11191.496382662799;11198.944005280004;11205.831912521318;11050.613228537042;11129.944350278278;11139.387333696643;11139.944300278528;11140.442977851075;45580.3162952556;45745.77127114376;45896;45898.54101458976;45962.31056534155;3706.4810926470045;3795.582485926546;3821.388577827562;4047.858324958642;4333.263345231318;35027;35243.1189220269;35367.29265414703;35388;35405;4426;4432.135733531963;4468.597826195625;4505.594496495299;4535.863924082283;363996;364003.9999999973;366320;366885;367692;64134;64277.357226427135;64640;64700.67649661721;64748.67625661936;39328;41551.7922410386;41586.1682766343;43337.78331108324;67258.32741672618;19486.5128371789;19648.508787280432;19655.115519801642;19662.410127696192;19666.50833729168;15213.239338033054;15344.079355238722;15345.769813452807;15355.155466449229;15355.462558810388;20662.690059649118;20952.476188095116;20988;21000.36998890036;21086.789132108788;6181.938180618136;7212.3869471094495;7429.331360177502;7460.14208366034;7547.132079810783;827.98344033119;938.6151677812064;1062.321889500618;1090.2858627598935;1150.2006105756586;33836.830815845766;33872.15319617029;33893;34435.96692099241;34455;1135.074913945132;1137.943102844871;1207.836942012817;1247.713026004006;1273.3633183408297;17554;17556.561085972953;17690.469285921186;17714.734278985827;17879.821201787814;554185;568634;571231;816439;818773;59681.403185968455;60094.09858852121;60257.69871150704;60406.697966509884;60445.69777151086;1337.625464869838;1380.7928810678277;1395;1431.8138641976477;1441.1209162410921;33237.16907077342;35002;35091.47362789611;35143.824280878434;35149.47275790916;52451.213231802314;52956.47043529515;53020;53110.203346949056;53210.73394633002;430148;433178;435111;435345;436291;30549.54175687322;31871;32215.194620133745;33746.66253337435;33771.83114084414;51415.74292128516;51514.48485515247;51546;51592;51725.741371292905;43360.783196083816;44384.33423498586;44708.76456177113;44738.55261447344;45803.3129503051;43427.34858977055;44787;45127.32309015433;45389;45742;44229.336559950985;45044.54955450403;45382.54617453915;45521.54478455306;45661.315080274486;35650.28699425945;38663;39104;41969.160616788104;42663.7866810664;29392.706072938996;29805.5529167067;30112.698873011865;30317.242068948453;30541.236469087562 14:56:28 INFO - PROCESS | 16889 | |2;jquery.html;390.4982098004065;434.6742435571508;437.61489888897773;437.71548493479236;448.13286291026867;16973.660526789456;21189.788102118975;21736.673949890745;21879.234226802066;21987.34037978863;20975.685364719542;21001.894990525027;21019.054142563582;21067.57864842702;21158.682619760715;4653.627709783218;5892.558058145635;5951.6429014259065;5976.073708575156;5979.402059794008;5817.12743088538;5841.386654401291;5873.530117590582;5949.464548190662;5950.55370847186;5927.466528012478;5942.078977758432;5956.851078723023;5958.344582095988;5961.701914904259;5668.773249070032;5775.191473193714;5829.038208695561;5949.88100237995;5954.9404505955035;5203.791848326063;5208.973955130238;5215.191645294985;5217.686938783685;5224.73876306187;24429.511409771705;24479.38801529958;24787.380315492257;24930.750692493206;24988;2469.3826543364157;2546.974530254692;2756.641636587251;2810.718928107173;3176.5552822604855;15538.689226215412;15666.138362390064;15694.293756780973;15864.651504622121;16454.177291135395;2030.6547886859269;2071.109422948132;2098.9055492502875;2116.7777383374832;2120.7879212078824;65873.67063164701;66634;66978.3302166977;68363.65818170927;77150.61424692896;11304.547818087349;12099;12221.205621634565;12357.814632780515;12460.81308780369;17244.224009919584;17422.912885435493;17436.564085897953;17460.650786984188;17465.476035718948;8629.784255393666;8685.782855428539;8918.821623567492;9031.232345250728;9177.541122943827;8692.261157801659;9074.86387704185;9095.36332456735;9283.25733941283;9320.394174378644;4983.103041452573;5170.560502357342;5205.115130427836;5308.309919710413;5334.866628334323;1937.2832052140798;2038.6126635939124;2064.1743302678747;2125.9574808503744;2151.634222182233;896.8923729152543;990.5294984882123;1010.7675234695914;1028.861103750999;1060.9098226650667;20268.29060982888;20785.480362991046;20852.582948341253;20954.79045209559;21001.579968400853;1033.850091736709;1043.5043354406596;1047.402980301221;1098.4343063322394;1105.6240878101485;11391.601293954673;11641.941790290994;11699.181057326075;11743.647690569296;11744.882551174378;477432;485268;488188;489311;490685;98302.5084874571;101810;102451;104265;104699.476502617;997.5411310796969;1028.8713910761155;1060.5439660945713;1101.542859713242;1110.5058249079243;19082;19451.61096778085;19605.31381401644;19663.213471460982;19669.901650491654;45982.54017459916;46415.53584464112;47266.76366618145;47512.52487475081;48428.273575895684;64361;64442.677786610766;64881;65359.67320163369;65800.67099664471;6141.140240366263;7953.761387158394;8742.562871856255;8884.689035883714;9291.860622090539;12516.874831251935;14036.438542458187;14098.859011409755;14251.429942802171;14508.782368264274;11659.18385712992;11899.286042837457;11910.940445297718;12112.21270617407;12228.388580571114;11315;11463.369514676773;11718.23831450953;11978.76042479128;12127.393630318273;12018.399080045789;12040.879591203975;12353.752924941271;12422.937885310515;12635;8882.200601945857;8928.10718928102;9209.815803683754;9303.76740581491;9325.207357374698;9195.586198620944;11381.943090284496;11560.768784624428;11579.942100289445;11775 14:56:28 INFO - PROCESS | 16889 | |3;mootools.html;1430.5493769462626;1508.3589474473347;1549.4189678870423;1642.6386195037087;1799.1723807048766;8001.7199398021085;8985.23625491833;9318.347715659907;9343.71968840936;9438.905610943888;9332.62669493221;9335.813283734322;9357.81284374312;9427.434353938768;9464.242860571156;2404.146527982567;2428.963565546518;2431.538007778516;2434.853908765471;2435.695538057743;2412.7104747430335;2430.149447693302;2448.0574978633267;2452.766987136219;2457.213691618683;2421.2494126820743;2434.853908765471;2437.81716371272;2446.706395232575;2466.136852101768;2396.6405039244078;2397.280815755275;2408.759124087595;2410.3251089694827;2433.7931275841574;2375.09746296408;2381.880905954695;2387.928362149138;2390.0559279084664;2393.5930891748444;9124.087591240888;9233.49215793131;9375.671851485233;9393.953030234805;9465;5237.6071794615555;5425.104857698475;5436.320459942507;5436.945630543683;5458;3253.7559683023633;3262.3475304939107;3311.1556553079054;3317.319949410365;3322.8504717287537;1133.3766428464394;1161.6863446869384;1213.2356615332371;1218.256863313378;1240.968975775604;12357;12366.44351004198;12368.567100151542;12418;12461.75076498465;4376.737395756201;4483.237849565517;4597.908041839144;4650.906981860344;4651.209294419957;9772.31593788428;9794.75513112178;9795.51022448889;9974.301798874008;9992.450415227233;5382.515573598316;5396.757145928443;5415.998040362467;5418.051840927901;5423.186522021729;4496.595306422372;4629.86110416688;4935.111679897581;5026.396832380138;5054.646174767805;3957.821898014596;4055.371417430303;4083.060895993938;4145.2124096421585;4161.271777438936;1250.287336218365;1274.2609286613742;1283.2236496919415;1284.0498031456655;1306.8431788185478;981.0924894472585;981.9656312029044;985.3890587835588;1006.1347241372414;1018.4347687033619;5758.769649213985;5872.148538461985;6000.369961154103;6183.443490085824;6259.217597800275;463.66152708522293;465.864899179241;472.4661132919779;480.22923208250256;483.76537379371683;3924.823382947774;4055.8174882130374;4095.651869591118;4194.916101677949;4377.277749171415;11782.646520604396;11863.347515886537;11878.40607969598;11905.940470297593;12018.519259229708;11708.180427370173;11741.647750567497;11754.823677644843;11825.52697892092;11860.406979650983;8648.394612377198;8842.248408885316;8852.955735221283;8866.024737278894;8885.600147993486;6109.358517355614;6179.861950901521;6200.3799620037635;6210.97518909393;6240.375962403723;10455.790884182426;10623.309484883457;10763.246572740147;10771.08445782086;10837.67486975392;10912.672619821418;10916.712410798815;11064.557417703201;11094.445277736242;11237.943810281224;7512.361449276654;7725.845483090419;8141.552214628252;8170.428070035278;8212.46618969765;9020.458772473672;9187.724368268962;9211.355205135576;9255.953720231355;9305.813883722423;8092.878606820785;8161.632726527439;8242.958785206036;8284.544350060805;8399.70601028961;7824.765257042298;7890.053193616803;7953.244441778022;7985.281324680806;8042.839143216986;6611.867762644624;6665.733370665119;6684.498662600227;6687.8328041797395;6746.628935408599;5185.144451165515;5215.947840521546;5241.213817927342;5273.841784746311;5377.166539186433;5133.307003554472;5159.148740457783;5199.844004679866;5240.449752775904;5258.947410525846 14:56:28 INFO - PROCESS | 16889 | |4;prototype.html;335.71464255382926;347.6124121604411;349.68178957149;353.7530206023766;355.79897357992746;5531.612787104904;5553.666779993203;5554.4167862374425;5565.6104072714825;5573.442655734424;5215.4523775003645;5332.866678333044;5336.946630533694;5339.759710813013;5488.313960754906;4154.729942553739;4257.44553268039;4299.26912424887;4355.36847157162;4367.170237654851;4320.243957307474;4327.285997810373;4334.742924551876;4337.306031035035;4359.953611133337;4039.8788036358956;4235;4241;4287.099709061101;4296.355546668009;4220.451341325608;4240.724352917051;4241.406203131564;4258.870564717641;4260.9999999999845;3769.660730534265;3772.3781971529797;3772.9434058489146;3776.6592859535017;3789.810509474515;5230.398504172031;5261.815836445706;5300.840974770763;5339.759710812984;5381.623286369956;4841.080194762983;4860.708357498562;4864.246041863516;4865.6107511399005;4871.464138944713;5641.379448260688;5658.349289831681;5658.943410565883;5711.914321285184;5724.513416359614;3924.822553234047;4083.203775263825;4098.344264917629;4131.29767939451;4147.336426171798;5914.615549989237;5920.881582368328;5928.49607783339;5960.672163031031;5975.820725378246;4241.575842415796;4261.126469073833;4262.381954616563;4290.485141783006;4305.827766889352;4202.85290014848;4326.697131200785;4343.4136391586735;4367.711525100103;4368.104538569585;4877.195262781602;4897.7795999180125;4904.485029071968;4905.9264111038365;4917.901641967141;5752.424757524214;5755.395683453261;5767;5780.855478613068;5784.88430231393;1407.092425385641;1467.9192644404447;1475.697482016184;1480.370842391979;1492.5373134328393;919.3334832246701;925.5048549026238;928.2898582584328;929.6937802387656;935.1764060082866;4826.372571565674;4866.537678920497;4885.58009393426;4893.730844803499;4894.853154405374;5069.352460450368;5083.416191584924;5100.438951715309;5112.4979389117825;5119.564836988823;4553.408056952575;4793.736344501086;4891.608671306287;4939.962607852392;4943.047496239037;2711.4305995741115;2720.7551320380867;2721.1972468121953;2728.01791355112;2741.8629068546893;5191.039657663345;5236.947630523722;5247.239150323258;5270.604704647167;5292.44429334922;5194.415703210557;5218.452062533455;5240.973795131076;5677.886442271214;6086.421789929949;6129.785457508966;6143.815685529441;6149.508039356931;6158.507319414436;6160.44555989963;5881.882362352814;5933.554983376351;5971;6014.158017877413;6016.488598469179;5617.7191140442;5870.295564532284;5871.588988770745;5880.558958078247;5888.411158884077;6059.091136329585;6074.939250607437;6077;6110.541709371726;6111.908321375272;4045;4230.471191101113;4249.681273904408;4290.67819913514;4297.52727200014;5822.94177058224;5844.853878653068;5847.181394604844;5849.8537536560225;5852;5684.9431505684415;5705.4579814917515;5705.629134106436;5734.340550836707;5748.39641837601;5532.5020748132865;5749.712514374348;5750.096201418424;5808.186853840551;5819.15622234782;5725.656460612377;5743.569232307677;5746.339170995222;5746.913796292975;5748.5688573358;5681.176229446624;5818.534517238695;5830.854228644318;5831.1544826000845;5847.970760146172;5621.269234999424;5665.348484924121;5666.744996475251;5679.5172410345585;5689.837861612561 14:56:28 INFO - PROCESS | 16889 | |5;yui.html;812.3014207781304;818.7052661042023;822.8683410654296;863.300726411607;868.0624925080913;14755.631109222275;18012.63974720505;18227.088645567736;18236.088195590233;18237.908810455945;12876.356182190877;12900.419481123348;12998.350082495885;13008.414621342039;13068.21590704556;831.3681601982477;847.9533625650587;852.5864955496579;858.7209157023992;861.0872475176302;866.9176428239307;868;869.3479890082439;870.3950754225816;870.5386145342978;900.1763386501376;905.9954700226523;906.3791302957462;907.541691445819;907.8547432410816;900.7928176519405;902.6569903436717;904.2449554621866;904.3036861616552;904.3850181876321;664.1167247560733;668.6623255256113;668.6857177126743;670.5105273150579;670.8859493886051;15367.231638418034;15483.380664773396;15504.22478876063;15505.457308994131;15514.224288785515;14185.929070354685;14662.926685366505;14910.62723431912;15176.772348414783;16225.83774162255;13917.860821391758;14484.710305793826;14675.339609717481;14706.566899577625;14808.481703140445;4672.766361681936;4704.388429504177;4747.8575642730775;4782.067496838118;4883.926741098886;55421.72289138528;56937;57388;65685.67157164184;86277.56861215716;9612.807743845224;10024.147947424404;12208.694782630506;12548.68628284282;12692.492300307884;22200.11199552032;22213.22253721112;22228;22237;22255.332340029825;8015.559144247122;9201.769955751026;9354.111359420844;9501.667441639509;9806.705798825904;4805.543473370024;5019.924701129486;5083.008813281449;5145.922811157836;5183.067047931333;3452.913677158091;3624.6012938576737;3628.766219485388;3635.4365073413665;3639.4722765199426;557.5873853348573;560.742058653016;561.5199004850793;575.1315513574533;576.4437317988162;662.6521076434814;711.2389742975071;715.6457553511045;715.899774031636;725.372552741885;9755.365901216399;9794.853077203705;10045.849312260321;10326.793464130675;10385.792284154275;651.6122906870404;710.3677726823131;757.1913276220619;762.3634265388463;785.9371250299962;4739.478657347689;4827.734474603931;4844.515548445127;4847.563719265213;4876.195427754452;116108;125276.37361813315;125616;125627.3718631401;126541;104080.47959760153;108211;108717;109976.4501177489;111650;96100;100222;101299.49350253349;101787.49106254421;102568;9055.547222638974;9211.631534738535;9231.953840230755;9264.629414823332;9419.105185007413;56905.99999999834;57892.71053644705;57893.4210657888;58998;61425.69287153536;70530.29469705238;75868;81322;82562.58718706368;83574.5821270914;13153.53962611304;14249.572512824632;14620.488282910048;14923.328450219984;14958.476453324516;14329.362662379674;14967.18816278681;16531.504054878373;16733.33066677368;16909.239084241486;13447.193168409927;13463.528776492776;13482.460701571827;13715.519956801463;13767.449302028208;14896.180710061051;15192.240387980335;15456.536303910902;15596.98619589723;16207.67584648324;13068.8039679403;14121.293935302989;14197.858021419654;14225.928870355581;15416.845831541541;11205.271657342246;11242.156838237328;11876.881231187577;11950.46222919988;12072.637820865388;11189.496472658913;11627.244229125079;12288.436353457397;12536.937315313366;12712.982961363254 14:56:28 INFO - PROCESS | 16889 | __end_tp_report 14:56:28 INFO - PROCESS | 16889 | __start_cc_report 14:56:28 INFO - PROCESS | 16889 | _x_x_mozilla_cycle_collect,918 14:56:28 INFO - PROCESS | 16889 | __end_cc_report 14:56:28 INFO - PROCESS | 16889 | __startTimestamp1477518988154__endTimestamp 14:56:28 INFO - PROCESS | 16889 | 14:56:28 INFO - PROCESS | 16889 | ------- Summary: start ------- 14:56:28 INFO - PROCESS | 16889 | Number of tests: 6 14:56:28 INFO - PROCESS | 16889 | 14:56:28 INFO - PROCESS | 16889 | [#0] dojo.html Cycles:165 Average:5619.15 Median:5845.24 stddev:649.64 (11.1%) stddev-sans-first:621.73 14:56:28 INFO - PROCESS | 16889 | Values: 3135.7 3186.3 3199.1 3222.8 3242.8 5636.2 5685.9 5726.7 5733.4 5748.1 5601.9 5677.5 5682.4 5690.7 5732.8 5079.1 5104.9 5121.6 5142.2 5196.4 4959.6 5190.7 5191.6 5191.9 5209.5 4977.3 5083.9 5103.8 5148.2 5157.2 5151.6 5190.2 5194.3 5233.6 5248.4 5084.7 5121.8 5204.6 5206.3 5224.7 5419.7 5490.6 5491.6 5585.1 5597.9 6050.5 6089.8 6136.6 6144.6 6146.1 6141.0 6144.2 6153.9 6155.6 6158.5 5541.1 5576.1 5589.1 5662.5 5665.9 6187.0 6214.0 6214.4 6224.4 6224.8 5961.0 5970.6 5974.6 5983.6 5986.1 5838.3 5880.7 6018.3 6075.4 6081.2 6088.8 6096.0 6105.0 6113.4 6127.2 6042.1 6110.7 6116.6 6122.7 6123.1 4487.9 4539.5 4566.6 4583.4 4674.5 4094.4 4099.3 4111.7 4115.5 4120.8 5733.9 5760.0 5762.3 5766.3 5776.3 5867.1 5944.3 6054.9 6098.4 6106.1 5771.1 5837.7 5873.0 5878.7 5880.1 5310.1 5310.5 5318.8 5325.6 5329.7 5939.6 6245.3 6340.5 6352.4 6364.6 5824.9 5916.6 5928.6 5935.3 6006.7 6138.0 6138.7 6144.1 6144.4 6144.6 5863.7 5878.8 5881.0 5883.1 5891.3 5838.6 5943.9 6019.1 6037.8 6076.4 5989.4 5992.0 5992.8 5993.5 6000.7 5965.9 5970.0 5975.5 5986.7 5986.8 5578.8 5740.9 5769.7 5815.9 5935.4 5964.9 5973.8 5979.5 5990.8 5991.9 5802.6 5813.2 5840.4 5845.2 5846.2 14:56:28 INFO - PROCESS | 16889 | 14:56:28 INFO - PROCESS | 16889 | [#1] ext.html Cycles:180 Average:65393.55 Median:41777.66 stddev:136108.92 (325.8%) stddev-sans-first:136403.79 14:56:28 INFO - PROCESS | 16889 | Values: 594.9 603.9 631.1 637.3 644.2 35153.0 38230.4 38238.2 38249.2 38296.8 38735.6 38969.6 48211.3 49283.0 49576.8 9239.2 9372.9 9380.2 9383.5 9384.0 9235.3 9315.8 9334.8 9335.0 9336.0 8541.7 8807.2 8814.4 9019.5 10883.7 10780.0 11108.6 11191.5 11198.9 11205.8 11050.6 11129.9 11139.4 11139.9 11140.4 45580.3 45745.8 45896.0 45898.5 45962.3 3706.5 3795.6 3821.4 4047.9 4333.3 35027.0 35243.1 35367.3 35388.0 35405.0 4426.0 4432.1 4468.6 4505.6 4535.9 363996.0 364004.0 366320.0 366885.0 367692.0 64134.0 64277.4 64640.0 64700.7 64748.7 39328.0 41551.8 41586.2 43337.8 67258.3 19486.5 19648.5 19655.1 19662.4 19666.5 15213.2 15344.1 15345.8 15355.2 15355.5 20662.7 20952.5 20988.0 21000.4 21086.8 6181.9 7212.4 7429.3 7460.1 7547.1 828.0 938.6 1062.3 1090.3 1150.2 33836.8 33872.2 33893.0 34436.0 34455.0 1135.1 1137.9 1207.8 1247.7 1273.4 17554.0 17556.6 17690.5 17714.7 17879.8 554185.0 568634.0 571231.0 816439.0 818773.0 59681.4 60094.1 60257.7 60406.7 60445.7 1337.6 1380.8 1395.0 1431.8 1441.1 33237.2 35002.0 35091.5 35143.8 35149.5 52451.2 52956.5 53020.0 53110.2 53210.7 430148.0 433178.0 435111.0 435345.0 436291.0 30549.5 31871.0 32215.2 33746.7 33771.8 51415.7 51514.5 51546.0 51592.0 51725.7 43360.8 44384.3 44708.8 44738.6 45803.3 43427.3 44787.0 45127.3 45389.0 45742.0 44229.3 45044.5 45382.5 45521.5 45661.3 35650.3 38663.0 39104.0 41969.2 42663.8 29392.7 29805.6 30112.7 30317.2 30541.2 14:56:28 INFO - PROCESS | 16889 | 14:56:28 INFO - PROCESS | 16889 | [#2] jquery.html Cycles:180 Average:29829.11 Median:24454.45 stddev:80233.64 (328.1%) stddev-sans-first:80428.27 14:56:28 INFO - PROCESS | 16889 | Values: 390.5 434.7 437.6 437.7 448.1 16973.7 21189.8 21736.7 21879.2 21987.3 20975.7 21001.9 21019.1 21067.6 21158.7 4653.6 5892.6 5951.6 5976.1 5979.4 5817.1 5841.4 5873.5 5949.5 5950.6 5927.5 5942.1 5956.9 5958.3 5961.7 5668.8 5775.2 5829.0 5949.9 5954.9 5203.8 5209.0 5215.2 5217.7 5224.7 24429.5 24479.4 24787.4 24930.8 24988.0 2469.4 2547.0 2756.6 2810.7 3176.6 15538.7 15666.1 15694.3 15864.7 16454.2 2030.7 2071.1 2098.9 2116.8 2120.8 65873.7 66634.0 66978.3 68363.7 77150.6 11304.5 12099.0 12221.2 12357.8 12460.8 17244.2 17422.9 17436.6 17460.7 17465.5 8629.8 8685.8 8918.8 9031.2 9177.5 8692.3 9074.9 9095.4 9283.3 9320.4 4983.1 5170.6 5205.1 5308.3 5334.9 1937.3 2038.6 2064.2 2126.0 2151.6 896.9 990.5 1010.8 1028.9 1060.9 20268.3 20785.5 20852.6 20954.8 21001.6 1033.9 1043.5 1047.4 1098.4 1105.6 11391.6 11641.9 11699.2 11743.6 11744.9 477432.0 485268.0 488188.0 489311.0 490685.0 98302.5 101810.0 102451.0 104265.0 104699.5 997.5 1028.9 1060.5 1101.5 1110.5 19082.0 19451.6 19605.3 19663.2 19669.9 45982.5 46415.5 47266.8 47512.5 48428.3 64361.0 64442.7 64881.0 65359.7 65800.7 6141.1 7953.8 8742.6 8884.7 9291.9 12516.9 14036.4 14098.9 14251.4 14508.8 11659.2 11899.3 11910.9 12112.2 12228.4 11315.0 11463.4 11718.2 11978.8 12127.4 12018.4 12040.9 12353.8 12422.9 12635.0 8882.2 8928.1 9209.8 9303.8 9325.2 9195.6 11381.9 11560.8 11579.9 11775.0 14:56:28 INFO - PROCESS | 16889 | 14:56:28 INFO - PROCESS | 16889 | [#3] mootools.html Cycles:180 Average:6005.19 Median:2561.84 stddev:3502.57 (136.7%) stddev-sans-first:3495.53 14:56:28 INFO - PROCESS | 16889 | Values: 1430.5 1508.4 1549.4 1642.6 1799.2 8001.7 8985.2 9318.3 9343.7 9438.9 9332.6 9335.8 9357.8 9427.4 9464.2 2404.1 2429.0 2431.5 2434.9 2435.7 2412.7 2430.1 2448.1 2452.8 2457.2 2421.2 2434.9 2437.8 2446.7 2466.1 2396.6 2397.3 2408.8 2410.3 2433.8 2375.1 2381.9 2387.9 2390.1 2393.6 9124.1 9233.5 9375.7 9394.0 9465.0 5237.6 5425.1 5436.3 5436.9 5458.0 3253.8 3262.3 3311.2 3317.3 3322.9 1133.4 1161.7 1213.2 1218.3 1241.0 12357.0 12366.4 12368.6 12418.0 12461.8 4376.7 4483.2 4597.9 4650.9 4651.2 9772.3 9794.8 9795.5 9974.3 9992.5 5382.5 5396.8 5416.0 5418.1 5423.2 4496.6 4629.9 4935.1 5026.4 5054.6 3957.8 4055.4 4083.1 4145.2 4161.3 1250.3 1274.3 1283.2 1284.0 1306.8 981.1 982.0 985.4 1006.1 1018.4 5758.8 5872.1 6000.4 6183.4 6259.2 463.7 465.9 472.5 480.2 483.8 3924.8 4055.8 4095.7 4194.9 4377.3 11782.6 11863.3 11878.4 11905.9 12018.5 11708.2 11741.6 11754.8 11825.5 11860.4 8648.4 8842.2 8853.0 8866.0 8885.6 6109.4 6179.9 6200.4 6211.0 6240.4 10455.8 10623.3 10763.2 10771.1 10837.7 10912.7 10916.7 11064.6 11094.4 11237.9 7512.4 7725.8 8141.6 8170.4 8212.5 9020.5 9187.7 9211.4 9256.0 9305.8 8092.9 8161.6 8243.0 8284.5 8399.7 7824.8 7890.1 7953.2 7985.3 8042.8 6611.9 6665.7 6684.5 6687.8 6746.6 5185.1 5215.9 5241.2 5273.8 5377.2 5133.3 5159.1 5199.8 5240.4 5258.9 14:56:28 INFO - PROCESS | 16889 | 14:56:28 INFO - PROCESS | 16889 | [#4] prototype.html Cycles:180 Average:4739.51 Median:5238.96 stddev:1399.20 (26.7%) stddev-sans-first:1363.53 14:56:28 INFO - PROCESS | 16889 | Values: 335.7 347.6 349.7 353.8 355.8 5531.6 5553.7 5554.4 5565.6 5573.4 5215.5 5332.9 5336.9 5339.8 5488.3 4154.7 4257.4 4299.3 4355.4 4367.2 4320.2 4327.3 4334.7 4337.3 4360.0 4039.9 4235.0 4241.0 4287.1 4296.4 4220.5 4240.7 4241.4 4258.9 4261.0 3769.7 3772.4 3772.9 3776.7 3789.8 5230.4 5261.8 5300.8 5339.8 5381.6 4841.1 4860.7 4864.2 4865.6 4871.5 5641.4 5658.3 5658.9 5711.9 5724.5 3924.8 4083.2 4098.3 4131.3 4147.3 5914.6 5920.9 5928.5 5960.7 5975.8 4241.6 4261.1 4262.4 4290.5 4305.8 4202.9 4326.7 4343.4 4367.7 4368.1 4877.2 4897.8 4904.5 4905.9 4917.9 5752.4 5755.4 5767.0 5780.9 5784.9 1407.1 1467.9 1475.7 1480.4 1492.5 919.3 925.5 928.3 929.7 935.2 4826.4 4866.5 4885.6 4893.7 4894.9 5069.4 5083.4 5100.4 5112.5 5119.6 4553.4 4793.7 4891.6 4940.0 4943.0 2711.4 2720.8 2721.2 2728.0 2741.9 5191.0 5236.9 5247.2 5270.6 5292.4 5194.4 5218.5 5241.0 5677.9 6086.4 6129.8 6143.8 6149.5 6158.5 6160.4 5881.9 5933.6 5971.0 6014.2 6016.5 5617.7 5870.3 5871.6 5880.6 5888.4 6059.1 6074.9 6077.0 6110.5 6111.9 4045.0 4230.5 4249.7 4290.7 4297.5 5822.9 5844.9 5847.2 5849.9 5852.0 5684.9 5705.5 5705.6 5734.3 5748.4 5532.5 5749.7 5750.1 5808.2 5819.2 5725.7 5743.6 5746.3 5746.9 5748.6 5681.2 5818.5 5830.9 5831.2 5848.0 5621.3 5665.3 5666.7 5679.5 5689.8 14:56:28 INFO - PROCESS | 16889 | 14:56:28 INFO - PROCESS | 16889 | [#5] yui.html Cycles:180 Average:22073.25 Median:4156.12 stddev:32204.60 (774.9%) stddev-sans-first:32255.38 14:56:28 INFO - PROCESS | 16889 | Values: 812.3 818.7 822.9 863.3 868.1 14755.6 18012.6 18227.1 18236.1 18237.9 12876.4 12900.4 12998.4 13008.4 13068.2 831.4 848.0 852.6 858.7 861.1 866.9 868.0 869.3 870.4 870.5 900.2 906.0 906.4 907.5 907.9 900.8 902.7 904.2 904.3 904.4 664.1 668.7 668.7 670.5 670.9 15367.2 15483.4 15504.2 15505.5 15514.2 14185.9 14662.9 14910.6 15176.8 16225.8 13917.9 14484.7 14675.3 14706.6 14808.5 4672.8 4704.4 4747.9 4782.1 4883.9 55421.7 56937.0 57388.0 65685.7 86277.6 9612.8 10024.1 12208.7 12548.7 12692.5 22200.1 22213.2 22228.0 22237.0 22255.3 8015.6 9201.8 9354.1 9501.7 9806.7 4805.5 5019.9 5083.0 5145.9 5183.1 3452.9 3624.6 3628.8 3635.4 3639.5 557.6 560.7 561.5 575.1 576.4 662.7 711.2 715.6 715.9 725.4 9755.4 9794.9 10045.8 10326.8 10385.8 651.6 710.4 757.2 762.4 785.9 4739.5 4827.7 4844.5 4847.6 4876.2 116108.0 125276.4 125616.0 125627.4 126541.0 104080.5 108211.0 108717.0 109976.5 111650.0 96100.0 100222.0 101299.5 101787.5 102568.0 9055.5 9211.6 9232.0 9264.6 9419.1 56906.0 57892.7 57893.4 58998.0 61425.7 70530.3 75868.0 81322.0 82562.6 83574.6 13153.5 14249.6 14620.5 14923.3 14958.5 14329.4 14967.2 16531.5 16733.3 16909.2 13447.2 13463.5 13482.5 13715.5 13767.4 14896.2 15192.2 15456.5 15597.0 16207.7 13068.8 14121.3 14197.9 14225.9 15416.8 11205.3 11242.2 11876.9 11950.5 12072.6 11189.5 11627.2 12288.4 12536.9 12713.0 14:56:28 INFO - PROCESS | 16889 | -------- Summary: end -------- 14:56:28 INFO - PROCESS | 16889 | 14:56:28 INFO - TEST-INFO | 16889: exit 0 14:56:28 INFO - TEST-OK | dromaeo_css | took 1113288ms 14:56:28 INFO - TEST-START | kraken 14:56:28 INFO - operating with platform_type : linux_ 14:56:28 INFO - Initialising browser for kraken test... 14:56:28 INFO - TEST-INFO | started process 17208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc1Zjui/profile http://localhost:54271/getInfo.html) 14:56:32 INFO - PROCESS | 17208 | __metrics Screen width/height:1600/1200 14:56:32 INFO - PROCESS | 17208 | colorDepth:24 14:56:32 INFO - PROCESS | 17208 | Browser inner width/height: 1024/697 14:56:32 INFO - PROCESS | 17208 | __metrics 14:56:33 INFO - PROCESS | 17208 | 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" 14:56:33 INFO - PROCESS | 17208 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:56:33 INFO - PROCESS | 17208 | console.error: PushService: 14:56:33 INFO - PROCESS | 17208 | stateChangeProcessEnqueue: Error transitioning state 14:56:33 INFO - PROCESS | 17208 | UnknownError 14:56:34 INFO - TEST-INFO | 17208: exit 0 14:56:34 INFO - Browser initialized. 14:56:34 INFO - Running cycle 1/1 for kraken test... 14:56:34 INFO - TEST-INFO | started process 17302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc1Zjui/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:56:46 INFO - PROCESS | 17302 | RSS: Main: 144084992 14:56:46 INFO - PROCESS | 17302 | 14:56:48 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54271/tests/kraken/driver.html?testName=audio-beat-detection) 14:56:49 INFO - PROCESS | 17302 | RSS: Main: 186429440 14:56:49 INFO - PROCESS | 17302 | 14:56:51 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54271/tests/kraken/driver.html?testName=audio-dft) 14:56:52 INFO - PROCESS | 17302 | RSS: Main: 175296512 14:56:52 INFO - PROCESS | 17302 | 14:56:55 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54271/tests/kraken/driver.html?testName=audio-fft) 14:56:55 INFO - PROCESS | 17302 | RSS: Main: 266858496 14:56:55 INFO - PROCESS | 17302 | 14:56:58 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54271/tests/kraken/driver.html?testName=audio-oscillator) 14:56:58 INFO - PROCESS | 17302 | RSS: Main: 173543424 14:56:58 INFO - PROCESS | 17302 | 14:57:00 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:57:01 INFO - PROCESS | 17302 | RSS: Main: 174714880 14:57:01 INFO - PROCESS | 17302 | 14:57:04 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54271/tests/kraken/driver.html?testName=imaging-darkroom) 14:57:04 INFO - PROCESS | 17302 | RSS: Main: 210722816 14:57:04 INFO - PROCESS | 17302 | 14:57:08 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54271/tests/kraken/driver.html?testName=imaging-desaturate) 14:57:08 INFO - PROCESS | 17302 | RSS: Main: 209879040 14:57:08 INFO - PROCESS | 17302 | 14:57:11 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54271/tests/kraken/driver.html?testName=json-parse-financial) 14:57:12 INFO - PROCESS | 17302 | RSS: Main: 209887232 14:57:12 INFO - PROCESS | 17302 | 14:57:13 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:57:14 INFO - PROCESS | 17302 | RSS: Main: 172023808 14:57:14 INFO - PROCESS | 17302 | 14:57:15 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54271/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:57:16 INFO - PROCESS | 17302 | RSS: Main: 178708480 14:57:16 INFO - PROCESS | 17302 | 14:57:18 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:57:19 INFO - PROCESS | 17302 | RSS: Main: 188321792 14:57:19 INFO - PROCESS | 17302 | 14:57:21 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:57:22 INFO - PROCESS | 17302 | RSS: Main: 196780032 14:57:22 INFO - PROCESS | 17302 | 14:57:24 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:57:25 INFO - PROCESS | 17302 | RSS: Main: 193290240 14:57:25 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | Cycle 1(1): loaded http://localhost:54271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54271/tests/kraken/driver.html?testName=ai-astar) 14:57:27 INFO - PROCESS | 17302 | RSS: Main: 245075968 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | __start_tp_report 14:57:27 INFO - PROCESS | 17302 | _x_x_mozilla_page_load 14:57:27 INFO - PROCESS | 17302 | _x_x_mozilla_page_load_details 14:57:27 INFO - PROCESS | 17302 | |i|pagename|runs| 14:57:27 INFO - PROCESS | 17302 | |0;ai-astar;111;113;111;112;112;112;112;113;111;113 14:57:27 INFO - PROCESS | 17302 | |1;audio-beat-detection;142;121;120;162;117;125;117;121;150;120 14:57:27 INFO - PROCESS | 17302 | |2;audio-dft;160;161;161;160;162;161;161;161;159;160 14:57:27 INFO - PROCESS | 17302 | |3;audio-fft;76;75;75;112;77;76;76;77;104;75 14:57:27 INFO - PROCESS | 17302 | |4;audio-oscillator;81;80;115;82;81;82;99;81;81;122 14:57:27 INFO - PROCESS | 17302 | |5;imaging-gaussian-blur;118;118;116;117;116;117;117;117;117;117 14:57:27 INFO - PROCESS | 17302 | |6;imaging-darkroom;148;148;149;148;149;148;149;149;149;146 14:57:27 INFO - PROCESS | 17302 | |7;imaging-desaturate;95;95;94;95;95;95;95;96;96;95 14:57:27 INFO - PROCESS | 17302 | |8;json-parse-financial;51;49;48;49;49;50;48;61;48;50 14:57:27 INFO - PROCESS | 17302 | |9;json-stringify-tinderbox;60;59;61;60;59;59;59;60;61;59 14:57:27 INFO - PROCESS | 17302 | |10;stanford-crypto-aes;73;72;73;75;77;81;72;74;74;73 14:57:27 INFO - PROCESS | 17302 | |11;stanford-crypto-ccm;121;124;120;119;128;126;116;119;158;123 14:57:27 INFO - PROCESS | 17302 | |12;stanford-crypto-pbkdf2;157;153;155;156;153;152;151;162;151;152 14:57:27 INFO - PROCESS | 17302 | |13;stanford-crypto-sha256-iterative;66;65;67;63;62;62;67;61;62;62 14:57:27 INFO - PROCESS | 17302 | __end_tp_report 14:57:27 INFO - PROCESS | 17302 | __start_cc_report 14:57:27 INFO - PROCESS | 17302 | _x_x_mozilla_cycle_collect,1572 14:57:27 INFO - PROCESS | 17302 | __end_cc_report 14:57:27 INFO - PROCESS | 17302 | __startTimestamp1477519047366__endTimestamp 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | ------- Summary: start ------- 14:57:27 INFO - PROCESS | 17302 | Number of tests: 14 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 14:57:27 INFO - PROCESS | 17302 | Values: 111.0 113.0 111.0 112.0 112.0 112.0 112.0 113.0 111.0 113.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:123.00 stddev:15.95 (13.0%) stddev-sans-first:16.27 14:57:27 INFO - PROCESS | 17302 | Values: 142.0 121.0 120.0 162.0 117.0 125.0 117.0 121.0 150.0 120.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 14:57:27 INFO - PROCESS | 17302 | Values: 160.0 161.0 161.0 160.0 162.0 161.0 161.0 161.0 159.0 160.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:13.70 (18.0%) stddev-sans-first:14.34 14:57:27 INFO - PROCESS | 17302 | Values: 76.0 75.0 75.0 112.0 77.0 76.0 76.0 77.0 104.0 75.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:81.00 stddev:15.92 (19.7%) stddev-sans-first:16.52 14:57:27 INFO - PROCESS | 17302 | Values: 81.0 80.0 115.0 82.0 81.0 82.0 99.0 81.0 81.0 122.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 14:57:27 INFO - PROCESS | 17302 | Values: 118.0 118.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:149.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 14:57:27 INFO - PROCESS | 17302 | Values: 148.0 148.0 149.0 148.0 149.0 148.0 149.0 149.0 149.0 146.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:57:27 INFO - PROCESS | 17302 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:49.50 stddev:3.89 (7.9%) stddev-sans-first:4.12 14:57:27 INFO - PROCESS | 17302 | Values: 51.0 49.0 48.0 49.0 49.0 50.0 48.0 61.0 48.0 50.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 14:57:27 INFO - PROCESS | 17302 | Values: 60.0 59.0 61.0 60.0 59.0 59.0 59.0 60.0 61.0 59.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.00 stddev:2.76 (3.7%) stddev-sans-first:2.88 14:57:27 INFO - PROCESS | 17302 | Values: 73.0 72.0 73.0 75.0 77.0 81.0 72.0 74.0 74.0 73.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:123.50 stddev:12.00 (9.7%) stddev-sans-first:12.62 14:57:27 INFO - PROCESS | 17302 | Values: 121.0 124.0 120.0 119.0 128.0 126.0 116.0 119.0 158.0 123.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:154.00 stddev:3.43 (2.2%) stddev-sans-first:3.48 14:57:27 INFO - PROCESS | 17302 | Values: 157.0 153.0 155.0 156.0 153.0 152.0 151.0 162.0 151.0 152.0 14:57:27 INFO - PROCESS | 17302 | 14:57:27 INFO - PROCESS | 17302 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:2.31 (3.6%) stddev-sans-first:2.30 14:57:27 INFO - PROCESS | 17302 | Values: 66.0 65.0 67.0 63.0 62.0 62.0 67.0 61.0 62.0 62.0 14:57:27 INFO - PROCESS | 17302 | -------- Summary: end -------- 14:57:27 INFO - PROCESS | 17302 | 14:57:28 INFO - TEST-INFO | 17302: exit 0 14:57:28 INFO - TEST-OK | kraken | took 59562ms 14:57:28 INFO - SUITE-END | took 1172s 14:57:28 INFO - Completed test suite (00:19:32) 14:57:28 INFO - javascript benchmark 14:57:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.7177853993135, 3186.299014216873, 3199.056278397874, 3222.8388580570995, 3242.8054316740995, 5636.239107720457, 5685.914711279334, 5726.7422965966525, 5733.369329373765, 5748.109043098321, 5601.859953501154, 5677.48902598766, 5682.403347648499, 5690.658560486363, 5732.770689172428, 5079.085764562386, 5104.948950510503, 5121.564667003309, 5142.228665700138, 5196.350456192976, 4959.553640172384, 5190.740462976855, 5191.558717509016, 5191.870203244911, 5209.531142197202, 4977.328060711812, 5083.923741143886, 5103.821366252182, 5148.227765835118, 5157.226416037605, 5151.587872970172, 5190.169572868361, 5194.27280180775, 5233.555147812441, 5248.370195576517, 5084.694918304914, 5121.82073627425, 5204.583633309327, 5206.271122042917, 5224.660397074178, 5419.729013549346, 5490.6431081979545, 5491.615586908918, 5585.078462053756, 5597.916031259534, 6050.485708714765, 6089.756409743605, 6136.6011209271255, 6144.631322120687, 6146.108814221912, 6141.048137538689, 6144.170536977495, 6153.876922461571, 6155.569110162291, 6158.507319414436, 5541.0580201365465, 5576.1356989666665, 5589.133684278902, 5662.462066103713, 5665.915011274834, 6187.041008643668, 6213.96893015532, 6214.378562143749, 6224.37756224374, 6224.782132625427, 5960.970195148997, 5970.641761494324, 5974.551908606872, 5983.551233657406, 5986.132010858401, 5838.2702162229725, 5880.735366908414, 6018.277806663141, 6075.392460753889, 6081.209442772411, 6088.786892458743, 6095.969520152459, 6104.969475152596, 6113.358097399709, 6127.172831667668, 6042.093685947143, 6110.694465276719, 6116.5718399711595, 6122.663253521099, 6123.08153776937, 4487.910241795211, 4539.5460453955, 4566.566176213254, 4583.4041574595085, 4674.462436819741, 4094.385842123705, 4099.344104943195, 4111.691623128278, 4115.506139263308, 4120.793960301973, 5733.88532229353, 5760.0, 5762.337331206881, 5766.250387449605, 5776.277965254343, 5867.14926335679, 5944.316403613553, 6054.878902421927, 6098.390160983955, 6106.145139680449, 5771.134329850556, 5837.737301821428, 5873.030949893306, 5878.676672782953, 5880.117982302689, 5310.123829568155, 5310.522053015247, 5318.813841515605, 5325.627206095536, 5329.733513324396, 5939.584229103922, 6245.313015568284, 6340.524460665469, 6352.396522330464, 6364.64994425311, 5824.94175058244, 5916.55625828056, 5928.614640048383, 5935.2877654681715, 6006.729697163725, 6138.048602466625, 6138.693065346804, 6144.109104179958, 6144.38556144382, 6144.600600960924, 5863.736131874161, 5878.823635290948, 5881.029630110984, 5883.117532370179, 5891.3224979127945, 5838.562107842014, 5943.881122377615, 6019.127226552213, 6037.75848966054, 6076.361981991828, 5989.4310040547825, 5992.04127339641, 5992.760289588542, 5993.460588547052, 6000.729967151401, 5965.850853728692, 5970.0, 5975.521958243417, 5986.6707331097205, 5986.760529578768, 5578.832635020955, 5740.942590574041, 5769.653820770767, 5815.912761308499, 5935.376785437467, 5964.910526342195, 5973.820785376446, 5979.4917432018765, 5990.820275391745, 5991.880162396815, 5802.593818432838, 5813.186153938536, 5840.415958404125, 5845.240118784531, 5846.152307915243], "value": 5573.948717752659, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8572342637766, 603.8762053778976, 631.1227393922449, 637.2639601260544, 644.233362298864, 35153.0, 38230.42654360187, 38238.23523529531, 38249.23501529968, 38296.80851595745, 38735.61264387355, 38969.61030389695, 48211.276830847564, 49283.0, 49576.752116239455, 9239.168474837263, 9372.859407108865, 9380.24958003358, 9383.530823458834, 9384.0, 9235.261179105655, 9315.76710582234, 9334.766630834216, 9335.019822918597, 9336.0, 8541.743747687548, 8807.207351338378, 8814.382993190478, 9019.45883247004, 10883.727906802314, 10780.0, 11108.555657773679, 11191.496382662799, 11198.944005280004, 11205.831912521318, 11050.613228537042, 11129.944350278278, 11139.387333696643, 11139.944300278528, 11140.442977851075, 45580.3162952556, 45745.77127114376, 45896.0, 45898.54101458976, 45962.31056534155, 3706.4810926470045, 3795.582485926546, 3821.388577827562, 4047.858324958642, 4333.263345231318, 35027.0, 35243.1189220269, 35367.29265414703, 35388.0, 35405.0, 4426.0, 4432.135733531963, 4468.597826195625, 4505.594496495299, 4535.863924082283, 363996.0, 364003.9999999973, 366320.0, 366885.0, 367692.0, 64134.0, 64277.357226427135, 64640.0, 64700.67649661721, 64748.67625661936, 39328.0, 41551.7922410386, 41586.1682766343, 43337.78331108324, 67258.32741672618, 19486.5128371789, 19648.508787280432, 19655.115519801642, 19662.410127696192, 19666.50833729168, 15213.239338033054, 15344.079355238722, 15345.769813452807, 15355.155466449229, 15355.462558810388, 20662.690059649118, 20952.476188095116, 20988.0, 21000.36998890036, 21086.789132108788, 6181.938180618136, 7212.3869471094495, 7429.331360177502, 7460.14208366034, 7547.132079810783, 827.98344033119, 938.6151677812064, 1062.321889500618, 1090.2858627598935, 1150.2006105756586, 33836.830815845766, 33872.15319617029, 33893.0, 34435.96692099241, 34455.0, 1135.074913945132, 1137.943102844871, 1207.836942012817, 1247.713026004006, 1273.3633183408297, 17554.0, 17556.561085972953, 17690.469285921186, 17714.734278985827, 17879.821201787814, 554185.0, 568634.0, 571231.0, 816439.0, 818773.0, 59681.403185968455, 60094.09858852121, 60257.69871150704, 60406.697966509884, 60445.69777151086, 1337.625464869838, 1380.7928810678277, 1395.0, 1431.8138641976477, 1441.1209162410921, 33237.16907077342, 35002.0, 35091.47362789611, 35143.824280878434, 35149.47275790916, 52451.213231802314, 52956.47043529515, 53020.0, 53110.203346949056, 53210.73394633002, 430148.0, 433178.0, 435111.0, 435345.0, 436291.0, 30549.54175687322, 31871.0, 32215.194620133745, 33746.66253337435, 33771.83114084414, 51415.74292128516, 51514.48485515247, 51546.0, 51592.0, 51725.741371292905, 43360.783196083816, 44384.33423498586, 44708.76456177113, 44738.55261447344, 45803.3129503051, 43427.34858977055, 44787.0, 45127.32309015433, 45389.0, 45742.0, 44229.336559950985, 45044.54955450403, 45382.54617453915, 45521.54478455306, 45661.315080274486, 35650.28699425945, 38663.0, 39104.0, 41969.160616788104, 42663.7866810664, 29392.706072938996, 29805.5529167067, 30112.698873011865, 30317.242068948453, 30541.236469087562], "value": 21463.127736120277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.4982098004065, 434.6742435571508, 437.61489888897773, 437.71548493479236, 448.13286291026867, 16973.660526789456, 21189.788102118975, 21736.673949890745, 21879.234226802066, 21987.34037978863, 20975.685364719542, 21001.894990525027, 21019.054142563582, 21067.57864842702, 21158.682619760715, 4653.627709783218, 5892.558058145635, 5951.6429014259065, 5976.073708575156, 5979.402059794008, 5817.12743088538, 5841.386654401291, 5873.530117590582, 5949.464548190662, 5950.55370847186, 5927.466528012478, 5942.078977758432, 5956.851078723023, 5958.344582095988, 5961.701914904259, 5668.773249070032, 5775.191473193714, 5829.038208695561, 5949.88100237995, 5954.9404505955035, 5203.791848326063, 5208.973955130238, 5215.191645294985, 5217.686938783685, 5224.73876306187, 24429.511409771705, 24479.38801529958, 24787.380315492257, 24930.750692493206, 24988.0, 2469.3826543364157, 2546.974530254692, 2756.641636587251, 2810.718928107173, 3176.5552822604855, 15538.689226215412, 15666.138362390064, 15694.293756780973, 15864.651504622121, 16454.177291135395, 2030.6547886859269, 2071.109422948132, 2098.9055492502875, 2116.7777383374832, 2120.7879212078824, 65873.67063164701, 66634.0, 66978.3302166977, 68363.65818170927, 77150.61424692896, 11304.547818087349, 12099.0, 12221.205621634565, 12357.814632780515, 12460.81308780369, 17244.224009919584, 17422.912885435493, 17436.564085897953, 17460.650786984188, 17465.476035718948, 8629.784255393666, 8685.782855428539, 8918.821623567492, 9031.232345250728, 9177.541122943827, 8692.261157801659, 9074.86387704185, 9095.36332456735, 9283.25733941283, 9320.394174378644, 4983.103041452573, 5170.560502357342, 5205.115130427836, 5308.309919710413, 5334.866628334323, 1937.2832052140798, 2038.6126635939124, 2064.1743302678747, 2125.9574808503744, 2151.634222182233, 896.8923729152543, 990.5294984882123, 1010.7675234695914, 1028.861103750999, 1060.9098226650667, 20268.29060982888, 20785.480362991046, 20852.582948341253, 20954.79045209559, 21001.579968400853, 1033.850091736709, 1043.5043354406596, 1047.402980301221, 1098.4343063322394, 1105.6240878101485, 11391.601293954673, 11641.941790290994, 11699.181057326075, 11743.647690569296, 11744.882551174378, 477432.0, 485268.0, 488188.0, 489311.0, 490685.0, 98302.5084874571, 101810.0, 102451.0, 104265.0, 104699.476502617, 997.5411310796969, 1028.8713910761155, 1060.5439660945713, 1101.542859713242, 1110.5058249079243, 19082.0, 19451.61096778085, 19605.31381401644, 19663.213471460982, 19669.901650491654, 45982.54017459916, 46415.53584464112, 47266.76366618145, 47512.52487475081, 48428.273575895684, 64361.0, 64442.677786610766, 64881.0, 65359.67320163369, 65800.67099664471, 6141.140240366263, 7953.761387158394, 8742.562871856255, 8884.689035883714, 9291.860622090539, 12516.874831251935, 14036.438542458187, 14098.859011409755, 14251.429942802171, 14508.782368264274, 11659.18385712992, 11899.286042837457, 11910.940445297718, 12112.21270617407, 12228.388580571114, 11315.0, 11463.369514676773, 11718.23831450953, 11978.76042479128, 12127.393630318273, 12018.399080045789, 12040.879591203975, 12353.752924941271, 12422.937885310515, 12635.0, 8882.200601945857, 8928.10718928102, 9209.815803683754, 9303.76740581491, 9325.207357374698, 9195.586198620944, 11381.943090284496, 11560.768784624428, 11579.942100289445, 11775.0], "value": 9820.918122029576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.5493769462626, 1508.3589474473347, 1549.4189678870423, 1642.6386195037087, 1799.1723807048766, 8001.7199398021085, 8985.23625491833, 9318.347715659907, 9343.71968840936, 9438.905610943888, 9332.62669493221, 9335.813283734322, 9357.81284374312, 9427.434353938768, 9464.242860571156, 2404.146527982567, 2428.963565546518, 2431.538007778516, 2434.853908765471, 2435.695538057743, 2412.7104747430335, 2430.149447693302, 2448.0574978633267, 2452.766987136219, 2457.213691618683, 2421.2494126820743, 2434.853908765471, 2437.81716371272, 2446.706395232575, 2466.136852101768, 2396.6405039244078, 2397.280815755275, 2408.759124087595, 2410.3251089694827, 2433.7931275841574, 2375.09746296408, 2381.880905954695, 2387.928362149138, 2390.0559279084664, 2393.5930891748444, 9124.087591240888, 9233.49215793131, 9375.671851485233, 9393.953030234805, 9465.0, 5237.6071794615555, 5425.104857698475, 5436.320459942507, 5436.945630543683, 5458.0, 3253.7559683023633, 3262.3475304939107, 3311.1556553079054, 3317.319949410365, 3322.8504717287537, 1133.3766428464394, 1161.6863446869384, 1213.2356615332371, 1218.256863313378, 1240.968975775604, 12357.0, 12366.44351004198, 12368.567100151542, 12418.0, 12461.75076498465, 4376.737395756201, 4483.237849565517, 4597.908041839144, 4650.906981860344, 4651.209294419957, 9772.31593788428, 9794.75513112178, 9795.51022448889, 9974.301798874008, 9992.450415227233, 5382.515573598316, 5396.757145928443, 5415.998040362467, 5418.051840927901, 5423.186522021729, 4496.595306422372, 4629.86110416688, 4935.111679897581, 5026.396832380138, 5054.646174767805, 3957.821898014596, 4055.371417430303, 4083.060895993938, 4145.2124096421585, 4161.271777438936, 1250.287336218365, 1274.2609286613742, 1283.2236496919415, 1284.0498031456655, 1306.8431788185478, 981.0924894472585, 981.9656312029044, 985.3890587835588, 1006.1347241372414, 1018.4347687033619, 5758.769649213985, 5872.148538461985, 6000.369961154103, 6183.443490085824, 6259.217597800275, 463.66152708522293, 465.864899179241, 472.4661132919779, 480.22923208250256, 483.76537379371683, 3924.823382947774, 4055.8174882130374, 4095.651869591118, 4194.916101677949, 4377.277749171415, 11782.646520604396, 11863.347515886537, 11878.40607969598, 11905.940470297593, 12018.519259229708, 11708.180427370173, 11741.647750567497, 11754.823677644843, 11825.52697892092, 11860.406979650983, 8648.394612377198, 8842.248408885316, 8852.955735221283, 8866.024737278894, 8885.600147993486, 6109.358517355614, 6179.861950901521, 6200.3799620037635, 6210.97518909393, 6240.375962403723, 10455.790884182426, 10623.309484883457, 10763.246572740147, 10771.08445782086, 10837.67486975392, 10912.672619821418, 10916.712410798815, 11064.557417703201, 11094.445277736242, 11237.943810281224, 7512.361449276654, 7725.845483090419, 8141.552214628252, 8170.428070035278, 8212.46618969765, 9020.458772473672, 9187.724368268962, 9211.355205135576, 9255.953720231355, 9305.813883722423, 8092.878606820785, 8161.632726527439, 8242.958785206036, 8284.544350060805, 8399.70601028961, 7824.765257042298, 7890.053193616803, 7953.244441778022, 7985.281324680806, 8042.839143216986, 6611.867762644624, 6665.733370665119, 6684.498662600227, 6687.8328041797395, 6746.628935408599, 5185.144451165515, 5215.947840521546, 5241.213817927342, 5273.841784746311, 5377.166539186433, 5133.307003554472, 5159.148740457783, 5199.844004679866, 5240.449752775904, 5258.947410525846], "value": 4698.237000069828, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.71464255382926, 347.6124121604411, 349.68178957149, 353.7530206023766, 355.79897357992746, 5531.612787104904, 5553.666779993203, 5554.4167862374425, 5565.6104072714825, 5573.442655734424, 5215.4523775003645, 5332.866678333044, 5336.946630533694, 5339.759710813013, 5488.313960754906, 4154.729942553739, 4257.44553268039, 4299.26912424887, 4355.36847157162, 4367.170237654851, 4320.243957307474, 4327.285997810373, 4334.742924551876, 4337.306031035035, 4359.953611133337, 4039.8788036358956, 4235.0, 4241.0, 4287.099709061101, 4296.355546668009, 4220.451341325608, 4240.724352917051, 4241.406203131564, 4258.870564717641, 4260.9999999999845, 3769.660730534265, 3772.3781971529797, 3772.9434058489146, 3776.6592859535017, 3789.810509474515, 5230.398504172031, 5261.815836445706, 5300.840974770763, 5339.759710812984, 5381.623286369956, 4841.080194762983, 4860.708357498562, 4864.246041863516, 4865.6107511399005, 4871.464138944713, 5641.379448260688, 5658.349289831681, 5658.943410565883, 5711.914321285184, 5724.513416359614, 3924.822553234047, 4083.203775263825, 4098.344264917629, 4131.29767939451, 4147.336426171798, 5914.615549989237, 5920.881582368328, 5928.49607783339, 5960.672163031031, 5975.820725378246, 4241.575842415796, 4261.126469073833, 4262.381954616563, 4290.485141783006, 4305.827766889352, 4202.85290014848, 4326.697131200785, 4343.4136391586735, 4367.711525100103, 4368.104538569585, 4877.195262781602, 4897.7795999180125, 4904.485029071968, 4905.9264111038365, 4917.901641967141, 5752.424757524214, 5755.395683453261, 5767.0, 5780.855478613068, 5784.88430231393, 1407.092425385641, 1467.9192644404447, 1475.697482016184, 1480.370842391979, 1492.5373134328393, 919.3334832246701, 925.5048549026238, 928.2898582584328, 929.6937802387656, 935.1764060082866, 4826.372571565674, 4866.537678920497, 4885.58009393426, 4893.730844803499, 4894.853154405374, 5069.352460450368, 5083.416191584924, 5100.438951715309, 5112.4979389117825, 5119.564836988823, 4553.408056952575, 4793.736344501086, 4891.608671306287, 4939.962607852392, 4943.047496239037, 2711.4305995741115, 2720.7551320380867, 2721.1972468121953, 2728.01791355112, 2741.8629068546893, 5191.039657663345, 5236.947630523722, 5247.239150323258, 5270.604704647167, 5292.44429334922, 5194.415703210557, 5218.452062533455, 5240.973795131076, 5677.886442271214, 6086.421789929949, 6129.785457508966, 6143.815685529441, 6149.508039356931, 6158.507319414436, 6160.44555989963, 5881.882362352814, 5933.554983376351, 5971.0, 6014.158017877413, 6016.488598469179, 5617.7191140442, 5870.295564532284, 5871.588988770745, 5880.558958078247, 5888.411158884077, 6059.091136329585, 6074.939250607437, 6077.0, 6110.541709371726, 6111.908321375272, 4045.0, 4230.471191101113, 4249.681273904408, 4290.67819913514, 4297.52727200014, 5822.94177058224, 5844.853878653068, 5847.181394604844, 5849.8537536560225, 5852.0, 5684.9431505684415, 5705.4579814917515, 5705.629134106436, 5734.340550836707, 5748.39641837601, 5532.5020748132865, 5749.712514374348, 5750.096201418424, 5808.186853840551, 5819.15622234782, 5725.656460612377, 5743.569232307677, 5746.339170995222, 5746.913796292975, 5748.5688573358, 5681.176229446624, 5818.534517238695, 5830.854228644318, 5831.1544826000845, 5847.970760146172, 5621.269234999424, 5665.348484924121, 5666.744996475251, 5679.5172410345585, 5689.837861612561], "value": 4294.841977030354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.3014207781304, 818.7052661042023, 822.8683410654296, 863.300726411607, 868.0624925080913, 14755.631109222275, 18012.63974720505, 18227.088645567736, 18236.088195590233, 18237.908810455945, 12876.356182190877, 12900.419481123348, 12998.350082495885, 13008.414621342039, 13068.21590704556, 831.3681601982477, 847.9533625650587, 852.5864955496579, 858.7209157023992, 861.0872475176302, 866.9176428239307, 868.0, 869.3479890082439, 870.3950754225816, 870.5386145342978, 900.1763386501376, 905.9954700226523, 906.3791302957462, 907.541691445819, 907.8547432410816, 900.7928176519405, 902.6569903436717, 904.2449554621866, 904.3036861616552, 904.3850181876321, 664.1167247560733, 668.6623255256113, 668.6857177126743, 670.5105273150579, 670.8859493886051, 15367.231638418034, 15483.380664773396, 15504.22478876063, 15505.457308994131, 15514.224288785515, 14185.929070354685, 14662.926685366505, 14910.62723431912, 15176.772348414783, 16225.83774162255, 13917.860821391758, 14484.710305793826, 14675.339609717481, 14706.566899577625, 14808.481703140445, 4672.766361681936, 4704.388429504177, 4747.8575642730775, 4782.067496838118, 4883.926741098886, 55421.72289138528, 56937.0, 57388.0, 65685.67157164184, 86277.56861215716, 9612.807743845224, 10024.147947424404, 12208.694782630506, 12548.68628284282, 12692.492300307884, 22200.11199552032, 22213.22253721112, 22228.0, 22237.0, 22255.332340029825, 8015.559144247122, 9201.769955751026, 9354.111359420844, 9501.667441639509, 9806.705798825904, 4805.543473370024, 5019.924701129486, 5083.008813281449, 5145.922811157836, 5183.067047931333, 3452.913677158091, 3624.6012938576737, 3628.766219485388, 3635.4365073413665, 3639.4722765199426, 557.5873853348573, 560.742058653016, 561.5199004850793, 575.1315513574533, 576.4437317988162, 662.6521076434814, 711.2389742975071, 715.6457553511045, 715.899774031636, 725.372552741885, 9755.365901216399, 9794.853077203705, 10045.849312260321, 10326.793464130675, 10385.792284154275, 651.6122906870404, 710.3677726823131, 757.1913276220619, 762.3634265388463, 785.9371250299962, 4739.478657347689, 4827.734474603931, 4844.515548445127, 4847.563719265213, 4876.195427754452, 116108.0, 125276.37361813315, 125616.0, 125627.3718631401, 126541.0, 104080.47959760153, 108211.0, 108717.0, 109976.4501177489, 111650.0, 96100.0, 100222.0, 101299.49350253349, 101787.49106254421, 102568.0, 9055.547222638974, 9211.631534738535, 9231.953840230755, 9264.629414823332, 9419.105185007413, 56905.99999999834, 57892.71053644705, 57893.4210657888, 58998.0, 61425.69287153536, 70530.29469705238, 75868.0, 81322.0, 82562.58718706368, 83574.5821270914, 13153.53962611304, 14249.572512824632, 14620.488282910048, 14923.328450219984, 14958.476453324516, 14329.362662379674, 14967.18816278681, 16531.504054878373, 16733.33066677368, 16909.239084241486, 13447.193168409927, 13463.528776492776, 13482.460701571827, 13715.519956801463, 13767.449302028208, 14896.180710061051, 15192.240387980335, 15456.536303910902, 15596.98619589723, 16207.67584648324, 13068.8039679403, 14121.293935302989, 14197.858021419654, 14225.928870355581, 15416.845831541541, 11205.271657342246, 11242.156838237328, 11876.881231187577, 11950.46222919988, 12072.637820865388, 11189.496472658913, 11627.244229125079, 12288.436353457397, 12536.937315313366, 12712.982961363254], "value": 7956.530506375918, "unit": "score"}], "name": "dromaeo_css", "value": 7573.152843909054, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 111.0, 112.0, 112.0, 112.0, 112.0, 113.0, 111.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 121.0, 120.0, 162.0, 117.0, 125.0, 117.0, 121.0, 150.0, 120.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 162.0, 161.0, 161.0, 161.0, 159.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 112.0, 77.0, 76.0, 76.0, 77.0, 104.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 115.0, 82.0, 81.0, 82.0, 99.0, 81.0, 81.0, 122.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 149.0, 148.0, 149.0, 149.0, 149.0, 146.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 48.0, 49.0, 49.0, 50.0, 48.0, 61.0, 48.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 61.0, 60.0, 59.0, 59.0, 59.0, 60.0, 61.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 75.0, 77.0, 81.0, 72.0, 74.0, 74.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 124.0, 120.0, 119.0, 128.0, 126.0, 116.0, 119.0, 158.0, 123.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 155.0, 156.0, 153.0, 152.0, 151.0, 162.0, 151.0, 152.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 63.0, 62.0, 62.0, 67.0, 61.0, 62.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1462.9000000000003, "alertThreshold": 2.0}]} 14:57:28 INFO - Return code: 0 14:57:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:57:28 INFO - # TBPL SUCCESS # 14:57:28 INFO - Running post-action listener: _resource_record_post_action 14:57:28 INFO - [mozharness: 2016-10-26 21:57:28.669378Z] Finished run-tests step (success) 14:57:28 INFO - Running post-run listener: _resource_record_post_run 14:57:28 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 397312; Write bytes: 359235584; Read time: 276; Write time: 215748 14:57:28 INFO - TinderboxPrint: CPU usage
12.9% 14:57:28 INFO - TinderboxPrint: I/O read bytes / time
397,312 / 276 14:57:28 INFO - TinderboxPrint: I/O write bytes / time
359,235,584 / 215,748 14:57:28 INFO - TinderboxPrint: CPU idle
8,259.6 (87.0%) 14:57:28 INFO - TinderboxPrint: CPU user
1,186.4 (12.5%) 14:57:28 INFO - TinderboxPrint: Swap in / out
0 / 0 14:57:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107540480; Read time: 0; Write time: 91932 14:57:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249487360; Read time: 12; Write time: 123668 14:57:29 INFO - Running post-run listener: _upload_blobber_files 14:57:29 INFO - Blob upload gear active. 14:57:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:57:29 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 14:57:29 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:57:29 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:57:29 INFO - (blobuploader) - INFO - Open directory for files ... 14:57:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:57:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:57:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:30 INFO - (blobuploader) - INFO - Done attempting. 14:57:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:57:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:57:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:31 INFO - (blobuploader) - INFO - Done attempting. 14:57:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:57:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:39 INFO - (blobuploader) - INFO - Done attempting. 14:57:39 INFO - (blobuploader) - INFO - Iteration through files over. 14:57:39 INFO - Return code: 0 14:57:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:57:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:57:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c75f9f5fe0659ee1ab417a573ec74e50702a588178a4a9bb9ef1841f1429495b27a649244ec9d39975d4ce9f7052cc6f2f0b6996478bb13f9147ac325f6e8cc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/055e179ff7fa74da86e4effca61f76dde6aa430aaee8c987c0b41200c1bbd29dcbb3f3c5d347a32aff4328b730a0386f4e645d308e88a347b62e5a12d2fb74c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8681e715659bd68f84e5d0c30ea6bf5e91a0d2e0e39560b9bd1a277e4d00b2f92d18697a0409fe5145fb9eb927dbd978d04c78086ea5932effb5c937c9e77126"} 14:57:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:57:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:57:39 INFO - Contents: 14:57:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c75f9f5fe0659ee1ab417a573ec74e50702a588178a4a9bb9ef1841f1429495b27a649244ec9d39975d4ce9f7052cc6f2f0b6996478bb13f9147ac325f6e8cc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/055e179ff7fa74da86e4effca61f76dde6aa430aaee8c987c0b41200c1bbd29dcbb3f3c5d347a32aff4328b730a0386f4e645d308e88a347b62e5a12d2fb74c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8681e715659bd68f84e5d0c30ea6bf5e91a0d2e0e39560b9bd1a277e4d00b2f92d18697a0409fe5145fb9eb927dbd978d04c78086ea5932effb5c937c9e77126"} 14:57:39 INFO - Running post-run listener: copy_logs_to_upload_dir 14:57:39 INFO - Copying logs to upload dir... 14:57:39 INFO - mkdir: /builds/slave/test/build/upload/logs 14:57:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.640745 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-26 14:57:39.328271) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:57:39.331841) ========= 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=bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156 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-Aurora/sha512/c75f9f5fe0659ee1ab417a573ec74e50702a588178a4a9bb9ef1841f1429495b27a649244ec9d39975d4ce9f7052cc6f2f0b6996478bb13f9147ac325f6e8cc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/055e179ff7fa74da86e4effca61f76dde6aa430aaee8c987c0b41200c1bbd29dcbb3f3c5d347a32aff4328b730a0386f4e645d308e88a347b62e5a12d2fb74c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8681e715659bd68f84e5d0c30ea6bf5e91a0d2e0e39560b9bd1a277e4d00b2f92d18697a0409fe5145fb9eb927dbd978d04c78086ea5932effb5c937c9e77126"} build_url:https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/DTaH4zBgRum9MGH9BkXDZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c75f9f5fe0659ee1ab417a573ec74e50702a588178a4a9bb9ef1841f1429495b27a649244ec9d39975d4ce9f7052cc6f2f0b6996478bb13f9147ac325f6e8cc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/055e179ff7fa74da86e4effca61f76dde6aa430aaee8c987c0b41200c1bbd29dcbb3f3c5d347a32aff4328b730a0386f4e645d308e88a347b62e5a12d2fb74c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8681e715659bd68f84e5d0c30ea6bf5e91a0d2e0e39560b9bd1a277e4d00b2f92d18697a0409fe5145fb9eb927dbd978d04c78086ea5932effb5c937c9e77126"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:57:39.357713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:57:39.358084) ========= 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=bb9b54edd4a927dc735d112f000001d9-1477517820.364760-1607439156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:57:39.440265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:57:39.440609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:57:39.440942) ========= ========= Total master_lag: 0.16 =========