builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1492443335.38 results: success (0) revision: d68c89ad6e51a45ebbe260f865852549bb622e46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:35.381944) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:35.382411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:35.382692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:35.397892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:35.398282) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-17 08:35:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-04-17 08:35:36 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137565 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:35.550466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:35.550825) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015074 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:35.600499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 08:35:35.600878) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d68c89ad6e51a45ebbe260f865852549bb622e46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d68c89ad6e51a45ebbe260f865852549bb622e46 --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=516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-17 08:35:36,212 truncating revision to first 12 chars 2017-04-17 08:35:36,212 Setting DEBUG logging. 2017-04-17 08:35:36,212 attempt 1/10 2017-04-17 08:35:36,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d68c89ad6e51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-17 08:35:37,125 unpacking tar archive at: mozilla-aurora-d68c89ad6e51/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289097 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 08:35:36.903310) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:36.903692) ========= script_repo_revision: d68c89ad6e51a45ebbe260f865852549bb622e46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:36.904064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:36.904383) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 08:35:36.915459) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-17 08:35:36.915854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] 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=516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:35:37 INFO - MultiFileLogger online at 20170417 08:35:37 in /builds/slave/test 08:35:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 08:35:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:35:37 INFO - {'append_to_log': False, 08:35:37 INFO - 'base_work_dir': '/builds/slave/test', 08:35:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 08:35:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:35:37 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 08:35:37 INFO - 'buildbot_json_path': 'buildprops.json', 08:35:37 INFO - 'config_files': ('talos/linux_config.py',), 08:35:37 INFO - 'default_actions': ('clobber', 08:35:37 INFO - 'read-buildbot-config', 08:35:37 INFO - 'download-and-extract', 08:35:37 INFO - 'populate-webroot', 08:35:37 INFO - 'create-virtualenv', 08:35:37 INFO - 'install', 08:35:37 INFO - 'run-tests'), 08:35:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:35:37 INFO - 'download_minidump_stackwalk': True, 08:35:37 INFO - 'download_symbols': 'ondemand', 08:35:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:35:37 INFO - 'tooltool.py': '/tools/tooltool.py', 08:35:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:35:37 INFO - '/tools/misc-python/virtualenv.py')}, 08:35:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:35:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:35:37 INFO - 'gecko_profile': False, 08:35:37 INFO - 'gecko_profile_interval': 0, 08:35:37 INFO - 'installer_path': 'installer.exe', 08:35:37 INFO - 'log_level': 'info', 08:35:37 INFO - 'log_name': 'talos', 08:35:37 INFO - 'log_to_console': True, 08:35:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:35:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:35:37 INFO - 'opt_config_files': (), 08:35:37 INFO - 'pip_index': False, 08:35:37 INFO - 'suite': 'dromaeojs', 08:35:37 INFO - 'system_bits': '32', 08:35:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:35:37 INFO - 'title': 'talos-linux64-ix-061', 08:35:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:35:37 INFO - 'use_talos_json': True, 08:35:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:35:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:35:37 INFO - 'work_dir': 'build'} 08:35:37 INFO - [mozharness: 2017-04-17 15:35:37.623016Z] Running clobber step. 08:35:37 INFO - Running pre-action listener: _resource_record_pre_action 08:35:37 INFO - Running main action method: clobber 08:35:37 INFO - rmtree: /builds/slave/test/build 08:35:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:35:38 INFO - Running post-action listener: _resource_record_post_action 08:35:38 INFO - [mozharness: 2017-04-17 15:35:38.633662Z] Finished clobber step (success) 08:35:38 INFO - [mozharness: 2017-04-17 15:35:38.633762Z] Running read-buildbot-config step. 08:35:38 INFO - Running pre-action listener: _resource_record_pre_action 08:35:38 INFO - Running main action method: read_buildbot_config 08:35:38 INFO - Using buildbot properties: 08:35:38 INFO - { 08:35:38 INFO - "project": "", 08:35:38 INFO - "product": "firefox", 08:35:38 INFO - "who": "ryanvm@gmail.com", 08:35:38 INFO - "installer_path": "public/build/target.tar.bz2", 08:35:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:35:38 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:35:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 08:35:38 INFO - "stage_platform": "linux64", 08:35:38 INFO - "basedir": "/builds/slave/test", 08:35:38 INFO - "buildnumber": 131, 08:35:38 INFO - "platform": "ubuntu64_hw", 08:35:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:35:38 INFO - "slavebuilddir": "test", 08:35:38 INFO - "taskId": "Ai27JDrqRCu916Di9PTcJQ", 08:35:38 INFO - "branch": "mozilla-aurora", 08:35:38 INFO - "script_repo_revision": "production", 08:35:38 INFO - "revision": "d68c89ad6e51a45ebbe260f865852549bb622e46", 08:35:38 INFO - "slavename": "talos-linux64-ix-061", 08:35:38 INFO - "repo_path": "releases/mozilla-aurora" 08:35:38 INFO - } 08:35:38 INFO - Finding installer, test and symbols from parent task. 08:35:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ai27JDrqRCu916Di9PTcJQ'}, attempt #1 08:35:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ai27JDrqRCu916Di9PTcJQ'}, attempt #1 08:35:39 INFO - Task dependencies: Md3QxUa9S42b61RsF7TKlQ 08:35:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ'}, attempt #1 08:35:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.tar.bz2 08:35:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/test_packages.json 08:35:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.crashreporter-symbols.zip 08:35:39 INFO - Running post-action listener: _resource_record_post_action 08:35:39 INFO - [mozharness: 2017-04-17 15:35:39.989028Z] Finished read-buildbot-config step (success) 08:35:39 INFO - [mozharness: 2017-04-17 15:35:39.989245Z] Running download-and-extract step. 08:35:39 INFO - Running pre-action listener: _resource_record_pre_action 08:35:39 INFO - Running main action method: download_and_extract 08:35:39 INFO - mkdir: /builds/slave/test/build/tests 08:35:39 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')]} 08:35:39 INFO - trying https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.test_packages.json 08:35:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:35:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:35:40 INFO - Downloaded 896 bytes. 08:35:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:35:40 INFO - Using the following test package requirements: 08:35:40 INFO - {u'common': [u'target.common.tests.zip'], 08:35:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:35:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:35:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:35:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:35:40 INFO - u'mozbase': [u'target.common.tests.zip'], 08:35:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:35:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:35:40 INFO - u'web-platform': [u'target.common.tests.zip', 08:35:40 INFO - u'target.web-platform.tests.zip'], 08:35:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:35:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:35:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.common.tests.zip 08:35:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:35:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.common.tests.zip into memory 08:35:41 INFO - Expected file size: 59540231 08:35:41 INFO - Obtained file size: 59540231 08:35:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:35:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.common.tests.zip 08:35:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:35:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.common.tests.zip into memory 08:35:52 INFO - Expected file size: 59540231 08:35:52 INFO - Obtained file size: 59540231 08:36:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.talos.tests.zip 08:36:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:36:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.talos.tests.zip into memory 08:36:04 INFO - Expected file size: 14404424 08:36:04 INFO - Obtained file size: 14404424 08:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:04 INFO - trying https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.tar.bz2 08:36:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:36:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:36:05 INFO - Downloaded 66724589 bytes. 08:36:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.tar.bz2 08:36:05 INFO - mkdir: /builds/slave/test/properties 08:36:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:36:05 INFO - Writing to file /builds/slave/test/properties/build_url 08:36:05 INFO - Contents: 08:36:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.tar.bz2 08:36:05 INFO - Running post-action listener: _resource_record_post_action 08:36:05 INFO - Running post-action listener: set_extra_try_arguments 08:36:05 INFO - [mozharness: 2017-04-17 15:36:05.987590Z] Finished download-and-extract step (success) 08:36:05 INFO - [mozharness: 2017-04-17 15:36:05.987686Z] Running populate-webroot step. 08:36:05 INFO - Running pre-action listener: _resource_record_pre_action 08:36:05 INFO - Running main action method: populate_webroot 08:36:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:36:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:36:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:36:05 INFO - '--tppagecycles', 08:36:05 INFO - '7'], 08:36:05 INFO - 'tests': ['tsvgm']}}, 08:36:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:36:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:36:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:36:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:36:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:36:05 INFO - 'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:36:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:36:05 INFO - 'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['damp', 'tps']}, 08:36:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:36:05 INFO - 'tests': ['damp', 'tps']}, 08:36:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['dromaeo_dom']}, 08:36:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:36:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['basic_compositor_video']}, 08:36:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:36:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['a11yr', 08:36:05 INFO - 'ts_paint', 08:36:05 INFO - 'tpaint', 08:36:05 INFO - 'sessionrestore', 08:36:05 INFO - 'sessionrestore_no_auto_restore', 08:36:05 INFO - 'tabpaint']}, 08:36:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:36:05 INFO - 'ts_paint', 08:36:05 INFO - 'tpaint', 08:36:05 INFO - 'sessionrestore', 08:36:05 INFO - 'sessionrestore_no_auto_restore', 08:36:05 INFO - 'tabpaint']}, 08:36:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:36:05 INFO - 'ts_paint', 08:36:05 INFO - 'tpaint', 08:36:05 INFO - 'sessionrestore', 08:36:05 INFO - 'sessionrestore_no_auto_restore', 08:36:05 INFO - 'tabpaint']}, 08:36:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:36:05 INFO - 'ts_paint', 08:36:05 INFO - 'tpaint', 08:36:05 INFO - 'sessionrestore', 08:36:05 INFO - 'sessionrestore_no_auto_restore', 08:36:05 INFO - 'tabpaint']}, 08:36:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['a11yr', 08:36:05 INFO - 'ts_paint', 08:36:05 INFO - 'tpaint', 08:36:05 INFO - 'sessionrestore', 08:36:05 INFO - 'sessionrestore_no_auto_restore', 08:36:05 INFO - 'tabpaint']}, 08:36:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['a11yr', 08:36:05 INFO - 'ts_paint', 08:36:05 INFO - 'tpaint', 08:36:05 INFO - 'sessionrestore', 08:36:05 INFO - 'sessionrestore_no_auto_restore', 08:36:05 INFO - 'tabpaint']}, 08:36:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['tsvgx', 08:36:05 INFO - 'tsvgr_opacity', 08:36:05 INFO - 'tart', 08:36:05 INFO - 'tscrollx', 08:36:05 INFO - 'cart', 08:36:05 INFO - 'tsvg_static']}, 08:36:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:36:05 INFO - 'tsvgr_opacity', 08:36:05 INFO - 'tart', 08:36:05 INFO - 'tscrollx', 08:36:05 INFO - 'cart', 08:36:05 INFO - 'tsvg_static']}, 08:36:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:36:05 INFO - 'talos_options': ['--disable-e10s'], 08:36:05 INFO - 'tests': ['tp5o']}, 08:36:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:36:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:36:06 INFO - 'talos_options': ['--disable-e10s', 08:36:06 INFO - '--xperf_path', 08:36:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:06 INFO - 'tests': ['tp5n']}, 08:36:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:36:06 INFO - 'talos_options': ['--xperf_path', 08:36:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:06 INFO - 'tests': ['tp5n']}}, 08:36:06 INFO - 'talos.zip': {'path': '', 08:36:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:36:06 INFO - Running post-action listener: _resource_record_post_action 08:36:06 INFO - [mozharness: 2017-04-17 15:36:06.000828Z] Finished populate-webroot step (success) 08:36:06 INFO - [mozharness: 2017-04-17 15:36:06.000918Z] Running create-virtualenv step. 08:36:06 INFO - Running pre-action listener: _resource_record_pre_action 08:36:06 INFO - Running main action method: create_virtualenv 08:36:06 INFO - Creating virtualenv /builds/slave/test/build/venv 08:36:06 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 08:36:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:36:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:36:06 INFO - Using real prefix '/usr' 08:36:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:36:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:36:08 INFO - Installing pip.................done. 08:36:08 INFO - Return code: 0 08:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:36:08 INFO - Reading from file tmpfile_stdout 08:36:08 INFO - Output received: 08:36:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:36:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:08 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 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:08 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 08:36:08 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 08:36:08 INFO - Using env: {'DISPLAY': ':0', 08:36:08 INFO - 'HOME': '/home/cltbld', 08:36:08 INFO - 'LANG': 'en_US.UTF-8', 08:36:08 INFO - 'LANGUAGE': 'en_US:en', 08:36:08 INFO - 'LOGNAME': 'cltbld', 08:36:08 INFO - 'MAIL': '/var/mail/cltbld', 08:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:08 INFO - 'MOZ_NO_REMOTE': '1', 08:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:08 INFO - 'NO_EM_RESTART': '1', 08:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:08 INFO - 'PWD': '/builds/slave/test', 08:36:08 INFO - 'SHELL': '/bin/bash', 08:36:08 INFO - 'SHLVL': '1', 08:36:08 INFO - 'TERM': 'linux', 08:36:08 INFO - 'TMOUT': '86400', 08:36:08 INFO - 'USER': 'cltbld', 08:36:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:08 INFO - '_': '/tools/buildbot/bin/python'} 08:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:08 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 08:36:08 INFO - Cleaning up... 08:36:09 INFO - Return code: 0 08:36:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:36:09 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')]} 08:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:09 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')]} 08:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:09 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 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:09 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 08:36:09 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 08:36:09 INFO - Using env: {'DISPLAY': ':0', 08:36:09 INFO - 'HOME': '/home/cltbld', 08:36:09 INFO - 'LANG': 'en_US.UTF-8', 08:36:09 INFO - 'LANGUAGE': 'en_US:en', 08:36:09 INFO - 'LOGNAME': 'cltbld', 08:36:09 INFO - 'MAIL': '/var/mail/cltbld', 08:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:09 INFO - 'MOZ_NO_REMOTE': '1', 08:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:09 INFO - 'NO_EM_RESTART': '1', 08:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:09 INFO - 'PWD': '/builds/slave/test', 08:36:09 INFO - 'SHELL': '/bin/bash', 08:36:09 INFO - 'SHLVL': '1', 08:36:09 INFO - 'TERM': 'linux', 08:36:09 INFO - 'TMOUT': '86400', 08:36:09 INFO - 'USER': 'cltbld', 08:36:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:09 INFO - '_': '/tools/buildbot/bin/python'} 08:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:09 INFO - Downloading/unpacking psutil>=3.1.1 08:36:09 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 08:36:09 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 08:36:09 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 08:36:09 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 08:36:09 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 08:36:09 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 08:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:36:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:11 INFO - Installing collected packages: psutil 08:36:11 INFO - Running setup.py install for psutil 08:36:11 INFO - building 'psutil._psutil_linux' extension 08:36:11 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 08:36:11 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 08:36:11 INFO - building 'psutil._psutil_posix' extension 08:36:11 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 08:36:11 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 08:36:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:11 INFO - Successfully installed psutil 08:36:11 INFO - Cleaning up... 08:36:11 INFO - Return code: 0 08:36:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:11 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 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:11 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 08:36:11 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 08:36:11 INFO - Using env: {'DISPLAY': ':0', 08:36:11 INFO - 'HOME': '/home/cltbld', 08:36:11 INFO - 'LANG': 'en_US.UTF-8', 08:36:11 INFO - 'LANGUAGE': 'en_US:en', 08:36:11 INFO - 'LOGNAME': 'cltbld', 08:36:11 INFO - 'MAIL': '/var/mail/cltbld', 08:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:11 INFO - 'MOZ_NO_REMOTE': '1', 08:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:11 INFO - 'NO_EM_RESTART': '1', 08:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:11 INFO - 'PWD': '/builds/slave/test', 08:36:11 INFO - 'SHELL': '/bin/bash', 08:36:11 INFO - 'SHLVL': '1', 08:36:11 INFO - 'TERM': 'linux', 08:36:11 INFO - 'TMOUT': '86400', 08:36:11 INFO - 'USER': 'cltbld', 08:36:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:11 INFO - '_': '/tools/buildbot/bin/python'} 08:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:36:14 INFO - Installing collected packages: mozsystemmonitor 08:36:14 INFO - Running setup.py install for mozsystemmonitor 08:36:14 INFO - Successfully installed mozsystemmonitor 08:36:14 INFO - Cleaning up... 08:36:14 INFO - Return code: 0 08:36:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:36:14 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')]} 08:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:14 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')]} 08:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:14 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 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:14 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 08:36:14 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 08:36:14 INFO - Using env: {'DISPLAY': ':0', 08:36:14 INFO - 'HOME': '/home/cltbld', 08:36:14 INFO - 'LANG': 'en_US.UTF-8', 08:36:14 INFO - 'LANGUAGE': 'en_US:en', 08:36:14 INFO - 'LOGNAME': 'cltbld', 08:36:14 INFO - 'MAIL': '/var/mail/cltbld', 08:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:14 INFO - 'MOZ_NO_REMOTE': '1', 08:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:14 INFO - 'NO_EM_RESTART': '1', 08:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:14 INFO - 'PWD': '/builds/slave/test', 08:36:14 INFO - 'SHELL': '/bin/bash', 08:36:14 INFO - 'SHLVL': '1', 08:36:14 INFO - 'TERM': 'linux', 08:36:14 INFO - 'TMOUT': '86400', 08:36:14 INFO - 'USER': 'cltbld', 08:36:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:14 INFO - '_': '/tools/buildbot/bin/python'} 08:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:14 INFO - Downloading/unpacking jsonschema==2.5.1 08:36:14 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 08:36:14 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 08:36:14 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 08:36:14 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 08:36:14 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 08:36:14 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 08:36:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:36:16 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 08:36:16 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 08:36:16 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 08:36:16 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 08:36:16 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 08:36:16 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 08:36:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:16 INFO - warning: no files found matching '*.txt' 08:36:16 INFO - no previously-included directories found matching 'build' 08:36:16 INFO - no previously-included directories found matching 'dist' 08:36:16 INFO - no previously-included directories found matching '.git*' 08:36:16 INFO - Installing collected packages: jsonschema, functools32 08:36:16 INFO - Running setup.py install for functools32 08:36:16 INFO - warning: no files found matching '*.txt' 08:36:16 INFO - no previously-included directories found matching 'build' 08:36:16 INFO - no previously-included directories found matching 'dist' 08:36:16 INFO - no previously-included directories found matching '.git*' 08:36:17 INFO - Successfully installed jsonschema functools32 08:36:17 INFO - Cleaning up... 08:36:17 INFO - Return code: 0 08:36:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:36:17 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')]} 08:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:17 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')]} 08:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:17 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 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:17 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 08:36:17 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 08:36:17 INFO - Using env: {'DISPLAY': ':0', 08:36:17 INFO - 'HOME': '/home/cltbld', 08:36:17 INFO - 'LANG': 'en_US.UTF-8', 08:36:17 INFO - 'LANGUAGE': 'en_US:en', 08:36:17 INFO - 'LOGNAME': 'cltbld', 08:36:17 INFO - 'MAIL': '/var/mail/cltbld', 08:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:17 INFO - 'MOZ_NO_REMOTE': '1', 08:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:17 INFO - 'NO_EM_RESTART': '1', 08:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:17 INFO - 'PWD': '/builds/slave/test', 08:36:17 INFO - 'SHELL': '/bin/bash', 08:36:17 INFO - 'SHLVL': '1', 08:36:17 INFO - 'TERM': 'linux', 08:36:17 INFO - 'TMOUT': '86400', 08:36:17 INFO - 'USER': 'cltbld', 08:36:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:17 INFO - '_': '/tools/buildbot/bin/python'} 08:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:36:17 INFO - Cleaning up... 08:36:17 INFO - Return code: 0 08:36:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:36:17 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')]} 08:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:17 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')]} 08:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:17 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 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:17 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 08:36:17 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 08:36:17 INFO - Using env: {'DISPLAY': ':0', 08:36:17 INFO - 'HOME': '/home/cltbld', 08:36:17 INFO - 'LANG': 'en_US.UTF-8', 08:36:17 INFO - 'LANGUAGE': 'en_US:en', 08:36:17 INFO - 'LOGNAME': 'cltbld', 08:36:17 INFO - 'MAIL': '/var/mail/cltbld', 08:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:17 INFO - 'MOZ_NO_REMOTE': '1', 08:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:17 INFO - 'NO_EM_RESTART': '1', 08:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:17 INFO - 'PWD': '/builds/slave/test', 08:36:17 INFO - 'SHELL': '/bin/bash', 08:36:17 INFO - 'SHLVL': '1', 08:36:17 INFO - 'TERM': 'linux', 08:36:17 INFO - 'TMOUT': '86400', 08:36:17 INFO - 'USER': 'cltbld', 08:36:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:17 INFO - '_': '/tools/buildbot/bin/python'} 08:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:17 INFO - Downloading/unpacking blobuploader==1.2.4 08:36:17 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 08:36:17 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 08:36:17 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 08:36:17 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 08:36:17 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 08:36:17 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 08:36:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:36:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:20 INFO - Downloading docopt-0.6.1.tar.gz 08:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:20 INFO - Running setup.py install for blobuploader 08:36:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:36:20 INFO - Running setup.py install for requests 08:36:20 INFO - Running setup.py install for docopt 08:36:20 INFO - Successfully installed blobuploader requests docopt 08:36:20 INFO - Cleaning up... 08:36:20 INFO - Return code: 0 08:36:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:20 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')]} 08:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:20 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')]} 08:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:20 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 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:20 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 08:36:20 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 08:36:20 INFO - Using env: {'DISPLAY': ':0', 08:36:21 INFO - 'HOME': '/home/cltbld', 08:36:21 INFO - 'LANG': 'en_US.UTF-8', 08:36:21 INFO - 'LANGUAGE': 'en_US:en', 08:36:21 INFO - 'LOGNAME': 'cltbld', 08:36:21 INFO - 'MAIL': '/var/mail/cltbld', 08:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:21 INFO - 'MOZ_NO_REMOTE': '1', 08:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:21 INFO - 'NO_EM_RESTART': '1', 08:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:21 INFO - 'PWD': '/builds/slave/test', 08:36:21 INFO - 'SHELL': '/bin/bash', 08:36:21 INFO - 'SHLVL': '1', 08:36:21 INFO - 'TERM': 'linux', 08:36:21 INFO - 'TMOUT': '86400', 08:36:21 INFO - 'USER': 'cltbld', 08:36:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:21 INFO - '_': '/tools/buildbot/bin/python'} 08:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:21 INFO - Running setup.py (path:/tmp/pip-T9zvKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:21 INFO - Running setup.py (path:/tmp/pip-GNXb2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:21 INFO - Running setup.py (path:/tmp/pip-m7VLOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:21 INFO - Running setup.py (path:/tmp/pip-hlJtfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:21 INFO - Running setup.py (path:/tmp/pip-5Wt5Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:21 INFO - Running setup.py (path:/tmp/pip-jIXkwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:21 INFO - Running setup.py (path:/tmp/pip-H1qGPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:21 INFO - Running setup.py (path:/tmp/pip-HQCM7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:21 INFO - Running setup.py (path:/tmp/pip-SUmRH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:21 INFO - Running setup.py (path:/tmp/pip-zsk_57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:21 INFO - Running setup.py (path:/tmp/pip-eyyw5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:22 INFO - Running setup.py (path:/tmp/pip-LTEh1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:22 INFO - Running setup.py (path:/tmp/pip-fsbLXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:22 INFO - Running setup.py (path:/tmp/pip-5r6455-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:22 INFO - Running setup.py (path:/tmp/pip-hPgtg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:22 INFO - Running setup.py (path:/tmp/pip-eqPwm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:22 INFO - Running setup.py (path:/tmp/pip-DjH9Bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:22 INFO - Running setup.py install for manifestparser 08:36:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Running setup.py install for mozcrash 08:36:22 INFO - Running setup.py install for mozdebug 08:36:22 INFO - Running setup.py install for mozdevice 08:36:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:36:22 INFO - Running setup.py install for mozfile 08:36:22 INFO - Running setup.py install for mozhttpd 08:36:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for mozinfo 08:36:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for mozInstall 08:36:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for mozleak 08:36:23 INFO - Running setup.py install for mozlog 08:36:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for moznetwork 08:36:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for mozprocess 08:36:23 INFO - Running setup.py install for mozprofile 08:36:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for mozrunner 08:36:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:23 INFO - Running setup.py install for mozscreenshot 08:36:24 INFO - Running setup.py install for moztest 08:36:24 INFO - Running setup.py install for mozversion 08:36:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:24 INFO - Cleaning up... 08:36:24 INFO - Return code: 0 08:36:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:24 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 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:24 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 08:36:24 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 08:36:24 INFO - Using env: {'DISPLAY': ':0', 08:36:24 INFO - 'HOME': '/home/cltbld', 08:36:24 INFO - 'LANG': 'en_US.UTF-8', 08:36:24 INFO - 'LANGUAGE': 'en_US:en', 08:36:24 INFO - 'LOGNAME': 'cltbld', 08:36:24 INFO - 'MAIL': '/var/mail/cltbld', 08:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:24 INFO - 'MOZ_NO_REMOTE': '1', 08:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:24 INFO - 'NO_EM_RESTART': '1', 08:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:24 INFO - 'PWD': '/builds/slave/test', 08:36:24 INFO - 'SHELL': '/bin/bash', 08:36:24 INFO - 'SHLVL': '1', 08:36:24 INFO - 'TERM': 'linux', 08:36:24 INFO - 'TMOUT': '86400', 08:36:24 INFO - 'USER': 'cltbld', 08:36:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:24 INFO - '_': '/tools/buildbot/bin/python'} 08:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:24 INFO - Running setup.py (path:/tmp/pip-r4CbMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:24 INFO - Running setup.py (path:/tmp/pip-2DMiJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:24 INFO - Running setup.py (path:/tmp/pip-vdzWiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:24 INFO - Running setup.py (path:/tmp/pip-B_bU6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:24 INFO - Running setup.py (path:/tmp/pip-O4V371-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:24 INFO - Running setup.py (path:/tmp/pip-9sK5NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:24 INFO - Running setup.py (path:/tmp/pip-02EXGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:24 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)) 08:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:24 INFO - Running setup.py (path:/tmp/pip-i7H_D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:25 INFO - Running setup.py (path:/tmp/pip-axWlXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:25 INFO - Running setup.py (path:/tmp/pip-7n0WFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:25 INFO - Running setup.py (path:/tmp/pip-mVxAo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:25 INFO - Running setup.py (path:/tmp/pip-xx9RAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:25 INFO - Running setup.py (path:/tmp/pip-WDcPWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:25 INFO - Running setup.py (path:/tmp/pip-P2Ew79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:25 INFO - Running setup.py (path:/tmp/pip-Ph6H27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:25 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:25 INFO - Running setup.py (path:/tmp/pip-kT_tsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:25 INFO - Running setup.py (path:/tmp/pip-IJz_0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:25 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)) 08:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:36:25 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)) 08:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:36:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:27 INFO - Downloading blessings-1.6.tar.gz 08:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:27 INFO - Installing collected packages: blessings 08:36:27 INFO - Running setup.py install for blessings 08:36:27 INFO - Successfully installed blessings 08:36:27 INFO - Cleaning up... 08:36:27 INFO - Return code: 0 08:36:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:28 INFO - Reading from file tmpfile_stdout 08:36:28 INFO - Current package versions: 08:36:28 INFO - argparse == 1.2.1 08:36:28 INFO - blessings == 1.6 08:36:28 INFO - blobuploader == 1.2.4 08:36:28 INFO - docopt == 0.6.1 08:36:28 INFO - functools32 == 3.2.3-2 08:36:28 INFO - jsonschema == 2.5.1 08:36:28 INFO - manifestparser == 1.1 08:36:28 INFO - mozInstall == 1.12 08:36:28 INFO - mozcrash == 1.0 08:36:28 INFO - mozdebug == 0.1 08:36:28 INFO - mozdevice == 0.49 08:36:28 INFO - mozfile == 1.2 08:36:28 INFO - mozhttpd == 0.7 08:36:28 INFO - mozinfo == 0.9 08:36:28 INFO - mozleak == 0.1 08:36:28 INFO - mozlog == 3.4 08:36:28 INFO - moznetwork == 0.27 08:36:28 INFO - mozprocess == 0.25 08:36:28 INFO - mozprofile == 0.28 08:36:28 INFO - mozrunner == 6.13 08:36:28 INFO - mozscreenshot == 0.1 08:36:28 INFO - mozsystemmonitor == 0.3 08:36:28 INFO - moztest == 0.8 08:36:28 INFO - mozversion == 1.4 08:36:28 INFO - psutil == 3.1.1 08:36:28 INFO - requests == 1.2.3 08:36:28 INFO - wsgiref == 0.1.2 08:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:28 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 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:28 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 08:36:28 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 08:36:28 INFO - Using env: {'DISPLAY': ':0', 08:36:28 INFO - 'HOME': '/home/cltbld', 08:36:28 INFO - 'LANG': 'en_US.UTF-8', 08:36:28 INFO - 'LANGUAGE': 'en_US:en', 08:36:28 INFO - 'LOGNAME': 'cltbld', 08:36:28 INFO - 'MAIL': '/var/mail/cltbld', 08:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:28 INFO - 'MOZ_NO_REMOTE': '1', 08:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:28 INFO - 'NO_EM_RESTART': '1', 08:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:28 INFO - 'PWD': '/builds/slave/test', 08:36:28 INFO - 'SHELL': '/bin/bash', 08:36:28 INFO - 'SHLVL': '1', 08:36:28 INFO - 'TERM': 'linux', 08:36:28 INFO - 'TMOUT': '86400', 08:36:28 INFO - 'USER': 'cltbld', 08:36:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:28 INFO - '_': '/tools/buildbot/bin/python'} 08:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:28 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)) 08:36:28 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)) 08:36:28 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)) 08:36:28 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)) 08:36:28 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)) 08:36:28 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)) 08:36:28 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)) 08:36:28 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)) 08:36:28 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)) 08:36:28 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)) 08:36:28 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)) 08:36:28 INFO - Cleaning up... 08:36:28 INFO - Return code: 0 08:36:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e88310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', '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 08:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:36:28 INFO - Using env: {'DISPLAY': ':0', 08:36:28 INFO - 'HOME': '/home/cltbld', 08:36:28 INFO - 'LANG': 'en_US.UTF-8', 08:36:28 INFO - 'LANGUAGE': 'en_US:en', 08:36:28 INFO - 'LOGNAME': 'cltbld', 08:36:28 INFO - 'MAIL': '/var/mail/cltbld', 08:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:28 INFO - 'MOZ_NO_REMOTE': '1', 08:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:28 INFO - 'NO_EM_RESTART': '1', 08:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:28 INFO - 'PWD': '/builds/slave/test', 08:36:28 INFO - 'SHELL': '/bin/bash', 08:36:28 INFO - 'SHLVL': '1', 08:36:28 INFO - 'TERM': 'linux', 08:36:28 INFO - 'TMOUT': '86400', 08:36:28 INFO - 'USER': 'cltbld', 08:36:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:28 INFO - '_': '/tools/buildbot/bin/python'} 08:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:36:28 INFO - Cleaning up... 08:36:28 INFO - Return code: 0 08:36:28 INFO - Running post-action listener: _resource_record_post_action 08:36:28 INFO - Running post-action listener: _start_resource_monitoring 08:36:28 INFO - Starting resource monitoring. 08:36:28 INFO - [mozharness: 2017-04-17 15:36:28.694985Z] Finished create-virtualenv step (success) 08:36:28 INFO - [mozharness: 2017-04-17 15:36:28.695496Z] Running install step. 08:36:28 INFO - Running pre-action listener: _resource_record_pre_action 08:36:28 INFO - Running main action method: install 08:36:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:28 INFO - Reading from file tmpfile_stdout 08:36:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:36:28 INFO - Reading from file tmpfile_stdout 08:36:28 INFO - Output received: 08:36:28 INFO - Usage: mozinstall [options] installer 08:36:28 INFO - Options: 08:36:28 INFO - -h, --help show this help message and exit 08:36:28 INFO - -d DEST, --destination=DEST 08:36:28 INFO - Directory to install application into. [default: 08:36:28 INFO - "/builds/slave/test"] 08:36:28 INFO - --app=APP Application being installed. [default: firefox] 08:36:28 INFO - mkdir: /builds/slave/test/build/application 08:36:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:36:45 INFO - Reading from file tmpfile_stdout 08:36:45 INFO - Output received: 08:36:45 INFO - /builds/slave/test/build/application/firefox/firefox 08:36:45 INFO - Running post-action listener: _resource_record_post_action 08:36:45 INFO - [mozharness: 2017-04-17 15:36:45.578561Z] Finished install step (success) 08:36:45 INFO - [mozharness: 2017-04-17 15:36:45.578837Z] Running run-tests step. 08:36:45 INFO - Running pre-action listener: _resource_record_pre_action 08:36:45 INFO - Running main action method: run_tests 08:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:36:45 INFO - Python 2.7.3 08:36:45 INFO - Return code: 0 08:36:45 INFO - grabbing minidump binary from tooltool 08:36:45 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')]} 08:36:45 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 0x1e85400>, '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 0x1e863b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e86840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:36:45 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 08:36:45 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 08:36:45 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 08:36:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:45 INFO - Return code: 0 08:36:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:36:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:36:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:36:45 INFO - ENV: RUST_BACKTRACE is now 1 08:36:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:36:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 08:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 08:36:45 INFO - Using env: {'DISPLAY': ':0', 08:36:45 INFO - 'HOME': '/home/cltbld', 08:36:45 INFO - 'LANG': 'en_US.UTF-8', 08:36:45 INFO - 'LANGUAGE': 'en_US:en', 08:36:45 INFO - 'LOGNAME': 'cltbld', 08:36:45 INFO - 'MAIL': '/var/mail/cltbld', 08:36:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:45 INFO - 'MOZ_NO_REMOTE': '1', 08:36:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:45 INFO - 'NO_EM_RESTART': '1', 08:36:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:45 INFO - 'PWD': '/builds/slave/test', 08:36:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:45 INFO - 'RUST_BACKTRACE': '1', 08:36:45 INFO - 'SHELL': '/bin/bash', 08:36:45 INFO - 'SHLVL': '1', 08:36:45 INFO - 'TERM': 'linux', 08:36:45 INFO - 'TMOUT': '86400', 08:36:45 INFO - 'USER': 'cltbld', 08:36:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977', 08:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:45 INFO - '_': '/tools/buildbot/bin/python'} 08:36:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 08:36:45 INFO - mozversion application_buildid: 20170417143933 08:36:45 INFO - mozversion application_changeset: d68c89ad6e51a45ebbe260f865852549bb622e46 08:36:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:36:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:45 INFO - mozversion application_name: Firefox 08:36:45 INFO - mozversion application_remotingname: firefox-dev 08:36:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:36:45 INFO - mozversion application_vendor: Mozilla 08:36:45 INFO - mozversion application_version: 54.0a2 08:36:45 INFO - mozversion platform_buildid: 20170417143933 08:36:45 INFO - mozversion platform_changeset: d68c89ad6e51a45ebbe260f865852549bb622e46 08:36:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:36:45 INFO - mozversion platform_version: 54.0a2 08:36:45 INFO - using testdate: 1492443405 08:36:45 INFO - actual date: 1492443405 08:36:45 INFO - starting webserver on 'localhost:36927' 08:36:45 INFO - SUITE-START | Running 2 tests 08:36:45 INFO - TEST-START | dromaeo_css 08:36:45 INFO - operating with platform_type : linux_ 08:36:45 INFO - Initialising browser for dromaeo_css test... 08:36:45 INFO - TEST-INFO | started process 22066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8okv6h/profile http://localhost:36927/getInfo.html) 08:36:50 INFO - PROCESS | 22066 | __metrics Screen width/height:1600/1200 08:36:50 INFO - PROCESS | 22066 | colorDepth:24 08:36:50 INFO - PROCESS | 22066 | Browser inner width/height: 1024/697 08:36:50 INFO - PROCESS | 22066 | __metrics 08:36:51 INFO - PROCESS | 22066 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:36:51 INFO - PROCESS | 22066 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:36:51 INFO - PROCESS | 22066 | console.error: PushService: 08:36:51 INFO - PROCESS | 22066 | stateChangeProcessEnqueue: Error transitioning state 08:36:51 INFO - PROCESS | 22066 | UnknownError 08:36:52 INFO - TEST-INFO | 22066: exit 0 08:36:52 INFO - Browser initialized. 08:36:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:36:52 INFO - TEST-INFO | started process 22161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8okv6h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:04 INFO - PROCESS | 22161 | RSS: Main: 139857920 08:37:04 INFO - PROCESS | 22161 | 08:40:05 INFO - PROCESS | 22161 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36927/tests/dromaeo/cssquery-ext.html) 08:40:06 INFO - PROCESS | 22161 | RSS: Main: 232026112 08:40:06 INFO - PROCESS | 22161 | 08:41:54 INFO - PROCESS | 22161 | ************************* 08:41:54 INFO - PROCESS | 22161 | A coding exception was thrown and uncaught in a Task. 08:41:54 INFO - PROCESS | 22161 | 08:41:54 ERROR - PROCESS | 22161 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:41:54 INFO - PROCESS | 22161 | Full stack: 08:41:54 INFO - PROCESS | 22161 | ************************* 08:41:54 INFO - PROCESS | 22161 | ************************* 08:41:54 INFO - PROCESS | 22161 | A coding exception was thrown and uncaught in a Task. 08:41:54 INFO - PROCESS | 22161 | 08:41:54 ERROR - PROCESS | 22161 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:41:54 INFO - PROCESS | 22161 | Full stack: 08:41:54 INFO - PROCESS | 22161 | ************************* 08:41:54 INFO - PROCESS | 22161 | ************************* 08:41:54 INFO - PROCESS | 22161 | A coding exception was thrown and uncaught in a Task. 08:41:54 INFO - PROCESS | 22161 | 08:41:54 ERROR - PROCESS | 22161 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:41:54 INFO - PROCESS | 22161 | Full stack: 08:41:54 INFO - PROCESS | 22161 | ************************* 08:41:54 INFO - PROCESS | 22161 | ************************* 08:41:54 INFO - PROCESS | 22161 | A coding exception was thrown and uncaught in a Task. 08:41:54 INFO - PROCESS | 22161 | 08:41:54 ERROR - PROCESS | 22161 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:41:54 INFO - PROCESS | 22161 | Full stack: 08:41:54 INFO - PROCESS | 22161 | ************************* 08:43:08 INFO - PROCESS | 22161 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-ext.html (next: http://localhost:36927/tests/dromaeo/cssquery-jquery.html) 08:43:09 INFO - PROCESS | 22161 | RSS: Main: 222998528 08:43:09 INFO - PROCESS | 22161 | 08:46:11 INFO - PROCESS | 22161 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36927/tests/dromaeo/cssquery-mootools.html) 08:46:12 INFO - PROCESS | 22161 | RSS: Main: 170074112 08:46:12 INFO - PROCESS | 22161 | 08:49:13 INFO - PROCESS | 22161 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36927/tests/dromaeo/cssquery-prototype.html) 08:49:14 INFO - PROCESS | 22161 | RSS: Main: 170242048 08:49:14 INFO - PROCESS | 22161 | 08:52:17 INFO - PROCESS | 22161 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36927/tests/dromaeo/cssquery-yui.html) 08:52:17 INFO - PROCESS | 22161 | RSS: Main: 177963008 08:52:17 INFO - PROCESS | 22161 | 08:55:20 INFO - PROCESS | 22161 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-yui.html (next: http://localhost:36927/tests/dromaeo/cssquery-dojo.html) 08:55:20 INFO - PROCESS | 22161 | RSS: Main: 268361728 08:55:20 INFO - PROCESS | 22161 | 08:55:20 INFO - PROCESS | 22161 | __start_tp_report 08:55:20 INFO - PROCESS | 22161 | _x_x_mozilla_page_load 08:55:20 INFO - PROCESS | 22161 | _x_x_mozilla_page_load_details 08:55:20 INFO - PROCESS | 22161 | |i|pagename|runs| 08:55:20 INFO - PROCESS | 22161 | |0;dojo.html;3311.7185039271662;3364.8485818138174;3385.1706331948676;3406.2506248625295;3439.8452069656864;5609.186667933152;5633.887322253563;5644.887102257958;5647.29408823897;5660.915086273709;5689.886202275952;5777.364489906107;5801.680907550083;5811.418858114186;5813.040848260042;5253.737313134328;5262.394824595172;5263.210518422229;5304.496072873071;5341.599380046493;4951.727654978975;4975.751212439382;5329.866753331159;5351.197320401932;5351.277577527042;5185.844424667266;5206.45332240115;5213.165893457048;5216.191490319006;5232.581393488512;5288.497592728723;5299.788008479656;5304.496072873071;5311.309529761106;5317.042932272189;5036.219385995177;5145.382554093495;5217;5255.264263003182;5259.605529585297;5468.851541176357;5604.887902241973;5613.46672066153;5650.378458369576;5678.659280443187;6114.082887566856;6146.0473626587955;6163.599366041193;6166.290876549209;6168.629882207082;6201.0388389799655;6201.16284301618;6212.844678883019;6214.65819379934;6222.253329600477;5468.890622187534;5511.696856672881;5642.57680673947;5692.715364231854;5700.287464066992;6234.563580549318;6234.906476402857;6249.0938813871735;6256.5307601930035;6256.562040657111;5957.255343082114;6012.609180403259;6019.729112189962;6024.638521688713;6066.211392518944;5841.795537156179;5864.7947321844385;6032.457078862835;6060.636361818305;6112.938870611237;6072;6119.265688117454;6121.816345509642;6124.448799608057;6135.355787642234;5812.854678633068;5837.241158649348;5842.328132264759;6049.153118563405;6134.723937422827;4648.86053418398;4699.107169637758;4705.905881882343;4707.29390591414;4724.314974328703;4064.695147863863;4065.59344065597;4150.211459822624;4168.583141685807;4230;5955.67243801595;5980.641161530322;5990.520758339322;6005.189299444519;6024.126501657235;6169.167162433014;6190.3190649028575;6212.968935155295;6214.223222097238;6215.223097112861;5608.158776183605;5644.266245388073;5875.618084824473;5952.434518720715;5959.821205363846;5256.896051829159;5275.024120537712;5286.022085914118;5287.41838397776;5292.708901010481;6478.773242936569;6482.189726284215;6487.740490380426;6489.123968264318;6513.120728701565;5822.883542329215;6118.256296955346;6143.835924498797;6166.290876549075;6171.9691401542705;6222.875542489215;6364.140840986408;6393.104965304768;6543.083968244545;6552.803415897531;6071.967765479791;6072.423119803611;6074.605150665193;6076.3012253591405;6079.574429789872;6119.663418511846;6181.35095814933;6187.969060154671;6189.102580125947;6189.659568723763;5688.687122208153;5722.713864306685;5908.645481271137;5929.940700592939;6016.42843929826;5948.583599148018;5973.462388385066;5985.610935289366;6011.188489553854;6011.789587364421;5683.602147849776;5744.770209191585;6002.909956350571;6007.429294217042;6011.9479091158;5881.382454842351;5888.617239879565;5913.497352725067;5917.171595976481;5921.171036055042;5819.883602327845;5827.475527202572;5830.416958304305;5833.79581714638;5834.679092649945 08:55:20 INFO - PROCESS | 22161 | |1;ext.html;784.5684873319673;815.3966065111816;849.1635738797286;906.1844340093915;924.3991405586372;31361.686383136162;41650.375244371324;42750.99999999996;46915.76542117293;47105;45480.545194548045;45798.771006145005;45827.77086114573;45892.541074589244;45957.310640340336;7734.690612375498;7936.325412339958;9076.636934522629;9240.630374785;9248.075192480765;10645.414502202375;10887.237893347468;10952.835707464394;10966.725831854188;11252.493637786278;11026.944865275702;11044.502997365138;11049.723756906062;11050.944745276262;11100;10889.782204355908;10896.945515272451;10919.672409827717;10930.508127134259;10942.617008404748;10608.416537090457;10625.149988000941;10632.415217163052;10688.46557672121;10761.408122553257;41655.58344416578;41980.790096049626;41996.37005444921;42010;42040.159196816196;4022.7184097113213;4056.4523789288364;4103.938440923389;4160.583941605845;4197.874063778061;30278.09165725032;30354.392912141855;30768.8461557693;31191.844040779877;31519.84240078808;3986.142979259444;3989.4414781930554;4001.379786133125;4022.9798851005557;4128.02991297045;232984;234334;236020;237799.81100094563;238544;54348.72825635847;54498.18252726212;54684.72657636766;54748.72625636846;54814.72592637011;56850.43149568451;56907;56927.715361422925;57007.71496142493;57041.42958570444;14766.926165369105;14884.776728349083;14893.925530372278;14922.626934326729;14942;12904;13097.541586044443;13576.864231357758;14585.489507867174;14724.779128313085;14171.149731016172;14185.361658725382;14211.715765684628;14307.85692143086;14318.713625727427;5186.507281808223;5260;5268.9736551317;5294;5367.78528858849;960.4957397366298;968.941863488193;979.0405402705388;980.9313348065709;983.4935008470643;28219.858900705363;30831.8458407711;31413.37173256522;31450.528242076387;32505.837470812494;1131.6944425005202;1140.1448913315014;1146.9197156199152;1160.7620437810228;1178.092868491274;14980.925095374454;15150.393984240727;15179.620509487131;15382.230888455533;15553.066815991077;331184;332548;333714;333880;333973;50528.494715053115;50717;50763.492365076614;50786.23820642619;50814.74592627013;1415.412603769424;1457.6355911022245;1467.24436914991;1470.228130231637;1475.8450362711976;26010.73989260083;27137.321566960985;27312.317192069564;27445.176644700692;27862.3034424141;37654.62345376511;37661.246775064894;37801.81099094487;37816;37886.62113378941;316142;316150;316593;316771;317195;26887.73112268852;27859.44281114407;29252.853735731183;29767;29772.10683679493;36484.63515364812;36725;37179.62820371761;37242;37315.440268395454;27910.44179116447;28370.290742730773;28922.132336029954;29006;29105.27236819012;28537.571936421387;28803;28839.8558007217;29092.418151637274;29190.270243243238;32537.511937321433;32897.67102328946;32914.67085329116;33044.66955330416;33232.33535329328;27093.86453067801;27225.59161612617;27286.454270914866;27638.86180569084;27651.86174069117;21975.670364944857;22369.44076398103;22516.211932582282;22801.087956481555;22918.885405573532 08:55:20 INFO - PROCESS | 22161 | |2;jquery.html;409.55154106253644;460.886464674437;467.6539360872953;470.34387030093023;487.34452161842313;18784.906075469622;19415.41753747388;21063.28812398577;21111.68332475014;21195.57608847822;21526;21692.457688557795;21700;21777;21900.8904955475;6488.837779055514;6899.931000689979;6954.513184077116;7367.410607151442;7621.809454763647;4157.50109986802;7705.306522412981;7743.5353878767455;7755.108162561293;7759.379249660042;4344.63070638996;4532.546745325458;7608.429367797409;7782.299593036626;7791.065072191345;7562.659680314371;7625.733099341496;7683.039620047494;7744.690212391498;7759.689612415496;7289.890651640229;7537.208593097701;7559.28186822251;7561.092668879714;7568.924310756877;24965.750342496525;24978;25417.364565885815;25534.87232563844;25600.487990240275;3072.8924487642826;3099.4885843835964;3192.2498212919945;3212.7429805615493;3217.742580593547;15465.304061317267;15815.762763558556;15943.123128227942;16109.758353624706;16797.91601041999;2129.946751331214;2146.8389870759597;2193.6270833958106;2252.831037672181;2272.6704627829035;104238.47880760624;109128.81742365108;109634;111032;115792;14412.469082485808;16267.837321626632;18123.54691132706;18303.45089647313;19098.90450547766;32620.347593048005;32629.347413051604;32632.83683581567;32733.345333093683;33297.334053318795;10252.179825613934;10364.792704145875;10499.68500944973;10636.787264254672;10725.034746872663;8659.220670139717;8730.301575873915;8748.65005399777;8919.73240802777;8931.553422328858;9042.412243204171;9162.404443711137;9500.334976551714;9577.616895324249;9615.471149086867;3350.3466823969093;3449.4308439107267;3670.632936706308;3769.453429252743;3792.4311353297226;959.6353385713384;970.427447805798;972.3485264872411;976.6581696406201;984.4388698441819;20423;21332.466688332916;23054.884725576263;23365.299041028797;23547.175848845207;1098.2806261898309;1099.5326986031064;1110.134095405585;1113.92202545821;1123.7920984617872;10871.619493317854;11581.826272605918;11604.30374177552;11648.534058637559;11790.94104529472;431377;435294;619076;629921;635279;103774.48112759388;121908;122119;122282.38858805649;123945.38027309986;1300.681333073403;1333.2533781082625;1373.4368908747365;1385.300423286234;1388.1809732258016;13842.930785346009;19356.128974196476;19439.70840437366;19521.511962201057;19691.42024530675;49781.50218497769;49782;50029.249561255885;50292.74853625709;50936.74531627318;59525;59792.70103649454;63645.3635463658;63875.68062159659;64722.352776471635;7806.141324454192;10969.286996345212;12065.51737930508;12436.813447798471;12464.813027804772;13956.2324072177;13983.650408739863;14131.929340353232;14219.502317419254;14393.208373539137;11919.106067044833;12139.150259481752;12277.877221228031;12300.261984280973;12560.497580096693;10794.082502987334;11480.885191147981;11807.586734464252;11820;11902.464389102339;12450.750984980068;12554.811677824657;12661.430235639602;12683.619491415273;12689.365531723191;12652.493900244255;12755.80866287025;12864.549740759028;12900.741985160432;13152.671183220496;12151.513939442324;12181.33002684861;12287.93856030714;12306.507739690313;12689.555865544662 08:55:20 INFO - PROCESS | 22161 | |3;mootools.html;1536.3777670043637;1551.56556164274;1555.6733086051936;1565.8590726834589;1576.59008657749;10351.378917264969;11126.332420054803;11131.220814542985;11133.10935125188;11135.220534562584;10378.221633377489;10648.680539583826;10671;10680.679579612624;10687.145028397728;2400.147947478646;2463.002483993985;2473.356927198932;2482.056818409002;2483.776460118589;2378.327921271888;2404.2546810488802;2423.1761201191593;2434.7686969737933;2443.1937460637946;2380.5238952209543;2439.85360878347;2448.204333591581;2449.0326321103153;2449.191766716979;2305.5619432307976;2347.0259842165483;2353.788159065684;2359.469119448119;2379.250536081146;2317.084751523139;2343.7539058398966;2349.988250058756;2352.0591763294647;2355.140373763564;11091.112710983101;11268.436578171058;11282.379469129195;11283.43582820864;11322.716932076764;5743.4256574342235;5885.882282354329;5886.764529418818;5899.439553242478;5904.704764761745;3290.3583801158784;3322.5016247562817;3350.3801796667694;3355.966440335614;3409.9147521311916;1252.2486508095162;1282.8396450443695;1312.842458904928;1329.2489743295007;1388.2919710947388;14060.648483787885;14413.063150895157;15007.399704011827;15187.696246075127;15252.161131137784;4858.854234372974;4978.278149668277;5074.314967479417;5081.364829396325;5092.6435149539175;13898.305084745722;13902.443902243796;13905.652358690912;13909.652258693613;13916.51292204768;6197.659128747962;6204.534659900435;6214.098955651496;6222.3466536013975;6228.906566401508;5427.701476418835;5497.065498865202;5497.532709719639;5566.888662226814;5583.357913839879;4349.151915376535;4426.75652839097;4451.732896026248;4501.099780044005;4509.436320459942;1157.0974639780984;1200.7418405042959;1215.4044518186024;1217.5069097015723;1218.8171774233758;1046.926715129949;1048.9737756556146;1050.5377633841085;1054.6572363981736;1057.9947100264449;6651.700673469705;6875.3812156906115;6900.309969003059;6973.65131743421;6987.441004719611;1046.68076236747;1058.772363941756;1065.3980501016902;1106.878243393226;1111.1000089927186;4673.275642275453;4760.666753327234;4800.4719480857075;4846.151923413388;4864.318995340655;13935.303234838217;14345;14423;14462.20457874806;14490.565283041526;14204.076735012191;14208.502702405573;14499.202543860189;14517.78223326651;14529;9075.68402581622;10793.946030269799;10954.287971281841;10966.616168434066;10995.450227488594;6608.570442921195;7283.2352602975925;7461.850762984818;7580.204078571671;7607.429442791923;11837.881621183678;11845.940770296093;11858.16992810495;11952.34262115592;12227.205231659913;12655.367231638565;12661.87338126607;12705.237685738515;12762.808557871454;12801.61595152147;9489.572969216264;9590.184834289164;9662.855057174007;9681.951590242004;9713.757156071155;10309.690709278733;10394.688159355232;10614.8407773885;10623.575056997943;10661.253712240068;9121.270298376247;9153.725388238363;9168.587413566538;9297.256219502558;9327.486988215713;8970.192682658331;9051.18539331437;9106.635734570807;9193.494357810385;9222.40054396462;8259.83480330402;8271.172882711922;8314.168583141638;8355.12271211514;8355.623996920032;6143.723532440961;6176.938230617637;6229.750809967551;6296.118543403835;6366.5225108118;6015.548833837567;6043.244594425697;6084.726187321669;6091.482224011009;6181.9690901547 08:55:20 INFO - PROCESS | 22161 | |4;prototype.html;419.0759375576852;419.9517055538613;436.4478934148301;438.9626881715054;440.6959198153272;5219.217117432387;5222.582193424527;5312.379724184128;5319.973400132999;5339.332583427076;5120.667156634816;5152.789094562775;5168.837011672372;5182.792688292464;5187.455317191688;4260.978695106528;4314.525402205755;4412.227860124482;4412.404325416076;4434.647432533076;4396.252637051709;4402.779861006953;4404.7357158570585;4425.712328698641;4446.888827779299;4402.427684401039;4436.866893993185;4443.244648409778;4494.011317510142;4500.234960056799;4387.254166791653;4414.823407063714;4439.223135951195;4472.239719247703;4485.439320084989;4118.940529735132;4134.793260336971;4138;4168.291000689703;4189.413482112506;5122.33409656746;5126.641135120543;5135.717535535544;5174.97412512935;5187.844364669066;4822.951770482286;5064.468230835746;5067.695938243717;5132.689415327093;5141.871453213662;5406.405295417501;5411.618887689404;5447.428020057877;5457.290552228224;5480.945190548123;4526.207913615104;4581.144636422221;4585.747783871886;4606.516315786861;4622.722636641813;5460.34475862895;5622.803201887914;5637.295338082739;5663.858403539944;5686.687232202227;4677;4690.788914498856;4694.342792009122;4706.152892479318;4725.904532531197;4774.522547745198;4784.617230621611;4787.928181077217;4791.233402655628;4797.56821886032;4874.951250487521;4989.825356112518;4999.975000124976;5044.9495505045215;5091.949080509222;5394.514493695587;5394.541463975527;5402.972985135128;5439.972800136054;5472.616916815864;1643.86027187688;1647.8516933475805;1659.1372486307052;1664.1263336748304;1666.3586367428074;1243.0055955235775;1255.8241846141548;1256.918300310477;1273.611548477723;1290.6512694234548;5389.766140315857;5422.8373148805595;5509.393966663663;5530.364008139035;5594.440555944454;5610.298712660918;5633.239512665819;5638.2670252866865;5665.461781130786;5690.3456102548735;5145.897082058338;5357.35711714589;5431.82238390546;5435.83692489226;5442.945570544244;2941.6175897133235;2952.5571164325524;2959.4377068356944;2984;3009.3981203759336;5743.712814359265;5974.297325262366;6013.7895173669585;6026.638401695912;6039.7282122304605;5527.55779537636;5756.510696590753;5766.059309752057;5784.3926387729525;5799.420057994167;5767.596268261265;5778.884422311614;5917.822465326047;5921.276212942095;5942.821715348633;5585.972070139624;5595.328560572757;5624.746886390204;5638.421242052232;5663.4053424391495;5279.419263881046;5341.732913354394;5523.972380138234;5555.8888822222525;5589.273394458694;5846.824595262149;5850.912236316543;5859.974504461788;5909.7838310633515;5926.614770039933;4577.656675749266;4657.231556793226;4675.649326300473;4716.976415117902;4788.784504697227;5624.887502250014;5648.85877853057;5651.773929042956;5655.971720141373;5660.462256085665;5413.864653383697;5476.890462190813;5479.315085614298;5489.039418101896;5508.531774799027;5354.411014788292;5454.590905682169;5497.340319161726;5510.283663123929;5547.41752116022;5423.7830486780085;5449.809256675997;5476.72616369172;5477.287952566141;5480.260164877691;5264.236685680631;5406.594065640752;5450.427705090909;5493.972530137484;5570.582206334622;5363.823909926939;5379.623426360274;5390.51485366319;5400.594955378284;5439.225994742789 08:55:20 INFO - PROCESS | 22161 | |5;yui.html;831.3433279495842;852.0712423458431;853.2107800284737;855.1832999485492;877.0308808766317;17203.913980430098;18206.544836379097;18299.634007319863;18313.81686183138;18317.45047648571;15707.136107514083;15797;16889.23998420074;17137;17194.914025429855;833.2542374574751;898.6540182029901;899.1053901368115;903.5888670654837;907.1744712311797;909.4316052467208;909.5088652127843;912.1061359867334;912.6030176873048;913.0458670689112;944.7354740672588;945.0832692288503;946.3044662173297;946.9337146399755;947.2611363136764;923.6951805904102;933.10421994885;933.2207606648457;933.444600462727;933.7572231219898;684.6542496039468;692.6744430117836;692.705600119947;692.8718187135396;693.3724978894109;17996.55008624795;18085.7287140693;18200.817991820044;18549;18711.34510292147;16081.195940202942;16107.355705771755;16231.350745970147;16546.338146474125;17035;13066.412011459412;13255.602331930058;13445.731085378335;13999.580012599637;14002.966603239336;4077.5506970849246;4110.753354798691;4141.295979683461;4184.456020717287;4270.829166833323;91829;92039.53980230055;92407;93088.53455732678;95613;11501.42492875353;11736.647900562997;11882.049436045096;11932.761344773056;12190.268583884996;20663.41814115118;21707.674384884238;21746.673799893015;23103.653445198335;23316.7668323318;8787.297016238686;9181.357304988587;9186.127317904788;9266.305027122859;9335.626574937063;5097.923531147036;5098.847034588968;5173.430922598511;5232.1628539433505;5318.149096144598;3777.112378591029;3881.6506514413836;3884.941725874114;3885.203533275672;3887.475190849256;634.2642534659773;642.6882961763541;645.7191121861911;649.9642519661464;651.1274891645218;818.7912082418945;849.6813694864302;857.2327766648939;880.018779061342;880.4805164952709;10810.729731756612;10833.636621979484;10943.945280273707;11032;11739.88260117405;714;731.2960801332881;737.1080991999634;765.9080910290689;910.6994691751706;5469.425710300361;5697.259356283656;5718.285214348207;6025.216721826135;6044.123602077674;72605.6369718148;73196;81867.5906620475;84413;88664;69921;71018.2898171022;74041.62979185069;76009.57956891954;76814;65597;65820.34179658238;65949.34050659432;66475;66640.66679666571;11369.658910232707;11498.597549085742;11690.70773230676;11706.414679265832;11731.530738770354;46753;46945.765271173426;47178.76410617925;47849.28226076542;47974.040519188726;51257;51535.48464515307;51662.74168629133;52885.47114528959;53123;14354.49759258421;14421;14427.42290308376;14542.345594448487;14784.33470493852;15686;15936.36254549805;16251.837481625033;16504.092274924995;16559;14902.85097149058;15252.466163684217;15275.541733748005;15967.920160399124;15991.840081599035;14108.788368174692;14109.929450352682;14134.646633834236;14255.714885702435;14902.329395177027;13389.799153012907;13538.255395953318;13653.385597648328;13807.51673691416;14172.362243699265;10007.399556026661;10095.091441770275;10179;10336.0697537222;10591.89408105909;10996.034916554456;11223.214374993671;11247.88752112501;11286.492107855001;11311.264767790068 08:55:20 INFO - PROCESS | 22161 | __end_tp_report 08:55:20 INFO - PROCESS | 22161 | __start_cc_report 08:55:20 INFO - PROCESS | 22161 | _x_x_mozilla_cycle_collect,1349 08:55:20 INFO - PROCESS | 22161 | __end_cc_report 08:55:20 INFO - PROCESS | 22161 | __startTimestamp1492444520707__endTimestamp 08:55:20 INFO - PROCESS | 22161 | 08:55:20 INFO - PROCESS | 22161 | ------- Summary: start ------- 08:55:20 INFO - PROCESS | 22161 | Number of tests: 6 08:55:20 INFO - PROCESS | 22161 | 08:55:20 INFO - PROCESS | 22161 | [#0] dojo.html Cycles:165 Average:5686.41 Median:5875.62 stddev:645.80 (11.0%) stddev-sans-first:620.33 08:55:20 INFO - PROCESS | 22161 | Values: 3311.7 3364.8 3385.2 3406.3 3439.8 5609.2 5633.9 5644.9 5647.3 5660.9 5689.9 5777.4 5801.7 5811.4 5813.0 5253.7 5262.4 5263.2 5304.5 5341.6 4951.7 4975.8 5329.9 5351.2 5351.3 5185.8 5206.5 5213.2 5216.2 5232.6 5288.5 5299.8 5304.5 5311.3 5317.0 5036.2 5145.4 5217.0 5255.3 5259.6 5468.9 5604.9 5613.5 5650.4 5678.7 6114.1 6146.0 6163.6 6166.3 6168.6 6201.0 6201.2 6212.8 6214.7 6222.3 5468.9 5511.7 5642.6 5692.7 5700.3 6234.6 6234.9 6249.1 6256.5 6256.6 5957.3 6012.6 6019.7 6024.6 6066.2 5841.8 5864.8 6032.5 6060.6 6112.9 6072.0 6119.3 6121.8 6124.4 6135.4 5812.9 5837.2 5842.3 6049.2 6134.7 4648.9 4699.1 4705.9 4707.3 4724.3 4064.7 4065.6 4150.2 4168.6 4230.0 5955.7 5980.6 5990.5 6005.2 6024.1 6169.2 6190.3 6213.0 6214.2 6215.2 5608.2 5644.3 5875.6 5952.4 5959.8 5256.9 5275.0 5286.0 5287.4 5292.7 6478.8 6482.2 6487.7 6489.1 6513.1 5822.9 6118.3 6143.8 6166.3 6172.0 6222.9 6364.1 6393.1 6543.1 6552.8 6072.0 6072.4 6074.6 6076.3 6079.6 6119.7 6181.4 6188.0 6189.1 6189.7 5688.7 5722.7 5908.6 5929.9 6016.4 5948.6 5973.5 5985.6 6011.2 6011.8 5683.6 5744.8 6002.9 6007.4 6011.9 5881.4 5888.6 5913.5 5917.2 5921.2 5819.9 5827.5 5830.4 5833.8 5834.7 08:55:20 INFO - PROCESS | 22161 | 08:55:20 INFO - PROCESS | 22161 | [#1] ext.html Cycles:180 Average:45512.65 Median:31276.77 stddev:78109.46 (249.7%) stddev-sans-first:78256.38 08:55:20 INFO - PROCESS | 22161 | Values: 784.6 815.4 849.2 906.2 924.4 31361.7 41650.4 42751.0 46915.8 47105.0 45480.5 45798.8 45827.8 45892.5 45957.3 7734.7 7936.3 9076.6 9240.6 9248.1 10645.4 10887.2 10952.8 10966.7 11252.5 11026.9 11044.5 11049.7 11050.9 11100.0 10889.8 10896.9 10919.7 10930.5 10942.6 10608.4 10625.1 10632.4 10688.5 10761.4 41655.6 41980.8 41996.4 42010.0 42040.2 4022.7 4056.5 4103.9 4160.6 4197.9 30278.1 30354.4 30768.8 31191.8 31519.8 3986.1 3989.4 4001.4 4023.0 4128.0 232984.0 234334.0 236020.0 237799.8 238544.0 54348.7 54498.2 54684.7 54748.7 54814.7 56850.4 56907.0 56927.7 57007.7 57041.4 14766.9 14884.8 14893.9 14922.6 14942.0 12904.0 13097.5 13576.9 14585.5 14724.8 14171.1 14185.4 14211.7 14307.9 14318.7 5186.5 5260.0 5269.0 5294.0 5367.8 960.5 968.9 979.0 980.9 983.5 28219.9 30831.8 31413.4 31450.5 32505.8 1131.7 1140.1 1146.9 1160.8 1178.1 14980.9 15150.4 15179.6 15382.2 15553.1 331184.0 332548.0 333714.0 333880.0 333973.0 50528.5 50717.0 50763.5 50786.2 50814.7 1415.4 1457.6 1467.2 1470.2 1475.8 26010.7 27137.3 27312.3 27445.2 27862.3 37654.6 37661.2 37801.8 37816.0 37886.6 316142.0 316150.0 316593.0 316771.0 317195.0 26887.7 27859.4 29252.9 29767.0 29772.1 36484.6 36725.0 37179.6 37242.0 37315.4 27910.4 28370.3 28922.1 29006.0 29105.3 28537.6 28803.0 28839.9 29092.4 29190.3 32537.5 32897.7 32914.7 33044.7 33232.3 27093.9 27225.6 27286.5 27638.9 27651.9 21975.7 22369.4 22516.2 22801.1 22918.9 08:55:20 INFO - PROCESS | 22161 | 08:55:20 INFO - PROCESS | 22161 | [#2] jquery.html Cycles:180 Average:34475.91 Median:21738.50 stddev:92682.28 (426.4%) stddev-sans-first:92906.98 08:55:20 INFO - PROCESS | 22161 | Values: 409.6 460.9 467.7 470.3 487.3 18784.9 19415.4 21063.3 21111.7 21195.6 21526.0 21692.5 21700.0 21777.0 21900.9 6488.8 6899.9 6954.5 7367.4 7621.8 4157.5 7705.3 7743.5 7755.1 7759.4 4344.6 4532.5 7608.4 7782.3 7791.1 7562.7 7625.7 7683.0 7744.7 7759.7 7289.9 7537.2 7559.3 7561.1 7568.9 24965.8 24978.0 25417.4 25534.9 25600.5 3072.9 3099.5 3192.2 3212.7 3217.7 15465.3 15815.8 15943.1 16109.8 16797.9 2129.9 2146.8 2193.6 2252.8 2272.7 104238.5 109128.8 109634.0 111032.0 115792.0 14412.5 16267.8 18123.5 18303.5 19098.9 32620.3 32629.3 32632.8 32733.3 33297.3 10252.2 10364.8 10499.7 10636.8 10725.0 8659.2 8730.3 8748.7 8919.7 8931.6 9042.4 9162.4 9500.3 9577.6 9615.5 3350.3 3449.4 3670.6 3769.5 3792.4 959.6 970.4 972.3 976.7 984.4 20423.0 21332.5 23054.9 23365.3 23547.2 1098.3 1099.5 1110.1 1113.9 1123.8 10871.6 11581.8 11604.3 11648.5 11790.9 431377.0 435294.0 619076.0 629921.0 635279.0 103774.5 121908.0 122119.0 122282.4 123945.4 1300.7 1333.3 1373.4 1385.3 1388.2 13842.9 19356.1 19439.7 19521.5 19691.4 49781.5 49782.0 50029.2 50292.7 50936.7 59525.0 59792.7 63645.4 63875.7 64722.4 7806.1 10969.3 12065.5 12436.8 12464.8 13956.2 13983.7 14131.9 14219.5 14393.2 11919.1 12139.2 12277.9 12300.3 12560.5 10794.1 11480.9 11807.6 11820.0 11902.5 12450.8 12554.8 12661.4 12683.6 12689.4 12652.5 12755.8 12864.5 12900.7 13152.7 12151.5 12181.3 12287.9 12306.5 12689.6 08:55:20 INFO - PROCESS | 22161 | 08:55:20 INFO - PROCESS | 22161 | [#3] mootools.html Cycles:180 Average:7004.48 Median:2390.34 stddev:4329.67 (181.1%) stddev-sans-first:4322.32 08:55:20 INFO - PROCESS | 22161 | Values: 1536.4 1551.6 1555.7 1565.9 1576.6 10351.4 11126.3 11131.2 11133.1 11135.2 10378.2 10648.7 10671.0 10680.7 10687.1 2400.1 2463.0 2473.4 2482.1 2483.8 2378.3 2404.3 2423.2 2434.8 2443.2 2380.5 2439.9 2448.2 2449.0 2449.2 2305.6 2347.0 2353.8 2359.5 2379.3 2317.1 2343.8 2350.0 2352.1 2355.1 11091.1 11268.4 11282.4 11283.4 11322.7 5743.4 5885.9 5886.8 5899.4 5904.7 3290.4 3322.5 3350.4 3356.0 3409.9 1252.2 1282.8 1312.8 1329.2 1388.3 14060.6 14413.1 15007.4 15187.7 15252.2 4858.9 4978.3 5074.3 5081.4 5092.6 13898.3 13902.4 13905.7 13909.7 13916.5 6197.7 6204.5 6214.1 6222.3 6228.9 5427.7 5497.1 5497.5 5566.9 5583.4 4349.2 4426.8 4451.7 4501.1 4509.4 1157.1 1200.7 1215.4 1217.5 1218.8 1046.9 1049.0 1050.5 1054.7 1058.0 6651.7 6875.4 6900.3 6973.7 6987.4 1046.7 1058.8 1065.4 1106.9 1111.1 4673.3 4760.7 4800.5 4846.2 4864.3 13935.3 14345.0 14423.0 14462.2 14490.6 14204.1 14208.5 14499.2 14517.8 14529.0 9075.7 10793.9 10954.3 10966.6 10995.5 6608.6 7283.2 7461.9 7580.2 7607.4 11837.9 11845.9 11858.2 11952.3 12227.2 12655.4 12661.9 12705.2 12762.8 12801.6 9489.6 9590.2 9662.9 9682.0 9713.8 10309.7 10394.7 10614.8 10623.6 10661.3 9121.3 9153.7 9168.6 9297.3 9327.5 8970.2 9051.2 9106.6 9193.5 9222.4 8259.8 8271.2 8314.2 8355.1 8355.6 6143.7 6176.9 6229.8 6296.1 6366.5 6015.5 6043.2 6084.7 6091.5 6182.0 08:55:20 INFO - PROCESS | 22161 | 08:55:20 INFO - PROCESS | 22161 | [#4] prototype.html Cycles:180 Average:4803.25 Median:5316.18 stddev:1273.06 (23.9%) stddev-sans-first:1233.37 08:55:20 INFO - PROCESS | 22161 | Values: 419.1 420.0 436.4 439.0 440.7 5219.2 5222.6 5312.4 5320.0 5339.3 5120.7 5152.8 5168.8 5182.8 5187.5 4261.0 4314.5 4412.2 4412.4 4434.6 4396.3 4402.8 4404.7 4425.7 4446.9 4402.4 4436.9 4443.2 4494.0 4500.2 4387.3 4414.8 4439.2 4472.2 4485.4 4118.9 4134.8 4138.0 4168.3 4189.4 5122.3 5126.6 5135.7 5175.0 5187.8 4823.0 5064.5 5067.7 5132.7 5141.9 5406.4 5411.6 5447.4 5457.3 5480.9 4526.2 4581.1 4585.7 4606.5 4622.7 5460.3 5622.8 5637.3 5663.9 5686.7 4677.0 4690.8 4694.3 4706.2 4725.9 4774.5 4784.6 4787.9 4791.2 4797.6 4875.0 4989.8 5000.0 5044.9 5091.9 5394.5 5394.5 5403.0 5440.0 5472.6 1643.9 1647.9 1659.1 1664.1 1666.4 1243.0 1255.8 1256.9 1273.6 1290.7 5389.8 5422.8 5509.4 5530.4 5594.4 5610.3 5633.2 5638.3 5665.5 5690.3 5145.9 5357.4 5431.8 5435.8 5442.9 2941.6 2952.6 2959.4 2984.0 3009.4 5743.7 5974.3 6013.8 6026.6 6039.7 5527.6 5756.5 5766.1 5784.4 5799.4 5767.6 5778.9 5917.8 5921.3 5942.8 5586.0 5595.3 5624.7 5638.4 5663.4 5279.4 5341.7 5524.0 5555.9 5589.3 5846.8 5850.9 5860.0 5909.8 5926.6 4577.7 4657.2 4675.6 4717.0 4788.8 5624.9 5648.9 5651.8 5656.0 5660.5 5413.9 5476.9 5479.3 5489.0 5508.5 5354.4 5454.6 5497.3 5510.3 5547.4 5423.8 5449.8 5476.7 5477.3 5480.3 5264.2 5406.6 5450.4 5494.0 5570.6 5363.8 5379.6 5390.5 5400.6 5439.2 08:55:20 INFO - PROCESS | 22161 | 08:55:20 INFO - PROCESS | 22161 | [#5] yui.html Cycles:180 Average:18972.85 Median:46849.38 stddev:24041.91 (51.3%) stddev-sans-first:24070.76 08:55:20 INFO - PROCESS | 22161 | Values: 831.3 852.1 853.2 855.2 877.0 17203.9 18206.5 18299.6 18313.8 18317.5 15707.1 15797.0 16889.2 17137.0 17194.9 833.3 898.7 899.1 903.6 907.2 909.4 909.5 912.1 912.6 913.0 944.7 945.1 946.3 946.9 947.3 923.7 933.1 933.2 933.4 933.8 684.7 692.7 692.7 692.9 693.4 17996.6 18085.7 18200.8 18549.0 18711.3 16081.2 16107.4 16231.4 16546.3 17035.0 13066.4 13255.6 13445.7 13999.6 14003.0 4077.6 4110.8 4141.3 4184.5 4270.8 91829.0 92039.5 92407.0 93088.5 95613.0 11501.4 11736.6 11882.0 11932.8 12190.3 20663.4 21707.7 21746.7 23103.7 23316.8 8787.3 9181.4 9186.1 9266.3 9335.6 5097.9 5098.8 5173.4 5232.2 5318.1 3777.1 3881.7 3884.9 3885.2 3887.5 634.3 642.7 645.7 650.0 651.1 818.8 849.7 857.2 880.0 880.5 10810.7 10833.6 10943.9 11032.0 11739.9 714.0 731.3 737.1 765.9 910.7 5469.4 5697.3 5718.3 6025.2 6044.1 72605.6 73196.0 81867.6 84413.0 88664.0 69921.0 71018.3 74041.6 76009.6 76814.0 65597.0 65820.3 65949.3 66475.0 66640.7 11369.7 11498.6 11690.7 11706.4 11731.5 46753.0 46945.8 47178.8 47849.3 47974.0 51257.0 51535.5 51662.7 52885.5 53123.0 14354.5 14421.0 14427.4 14542.3 14784.3 15686.0 15936.4 16251.8 16504.1 16559.0 14902.9 15252.5 15275.5 15967.9 15991.8 14108.8 14109.9 14134.6 14255.7 14902.3 13389.8 13538.3 13653.4 13807.5 14172.4 10007.4 10095.1 10179.0 10336.1 10591.9 10996.0 11223.2 11247.9 11286.5 11311.3 08:55:20 INFO - PROCESS | 22161 | -------- Summary: end -------- 08:55:20 INFO - PROCESS | 22161 | 08:55:21 INFO - TEST-INFO | 22161: exit 0 08:55:21 INFO - TEST-OK | dromaeo_css | took 1115621ms 08:55:21 INFO - TEST-START | kraken 08:55:21 INFO - operating with platform_type : linux_ 08:55:21 INFO - Initialising browser for kraken test... 08:55:21 INFO - TEST-INFO | started process 22484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxBuCqU/profile http://localhost:36927/getInfo.html) 08:55:25 INFO - PROCESS | 22484 | __metrics Screen width/height:1600/1200 08:55:25 INFO - PROCESS | 22484 | colorDepth:24 08:55:25 INFO - PROCESS | 22484 | Browser inner width/height: 1024/697 08:55:25 INFO - PROCESS | 22484 | __metrics 08:55:26 INFO - PROCESS | 22484 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:55:26 INFO - PROCESS | 22484 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:27 INFO - PROCESS | 22484 | console.error: PushService: 08:55:27 INFO - PROCESS | 22484 | stateChangeProcessEnqueue: Error transitioning state 08:55:27 INFO - PROCESS | 22484 | UnknownError 08:55:27 INFO - TEST-INFO | 22484: exit 0 08:55:27 INFO - Browser initialized. 08:55:27 INFO - Running cycle 1/1 for kraken test... 08:55:27 INFO - TEST-INFO | started process 22576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxBuCqU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:39 INFO - PROCESS | 22576 | RSS: Main: 140099584 08:55:39 INFO - PROCESS | 22576 | 08:55:41 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36927/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:42 INFO - PROCESS | 22576 | RSS: Main: 183783424 08:55:42 INFO - PROCESS | 22576 | 08:55:45 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36927/tests/kraken/driver.html?testName=audio-dft) 08:55:45 INFO - PROCESS | 22576 | RSS: Main: 173793280 08:55:45 INFO - PROCESS | 22576 | 08:55:48 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36927/tests/kraken/driver.html?testName=audio-fft) 08:55:49 INFO - PROCESS | 22576 | RSS: Main: 266031104 08:55:49 INFO - PROCESS | 22576 | 08:55:51 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36927/tests/kraken/driver.html?testName=audio-oscillator) 08:55:51 INFO - PROCESS | 22576 | RSS: Main: 171732992 08:55:51 INFO - PROCESS | 22576 | 08:55:54 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:55:54 INFO - PROCESS | 22576 | RSS: Main: 174542848 08:55:54 INFO - PROCESS | 22576 | 08:55:57 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36927/tests/kraken/driver.html?testName=imaging-darkroom) 08:55:58 INFO - PROCESS | 22576 | RSS: Main: 213557248 08:55:58 INFO - PROCESS | 22576 | 08:56:01 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36927/tests/kraken/driver.html?testName=imaging-desaturate) 08:56:02 INFO - PROCESS | 22576 | RSS: Main: 212373504 08:56:02 INFO - PROCESS | 22576 | 08:56:04 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36927/tests/kraken/driver.html?testName=json-parse-financial) 08:56:05 INFO - PROCESS | 22576 | RSS: Main: 211202048 08:56:05 INFO - PROCESS | 22576 | 08:56:07 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:56:07 INFO - PROCESS | 22576 | RSS: Main: 173150208 08:56:07 INFO - PROCESS | 22576 | 08:56:09 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:56:09 INFO - PROCESS | 22576 | RSS: Main: 180273152 08:56:09 INFO - PROCESS | 22576 | 08:56:11 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:56:12 INFO - PROCESS | 22576 | RSS: Main: 189100032 08:56:12 INFO - PROCESS | 22576 | 08:56:15 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:56:15 INFO - PROCESS | 22576 | RSS: Main: 197890048 08:56:15 INFO - PROCESS | 22576 | 08:56:18 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:18 INFO - PROCESS | 22576 | RSS: Main: 194813952 08:56:18 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36927/tests/kraken/driver.html?testName=ai-astar) 08:56:20 INFO - PROCESS | 22576 | RSS: Main: 246738944 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | __start_tp_report 08:56:20 INFO - PROCESS | 22576 | _x_x_mozilla_page_load 08:56:20 INFO - PROCESS | 22576 | _x_x_mozilla_page_load_details 08:56:20 INFO - PROCESS | 22576 | |i|pagename|runs| 08:56:20 INFO - PROCESS | 22576 | |0;ai-astar;104;113;113;112;113;112;113;113;112;111 08:56:20 INFO - PROCESS | 22576 | |1;audio-beat-detection;158;119;122;154;117;121;115;123;137;115 08:56:20 INFO - PROCESS | 22576 | |2;audio-dft;161;160;161;164;162;162;161;160;162;162 08:56:20 INFO - PROCESS | 22576 | |3;audio-fft;76;77;76;108;76;75;75;75;93;86 08:56:20 INFO - PROCESS | 22576 | |4;audio-oscillator;82;82;106;82;82;82;96;83;82;106 08:56:20 INFO - PROCESS | 22576 | |5;imaging-gaussian-blur;113;113;113;113;113;113;112;113;113;113 08:56:20 INFO - PROCESS | 22576 | |6;imaging-darkroom;146;146;146;146;147;146;147;146;145;147 08:56:20 INFO - PROCESS | 22576 | |7;imaging-desaturate;94;94;94;93;94;94;93;94;94;94 08:56:20 INFO - PROCESS | 22576 | |8;json-parse-financial;54;55;55;54;54;55;58;54;55;53 08:56:20 INFO - PROCESS | 22576 | |9;json-stringify-tinderbox;52;52;53;51;51;51;51;51;51;51 08:56:20 INFO - PROCESS | 22576 | |10;stanford-crypto-aes;80;76;76;76;76;77;76;79;75;82 08:56:20 INFO - PROCESS | 22576 | |11;stanford-crypto-ccm;122;121;120;123;121;122;120;128;159;118 08:56:20 INFO - PROCESS | 22576 | |12;stanford-crypto-pbkdf2;159;159;156;158;156;157;154;156;159;156 08:56:20 INFO - PROCESS | 22576 | |13;stanford-crypto-sha256-iterative;64;60;64;59;58;60;62;60;60;61 08:56:20 INFO - PROCESS | 22576 | __end_tp_report 08:56:20 INFO - PROCESS | 22576 | __start_cc_report 08:56:20 INFO - PROCESS | 22576 | _x_x_mozilla_cycle_collect,1658 08:56:20 INFO - PROCESS | 22576 | __end_cc_report 08:56:20 INFO - PROCESS | 22576 | __startTimestamp1492444580854__endTimestamp 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | ------- Summary: start ------- 08:56:20 INFO - PROCESS | 22576 | Number of tests: 14 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:2.76 (2.4%) stddev-sans-first:0.73 08:56:20 INFO - PROCESS | 22576 | Values: 104.0 113.0 113.0 112.0 113.0 112.0 113.0 113.0 112.0 111.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:122.50 stddev:16.01 (13.1%) stddev-sans-first:12.81 08:56:20 INFO - PROCESS | 22576 | Values: 158.0 119.0 122.0 154.0 117.0 121.0 115.0 123.0 137.0 115.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 08:56:20 INFO - PROCESS | 22576 | Values: 161.0 160.0 161.0 164.0 162.0 162.0 161.0 160.0 162.0 162.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:11.02 (14.5%) stddev-sans-first:11.49 08:56:20 INFO - PROCESS | 22576 | Values: 76.0 77.0 76.0 108.0 76.0 75.0 75.0 75.0 93.0 86.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:82.00 stddev:10.29 (12.5%) stddev-sans-first:10.65 08:56:20 INFO - PROCESS | 22576 | Values: 82.0 82.0 106.0 82.0 82.0 82.0 96.0 83.0 82.0 106.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:56:20 INFO - PROCESS | 22576 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:56:20 INFO - PROCESS | 22576 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 145.0 147.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:56:20 INFO - PROCESS | 22576 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.34 (2.4%) stddev-sans-first:1.39 08:56:20 INFO - PROCESS | 22576 | Values: 54.0 55.0 55.0 54.0 54.0 55.0 58.0 54.0 55.0 53.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#9] json-stringify-tinderbox Cycles:10 Average:51.40 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.71 08:56:20 INFO - PROCESS | 22576 | Values: 52.0 52.0 53.0 51.0 51.0 51.0 51.0 51.0 51.0 51.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.50 stddev:2.26 (3.0%) stddev-sans-first:2.18 08:56:20 INFO - PROCESS | 22576 | Values: 80.0 76.0 76.0 76.0 76.0 77.0 76.0 79.0 75.0 82.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:122.00 stddev:12.09 (9.9%) stddev-sans-first:12.76 08:56:20 INFO - PROCESS | 22576 | Values: 122.0 121.0 120.0 123.0 121.0 122.0 120.0 128.0 159.0 118.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.50 stddev:1.70 (1.1%) stddev-sans-first:1.64 08:56:20 INFO - PROCESS | 22576 | Values: 159.0 159.0 156.0 158.0 156.0 157.0 154.0 156.0 159.0 156.0 08:56:20 INFO - PROCESS | 22576 | 08:56:20 INFO - PROCESS | 22576 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:60.50 stddev:1.99 (3.3%) stddev-sans-first:1.74 08:56:20 INFO - PROCESS | 22576 | Values: 64.0 60.0 64.0 59.0 58.0 60.0 62.0 60.0 60.0 61.0 08:56:20 INFO - PROCESS | 22576 | -------- Summary: end -------- 08:56:20 INFO - PROCESS | 22576 | 08:56:21 INFO - TEST-INFO | 22576: exit 0 08:56:21 INFO - TEST-OK | kraken | took 60489ms 08:56:21 INFO - SUITE-END | took 1176s 08:56:22 INFO - Completed test suite (00:19:36) 08:56:22 INFO - javascript benchmark 08:56:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7799.327428759816, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3311.7185039271662, 3364.8485818138174, 3385.1706331948676, 3406.2506248625295, 3439.8452069656864, 5609.186667933152, 5633.887322253563, 5644.887102257958, 5647.29408823897, 5660.915086273709, 5689.886202275952, 5777.364489906107, 5801.680907550083, 5811.418858114186, 5813.040848260042, 5253.737313134328, 5262.394824595172, 5263.210518422229, 5304.496072873071, 5341.599380046493, 4951.727654978975, 4975.751212439382, 5329.866753331159, 5351.197320401932, 5351.277577527042, 5185.844424667266, 5206.45332240115, 5213.165893457048, 5216.191490319006, 5232.581393488512, 5288.497592728723, 5299.788008479656, 5304.496072873071, 5311.309529761106, 5317.042932272189, 5036.219385995177, 5145.382554093495, 5217.0, 5255.264263003182, 5259.605529585297, 5468.851541176357, 5604.887902241973, 5613.46672066153, 5650.378458369576, 5678.659280443187, 6114.082887566856, 6146.0473626587955, 6163.599366041193, 6166.290876549209, 6168.629882207082, 6201.0388389799655, 6201.16284301618, 6212.844678883019, 6214.65819379934, 6222.253329600477, 5468.890622187534, 5511.696856672881, 5642.57680673947, 5692.715364231854, 5700.287464066992, 6234.563580549318, 6234.906476402857, 6249.0938813871735, 6256.5307601930035, 6256.562040657111, 5957.255343082114, 6012.609180403259, 6019.729112189962, 6024.638521688713, 6066.211392518944, 5841.795537156179, 5864.7947321844385, 6032.457078862835, 6060.636361818305, 6112.938870611237, 6072.0, 6119.265688117454, 6121.816345509642, 6124.448799608057, 6135.355787642234, 5812.854678633068, 5837.241158649348, 5842.328132264759, 6049.153118563405, 6134.723937422827, 4648.86053418398, 4699.107169637758, 4705.905881882343, 4707.29390591414, 4724.314974328703, 4064.695147863863, 4065.59344065597, 4150.211459822624, 4168.583141685807, 4230.0, 5955.67243801595, 5980.641161530322, 5990.520758339322, 6005.189299444519, 6024.126501657235, 6169.167162433014, 6190.3190649028575, 6212.968935155295, 6214.223222097238, 6215.223097112861, 5608.158776183605, 5644.266245388073, 5875.618084824473, 5952.434518720715, 5959.821205363846, 5256.896051829159, 5275.024120537712, 5286.022085914118, 5287.41838397776, 5292.708901010481, 6478.773242936569, 6482.189726284215, 6487.740490380426, 6489.123968264318, 6513.120728701565, 5822.883542329215, 6118.256296955346, 6143.835924498797, 6166.290876549075, 6171.9691401542705, 6222.875542489215, 6364.140840986408, 6393.104965304768, 6543.083968244545, 6552.803415897531, 6071.967765479791, 6072.423119803611, 6074.605150665193, 6076.3012253591405, 6079.574429789872, 6119.663418511846, 6181.35095814933, 6187.969060154671, 6189.102580125947, 6189.659568723763, 5688.687122208153, 5722.713864306685, 5908.645481271137, 5929.940700592939, 6016.42843929826, 5948.583599148018, 5973.462388385066, 5985.610935289366, 6011.188489553854, 6011.789587364421, 5683.602147849776, 5744.770209191585, 6002.909956350571, 6007.429294217042, 6011.9479091158, 5881.382454842351, 5888.617239879565, 5913.497352725067, 5917.171595976481, 5921.171036055042, 5819.883602327845, 5827.475527202572, 5830.416958304305, 5833.79581714638, 5834.679092649945], "value": 5643.649892508384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.5684873319673, 815.3966065111816, 849.1635738797286, 906.1844340093915, 924.3991405586372, 31361.686383136162, 41650.375244371324, 42750.99999999996, 46915.76542117293, 47105.0, 45480.545194548045, 45798.771006145005, 45827.77086114573, 45892.541074589244, 45957.310640340336, 7734.690612375498, 7936.325412339958, 9076.636934522629, 9240.630374785, 9248.075192480765, 10645.414502202375, 10887.237893347468, 10952.835707464394, 10966.725831854188, 11252.493637786278, 11026.944865275702, 11044.502997365138, 11049.723756906062, 11050.944745276262, 11100.0, 10889.782204355908, 10896.945515272451, 10919.672409827717, 10930.508127134259, 10942.617008404748, 10608.416537090457, 10625.149988000941, 10632.415217163052, 10688.46557672121, 10761.408122553257, 41655.58344416578, 41980.790096049626, 41996.37005444921, 42010.0, 42040.159196816196, 4022.7184097113213, 4056.4523789288364, 4103.938440923389, 4160.583941605845, 4197.874063778061, 30278.09165725032, 30354.392912141855, 30768.8461557693, 31191.844040779877, 31519.84240078808, 3986.142979259444, 3989.4414781930554, 4001.379786133125, 4022.9798851005557, 4128.02991297045, 232984.0, 234334.0, 236020.0, 237799.81100094563, 238544.0, 54348.72825635847, 54498.18252726212, 54684.72657636766, 54748.72625636846, 54814.72592637011, 56850.43149568451, 56907.0, 56927.715361422925, 57007.71496142493, 57041.42958570444, 14766.926165369105, 14884.776728349083, 14893.925530372278, 14922.626934326729, 14942.0, 12904.0, 13097.541586044443, 13576.864231357758, 14585.489507867174, 14724.779128313085, 14171.149731016172, 14185.361658725382, 14211.715765684628, 14307.85692143086, 14318.713625727427, 5186.507281808223, 5260.0, 5268.9736551317, 5294.0, 5367.78528858849, 960.4957397366298, 968.941863488193, 979.0405402705388, 980.9313348065709, 983.4935008470643, 28219.858900705363, 30831.8458407711, 31413.37173256522, 31450.528242076387, 32505.837470812494, 1131.6944425005202, 1140.1448913315014, 1146.9197156199152, 1160.7620437810228, 1178.092868491274, 14980.925095374454, 15150.393984240727, 15179.620509487131, 15382.230888455533, 15553.066815991077, 331184.0, 332548.0, 333714.0, 333880.0, 333973.0, 50528.494715053115, 50717.0, 50763.492365076614, 50786.23820642619, 50814.74592627013, 1415.412603769424, 1457.6355911022245, 1467.24436914991, 1470.228130231637, 1475.8450362711976, 26010.73989260083, 27137.321566960985, 27312.317192069564, 27445.176644700692, 27862.3034424141, 37654.62345376511, 37661.246775064894, 37801.81099094487, 37816.0, 37886.62113378941, 316142.0, 316150.0, 316593.0, 316771.0, 317195.0, 26887.73112268852, 27859.44281114407, 29252.853735731183, 29767.0, 29772.10683679493, 36484.63515364812, 36725.0, 37179.62820371761, 37242.0, 37315.440268395454, 27910.44179116447, 28370.290742730773, 28922.132336029954, 29006.0, 29105.27236819012, 28537.571936421387, 28803.0, 28839.8558007217, 29092.418151637274, 29190.270243243238, 32537.511937321433, 32897.67102328946, 32914.67085329116, 33044.66955330416, 33232.33535329328, 27093.86453067801, 27225.59161612617, 27286.454270914866, 27638.86180569084, 27651.86174069117, 21975.670364944857, 22369.44076398103, 22516.211932582282, 22801.087956481555, 22918.885405573532], "value": 18435.477566329802, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.55154106253644, 460.886464674437, 467.6539360872953, 470.34387030093023, 487.34452161842313, 18784.906075469622, 19415.41753747388, 21063.28812398577, 21111.68332475014, 21195.57608847822, 21526.0, 21692.457688557795, 21700.0, 21777.0, 21900.8904955475, 6488.837779055514, 6899.931000689979, 6954.513184077116, 7367.410607151442, 7621.809454763647, 4157.50109986802, 7705.306522412981, 7743.5353878767455, 7755.108162561293, 7759.379249660042, 4344.63070638996, 4532.546745325458, 7608.429367797409, 7782.299593036626, 7791.065072191345, 7562.659680314371, 7625.733099341496, 7683.039620047494, 7744.690212391498, 7759.689612415496, 7289.890651640229, 7537.208593097701, 7559.28186822251, 7561.092668879714, 7568.924310756877, 24965.750342496525, 24978.0, 25417.364565885815, 25534.87232563844, 25600.487990240275, 3072.8924487642826, 3099.4885843835964, 3192.2498212919945, 3212.7429805615493, 3217.742580593547, 15465.304061317267, 15815.762763558556, 15943.123128227942, 16109.758353624706, 16797.91601041999, 2129.946751331214, 2146.8389870759597, 2193.6270833958106, 2252.831037672181, 2272.6704627829035, 104238.47880760624, 109128.81742365108, 109634.0, 111032.0, 115792.0, 14412.469082485808, 16267.837321626632, 18123.54691132706, 18303.45089647313, 19098.90450547766, 32620.347593048005, 32629.347413051604, 32632.83683581567, 32733.345333093683, 33297.334053318795, 10252.179825613934, 10364.792704145875, 10499.68500944973, 10636.787264254672, 10725.034746872663, 8659.220670139717, 8730.301575873915, 8748.65005399777, 8919.73240802777, 8931.553422328858, 9042.412243204171, 9162.404443711137, 9500.334976551714, 9577.616895324249, 9615.471149086867, 3350.3466823969093, 3449.4308439107267, 3670.632936706308, 3769.453429252743, 3792.4311353297226, 959.6353385713384, 970.427447805798, 972.3485264872411, 976.6581696406201, 984.4388698441819, 20423.0, 21332.466688332916, 23054.884725576263, 23365.299041028797, 23547.175848845207, 1098.2806261898309, 1099.5326986031064, 1110.134095405585, 1113.92202545821, 1123.7920984617872, 10871.619493317854, 11581.826272605918, 11604.30374177552, 11648.534058637559, 11790.94104529472, 431377.0, 435294.0, 619076.0, 629921.0, 635279.0, 103774.48112759388, 121908.0, 122119.0, 122282.38858805649, 123945.38027309986, 1300.681333073403, 1333.2533781082625, 1373.4368908747365, 1385.300423286234, 1388.1809732258016, 13842.930785346009, 19356.128974196476, 19439.70840437366, 19521.511962201057, 19691.42024530675, 49781.50218497769, 49782.0, 50029.249561255885, 50292.74853625709, 50936.74531627318, 59525.0, 59792.70103649454, 63645.3635463658, 63875.68062159659, 64722.352776471635, 7806.141324454192, 10969.286996345212, 12065.51737930508, 12436.813447798471, 12464.813027804772, 13956.2324072177, 13983.650408739863, 14131.929340353232, 14219.502317419254, 14393.208373539137, 11919.106067044833, 12139.150259481752, 12277.877221228031, 12300.261984280973, 12560.497580096693, 10794.082502987334, 11480.885191147981, 11807.586734464252, 11820.0, 11902.464389102339, 12450.750984980068, 12554.811677824657, 12661.430235639602, 12683.619491415273, 12689.365531723191, 12652.493900244255, 12755.80866287025, 12864.549740759028, 12900.741985160432, 13152.671183220496, 12151.513939442324, 12181.33002684861, 12287.93856030714, 12306.507739690313, 12689.555865544662], "value": 11443.702868298125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.3777670043637, 1551.56556164274, 1555.6733086051936, 1565.8590726834589, 1576.59008657749, 10351.378917264969, 11126.332420054803, 11131.220814542985, 11133.10935125188, 11135.220534562584, 10378.221633377489, 10648.680539583826, 10671.0, 10680.679579612624, 10687.145028397728, 2400.147947478646, 2463.002483993985, 2473.356927198932, 2482.056818409002, 2483.776460118589, 2378.327921271888, 2404.2546810488802, 2423.1761201191593, 2434.7686969737933, 2443.1937460637946, 2380.5238952209543, 2439.85360878347, 2448.204333591581, 2449.0326321103153, 2449.191766716979, 2305.5619432307976, 2347.0259842165483, 2353.788159065684, 2359.469119448119, 2379.250536081146, 2317.084751523139, 2343.7539058398966, 2349.988250058756, 2352.0591763294647, 2355.140373763564, 11091.112710983101, 11268.436578171058, 11282.379469129195, 11283.43582820864, 11322.716932076764, 5743.4256574342235, 5885.882282354329, 5886.764529418818, 5899.439553242478, 5904.704764761745, 3290.3583801158784, 3322.5016247562817, 3350.3801796667694, 3355.966440335614, 3409.9147521311916, 1252.2486508095162, 1282.8396450443695, 1312.842458904928, 1329.2489743295007, 1388.2919710947388, 14060.648483787885, 14413.063150895157, 15007.399704011827, 15187.696246075127, 15252.161131137784, 4858.854234372974, 4978.278149668277, 5074.314967479417, 5081.364829396325, 5092.6435149539175, 13898.305084745722, 13902.443902243796, 13905.652358690912, 13909.652258693613, 13916.51292204768, 6197.659128747962, 6204.534659900435, 6214.098955651496, 6222.3466536013975, 6228.906566401508, 5427.701476418835, 5497.065498865202, 5497.532709719639, 5566.888662226814, 5583.357913839879, 4349.151915376535, 4426.75652839097, 4451.732896026248, 4501.099780044005, 4509.436320459942, 1157.0974639780984, 1200.7418405042959, 1215.4044518186024, 1217.5069097015723, 1218.8171774233758, 1046.926715129949, 1048.9737756556146, 1050.5377633841085, 1054.6572363981736, 1057.9947100264449, 6651.700673469705, 6875.3812156906115, 6900.309969003059, 6973.65131743421, 6987.441004719611, 1046.68076236747, 1058.772363941756, 1065.3980501016902, 1106.878243393226, 1111.1000089927186, 4673.275642275453, 4760.666753327234, 4800.4719480857075, 4846.151923413388, 4864.318995340655, 13935.303234838217, 14345.0, 14423.0, 14462.20457874806, 14490.565283041526, 14204.076735012191, 14208.502702405573, 14499.202543860189, 14517.78223326651, 14529.0, 9075.68402581622, 10793.946030269799, 10954.287971281841, 10966.616168434066, 10995.450227488594, 6608.570442921195, 7283.2352602975925, 7461.850762984818, 7580.204078571671, 7607.429442791923, 11837.881621183678, 11845.940770296093, 11858.16992810495, 11952.34262115592, 12227.205231659913, 12655.367231638565, 12661.87338126607, 12705.237685738515, 12762.808557871454, 12801.61595152147, 9489.572969216264, 9590.184834289164, 9662.855057174007, 9681.951590242004, 9713.757156071155, 10309.690709278733, 10394.688159355232, 10614.8407773885, 10623.575056997943, 10661.253712240068, 9121.270298376247, 9153.725388238363, 9168.587413566538, 9297.256219502558, 9327.486988215713, 8970.192682658331, 9051.18539331437, 9106.635734570807, 9193.494357810385, 9222.40054396462, 8259.83480330402, 8271.172882711922, 8314.168583141638, 8355.12271211514, 8355.623996920032, 6143.723532440961, 6176.938230617637, 6229.750809967551, 6296.118543403835, 6366.5225108118, 6015.548833837567, 6043.244594425697, 6084.726187321669, 6091.482224011009, 6181.9690901547], "value": 5371.572086549495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.0759375576852, 419.9517055538613, 436.4478934148301, 438.9626881715054, 440.6959198153272, 5219.217117432387, 5222.582193424527, 5312.379724184128, 5319.973400132999, 5339.332583427076, 5120.667156634816, 5152.789094562775, 5168.837011672372, 5182.792688292464, 5187.455317191688, 4260.978695106528, 4314.525402205755, 4412.227860124482, 4412.404325416076, 4434.647432533076, 4396.252637051709, 4402.779861006953, 4404.7357158570585, 4425.712328698641, 4446.888827779299, 4402.427684401039, 4436.866893993185, 4443.244648409778, 4494.011317510142, 4500.234960056799, 4387.254166791653, 4414.823407063714, 4439.223135951195, 4472.239719247703, 4485.439320084989, 4118.940529735132, 4134.793260336971, 4138.0, 4168.291000689703, 4189.413482112506, 5122.33409656746, 5126.641135120543, 5135.717535535544, 5174.97412512935, 5187.844364669066, 4822.951770482286, 5064.468230835746, 5067.695938243717, 5132.689415327093, 5141.871453213662, 5406.405295417501, 5411.618887689404, 5447.428020057877, 5457.290552228224, 5480.945190548123, 4526.207913615104, 4581.144636422221, 4585.747783871886, 4606.516315786861, 4622.722636641813, 5460.34475862895, 5622.803201887914, 5637.295338082739, 5663.858403539944, 5686.687232202227, 4677.0, 4690.788914498856, 4694.342792009122, 4706.152892479318, 4725.904532531197, 4774.522547745198, 4784.617230621611, 4787.928181077217, 4791.233402655628, 4797.56821886032, 4874.951250487521, 4989.825356112518, 4999.975000124976, 5044.9495505045215, 5091.949080509222, 5394.514493695587, 5394.541463975527, 5402.972985135128, 5439.972800136054, 5472.616916815864, 1643.86027187688, 1647.8516933475805, 1659.1372486307052, 1664.1263336748304, 1666.3586367428074, 1243.0055955235775, 1255.8241846141548, 1256.918300310477, 1273.611548477723, 1290.6512694234548, 5389.766140315857, 5422.8373148805595, 5509.393966663663, 5530.364008139035, 5594.440555944454, 5610.298712660918, 5633.239512665819, 5638.2670252866865, 5665.461781130786, 5690.3456102548735, 5145.897082058338, 5357.35711714589, 5431.82238390546, 5435.83692489226, 5442.945570544244, 2941.6175897133235, 2952.5571164325524, 2959.4377068356944, 2984.0, 3009.3981203759336, 5743.712814359265, 5974.297325262366, 6013.7895173669585, 6026.638401695912, 6039.7282122304605, 5527.55779537636, 5756.510696590753, 5766.059309752057, 5784.3926387729525, 5799.420057994167, 5767.596268261265, 5778.884422311614, 5917.822465326047, 5921.276212942095, 5942.821715348633, 5585.972070139624, 5595.328560572757, 5624.746886390204, 5638.421242052232, 5663.4053424391495, 5279.419263881046, 5341.732913354394, 5523.972380138234, 5555.8888822222525, 5589.273394458694, 5846.824595262149, 5850.912236316543, 5859.974504461788, 5909.7838310633515, 5926.614770039933, 4577.656675749266, 4657.231556793226, 4675.649326300473, 4716.976415117902, 4788.784504697227, 5624.887502250014, 5648.85877853057, 5651.773929042956, 5655.971720141373, 5660.462256085665, 5413.864653383697, 5476.890462190813, 5479.315085614298, 5489.039418101896, 5508.531774799027, 5354.411014788292, 5454.590905682169, 5497.340319161726, 5510.283663123929, 5547.41752116022, 5423.7830486780085, 5449.809256675997, 5476.72616369172, 5477.287952566141, 5480.260164877691, 5264.236685680631, 5406.594065640752, 5450.427705090909, 5493.972530137484, 5570.582206334622, 5363.823909926939, 5379.623426360274, 5390.51485366319, 5400.594955378284, 5439.225994742789], "value": 4436.147589351614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.3433279495842, 852.0712423458431, 853.2107800284737, 855.1832999485492, 877.0308808766317, 17203.913980430098, 18206.544836379097, 18299.634007319863, 18313.81686183138, 18317.45047648571, 15707.136107514083, 15797.0, 16889.23998420074, 17137.0, 17194.914025429855, 833.2542374574751, 898.6540182029901, 899.1053901368115, 903.5888670654837, 907.1744712311797, 909.4316052467208, 909.5088652127843, 912.1061359867334, 912.6030176873048, 913.0458670689112, 944.7354740672588, 945.0832692288503, 946.3044662173297, 946.9337146399755, 947.2611363136764, 923.6951805904102, 933.10421994885, 933.2207606648457, 933.444600462727, 933.7572231219898, 684.6542496039468, 692.6744430117836, 692.705600119947, 692.8718187135396, 693.3724978894109, 17996.55008624795, 18085.7287140693, 18200.817991820044, 18549.0, 18711.34510292147, 16081.195940202942, 16107.355705771755, 16231.350745970147, 16546.338146474125, 17035.0, 13066.412011459412, 13255.602331930058, 13445.731085378335, 13999.580012599637, 14002.966603239336, 4077.5506970849246, 4110.753354798691, 4141.295979683461, 4184.456020717287, 4270.829166833323, 91829.0, 92039.53980230055, 92407.0, 93088.53455732678, 95613.0, 11501.42492875353, 11736.647900562997, 11882.049436045096, 11932.761344773056, 12190.268583884996, 20663.41814115118, 21707.674384884238, 21746.673799893015, 23103.653445198335, 23316.7668323318, 8787.297016238686, 9181.357304988587, 9186.127317904788, 9266.305027122859, 9335.626574937063, 5097.923531147036, 5098.847034588968, 5173.430922598511, 5232.1628539433505, 5318.149096144598, 3777.112378591029, 3881.6506514413836, 3884.941725874114, 3885.203533275672, 3887.475190849256, 634.2642534659773, 642.6882961763541, 645.7191121861911, 649.9642519661464, 651.1274891645218, 818.7912082418945, 849.6813694864302, 857.2327766648939, 880.018779061342, 880.4805164952709, 10810.729731756612, 10833.636621979484, 10943.945280273707, 11032.0, 11739.88260117405, 714.0, 731.2960801332881, 737.1080991999634, 765.9080910290689, 910.6994691751706, 5469.425710300361, 5697.259356283656, 5718.285214348207, 6025.216721826135, 6044.123602077674, 72605.6369718148, 73196.0, 81867.5906620475, 84413.0, 88664.0, 69921.0, 71018.2898171022, 74041.62979185069, 76009.57956891954, 76814.0, 65597.0, 65820.34179658238, 65949.34050659432, 66475.0, 66640.66679666571, 11369.658910232707, 11498.597549085742, 11690.70773230676, 11706.414679265832, 11731.530738770354, 46753.0, 46945.765271173426, 47178.76410617925, 47849.28226076542, 47974.040519188726, 51257.0, 51535.48464515307, 51662.74168629133, 52885.47114528959, 53123.0, 14354.49759258421, 14421.0, 14427.42290308376, 14542.345594448487, 14784.33470493852, 15686.0, 15936.36254549805, 16251.837481625033, 16504.092274924995, 16559.0, 14902.85097149058, 15252.466163684217, 15275.541733748005, 15967.920160399124, 15991.840081599035, 14108.788368174692, 14109.929450352682, 14134.646633834236, 14255.714885702435, 14902.329395177027, 13389.799153012907, 13538.255395953318, 13653.385597648328, 13807.51673691416, 14172.362243699265, 10007.399556026661, 10095.091441770275, 10179.0, 10336.0697537222, 10591.89408105909, 10996.034916554456, 11223.214374993671, 11247.88752112501, 11286.492107855001, 11311.264767790068], "value": 7932.61993884853, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 113.0, 112.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 119.0, 122.0, 154.0, 117.0, 121.0, 115.0, 123.0, 137.0, 115.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 164.0, 162.0, 162.0, 161.0, 160.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 108.0, 76.0, 75.0, 75.0, 75.0, 93.0, 86.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 82.0, 82.0, 82.0, 96.0, 83.0, 82.0, 106.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 54.0, 55.0, 58.0, 54.0, 55.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 76.0, 76.0, 76.0, 77.0, 76.0, 79.0, 75.0, 82.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 120.0, 123.0, 121.0, 122.0, 120.0, 128.0, 159.0, 118.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 156.0, 158.0, 156.0, 157.0, 154.0, 156.0, 159.0, 156.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 64.0, 59.0, 58.0, 60.0, 62.0, 60.0, 60.0, 61.0], "value": 60.8, "unit": "score"}]}]} 08:56:22 INFO - Return code: 0 08:56:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:56:22 ERROR - # TBPL SUCCESS # 08:56:22 INFO - Running post-action listener: _resource_record_post_action 08:56:22 INFO - [mozharness: 2017-04-17 15:56:22.184617Z] Finished run-tests step (success) 08:56:22 INFO - Running post-run listener: _resource_record_post_run 08:56:22 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 363651072; Read time: 28; Write time: 207096 08:56:22 INFO - TinderboxPrint: CPU usage
13.1% 08:56:22 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 08:56:22 INFO - TinderboxPrint: I/O write bytes / time
363,651,072 / 207,096 08:56:22 INFO - TinderboxPrint: CPU idle
8,271.7 (86.9%) 08:56:22 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 08:56:22 INFO - TinderboxPrint: Swap in / out
0 / 0 08:56:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110067712; Read time: 0; Write time: 86452 08:56:22 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252514304; Read time: 28; Write time: 120584 08:56:22 INFO - Running post-run listener: _upload_blobber_files 08:56:22 INFO - Blob upload gear active. 08:56:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:22 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 08:56:22 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:56:22 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:56:23 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:56:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:56:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:24 INFO - (blobuploader) - INFO - Done attempting. 08:56:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:56:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:56:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:25 INFO - (blobuploader) - INFO - Done attempting. 08:56:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:56:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:28 INFO - (blobuploader) - INFO - Done attempting. 08:56:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:56:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:29 INFO - (blobuploader) - INFO - Done attempting. 08:56:29 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:29 INFO - Return code: 0 08:56:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/dd6aa83a3bdaf306017f6d697960c17071562d1e0a83f527c8f98723d8d926a1af7bd8c360b3d887d932b60eff79d1063abe1e2eaa8d447be63a0017ce9b7700", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8134af408a694be7fdcd6161439b2b880ebf496de0240527548d40b134597abc4cc9f440ab5a880c8c2314cabd30de142eff201ff96c749170bb443c39c625ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/da4065a8585fde8f5fb71f72ee1b093033310dc3359a75bda7aa4f34b5e7f086ce41ff44d5c537a5af1f4dd3ee14759c03a94f103aae73329cf8cfc5ff38b536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4b4db19fbedcad0714426c6269cb671ed3bd6208557abc84b5b2b3c5db3c74195c8a662d43c1512a0ba24d1685ede73006a67684f47ff8a2ce4ffacb1c3dabc5"} 08:56:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:29 INFO - Contents: 08:56:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/dd6aa83a3bdaf306017f6d697960c17071562d1e0a83f527c8f98723d8d926a1af7bd8c360b3d887d932b60eff79d1063abe1e2eaa8d447be63a0017ce9b7700", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8134af408a694be7fdcd6161439b2b880ebf496de0240527548d40b134597abc4cc9f440ab5a880c8c2314cabd30de142eff201ff96c749170bb443c39c625ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/da4065a8585fde8f5fb71f72ee1b093033310dc3359a75bda7aa4f34b5e7f086ce41ff44d5c537a5af1f4dd3ee14759c03a94f103aae73329cf8cfc5ff38b536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4b4db19fbedcad0714426c6269cb671ed3bd6208557abc84b5b2b3c5db3c74195c8a662d43c1512a0ba24d1685ede73006a67684f47ff8a2ce4ffacb1c3dabc5"} 08:56:29 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:29 INFO - Copying logs to upload dir... 08:56:29 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.699565 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-17 08:56:28.618403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 08:56:28.621751) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977 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-Non-PGO/sha512/dd6aa83a3bdaf306017f6d697960c17071562d1e0a83f527c8f98723d8d926a1af7bd8c360b3d887d932b60eff79d1063abe1e2eaa8d447be63a0017ce9b7700", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8134af408a694be7fdcd6161439b2b880ebf496de0240527548d40b134597abc4cc9f440ab5a880c8c2314cabd30de142eff201ff96c749170bb443c39c625ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/da4065a8585fde8f5fb71f72ee1b093033310dc3359a75bda7aa4f34b5e7f086ce41ff44d5c537a5af1f4dd3ee14759c03a94f103aae73329cf8cfc5ff38b536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4b4db19fbedcad0714426c6269cb671ed3bd6208557abc84b5b2b3c5db3c74195c8a662d43c1512a0ba24d1685ede73006a67684f47ff8a2ce4ffacb1c3dabc5"} build_url:https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/Md3QxUa9S42b61RsF7TKlQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/dd6aa83a3bdaf306017f6d697960c17071562d1e0a83f527c8f98723d8d926a1af7bd8c360b3d887d932b60eff79d1063abe1e2eaa8d447be63a0017ce9b7700", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8134af408a694be7fdcd6161439b2b880ebf496de0240527548d40b134597abc4cc9f440ab5a880c8c2314cabd30de142eff201ff96c749170bb443c39c625ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/da4065a8585fde8f5fb71f72ee1b093033310dc3359a75bda7aa4f34b5e7f086ce41ff44d5c537a5af1f4dd3ee14759c03a94f103aae73329cf8cfc5ff38b536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4b4db19fbedcad0714426c6269cb671ed3bd6208557abc84b5b2b3c5db3c74195c8a662d43c1512a0ba24d1685ede73006a67684f47ff8a2ce4ffacb1c3dabc5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 08:56:28.646966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:56:28.647294) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1492443335.242527-1591164977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:56:28.731601) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 08:56:28.731924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 08:56:28.732237) ========= ========= Total master_lag: 0.16 =========