builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-075 starttime: 1492331867.98 results: success (0) revision: 9da0d3c7fc50cc406d66fc1f286a5cf2254dd51e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:47.983273) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:47.983727) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:47.984004) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:47.999022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:47.999345) ========= 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=fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-16 01:37:48-- 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% 110M=0s 2017-04-16 01:37:48 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101784 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:48.118100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:48.118392) ========= 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=fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014734 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:48.169065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:48.169535) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9da0d3c7fc50cc406d66fc1f286a5cf2254dd51e --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 9da0d3c7fc50cc406d66fc1f286a5cf2254dd51e --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=fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-16 01:37:48,813 truncating revision to first 12 chars 2017-04-16 01:37:48,813 Setting DEBUG logging. 2017-04-16 01:37:48,813 attempt 1/10 2017-04-16 01:37:48,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9da0d3c7fc50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-16 01:37:49,311 unpacking tar archive at: mozilla-aurora-9da0d3c7fc50/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849237 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:49.033053) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:49.033419) ========= script_repo_revision: 9da0d3c7fc50cc406d66fc1f286a5cf2254dd51e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:49.033790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:49.034057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-16 01:37:49.047463) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-16 01:37:49.047758) ========= /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=fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:37:49 INFO - MultiFileLogger online at 20170416 01:37:49 in /builds/slave/test 01:37:49 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 01:37:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:37:49 INFO - {'append_to_log': False, 01:37:49 INFO - 'base_work_dir': '/builds/slave/test', 01:37:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:37:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:37:49 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:37:49 INFO - 'buildbot_json_path': 'buildprops.json', 01:37:49 INFO - 'config_files': ('talos/linux_config.py',), 01:37:49 INFO - 'default_actions': ('clobber', 01:37:49 INFO - 'read-buildbot-config', 01:37:49 INFO - 'download-and-extract', 01:37:49 INFO - 'populate-webroot', 01:37:49 INFO - 'create-virtualenv', 01:37:49 INFO - 'install', 01:37:49 INFO - 'run-tests'), 01:37:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:37:49 INFO - 'download_minidump_stackwalk': True, 01:37:49 INFO - 'download_symbols': 'ondemand', 01:37:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:37:49 INFO - 'tooltool.py': '/tools/tooltool.py', 01:37:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:37:49 INFO - '/tools/misc-python/virtualenv.py')}, 01:37:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:37:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:37:49 INFO - 'gecko_profile': False, 01:37:49 INFO - 'gecko_profile_interval': 0, 01:37:49 INFO - 'installer_path': 'installer.exe', 01:37:49 INFO - 'log_level': 'info', 01:37:49 INFO - 'log_name': 'talos', 01:37:49 INFO - 'log_to_console': True, 01:37:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:37:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:37:49 INFO - 'opt_config_files': (), 01:37:49 INFO - 'pip_index': False, 01:37:49 INFO - 'suite': 'dromaeojs', 01:37:49 INFO - 'system_bits': '32', 01:37:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:37:49 INFO - 'title': 'talos-linux64-ix-075', 01:37:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:37:49 INFO - 'use_talos_json': True, 01:37:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:37:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:37:49 INFO - 'work_dir': 'build'} 01:37:49 INFO - [mozharness: 2017-04-16 08:37:49.790536Z] Running clobber step. 01:37:49 INFO - Running pre-action listener: _resource_record_pre_action 01:37:49 INFO - Running main action method: clobber 01:37:49 INFO - rmtree: /builds/slave/test/build 01:37:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:37:50 INFO - Running post-action listener: _resource_record_post_action 01:37:50 INFO - [mozharness: 2017-04-16 08:37:50.718047Z] Finished clobber step (success) 01:37:50 INFO - [mozharness: 2017-04-16 08:37:50.718148Z] Running read-buildbot-config step. 01:37:50 INFO - Running pre-action listener: _resource_record_pre_action 01:37:50 INFO - Running main action method: read_buildbot_config 01:37:50 INFO - Using buildbot properties: 01:37:50 INFO - { 01:37:50 INFO - "project": "", 01:37:50 INFO - "product": "firefox", 01:37:50 INFO - "who": "nobody@mozilla.org", 01:37:50 INFO - "installer_path": "public/build/target.tar.bz2", 01:37:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:37:50 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:37:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 01:37:50 INFO - "stage_platform": "linux64", 01:37:50 INFO - "basedir": "/builds/slave/test", 01:37:50 INFO - "buildnumber": 129, 01:37:50 INFO - "platform": "ubuntu64_hw", 01:37:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:37:50 INFO - "slavebuilddir": "test", 01:37:50 INFO - "taskId": "QHzJIYplRyyKGWXQ-Co1yQ", 01:37:50 INFO - "branch": "mozilla-aurora", 01:37:50 INFO - "script_repo_revision": "production", 01:37:50 INFO - "revision": "9da0d3c7fc50cc406d66fc1f286a5cf2254dd51e", 01:37:50 INFO - "slavename": "talos-linux64-ix-075", 01:37:50 INFO - "repo_path": "releases/mozilla-aurora" 01:37:50 INFO - } 01:37:50 INFO - Finding installer, test and symbols from parent task. 01:37:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QHzJIYplRyyKGWXQ-Co1yQ'}, attempt #1 01:37:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QHzJIYplRyyKGWXQ-Co1yQ'}, attempt #1 01:37:51 INFO - Task dependencies: IfTaqtP1QSKf74Efh2AlUw 01:37:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw'}, attempt #1 01:37:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.tar.bz2 01:37:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/test_packages.json 01:37:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.crashreporter-symbols.zip 01:37:52 INFO - Running post-action listener: _resource_record_post_action 01:37:52 INFO - [mozharness: 2017-04-16 08:37:52.062537Z] Finished read-buildbot-config step (success) 01:37:52 INFO - [mozharness: 2017-04-16 08:37:52.062779Z] Running download-and-extract step. 01:37:52 INFO - Running pre-action listener: _resource_record_pre_action 01:37:52 INFO - Running main action method: download_and_extract 01:37:52 INFO - mkdir: /builds/slave/test/build/tests 01:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:52 INFO - trying https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.test_packages.json 01:37:52 INFO - Downloading https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:37:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:37:52 INFO - Downloaded 896 bytes. 01:37:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:37:52 INFO - Using the following test package requirements: 01:37:52 INFO - {u'common': [u'target.common.tests.zip'], 01:37:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:37:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:37:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:37:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:37:52 INFO - u'mozbase': [u'target.common.tests.zip'], 01:37:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:37:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:37:52 INFO - u'web-platform': [u'target.common.tests.zip', 01:37:52 INFO - u'target.web-platform.tests.zip'], 01:37:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:37:52 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:37:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.common.tests.zip 01:37:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:37:52 INFO - Fetch https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.common.tests.zip into memory 01:37:54 INFO - Expected file size: 59542478 01:37:54 INFO - Obtained file size: 59542478 01:38:04 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:38:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.common.tests.zip 01:38:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:38:04 INFO - Fetch https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.common.tests.zip into memory 01:38:05 INFO - Expected file size: 59542478 01:38:05 INFO - Obtained file size: 59542478 01:38:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.talos.tests.zip 01:38:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:38:16 INFO - Fetch https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.talos.tests.zip into memory 01:38:17 INFO - Expected file size: 14404424 01:38:17 INFO - Obtained file size: 14404424 01:38: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')]} 01:38:17 INFO - trying https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.tar.bz2 01:38:17 INFO - Downloading https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:38:19 INFO - Downloaded 66736587 bytes. 01:38:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.tar.bz2 01:38:19 INFO - mkdir: /builds/slave/test/properties 01:38:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:38:19 INFO - Writing to file /builds/slave/test/properties/build_url 01:38:19 INFO - Contents: 01:38:19 INFO - build_url:https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.tar.bz2 01:38:19 INFO - Running post-action listener: _resource_record_post_action 01:38:19 INFO - Running post-action listener: set_extra_try_arguments 01:38:19 INFO - [mozharness: 2017-04-16 08:38:19.981522Z] Finished download-and-extract step (success) 01:38:19 INFO - [mozharness: 2017-04-16 08:38:19.981619Z] Running populate-webroot step. 01:38:19 INFO - Running pre-action listener: _resource_record_pre_action 01:38:19 INFO - Running main action method: populate_webroot 01:38:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:38:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:38:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:38:19 INFO - '--tppagecycles', 01:38:19 INFO - '7'], 01:38:19 INFO - 'tests': ['tsvgm']}}, 01:38:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:38:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:38:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:38:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:38:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:38:19 INFO - 'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:38:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:38:19 INFO - 'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['damp', 'tps']}, 01:38:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:38:19 INFO - 'tests': ['damp', 'tps']}, 01:38:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['dromaeo_dom']}, 01:38:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:38:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['basic_compositor_video']}, 01:38:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:38:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['a11yr', 01:38:19 INFO - 'ts_paint', 01:38:19 INFO - 'tpaint', 01:38:19 INFO - 'sessionrestore', 01:38:19 INFO - 'sessionrestore_no_auto_restore', 01:38:19 INFO - 'tabpaint']}, 01:38:19 INFO - 'other-e10s': {'tests': ['a11yr', 01:38:19 INFO - 'ts_paint', 01:38:19 INFO - 'tpaint', 01:38:19 INFO - 'sessionrestore', 01:38:19 INFO - 'sessionrestore_no_auto_restore', 01:38:19 INFO - 'tabpaint']}, 01:38:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:38:19 INFO - 'ts_paint', 01:38:19 INFO - 'tpaint', 01:38:19 INFO - 'sessionrestore', 01:38:19 INFO - 'sessionrestore_no_auto_restore', 01:38:19 INFO - 'tabpaint']}, 01:38:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:38:19 INFO - 'ts_paint', 01:38:19 INFO - 'tpaint', 01:38:19 INFO - 'sessionrestore', 01:38:19 INFO - 'sessionrestore_no_auto_restore', 01:38:19 INFO - 'tabpaint']}, 01:38:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['a11yr', 01:38:19 INFO - 'ts_paint', 01:38:19 INFO - 'tpaint', 01:38:19 INFO - 'sessionrestore', 01:38:19 INFO - 'sessionrestore_no_auto_restore', 01:38:19 INFO - 'tabpaint']}, 01:38:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['a11yr', 01:38:19 INFO - 'ts_paint', 01:38:19 INFO - 'tpaint', 01:38:19 INFO - 'sessionrestore', 01:38:19 INFO - 'sessionrestore_no_auto_restore', 01:38:19 INFO - 'tabpaint']}, 01:38:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['tsvgx', 01:38:19 INFO - 'tsvgr_opacity', 01:38:19 INFO - 'tart', 01:38:19 INFO - 'tscrollx', 01:38:19 INFO - 'cart', 01:38:19 INFO - 'tsvg_static']}, 01:38:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:38:19 INFO - 'tsvgr_opacity', 01:38:19 INFO - 'tart', 01:38:19 INFO - 'tscrollx', 01:38:19 INFO - 'cart', 01:38:19 INFO - 'tsvg_static']}, 01:38:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:38:19 INFO - 'talos_options': ['--disable-e10s'], 01:38:19 INFO - 'tests': ['tp5o']}, 01:38:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:38:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:38:19 INFO - 'talos_options': ['--disable-e10s', 01:38:19 INFO - '--xperf_path', 01:38:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:19 INFO - 'tests': ['tp5n']}, 01:38:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:38:19 INFO - 'talos_options': ['--xperf_path', 01:38:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:19 INFO - 'tests': ['tp5n']}}, 01:38:19 INFO - 'talos.zip': {'path': '', 01:38:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:38:19 INFO - Running post-action listener: _resource_record_post_action 01:38:19 INFO - [mozharness: 2017-04-16 08:38:19.994807Z] Finished populate-webroot step (success) 01:38:19 INFO - [mozharness: 2017-04-16 08:38:19.994899Z] Running create-virtualenv step. 01:38:19 INFO - Running pre-action listener: _resource_record_pre_action 01:38:19 INFO - Running main action method: create_virtualenv 01:38:19 INFO - Creating virtualenv /builds/slave/test/build/venv 01:38:19 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 01:38:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:38:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:38:20 INFO - Using real prefix '/usr' 01:38:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:38:20 INFO - Installing distribute.............................................................................................................................................................................................done. 01:38:22 INFO - Installing pip.................done. 01:38:22 INFO - Return code: 0 01:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:38:22 INFO - Reading from file tmpfile_stdout 01:38:22 INFO - Output received: 01:38:22 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) 01:38:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:38:22 INFO - Using env: {'DISPLAY': ':0', 01:38:22 INFO - 'HOME': '/home/cltbld', 01:38:22 INFO - 'LANG': 'en_US.UTF-8', 01:38:22 INFO - 'LANGUAGE': 'en_US:en', 01:38:22 INFO - 'LOGNAME': 'cltbld', 01:38:22 INFO - 'MAIL': '/var/mail/cltbld', 01:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:22 INFO - 'MOZ_NO_REMOTE': '1', 01:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:22 INFO - 'NO_EM_RESTART': '1', 01:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:22 INFO - 'PWD': '/builds/slave/test', 01:38:22 INFO - 'SHELL': '/bin/bash', 01:38:22 INFO - 'SHLVL': '1', 01:38:22 INFO - 'TERM': 'linux', 01:38:22 INFO - 'TMOUT': '86400', 01:38:22 INFO - 'USER': 'cltbld', 01:38:22 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:22 INFO - '_': '/tools/buildbot/bin/python'} 01:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:22 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 01:38:22 INFO - Cleaning up... 01:38:22 INFO - Return code: 0 01:38:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:38:23 INFO - Using env: {'DISPLAY': ':0', 01:38:23 INFO - 'HOME': '/home/cltbld', 01:38:23 INFO - 'LANG': 'en_US.UTF-8', 01:38:23 INFO - 'LANGUAGE': 'en_US:en', 01:38:23 INFO - 'LOGNAME': 'cltbld', 01:38:23 INFO - 'MAIL': '/var/mail/cltbld', 01:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:23 INFO - 'MOZ_NO_REMOTE': '1', 01:38:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:23 INFO - 'NO_EM_RESTART': '1', 01:38:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:23 INFO - 'PWD': '/builds/slave/test', 01:38:23 INFO - 'SHELL': '/bin/bash', 01:38:23 INFO - 'SHLVL': '1', 01:38:23 INFO - 'TERM': 'linux', 01:38:23 INFO - 'TMOUT': '86400', 01:38:23 INFO - 'USER': 'cltbld', 01:38:23 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:23 INFO - '_': '/tools/buildbot/bin/python'} 01:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:23 INFO - Downloading/unpacking psutil>=3.1.1 01:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:38:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:25 INFO - Installing collected packages: psutil 01:38:25 INFO - Running setup.py install for psutil 01:38:25 INFO - building 'psutil._psutil_linux' extension 01:38:25 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 01:38:25 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 01:38:25 INFO - building 'psutil._psutil_posix' extension 01:38:25 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 01:38:25 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 01:38:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:25 INFO - Successfully installed psutil 01:38:25 INFO - Cleaning up... 01:38:25 INFO - Return code: 0 01:38:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:38:25 INFO - Using env: {'DISPLAY': ':0', 01:38:25 INFO - 'HOME': '/home/cltbld', 01:38:25 INFO - 'LANG': 'en_US.UTF-8', 01:38:25 INFO - 'LANGUAGE': 'en_US:en', 01:38:25 INFO - 'LOGNAME': 'cltbld', 01:38:25 INFO - 'MAIL': '/var/mail/cltbld', 01:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:25 INFO - 'MOZ_NO_REMOTE': '1', 01:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:25 INFO - 'NO_EM_RESTART': '1', 01:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:25 INFO - 'PWD': '/builds/slave/test', 01:38:25 INFO - 'SHELL': '/bin/bash', 01:38:25 INFO - 'SHLVL': '1', 01:38:25 INFO - 'TERM': 'linux', 01:38:25 INFO - 'TMOUT': '86400', 01:38:25 INFO - 'USER': 'cltbld', 01:38:25 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:25 INFO - '_': '/tools/buildbot/bin/python'} 01:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:38:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:38:28 INFO - Installing collected packages: mozsystemmonitor 01:38:28 INFO - Running setup.py install for mozsystemmonitor 01:38:28 INFO - Successfully installed mozsystemmonitor 01:38:28 INFO - Cleaning up... 01:38:28 INFO - Return code: 0 01:38:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:38:28 INFO - Using env: {'DISPLAY': ':0', 01:38:28 INFO - 'HOME': '/home/cltbld', 01:38:28 INFO - 'LANG': 'en_US.UTF-8', 01:38:28 INFO - 'LANGUAGE': 'en_US:en', 01:38:28 INFO - 'LOGNAME': 'cltbld', 01:38:28 INFO - 'MAIL': '/var/mail/cltbld', 01:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:28 INFO - 'MOZ_NO_REMOTE': '1', 01:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:28 INFO - 'NO_EM_RESTART': '1', 01:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:28 INFO - 'PWD': '/builds/slave/test', 01:38:28 INFO - 'SHELL': '/bin/bash', 01:38:28 INFO - 'SHLVL': '1', 01:38:28 INFO - 'TERM': 'linux', 01:38:28 INFO - 'TMOUT': '86400', 01:38:28 INFO - 'USER': 'cltbld', 01:38:28 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:28 INFO - '_': '/tools/buildbot/bin/python'} 01:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:28 INFO - Downloading/unpacking jsonschema==2.5.1 01:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:38:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:30 INFO - Downloading functools32-3.2.3-2.tar.gz 01:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:38:30 INFO - warning: no files found matching '*.txt' 01:38:30 INFO - no previously-included directories found matching 'build' 01:38:30 INFO - no previously-included directories found matching 'dist' 01:38:30 INFO - no previously-included directories found matching '.git*' 01:38:30 INFO - Installing collected packages: jsonschema, functools32 01:38:30 INFO - Running setup.py install for functools32 01:38:30 INFO - warning: no files found matching '*.txt' 01:38:30 INFO - no previously-included directories found matching 'build' 01:38:30 INFO - no previously-included directories found matching 'dist' 01:38:30 INFO - no previously-included directories found matching '.git*' 01:38:30 INFO - Successfully installed jsonschema functools32 01:38:30 INFO - Cleaning up... 01:38:30 INFO - Return code: 0 01:38:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:38:30 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')]} 01:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:30 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')]} 01:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:31 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 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:31 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 01:38:31 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 01:38:31 INFO - Using env: {'DISPLAY': ':0', 01:38:31 INFO - 'HOME': '/home/cltbld', 01:38:31 INFO - 'LANG': 'en_US.UTF-8', 01:38:31 INFO - 'LANGUAGE': 'en_US:en', 01:38:31 INFO - 'LOGNAME': 'cltbld', 01:38:31 INFO - 'MAIL': '/var/mail/cltbld', 01:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:31 INFO - 'MOZ_NO_REMOTE': '1', 01:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:31 INFO - 'NO_EM_RESTART': '1', 01:38:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:31 INFO - 'PWD': '/builds/slave/test', 01:38:31 INFO - 'SHELL': '/bin/bash', 01:38:31 INFO - 'SHLVL': '1', 01:38:31 INFO - 'TERM': 'linux', 01:38:31 INFO - 'TMOUT': '86400', 01:38:31 INFO - 'USER': 'cltbld', 01:38:31 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:31 INFO - '_': '/tools/buildbot/bin/python'} 01:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:38:31 INFO - Cleaning up... 01:38:31 INFO - Return code: 0 01:38:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:31 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 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:31 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 01:38:31 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 01:38:31 INFO - Using env: {'DISPLAY': ':0', 01:38:31 INFO - 'HOME': '/home/cltbld', 01:38:31 INFO - 'LANG': 'en_US.UTF-8', 01:38:31 INFO - 'LANGUAGE': 'en_US:en', 01:38:31 INFO - 'LOGNAME': 'cltbld', 01:38:31 INFO - 'MAIL': '/var/mail/cltbld', 01:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:31 INFO - 'MOZ_NO_REMOTE': '1', 01:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:31 INFO - 'NO_EM_RESTART': '1', 01:38:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:31 INFO - 'PWD': '/builds/slave/test', 01:38:31 INFO - 'SHELL': '/bin/bash', 01:38:31 INFO - 'SHLVL': '1', 01:38:31 INFO - 'TERM': 'linux', 01:38:31 INFO - 'TMOUT': '86400', 01:38:31 INFO - 'USER': 'cltbld', 01:38:31 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:31 INFO - '_': '/tools/buildbot/bin/python'} 01:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:31 INFO - Downloading/unpacking blobuploader==1.2.4 01:38:31 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 01:38:31 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 01:38:31 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 01:38:31 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 01:38:31 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 01:38:31 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 01:38:33 INFO - Downloading blobuploader-1.2.4.tar.gz 01:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:38:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:38:33 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 01:38:33 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 01:38:33 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 01:38:33 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 01:38:33 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 01:38:33 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 01:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:38:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:38:33 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 01:38:33 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 01:38:33 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 01:38:33 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 01:38:33 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 01:38:33 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 01:38:34 INFO - Downloading docopt-0.6.1.tar.gz 01:38:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:38:34 INFO - Installing collected packages: blobuploader, requests, docopt 01:38:34 INFO - Running setup.py install for blobuploader 01:38:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:38:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:38:34 INFO - Running setup.py install for requests 01:38:34 INFO - Running setup.py install for docopt 01:38:34 INFO - Successfully installed blobuploader requests docopt 01:38:34 INFO - Cleaning up... 01:38:34 INFO - Return code: 0 01:38:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:34 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 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:34 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 01:38:34 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 01:38:34 INFO - Using env: {'DISPLAY': ':0', 01:38:34 INFO - 'HOME': '/home/cltbld', 01:38:34 INFO - 'LANG': 'en_US.UTF-8', 01:38:34 INFO - 'LANGUAGE': 'en_US:en', 01:38:34 INFO - 'LOGNAME': 'cltbld', 01:38:34 INFO - 'MAIL': '/var/mail/cltbld', 01:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:34 INFO - 'MOZ_NO_REMOTE': '1', 01:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:34 INFO - 'NO_EM_RESTART': '1', 01:38:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:34 INFO - 'PWD': '/builds/slave/test', 01:38:34 INFO - 'SHELL': '/bin/bash', 01:38:34 INFO - 'SHLVL': '1', 01:38:34 INFO - 'TERM': 'linux', 01:38:34 INFO - 'TMOUT': '86400', 01:38:34 INFO - 'USER': 'cltbld', 01:38:34 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:34 INFO - '_': '/tools/buildbot/bin/python'} 01:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:35 INFO - Running setup.py (path:/tmp/pip-nR1Zmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:35 INFO - Running setup.py (path:/tmp/pip-2P61uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:35 INFO - Running setup.py (path:/tmp/pip-iTbvWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:35 INFO - Running setup.py (path:/tmp/pip-vHK7XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:35 INFO - Running setup.py (path:/tmp/pip-Tse2ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:35 INFO - Running setup.py (path:/tmp/pip-UXZDnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:35 INFO - Running setup.py (path:/tmp/pip-Hz9Roh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:35 INFO - Running setup.py (path:/tmp/pip-xcGu4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:35 INFO - Running setup.py (path:/tmp/pip-1Ki7s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:35 INFO - Running setup.py (path:/tmp/pip-J3t0K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:35 INFO - Running setup.py (path:/tmp/pip-9PuxPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:35 INFO - Running setup.py (path:/tmp/pip-qUGWfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:35 INFO - Running setup.py (path:/tmp/pip-k9bzJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:36 INFO - Running setup.py (path:/tmp/pip-bkKf6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:36 INFO - Running setup.py (path:/tmp/pip-O_A9dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:36 INFO - Running setup.py (path:/tmp/pip-gbIk9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:36 INFO - Running setup.py (path:/tmp/pip-KKUBXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:38:36 INFO - Running setup.py install for manifestparser 01:38:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:38:36 INFO - Running setup.py install for mozcrash 01:38:36 INFO - Running setup.py install for mozdebug 01:38:36 INFO - Running setup.py install for mozdevice 01:38:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:38:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:38:36 INFO - Running setup.py install for mozfile 01:38:36 INFO - Running setup.py install for mozhttpd 01:38:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:38:36 INFO - Running setup.py install for mozinfo 01:38:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Running setup.py install for mozInstall 01:38:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Running setup.py install for mozleak 01:38:37 INFO - Running setup.py install for mozlog 01:38:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Running setup.py install for moznetwork 01:38:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Running setup.py install for mozprocess 01:38:37 INFO - Running setup.py install for mozprofile 01:38:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Running setup.py install for mozrunner 01:38:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:38:37 INFO - Running setup.py install for mozscreenshot 01:38:37 INFO - Running setup.py install for moztest 01:38:38 INFO - Running setup.py install for mozversion 01:38:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:38:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:38:38 INFO - Cleaning up... 01:38:38 INFO - Return code: 0 01:38:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:38 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 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:38 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 01:38:38 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 01:38:38 INFO - Using env: {'DISPLAY': ':0', 01:38:38 INFO - 'HOME': '/home/cltbld', 01:38:38 INFO - 'LANG': 'en_US.UTF-8', 01:38:38 INFO - 'LANGUAGE': 'en_US:en', 01:38:38 INFO - 'LOGNAME': 'cltbld', 01:38:38 INFO - 'MAIL': '/var/mail/cltbld', 01:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:38 INFO - 'MOZ_NO_REMOTE': '1', 01:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:38 INFO - 'NO_EM_RESTART': '1', 01:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:38 INFO - 'PWD': '/builds/slave/test', 01:38:38 INFO - 'SHELL': '/bin/bash', 01:38:38 INFO - 'SHLVL': '1', 01:38:38 INFO - 'TERM': 'linux', 01:38:38 INFO - 'TMOUT': '86400', 01:38:38 INFO - 'USER': 'cltbld', 01:38:38 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:38 INFO - '_': '/tools/buildbot/bin/python'} 01:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:38 INFO - Running setup.py (path:/tmp/pip-EABh58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38:38 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)) 01:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:38 INFO - Running setup.py (path:/tmp/pip-cjKjWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38:38 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)) 01:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:38 INFO - Running setup.py (path:/tmp/pip-ueuTVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38:38 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)) 01:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:38 INFO - Running setup.py (path:/tmp/pip-dDAqog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38:38 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)) 01:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:38 INFO - Running setup.py (path:/tmp/pip-cKm2qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38:38 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)) 01:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:38 INFO - Running setup.py (path:/tmp/pip-6W3UX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38:38 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)) 01:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:38 INFO - Running setup.py (path:/tmp/pip-9_8gav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38:38 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)) 01:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:38 INFO - Running setup.py (path:/tmp/pip-AHsv4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38:38 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)) 01:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:38 INFO - Running setup.py (path:/tmp/pip-9HChrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38:39 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)) 01:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:39 INFO - Running setup.py (path:/tmp/pip-n3lyN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38:39 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)) 01:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:39 INFO - Running setup.py (path:/tmp/pip-5SmPzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38:39 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)) 01:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:39 INFO - Running setup.py (path:/tmp/pip-vsgQhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38:39 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)) 01:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:39 INFO - Running setup.py (path:/tmp/pip-1zlYPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38:39 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)) 01:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:39 INFO - Running setup.py (path:/tmp/pip-GHG83c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:39 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)) 01:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:39 INFO - Running setup.py (path:/tmp/pip-IeSVTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:39 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)) 01:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:39 INFO - Running setup.py (path:/tmp/pip-ON3Bor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:39 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)) 01:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:39 INFO - Running setup.py (path:/tmp/pip-UmxekS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38:39 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)) 01:38:39 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)) 01:38:39 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)) 01:38:39 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)) 01:38:39 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)) 01:38:39 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)) 01:38:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:41 INFO - Downloading blessings-1.6.tar.gz 01:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:38:41 INFO - Installing collected packages: blessings 01:38:41 INFO - Running setup.py install for blessings 01:38:41 INFO - Successfully installed blessings 01:38:41 INFO - Cleaning up... 01:38:41 INFO - Return code: 0 01:38:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:38:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:42 INFO - Reading from file tmpfile_stdout 01:38:42 INFO - Current package versions: 01:38:42 INFO - argparse == 1.2.1 01:38:42 INFO - blessings == 1.6 01:38:42 INFO - blobuploader == 1.2.4 01:38:42 INFO - docopt == 0.6.1 01:38:42 INFO - functools32 == 3.2.3-2 01:38:42 INFO - jsonschema == 2.5.1 01:38:42 INFO - manifestparser == 1.1 01:38:42 INFO - mozInstall == 1.12 01:38:42 INFO - mozcrash == 1.0 01:38:42 INFO - mozdebug == 0.1 01:38:42 INFO - mozdevice == 0.49 01:38:42 INFO - mozfile == 1.2 01:38:42 INFO - mozhttpd == 0.7 01:38:42 INFO - mozinfo == 0.9 01:38:42 INFO - mozleak == 0.1 01:38:42 INFO - mozlog == 3.4 01:38:42 INFO - moznetwork == 0.27 01:38:42 INFO - mozprocess == 0.25 01:38:42 INFO - mozprofile == 0.28 01:38:42 INFO - mozrunner == 6.13 01:38:42 INFO - mozscreenshot == 0.1 01:38:42 INFO - mozsystemmonitor == 0.3 01:38:42 INFO - moztest == 0.8 01:38:42 INFO - mozversion == 1.4 01:38:42 INFO - psutil == 3.1.1 01:38:42 INFO - requests == 1.2.3 01:38:42 INFO - wsgiref == 0.1.2 01:38:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:42 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')]} 01:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:42 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')]} 01:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:42 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 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:42 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 01:38:42 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 01:38:42 INFO - Using env: {'DISPLAY': ':0', 01:38:42 INFO - 'HOME': '/home/cltbld', 01:38:42 INFO - 'LANG': 'en_US.UTF-8', 01:38:42 INFO - 'LANGUAGE': 'en_US:en', 01:38:42 INFO - 'LOGNAME': 'cltbld', 01:38:42 INFO - 'MAIL': '/var/mail/cltbld', 01:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:42 INFO - 'MOZ_NO_REMOTE': '1', 01:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:42 INFO - 'NO_EM_RESTART': '1', 01:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:42 INFO - 'PWD': '/builds/slave/test', 01:38:42 INFO - 'SHELL': '/bin/bash', 01:38:42 INFO - 'SHLVL': '1', 01:38:42 INFO - 'TERM': 'linux', 01:38:42 INFO - 'TMOUT': '86400', 01:38:42 INFO - 'USER': 'cltbld', 01:38:42 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:42 INFO - '_': '/tools/buildbot/bin/python'} 01:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:42 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)) 01:38:42 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)) 01:38:42 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)) 01:38:42 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)) 01:38:42 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)) 01:38:42 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)) 01:38:42 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)) 01:38:42 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)) 01:38:42 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)) 01:38:42 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)) 01:38:42 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)) 01:38:42 INFO - Cleaning up... 01:38:42 INFO - Return code: 0 01:38:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:38:42 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')]} 01:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:42 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')]} 01:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:42 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 0xbe81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc26a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe86310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, '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': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', '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 01:38:42 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 01:38:42 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 01:38:42 INFO - Using env: {'DISPLAY': ':0', 01:38:42 INFO - 'HOME': '/home/cltbld', 01:38:42 INFO - 'LANG': 'en_US.UTF-8', 01:38:42 INFO - 'LANGUAGE': 'en_US:en', 01:38:42 INFO - 'LOGNAME': 'cltbld', 01:38:42 INFO - 'MAIL': '/var/mail/cltbld', 01:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:42 INFO - 'MOZ_NO_REMOTE': '1', 01:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:42 INFO - 'NO_EM_RESTART': '1', 01:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:42 INFO - 'PWD': '/builds/slave/test', 01:38:42 INFO - 'SHELL': '/bin/bash', 01:38:42 INFO - 'SHLVL': '1', 01:38:42 INFO - 'TERM': 'linux', 01:38:42 INFO - 'TMOUT': '86400', 01:38:42 INFO - 'USER': 'cltbld', 01:38:42 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:42 INFO - '_': '/tools/buildbot/bin/python'} 01:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:38:42 INFO - Cleaning up... 01:38:42 INFO - Return code: 0 01:38:42 INFO - Running post-action listener: _resource_record_post_action 01:38:42 INFO - Running post-action listener: _start_resource_monitoring 01:38:42 INFO - Starting resource monitoring. 01:38:42 INFO - [mozharness: 2017-04-16 08:38:42.612458Z] Finished create-virtualenv step (success) 01:38:42 INFO - [mozharness: 2017-04-16 08:38:42.612929Z] Running install step. 01:38:42 INFO - Running pre-action listener: _resource_record_pre_action 01:38:42 INFO - Running main action method: install 01:38:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:42 INFO - Reading from file tmpfile_stdout 01:38:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:38:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:38:42 INFO - Reading from file tmpfile_stdout 01:38:42 INFO - Output received: 01:38:42 INFO - Usage: mozinstall [options] installer 01:38:42 INFO - Options: 01:38:42 INFO - -h, --help show this help message and exit 01:38:42 INFO - -d DEST, --destination=DEST 01:38:42 INFO - Directory to install application into. [default: 01:38:42 INFO - "/builds/slave/test"] 01:38:42 INFO - --app=APP Application being installed. [default: firefox] 01:38:42 INFO - mkdir: /builds/slave/test/build/application 01:38:42 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'] 01:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:38:59 INFO - Reading from file tmpfile_stdout 01:38:59 INFO - Output received: 01:38:59 INFO - /builds/slave/test/build/application/firefox/firefox 01:38:59 INFO - Running post-action listener: _resource_record_post_action 01:38:59 INFO - [mozharness: 2017-04-16 08:38:59.525733Z] Finished install step (success) 01:38:59 INFO - [mozharness: 2017-04-16 08:38:59.525878Z] Running run-tests step. 01:38:59 INFO - Running pre-action listener: _resource_record_pre_action 01:38:59 INFO - Running main action method: run_tests 01:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:59 INFO - Python 2.7.3 01:38:59 INFO - Return code: 0 01:38:59 INFO - grabbing minidump binary from tooltool 01:38:59 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')]} 01:38:59 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 0xe83400>, '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 0xe843b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe84840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38:59 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 01:38:59 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 01:38:59 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 01:38:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:59 INFO - Return code: 0 01:38:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:38:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:59 INFO - ENV: RUST_BACKTRACE is now 1 01:38:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:38:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:59 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/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 01:38:59 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/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --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 01:38:59 INFO - Using env: {'DISPLAY': ':0', 01:38:59 INFO - 'HOME': '/home/cltbld', 01:38:59 INFO - 'LANG': 'en_US.UTF-8', 01:38:59 INFO - 'LANGUAGE': 'en_US:en', 01:38:59 INFO - 'LOGNAME': 'cltbld', 01:38:59 INFO - 'MAIL': '/var/mail/cltbld', 01:38:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:59 INFO - 'MOZ_NO_REMOTE': '1', 01:38:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:59 INFO - 'NO_EM_RESTART': '1', 01:38:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:59 INFO - 'PWD': '/builds/slave/test', 01:38:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:59 INFO - 'RUST_BACKTRACE': '1', 01:38:59 INFO - 'SHELL': '/bin/bash', 01:38:59 INFO - 'SHLVL': '1', 01:38:59 INFO - 'TERM': 'linux', 01:38:59 INFO - 'TMOUT': '86400', 01:38:59 INFO - 'USER': 'cltbld', 01:38:59 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662', 01:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:59 INFO - '_': '/tools/buildbot/bin/python'} 01:38:59 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/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 01:38:59 INFO - mozversion application_buildid: 20170416074743 01:38:59 INFO - mozversion application_changeset: 9da0d3c7fc50cc406d66fc1f286a5cf2254dd51e 01:38:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:38:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:59 INFO - mozversion application_name: Firefox 01:38:59 INFO - mozversion application_remotingname: firefox-dev 01:38:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:38:59 INFO - mozversion application_vendor: Mozilla 01:38:59 INFO - mozversion application_version: 54.0a2 01:38:59 INFO - mozversion platform_buildid: 20170416074743 01:38:59 INFO - mozversion platform_changeset: 9da0d3c7fc50cc406d66fc1f286a5cf2254dd51e 01:38:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:38:59 INFO - mozversion platform_version: 54.0a2 01:38:59 INFO - using testdate: 1492331939 01:38:59 INFO - actual date: 1492331939 01:38:59 INFO - starting webserver on 'localhost:42283' 01:38:59 INFO - SUITE-START | Running 2 tests 01:38:59 INFO - TEST-START | dromaeo_css 01:38:59 INFO - operating with platform_type : linux_ 01:38:59 INFO - Initialising browser for dromaeo_css test... 01:38:59 INFO - TEST-INFO | started process 18898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoTHOXb/profile http://localhost:42283/getInfo.html) 01:39:04 INFO - PROCESS | 18898 | __metrics Screen width/height:1600/1200 01:39:04 INFO - PROCESS | 18898 | colorDepth:24 01:39:04 INFO - PROCESS | 18898 | Browser inner width/height: 1024/697 01:39:04 INFO - PROCESS | 18898 | __metrics 01:39:05 INFO - PROCESS | 18898 | 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" 01:39:05 INFO - PROCESS | 18898 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:39:05 INFO - PROCESS | 18898 | console.error: PushService: 01:39:05 INFO - PROCESS | 18898 | stateChangeProcessEnqueue: Error transitioning state 01:39:05 INFO - PROCESS | 18898 | UnknownError 01:39:06 INFO - TEST-INFO | 18898: exit 0 01:39:06 INFO - Browser initialized. 01:39:06 INFO - Running cycle 1/1 for dromaeo_css test... 01:39:06 INFO - TEST-INFO | started process 18986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoTHOXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:17 INFO - PROCESS | 18986 | RSS: Main: 140218368 01:39:17 INFO - PROCESS | 18986 | 01:42:19 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:42283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42283/tests/dromaeo/cssquery-ext.html) 01:42:20 INFO - PROCESS | 18986 | RSS: Main: 281051136 01:42:20 INFO - PROCESS | 18986 | 01:44:08 INFO - PROCESS | 18986 | ************************* 01:44:08 INFO - PROCESS | 18986 | A coding exception was thrown and uncaught in a Task. 01:44:08 INFO - PROCESS | 18986 | 01:44:08 ERROR - PROCESS | 18986 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:44:08 INFO - PROCESS | 18986 | Full stack: 01:44:08 INFO - PROCESS | 18986 | ************************* 01:44:08 INFO - PROCESS | 18986 | ************************* 01:44:08 INFO - PROCESS | 18986 | A coding exception was thrown and uncaught in a Task. 01:44:08 INFO - PROCESS | 18986 | 01:44:08 ERROR - PROCESS | 18986 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:44:08 INFO - PROCESS | 18986 | Full stack: 01:44:08 INFO - PROCESS | 18986 | ************************* 01:44:08 INFO - PROCESS | 18986 | ************************* 01:44:08 INFO - PROCESS | 18986 | A coding exception was thrown and uncaught in a Task. 01:44:08 INFO - PROCESS | 18986 | 01:44:08 ERROR - PROCESS | 18986 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:44:08 INFO - PROCESS | 18986 | Full stack: 01:44:08 INFO - PROCESS | 18986 | ************************* 01:44:08 INFO - PROCESS | 18986 | ************************* 01:44:08 INFO - PROCESS | 18986 | A coding exception was thrown and uncaught in a Task. 01:44:08 INFO - PROCESS | 18986 | 01:44:08 ERROR - PROCESS | 18986 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:44:08 INFO - PROCESS | 18986 | Full stack: 01:44:08 INFO - PROCESS | 18986 | ************************* 01:45:23 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:42283/tests/dromaeo/cssquery-ext.html (next: http://localhost:42283/tests/dromaeo/cssquery-jquery.html) 01:45:23 INFO - PROCESS | 18986 | RSS: Main: 231120896 01:45:23 INFO - PROCESS | 18986 | 01:48:25 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:42283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42283/tests/dromaeo/cssquery-mootools.html) 01:48:26 INFO - PROCESS | 18986 | RSS: Main: 234393600 01:48:26 INFO - PROCESS | 18986 | 01:51:27 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:42283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42283/tests/dromaeo/cssquery-prototype.html) 01:51:28 INFO - PROCESS | 18986 | RSS: Main: 170905600 01:51:28 INFO - PROCESS | 18986 | 01:54:31 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:42283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42283/tests/dromaeo/cssquery-yui.html) 01:54:31 INFO - PROCESS | 18986 | RSS: Main: 176308224 01:54:31 INFO - PROCESS | 18986 | 01:57:34 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:42283/tests/dromaeo/cssquery-yui.html (next: http://localhost:42283/tests/dromaeo/cssquery-dojo.html) 01:57:34 INFO - PROCESS | 18986 | RSS: Main: 268357632 01:57:34 INFO - PROCESS | 18986 | 01:57:34 INFO - PROCESS | 18986 | __start_tp_report 01:57:34 INFO - PROCESS | 18986 | _x_x_mozilla_page_load 01:57:34 INFO - PROCESS | 18986 | _x_x_mozilla_page_load_details 01:57:34 INFO - PROCESS | 18986 | |i|pagename|runs| 01:57:34 INFO - PROCESS | 18986 | |0;dojo.html;3403.778754380965;3424.058383944415;3424.075499615102;3450.051235910126;3480.4257297545905;5671.8298451046485;5728.140778883169;5746.48281654651;5758.539316854647;5767.8269651910405;5663.3204015518095;5678.119891416837;5704.3154821421485;5710.200571919934;5720.256366672327;5121.828197022588;5174.611904107188;5180.585553155757;5180.818671346504;5218.6868787872845;5078.13671675816;5102.260172275018;5233.162693968966;5244.921326180111;5279.076161671711;5168.48315168482;5202.219667049954;5292.073887069767;5294.92057619136;5301.443348448415;5304.522592966651;5311.044012077825;5314.787408503656;5315.229291752674;5322.5209731124;5000.899982000376;5137.075326441239;5197.064528384889;5250.949810038008;5267.631265811395;5585.190147428641;5619.129034999582;5649.915251271234;5657.6322539035245;5678.205051292823;6145.262568491765;6184.226971628546;6197.628142311431;6203;6207.689615519206;6240.282367527747;6241.032639940817;6250.0312451569625;6257.937420625826;6261.561690681654;5525.944740552623;5549;5764.827055188351;5804.941950580483;5814.883702325972;6310.1796766420075;6320.810375688737;6337.6197428154455;6338.58799178052;6341.270753863272;6090.756369745249;6093.756249750049;6100.145979562864;6100.176476175749;6101.481374083252;5927.703614819242;5952.494038006818;6129.356417576179;6193.256809182927;6197.318294987548;6031.24609423822;6045.909311360333;6053.152558641794;6068.939310606926;6085.056816193497;5882.088276317178;5900.822975310747;5902.704864756745;6085.36103709113;6094.268687757498;4686.203345431285;4703.529647035338;4732.195526760459;4737.313089601988;4763.69036012658;4107.404426358161;4128.6284234419045;4141.213169497786;4224.598663126998;4272.551382104896;5881.382454842265;5886.440788125121;5958.970205148947;5960.552958528127;5979.01346277868;6197.070439434121;6201.317855035943;6205.069239614004;6208.782692605737;6210.130581718563;5614.6631202128;5960.821175364746;5971.104334349795;5985.940140598538;5986.2517185351835;5041.092603331435;5216.634835561475;5238.92141617876;5250.107481728115;5302.125149350391;6300.9684951574945;6321.525885558602;6367.204099487564;6374.203224596926;6379.3620637936765;6155.261368635793;6197.442230199304;6219.533534984985;6226.875462490634;6235.937640623536;6123.112148738319;6147.200863887666;6195.690215489298;6232.501399888089;6341.270753863365;6073.605215660968;6075.574709770451;6078.817635470943;6087.878242435215;6123.908141377972;6175.289841668266;6204.472619827366;6210.192674952408;6213.689315534296;6216.347283535345;5696.572757043321;5762.596618236683;5974;5979.893719661876;6057.848553786191;6039;6048.60684055535;6050.213472248755;6073;6099.024156134997;5988.520918326436;6034.668093254738;6049.78825741097;6052.66710330936;6052.75788968454;5795.94204057954;5830.504407125272;5856.355800861987;5956.404359564009;5970.522358211246;5911.261092363455;5912.911306330495;5923.111533269872;5925;5946.643201407929 01:57:34 INFO - PROCESS | 18986 | |1;ext.html;741.2587412587412;798.3493452835938;821.8397412504562;864.4640322999737;887.8268737596171;31004.689953100464;44041;45032.09935801282;45059.54940450599;45154.54845451545;41417.171656566854;45301;45534.77232613832;45569.088618227615;45641;7812.257835505618;8907.51008694523;9004.594793234288;9020.77448063797;9028;7871.921280787176;7940.563269020202;7947.086085100201;10681.41252231127;10907.400092994882;11046.171537134707;11047.337159770439;11064.723381915435;11065.225434219608;11065.391403472806;10943.23397362185;10957.06864916483;10965.780684386307;10972.835407468894;10976.231663783537;10244.897551024544;10286.434246116462;10298.9485052575;10302.072813446826;10305;43196.78401607972;43671.56328436707;43691.126177476275;43747.78126109381;43788.3431748524;4174.147662457468;4225.133847561243;4259.680523960716;4351.934720979188;4364.192624364503;30544.54183187254;30954;31020.689793102232;31634.36731265385;32291.83854080738;3667.3582123128613;3763.284975854579;3778.9055273618105;3784.3188226119287;3851.0372406898277;243079;244165;244187;244997;245729;54112.729436352565;54649;54664.18003729947;54709.179362309595;54717.179242311395;56674.7166264166;56682;56904.43095568991;56911.71544142253;56996.715016424656;15944.681106377808;16086.83913160877;16097.356105755638;16101.19494025294;16101.27544260511;13624.455021799016;13631;13645;13653.795193072112;13657;12178.391080445943;12385.752284954431;12856.485740570273;13238.404271807793;13589.796153057712;5476.863078423071;5575;5664.575156863251;5676.631018983753;5733.856653583611;973.3575839945602;974.5176137811828;983.1250187333279;998.4308943901906;1000.3147843726924;28059;28121.859390703325;28295.151145465257;28686.426271474455;28788.568171477444;1050.9421981790922;1074.5433190893839;1078.3799315393524;1095.6767753512734;1098.1763677242068;14556.490522831862;14681;14724.411023559152;14819.110853348619;14831.555053348417;268288;268313;268625;268782;269432;54142.729286353315;54155.72922135364;54218.18672719912;54227.45772542224;54298;1480.4670318685264;1495.1477657734986;1500.8949373543746;1542.930568124437;1544.3513724235847;25628.231153065437;26850.731492684823;27142.321441964108;27183.592246115928;27240.72759272382;41221.1755764889;41441.37837932494;41446.37830432606;41541.37687934744;41568.792156039024;261123;263599;263819;264155;264843;34632.987544635114;34787;34986.12534686653;35032.29935401329;35149.64850351566;42126.1574768509;42602;42747.57252427436;42827.357589635554;44105.77947110244;32311.35377292488;32794.50808237926;32867.50698739569;32906.50640240446;33113;32168.356632866744;32727;33143.33713325768;33256.339492841;33695.831520842235;37734;38309.4253586202;38390.04024899288;38567.80716096402;38617.6138238614;32687.50968735423;33250;33289.334213315116;33317.66682333242;34122.48816267808;25561.360965976;26323.73676263213;26458.338541536614;26611.600825988015;27009.86495067512 01:57:34 INFO - PROCESS | 18986 | |2;jquery.html;407.95920407959187;447.42282455632227;453.73910001749005;460.7788261634415;473.47207863232495;18711.4386568403;19128.23487060516;20520.17919283229;20529;20703.275385361514;21132.366029019115;21770.238041668545;21804.89097554514;21868.45328866775;21991.780082199173;5097.745112744366;6497.675116244192;6773.932260677404;6802.897956530656;6811.659417029129;6713.127293451845;6725.66371681414;6746.797596072101;6748.39264466198;6782.287859774727;6457.063725759762;6693;6724.798256052301;6736.05695202672;6766.357196066366;6404.7117879695525;6616.636085015322;6694.062831203635;6745.426638735713;6754.628495432749;6517.576357536745;6525.445337146348;6528.738850445977;6534.967325163391;6535.901961470534;24203.757962420328;24467.510649786906;24485.38786530351;24610.507789844283;24711.62932556013;2833.4616422879585;3166.5250212468086;3226.9838650806596;3232.692894175073;3247.9675203247903;16153.143673939398;16275.83724162755;16537.66924661512;16614.75077873833;17173.570660733458;2305.2738387407912;2367.1005018093015;2370.134900761227;2415.7342692303832;2424.151546958568;112750.43624781906;116134.99999999916;116472;117097.41451292775;117236;14084.871857597309;16467.176641167895;18061.819381806275;18394.26422943094;18597.34909278196;30895.0731478056;31155.68844311573;31189.844050780055;31232.37535249282;31263.53104703386;10354.585816567404;10506.264561480775;10584.788304233873;10641.893581064245;10781.191410644233;8826.117388261251;8881.689140880038;8884.200421961925;9109.954450227706;9112.589933453011;9110.27117830572;9121.77195570116;9303.76740581491;9395;9517.333786634868;3727.5154229949935;3867.651911327994;3948.8617898373996;3955.545112312121;4055.1889622075705;958.712386284112;963.8602402651717;966.5360626899128;967.1344146988406;969.8448248280241;19921;20897.47756306074;20938;21334.78665213359;21432.142714291567;972.5088830140875;975.8292298847673;980.5538479991586;1001.62439085343;1016.3800081950004;11154.10767138627;11230.66308010761;11646.301221926711;11945.58190463347;12062.87937120635;574093;604093;604479;610930;617124;109824;110838.44580777045;111568;113246.43376783228;115015;1340.0753480098701;1340.5978206538;1363.5091367107634;1377.9517716880061;1383.2184815579367;13823.447062117402;17924;18352.17415216345;19375.90312048431;19402.223911043966;49092.50907490879;50082.74958625183;50200;50804.491955079975;51194.44027798521;61818;63469.682651586445;63838.36161638324;63880;64104.35895640984;11752.35362055061;12045.33750643688;12117.69705757363;12350.81473777876;12395.566155184886;12647.430865611253;12747.362631868184;13232.272225027717;14104;14169.36237869319;12266.632001039983;12339.69150771238;12344.691382715504;12375.504979800708;12790;11559.826602600799;11664.358460284766;11672.88327116718;11818.881811181778;11823.881761182278;11497.655070347902;11734;12000.459979300778;12025.4588543514;12441.688957776129;11935.82096268574;11940.76118477643;12002.1598488105;12361.196522226026;12452.377381130726;11164.385958772345;12206.87793122093;12243.632691019284;12344.259344439002;12428.13003089775 01:57:34 INFO - PROCESS | 18986 | |3;mootools.html;1493.9775903361444;1543.603039249479;1568.3256199834073;1571.4735563586198;1573.457157280738;10596.576136954522;11345.37600431978;11351.489182986765;11351.659450216497;11355.659330220096;10948.781024379508;11288.492017859195;11290.322580645166;11303.26528775629;11337.319760814356;2293.117149897289;2317.698699169114;2325.0699720112007;2335.2760644200353;2338.812894968407;2287.0965968442456;2368.08828600989;2394.8084153267696;2397.6883005209384;2409.578323793338;2238.104758096758;2275.84069115162;2283.805876500491;2348.365941195876;2349.7297810751725;2270.3416009357265;2271.670607761882;2276.8975396107217;2278.065992942894;2280.84034117611;2347.213683416058;2349.34218418843;2363.5981883079917;2364.042562762084;2364.231624721955;11322.660320190407;11422.200445968785;11425.200235983484;11437.714057148554;11440.42797860112;5730.369659337512;5828.3297420796725;5854.946109700252;5863.061910094364;5863.970680146572;3147.7796554241213;3192.808431494118;3327.1183136468853;3366.596008478998;3390.762646614738;1291.4963164365904;1293.8484748573683;1307.0654482045384;1312.5406107862268;1344.3748656874502;14760.409583616642;15139.697206055927;15689.686206275925;16809;16845.15774211297;4502.594766471033;4576.839810606612;4670.602998745077;4683.7423941682855;4695.835645752382;12699.111062225555;12700.11099223064;12710.173838700455;12718.745625087446;12719.491220351267;4936.605071594264;5106.183010718267;5692.48767610917;5801.680907550125;5824.504917082011;5149.716765577929;5420.105682562412;5440;5447.4824891635235;5467.125259958388;3662.7069834413182;3715.8327875245677;3758.1168425420005;3760.793156376371;3764.435334699817;1046.8168070587617;1054.4991129213563;1060.411471633251;1063.0751246415668;1068.9251752377259;965.8792650918635;992.3153024413132;993.7962717642865;998.8002399520125;1011.0698157694939;6779.966100169468;6837.521373503807;6850.451963842881;6892.069570607904;6951.89572156418;1013.3261381181579;1030.0883717909703;1037.8391349340864;1058.7353161709573;1059.597353005853;4395.362672412482;4412.4705035395955;4419.359192917073;4464.464264288241;4515.164694531522;13948.16311021342;14368.497102601359;14458.204798736171;14458.638534036523;14463.92768036153;14491.637709057148;14671.413143474141;14705;14717.55847324582;14743.483978060716;8923.464592124623;10602.257841951143;10638.308509946828;10658.520366583522;10717.464126793786;5929.851753706192;6593.505487088583;6650.102236198051;6686.0973768540625;6720.899186512304;11350.659480215607;11506.82739758921;11773.529058837894;11799.35103569312;11819.881801181878;11790.410479476164;11806.704832378915;11837.644870653894;11945;12009.939950300193;8769.780755481164;8882.955585222033;8929.73210803677;8938.86591701138;8940.284777217938;9942.15491683215;9964.601415943282;9971.202303815822;9995.950020249853;10055.195584353089;8875.866861997205;8957.417767845069;8989.685361012333;9121.635134594542;9295.907040929775;8753.824923501366;8829.16122968317;8879.511626860585;8889.422187557788;9093.681721139994;8264.83470330578;8291.58542072906;8332;8332.083470818327;8344.541050242295;5968.403159683997;6063.272407311151;6158.784442544489;6180.6909654517995;6267.561270711007;6181.505479561534;6248.843778905563;6267.561270711007;6307.96846015767;6372.745090196526 01:57:34 INFO - PROCESS | 18986 | |4;prototype.html;426.957304269573;434.19023521133084;437.2501160509725;442.27687730560547;442.32766195383016;5211.827338848757;5290.444503327149;5347.759350829212;5350.224217488462;5358.3569971603465;5211.843644690656;5216.347956505437;5247.737613119348;5252.505060096461;5278.577713782898;4377.430933978579;4434.711743736663;4457.353683715875;4464.732116073038;4485.34962430449;4469.307257375112;4474.545772623894;4509.503954564995;4512.2329204035395;4544.431946006749;4449.755263460508;4466.79899404526;4468.932966005513;4495.707778994371;4499.167653984007;4384.561543845622;4384.671149663788;4423.955760442386;4490.663200259961;4508.346289787979;4113.197926404352;4129.15352352767;4145.730527515732;4147.274227010261;4151.14901445203;5090.516400941905;5121.769520371555;5134.204198349262;5137.588992880561;5181.145111056671;4874.366332376769;5034.270030845507;5087.26234695967;5134.64057515974;5156.510131537498;5436.565074794007;5481.4651897468775;5506.366767821712;5523.309586301712;5523.751431185566;4591.931121033187;4604.562566556206;4612.723236605814;4618.861434156981;4665.4168228971375;5507.779688812443;5650.29371328584;5701.14482827575;5752.6836024019085;5776.6534007959235;4716.976415117902;4735.266033764703;4771.212749896297;4787.760611969387;4809.5430934061205;4869.123557759566;4893.06416150307;4925.21196608541;4944.047101394929;4955.4796746341835;4930.457649658606;5065.240213967861;5091.8981620367385;5122.92315615266;5145.614078944094;5384.757685904144;5395.757190926418;5470.100846551255;5496.642718223383;5520.61984503874;1629.8533132017938;1641.7291146960617;1660.4188534012999;1683.4612923864245;1698.6432849101827;1395.4697215058416;1439.4242303078852;1467.7284702330103;1477.793108964746;1496.393960446021;5348.705821179795;5360.276362690986;5372.489613486712;5374.91937620936;5447.210154527651;5639.3232812062815;5682.318121825408;5707.400722924116;5744.856378590485;5752;5197.284895984316;5382.4886635769535;5411.160205530138;5435.456454354533;5441.537469315073;3011.217083558247;3024.017194411781;3024.7163391639174;3026.2888221267986;3036.3320069584656;5882.176495290662;5898.734556944948;5908.970455147697;5911.674857882772;5931.673757943355;5619.6347237430255;5628.746706398222;5801.970990145022;5813.796517121965;5834.154047663065;5652.236948012048;5709.3719690834805;5777.88444231113;5800.1299805029585;5832.300123984979;5603.35561410443;5612.410696876933;5637.887242255214;5662.207290979184;5677.574181936454;5493.670379777226;5536.114221724666;5617.410171931889;5619.960307343154;5623.268975033219;5844.444777746107;5901.822945311475;5902.940970590239;5912.408759124053;5920.970395147997;4740.976295118502;4756.096341695067;4765.26138448541;4777.7372244525495;4791.425028996543;5339.332583427072;5642.71786410686;5697.23087383198;5710.17202505626;5715.828525144252;5553.639358357228;5576.888462230651;5595.5803314752375;5602.607817452739;5633.718314084362;5344.518993290622;5561.805336813192;5567.079357621614;5579.442055794388;5584.86037849057;5566.717645765379;5580.609357345109;5583.855309661591;5597.328320601554;5606.747696353756;5577.609567330248;5589.860253493533;5643.633163844337;5667.4332566743;5698.2592263005545;5147;5398.541124004503;5423.62034657586;5428.7557059931605;5500.80747173847 01:57:34 INFO - PROCESS | 18986 | |5;yui.html;850.9957450212748;856.7558245899916;913.9634414623415;915.3501014279859;935.8689783430317;17338.739918901225;17873.405852398253;17932.55168620785;18304.450866473995;18512.074396280164;15020.699586008273;15074.397024119022;17171.82828171718;17838.732419013726;17934.730979035325;895.0870112485277;910.2399496420497;911.544227886057;912.0104686415248;913.0139449394671;871.7646235516438;898.1691934960136;905.529124855075;905.741863568883;906.4380084347714;943.9103285187896;947.327397547742;947.9715608531756;950.3110245072302;951.286535098676;941.5151197133482;941.6751220828803;941.7928055827707;945.08799008956;945.3004776465435;689.9724011039552;691.7751730687546;692.3595674001579;692.3699433515477;692.6986760759086;17403.477895663025;17550.648987020315;17588.47234582952;18532.81467185338;18769.71845422306;15775.842241577551;15961.281742321624;16009.439669611507;16147.757783633255;16347.59131021734;12292.877071229263;12504;12608.180468269533;12679.112462127654;12729.045321600825;3884.864029758945;3887.5140607424073;3889.9222015559812;3896.415537669344;3959.1685745993377;87496.56251718765;88463;89044;90974.09025909723;92091.53954230253;11981;12224.511019559119;12226.449809758582;12229.816552751716;12272.631821045383;24135.275941721775;24156.275311740676;24175.637365439532;24195.395115122265;24350.147744828846;8713;8784.648614055366;8785.868211976825;8982.371234013557;9047.502387368626;4749.95250047502;4911.45973942866;4953.72754498506;5055.292259083732;5065.468125846806;3828.8851334459455;3834.386498160281;3903.0632648164237;3907.1208977979727;3957.6635985941516;591.8313280714975;592.6947621974687;689.36233983565;721.5778769419948;728.9744858929912;838.1785849867165;861.3539845116163;865.4201684871151;892.6474042753076;899.3434792601438;10825.350478971286;10830.729231769268;11010.39442830652;11235.606753763579;11621.186516943733;809.6113865344668;818.2104269380077;821.7616891101513;827.4456114403364;833.2667252817482;5428.67427954324;5493.066178749622;5549.112142057252;5611.186377975171;5618.101103823368;62135;62721;63076.684616576626;80126.5993670028;87041.56479217563;57258;58316.708416457644;66933.66533167304;72107.63946180236;74878.25121748712;54322.72838635781;56002.71998639981;59627.105593416134;65305;65725.67137164283;11387.601433949772;11654.359010254517;11967.76064478723;11985.28088314704;12106.334151621746;41239;42762.00665953478;43417.3487397683;43522.56477435185;44422.777886110365;42516;46296.30555541737;46691;47622.76188619035;48840.511594885014;13162.407691653707;13409.597712068653;13466.326683665582;13859.584212473643;14000.43998240059;15521.611959701098;16041.67916641684;16083.75874361909;16246.025238485729;16285.185740713154;13783.724325513233;13865.168089914638;13874.167549947035;13912.443502259795;15310.081395116329;14248.216348100954;14342.354594043501;14439;15531.22343882824;15676.216189190267;13312.667183320495;13328.200307981551;13439.193648381128;13556;13919.373628186553;10252.948735256276;10276.075153235946;10389.272750907365;10569.207309451667;10811.837822432513;11404.94297528507;11475.598354057567;11566.132540059698;11730.882691173321;11831.704207394883 01:57:34 INFO - PROCESS | 18986 | __end_tp_report 01:57:34 INFO - PROCESS | 18986 | __start_cc_report 01:57:34 INFO - PROCESS | 18986 | _x_x_mozilla_cycle_collect,1417 01:57:34 INFO - PROCESS | 18986 | __end_cc_report 01:57:34 INFO - PROCESS | 18986 | __startTimestamp1492333054461__endTimestamp 01:57:34 INFO - PROCESS | 18986 | 01:57:34 INFO - PROCESS | 18986 | ------- Summary: start ------- 01:57:34 INFO - PROCESS | 18986 | Number of tests: 6 01:57:34 INFO - PROCESS | 18986 | 01:57:34 INFO - PROCESS | 18986 | [#0] dojo.html Cycles:165 Average:5705.26 Median:5952.49 stddev:640.18 (10.8%) stddev-sans-first:616.16 01:57:34 INFO - PROCESS | 18986 | Values: 3403.8 3424.1 3424.1 3450.1 3480.4 5671.8 5728.1 5746.5 5758.5 5767.8 5663.3 5678.1 5704.3 5710.2 5720.3 5121.8 5174.6 5180.6 5180.8 5218.7 5078.1 5102.3 5233.2 5244.9 5279.1 5168.5 5202.2 5292.1 5294.9 5301.4 5304.5 5311.0 5314.8 5315.2 5322.5 5000.9 5137.1 5197.1 5250.9 5267.6 5585.2 5619.1 5649.9 5657.6 5678.2 6145.3 6184.2 6197.6 6203.0 6207.7 6240.3 6241.0 6250.0 6257.9 6261.6 5525.9 5549.0 5764.8 5804.9 5814.9 6310.2 6320.8 6337.6 6338.6 6341.3 6090.8 6093.8 6100.1 6100.2 6101.5 5927.7 5952.5 6129.4 6193.3 6197.3 6031.2 6045.9 6053.2 6068.9 6085.1 5882.1 5900.8 5902.7 6085.4 6094.3 4686.2 4703.5 4732.2 4737.3 4763.7 4107.4 4128.6 4141.2 4224.6 4272.6 5881.4 5886.4 5959.0 5960.6 5979.0 6197.1 6201.3 6205.1 6208.8 6210.1 5614.7 5960.8 5971.1 5985.9 5986.3 5041.1 5216.6 5238.9 5250.1 5302.1 6301.0 6321.5 6367.2 6374.2 6379.4 6155.3 6197.4 6219.5 6226.9 6235.9 6123.1 6147.2 6195.7 6232.5 6341.3 6073.6 6075.6 6078.8 6087.9 6123.9 6175.3 6204.5 6210.2 6213.7 6216.3 5696.6 5762.6 5974.0 5979.9 6057.8 6039.0 6048.6 6050.2 6073.0 6099.0 5988.5 6034.7 6049.8 6052.7 6052.8 5795.9 5830.5 5856.4 5956.4 5970.5 5911.3 5912.9 5923.1 5925.0 5946.6 01:57:34 INFO - PROCESS | 18986 | 01:57:34 INFO - PROCESS | 18986 | [#1] ext.html Cycles:180 Average:43546.45 Median:33009.75 stddev:67287.65 (203.8%) stddev-sans-first:67399.65 01:57:34 INFO - PROCESS | 18986 | Values: 741.3 798.3 821.8 864.5 887.8 31004.7 44041.0 45032.1 45059.5 45154.5 41417.2 45301.0 45534.8 45569.1 45641.0 7812.3 8907.5 9004.6 9020.8 9028.0 7871.9 7940.6 7947.1 10681.4 10907.4 11046.2 11047.3 11064.7 11065.2 11065.4 10943.2 10957.1 10965.8 10972.8 10976.2 10244.9 10286.4 10298.9 10302.1 10305.0 43196.8 43671.6 43691.1 43747.8 43788.3 4174.1 4225.1 4259.7 4351.9 4364.2 30544.5 30954.0 31020.7 31634.4 32291.8 3667.4 3763.3 3778.9 3784.3 3851.0 243079.0 244165.0 244187.0 244997.0 245729.0 54112.7 54649.0 54664.2 54709.2 54717.2 56674.7 56682.0 56904.4 56911.7 56996.7 15944.7 16086.8 16097.4 16101.2 16101.3 13624.5 13631.0 13645.0 13653.8 13657.0 12178.4 12385.8 12856.5 13238.4 13589.8 5476.9 5575.0 5664.6 5676.6 5733.9 973.4 974.5 983.1 998.4 1000.3 28059.0 28121.9 28295.2 28686.4 28788.6 1050.9 1074.5 1078.4 1095.7 1098.2 14556.5 14681.0 14724.4 14819.1 14831.6 268288.0 268313.0 268625.0 268782.0 269432.0 54142.7 54155.7 54218.2 54227.5 54298.0 1480.5 1495.1 1500.9 1542.9 1544.4 25628.2 26850.7 27142.3 27183.6 27240.7 41221.2 41441.4 41446.4 41541.4 41568.8 261123.0 263599.0 263819.0 264155.0 264843.0 34633.0 34787.0 34986.1 35032.3 35149.6 42126.2 42602.0 42747.6 42827.4 44105.8 32311.4 32794.5 32867.5 32906.5 33113.0 32168.4 32727.0 33143.3 33256.3 33695.8 37734.0 38309.4 38390.0 38567.8 38617.6 32687.5 33250.0 33289.3 33317.7 34122.5 25561.4 26323.7 26458.3 26611.6 27009.9 01:57:34 INFO - PROCESS | 18986 | 01:57:34 INFO - PROCESS | 18986 | [#2] jquery.html Cycles:180 Average:35719.96 Median:21930.12 stddev:99568.35 (454.0%) stddev-sans-first:99812.36 01:57:34 INFO - PROCESS | 18986 | Values: 408.0 447.4 453.7 460.8 473.5 18711.4 19128.2 20520.2 20529.0 20703.3 21132.4 21770.2 21804.9 21868.5 21991.8 5097.7 6497.7 6773.9 6802.9 6811.7 6713.1 6725.7 6746.8 6748.4 6782.3 6457.1 6693.0 6724.8 6736.1 6766.4 6404.7 6616.6 6694.1 6745.4 6754.6 6517.6 6525.4 6528.7 6535.0 6535.9 24203.8 24467.5 24485.4 24610.5 24711.6 2833.5 3166.5 3227.0 3232.7 3248.0 16153.1 16275.8 16537.7 16614.8 17173.6 2305.3 2367.1 2370.1 2415.7 2424.2 112750.4 116135.0 116472.0 117097.4 117236.0 14084.9 16467.2 18061.8 18394.3 18597.3 30895.1 31155.7 31189.8 31232.4 31263.5 10354.6 10506.3 10584.8 10641.9 10781.2 8826.1 8881.7 8884.2 9110.0 9112.6 9110.3 9121.8 9303.8 9395.0 9517.3 3727.5 3867.7 3948.9 3955.5 4055.2 958.7 963.9 966.5 967.1 969.8 19921.0 20897.5 20938.0 21334.8 21432.1 972.5 975.8 980.6 1001.6 1016.4 11154.1 11230.7 11646.3 11945.6 12062.9 574093.0 604093.0 604479.0 610930.0 617124.0 109824.0 110838.4 111568.0 113246.4 115015.0 1340.1 1340.6 1363.5 1378.0 1383.2 13823.4 17924.0 18352.2 19375.9 19402.2 49092.5 50082.7 50200.0 50804.5 51194.4 61818.0 63469.7 63838.4 63880.0 64104.4 11752.4 12045.3 12117.7 12350.8 12395.6 12647.4 12747.4 13232.3 14104.0 14169.4 12266.6 12339.7 12344.7 12375.5 12790.0 11559.8 11664.4 11672.9 11818.9 11823.9 11497.7 11734.0 12000.5 12025.5 12441.7 11935.8 11940.8 12002.2 12361.2 12452.4 11164.4 12206.9 12243.6 12344.3 12428.1 01:57:34 INFO - PROCESS | 18986 | 01:57:34 INFO - PROCESS | 18986 | [#3] mootools.html Cycles:180 Average:6847.23 Median:2364.14 stddev:4360.07 (184.4%) stddev-sans-first:4353.75 01:57:34 INFO - PROCESS | 18986 | Values: 1494.0 1543.6 1568.3 1571.5 1573.5 10596.6 11345.4 11351.5 11351.7 11355.7 10948.8 11288.5 11290.3 11303.3 11337.3 2293.1 2317.7 2325.1 2335.3 2338.8 2287.1 2368.1 2394.8 2397.7 2409.6 2238.1 2275.8 2283.8 2348.4 2349.7 2270.3 2271.7 2276.9 2278.1 2280.8 2347.2 2349.3 2363.6 2364.0 2364.2 11322.7 11422.2 11425.2 11437.7 11440.4 5730.4 5828.3 5854.9 5863.1 5864.0 3147.8 3192.8 3327.1 3366.6 3390.8 1291.5 1293.8 1307.1 1312.5 1344.4 14760.4 15139.7 15689.7 16809.0 16845.2 4502.6 4576.8 4670.6 4683.7 4695.8 12699.1 12700.1 12710.2 12718.7 12719.5 4936.6 5106.2 5692.5 5801.7 5824.5 5149.7 5420.1 5440.0 5447.5 5467.1 3662.7 3715.8 3758.1 3760.8 3764.4 1046.8 1054.5 1060.4 1063.1 1068.9 965.9 992.3 993.8 998.8 1011.1 6780.0 6837.5 6850.5 6892.1 6951.9 1013.3 1030.1 1037.8 1058.7 1059.6 4395.4 4412.5 4419.4 4464.5 4515.2 13948.2 14368.5 14458.2 14458.6 14463.9 14491.6 14671.4 14705.0 14717.6 14743.5 8923.5 10602.3 10638.3 10658.5 10717.5 5929.9 6593.5 6650.1 6686.1 6720.9 11350.7 11506.8 11773.5 11799.4 11819.9 11790.4 11806.7 11837.6 11945.0 12009.9 8769.8 8883.0 8929.7 8938.9 8940.3 9942.2 9964.6 9971.2 9996.0 10055.2 8875.9 8957.4 8989.7 9121.6 9295.9 8753.8 8829.2 8879.5 8889.4 9093.7 8264.8 8291.6 8332.0 8332.1 8344.5 5968.4 6063.3 6158.8 6180.7 6267.6 6181.5 6248.8 6267.6 6308.0 6372.7 01:57:34 INFO - PROCESS | 18986 | 01:57:34 INFO - PROCESS | 18986 | [#4] prototype.html Cycles:180 Average:4844.46 Median:5346.14 stddev:1262.87 (23.6%) stddev-sans-first:1222.11 01:57:34 INFO - PROCESS | 18986 | Values: 427.0 434.2 437.3 442.3 442.3 5211.8 5290.4 5347.8 5350.2 5358.4 5211.8 5216.3 5247.7 5252.5 5278.6 4377.4 4434.7 4457.4 4464.7 4485.3 4469.3 4474.5 4509.5 4512.2 4544.4 4449.8 4466.8 4468.9 4495.7 4499.2 4384.6 4384.7 4424.0 4490.7 4508.3 4113.2 4129.2 4145.7 4147.3 4151.1 5090.5 5121.8 5134.2 5137.6 5181.1 4874.4 5034.3 5087.3 5134.6 5156.5 5436.6 5481.5 5506.4 5523.3 5523.8 4591.9 4604.6 4612.7 4618.9 4665.4 5507.8 5650.3 5701.1 5752.7 5776.7 4717.0 4735.3 4771.2 4787.8 4809.5 4869.1 4893.1 4925.2 4944.0 4955.5 4930.5 5065.2 5091.9 5122.9 5145.6 5384.8 5395.8 5470.1 5496.6 5520.6 1629.9 1641.7 1660.4 1683.5 1698.6 1395.5 1439.4 1467.7 1477.8 1496.4 5348.7 5360.3 5372.5 5374.9 5447.2 5639.3 5682.3 5707.4 5744.9 5752.0 5197.3 5382.5 5411.2 5435.5 5441.5 3011.2 3024.0 3024.7 3026.3 3036.3 5882.2 5898.7 5909.0 5911.7 5931.7 5619.6 5628.7 5802.0 5813.8 5834.2 5652.2 5709.4 5777.9 5800.1 5832.3 5603.4 5612.4 5637.9 5662.2 5677.6 5493.7 5536.1 5617.4 5620.0 5623.3 5844.4 5901.8 5902.9 5912.4 5921.0 4741.0 4756.1 4765.3 4777.7 4791.4 5339.3 5642.7 5697.2 5710.2 5715.8 5553.6 5576.9 5595.6 5602.6 5633.7 5344.5 5561.8 5567.1 5579.4 5584.9 5566.7 5580.6 5583.9 5597.3 5606.7 5577.6 5589.9 5643.6 5667.4 5698.3 5147.0 5398.5 5423.6 5428.8 5500.8 01:57:34 INFO - PROCESS | 18986 | 01:57:34 INFO - PROCESS | 18986 | [#5] yui.html Cycles:180 Average:17934.90 Median:41877.50 stddev:22082.54 (52.7%) stddev-sans-first:22107.22 01:57:34 INFO - PROCESS | 18986 | Values: 851.0 856.8 914.0 915.4 935.9 17338.7 17873.4 17932.6 18304.5 18512.1 15020.7 15074.4 17171.8 17838.7 17934.7 895.1 910.2 911.5 912.0 913.0 871.8 898.2 905.5 905.7 906.4 943.9 947.3 948.0 950.3 951.3 941.5 941.7 941.8 945.1 945.3 690.0 691.8 692.4 692.4 692.7 17403.5 17550.6 17588.5 18532.8 18769.7 15775.8 15961.3 16009.4 16147.8 16347.6 12292.9 12504.0 12608.2 12679.1 12729.0 3884.9 3887.5 3889.9 3896.4 3959.2 87496.6 88463.0 89044.0 90974.1 92091.5 11981.0 12224.5 12226.4 12229.8 12272.6 24135.3 24156.3 24175.6 24195.4 24350.1 8713.0 8784.6 8785.9 8982.4 9047.5 4750.0 4911.5 4953.7 5055.3 5065.5 3828.9 3834.4 3903.1 3907.1 3957.7 591.8 592.7 689.4 721.6 729.0 838.2 861.4 865.4 892.6 899.3 10825.4 10830.7 11010.4 11235.6 11621.2 809.6 818.2 821.8 827.4 833.3 5428.7 5493.1 5549.1 5611.2 5618.1 62135.0 62721.0 63076.7 80126.6 87041.6 57258.0 58316.7 66933.7 72107.6 74878.3 54322.7 56002.7 59627.1 65305.0 65725.7 11387.6 11654.4 11967.8 11985.3 12106.3 41239.0 42762.0 43417.3 43522.6 44422.8 42516.0 46296.3 46691.0 47622.8 48840.5 13162.4 13409.6 13466.3 13859.6 14000.4 15521.6 16041.7 16083.8 16246.0 16285.2 13783.7 13865.2 13874.2 13912.4 15310.1 14248.2 14342.4 14439.0 15531.2 15676.2 13312.7 13328.2 13439.2 13556.0 13919.4 10252.9 10276.1 10389.3 10569.2 10811.8 11404.9 11475.6 11566.1 11730.9 11831.7 01:57:34 INFO - PROCESS | 18986 | -------- Summary: end -------- 01:57:34 INFO - PROCESS | 18986 | 01:57:35 INFO - TEST-INFO | 18986: exit 0 01:57:35 INFO - TEST-OK | dromaeo_css | took 1115343ms 01:57:35 INFO - TEST-START | kraken 01:57:35 INFO - operating with platform_type : linux_ 01:57:35 INFO - Initialising browser for kraken test... 01:57:35 INFO - TEST-INFO | started process 19309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxmwGkp/profile http://localhost:42283/getInfo.html) 01:57:39 INFO - PROCESS | 19309 | __metrics Screen width/height:1600/1200 01:57:39 INFO - PROCESS | 19309 | colorDepth:24 01:57:39 INFO - PROCESS | 19309 | Browser inner width/height: 1024/697 01:57:39 INFO - PROCESS | 19309 | __metrics 01:57:40 INFO - PROCESS | 19309 | 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" 01:57:40 INFO - PROCESS | 19309 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:57:41 INFO - TEST-INFO | 19309: exit 0 01:57:41 INFO - Browser initialized. 01:57:41 INFO - Running cycle 1/1 for kraken test... 01:57:41 INFO - TEST-INFO | started process 19401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxmwGkp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:53 INFO - PROCESS | 19401 | RSS: Main: 140029952 01:57:53 INFO - PROCESS | 19401 | 01:57:55 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42283/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:56 INFO - PROCESS | 19401 | RSS: Main: 183267328 01:57:56 INFO - PROCESS | 19401 | 01:57:58 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42283/tests/kraken/driver.html?testName=audio-dft) 01:57:59 INFO - PROCESS | 19401 | RSS: Main: 174682112 01:57:59 INFO - PROCESS | 19401 | 01:58:02 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42283/tests/kraken/driver.html?testName=audio-fft) 01:58:02 INFO - PROCESS | 19401 | RSS: Main: 265629696 01:58:02 INFO - PROCESS | 19401 | 01:58:04 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42283/tests/kraken/driver.html?testName=audio-oscillator) 01:58:05 INFO - PROCESS | 19401 | RSS: Main: 172371968 01:58:05 INFO - PROCESS | 19401 | 01:58:07 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:58:08 INFO - PROCESS | 19401 | RSS: Main: 174362624 01:58:08 INFO - PROCESS | 19401 | 01:58:11 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42283/tests/kraken/driver.html?testName=imaging-darkroom) 01:58:11 INFO - PROCESS | 19401 | RSS: Main: 213393408 01:58:11 INFO - PROCESS | 19401 | 01:58:15 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42283/tests/kraken/driver.html?testName=imaging-desaturate) 01:58:15 INFO - PROCESS | 19401 | RSS: Main: 211988480 01:58:15 INFO - PROCESS | 19401 | 01:58:18 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42283/tests/kraken/driver.html?testName=json-parse-financial) 01:58:19 INFO - PROCESS | 19401 | RSS: Main: 210481152 01:58:19 INFO - PROCESS | 19401 | 01:58:20 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:58:21 INFO - PROCESS | 19401 | RSS: Main: 172916736 01:58:21 INFO - PROCESS | 19401 | 01:58:22 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42283/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:58:23 INFO - PROCESS | 19401 | RSS: Main: 179376128 01:58:23 INFO - PROCESS | 19401 | 01:58:25 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:58:26 INFO - PROCESS | 19401 | RSS: Main: 189124608 01:58:26 INFO - PROCESS | 19401 | 01:58:28 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:58:29 INFO - PROCESS | 19401 | RSS: Main: 198594560 01:58:29 INFO - PROCESS | 19401 | 01:58:32 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:58:32 INFO - PROCESS | 19401 | RSS: Main: 194727936 01:58:32 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | Cycle 1(1): loaded http://localhost:42283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42283/tests/kraken/driver.html?testName=ai-astar) 01:58:34 INFO - PROCESS | 19401 | RSS: Main: 245583872 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | __start_tp_report 01:58:34 INFO - PROCESS | 19401 | _x_x_mozilla_page_load 01:58:34 INFO - PROCESS | 19401 | _x_x_mozilla_page_load_details 01:58:34 INFO - PROCESS | 19401 | |i|pagename|runs| 01:58:34 INFO - PROCESS | 19401 | |0;ai-astar;103;109;111;112;112;112;111;111;111;111 01:58:34 INFO - PROCESS | 19401 | |1;audio-beat-detection;142;117;121;154;116;116;122;120;144;114 01:58:34 INFO - PROCESS | 19401 | |2;audio-dft;162;162;161;160;161;159;162;159;158;162 01:58:34 INFO - PROCESS | 19401 | |3;audio-fft;74;75;74;107;76;77;77;76;90;78 01:58:34 INFO - PROCESS | 19401 | |4;audio-oscillator;82;83;111;82;81;82;100;82;82;103 01:58:34 INFO - PROCESS | 19401 | |5;imaging-gaussian-blur;113;113;113;112;112;113;112;113;112;112 01:58:34 INFO - PROCESS | 19401 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;145;146 01:58:34 INFO - PROCESS | 19401 | |7;imaging-desaturate;94;93;94;94;94;94;93;94;93;93 01:58:34 INFO - PROCESS | 19401 | |8;json-parse-financial;56;53;53;53;53;55;56;54;55;55 01:58:34 INFO - PROCESS | 19401 | |9;json-stringify-tinderbox;52;52;54;54;52;52;53;53;53;53 01:58:34 INFO - PROCESS | 19401 | |10;stanford-crypto-aes;79;77;83;81;80;84;90;80;85;79 01:58:34 INFO - PROCESS | 19401 | |11;stanford-crypto-ccm;121;124;130;120;130;119;134;120;159;150 01:58:34 INFO - PROCESS | 19401 | |12;stanford-crypto-pbkdf2;157;156;155;156;156;154;160;156;156;151 01:58:34 INFO - PROCESS | 19401 | |13;stanford-crypto-sha256-iterative;60;59;68;60;65;60;60;60;59;60 01:58:34 INFO - PROCESS | 19401 | __end_tp_report 01:58:34 INFO - PROCESS | 19401 | __start_cc_report 01:58:34 INFO - PROCESS | 19401 | _x_x_mozilla_cycle_collect,1640 01:58:34 INFO - PROCESS | 19401 | __end_cc_report 01:58:34 INFO - PROCESS | 19401 | __startTimestamp1492333114513__endTimestamp 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | ------- Summary: start ------- 01:58:34 INFO - PROCESS | 19401 | Number of tests: 14 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.71 (2.4%) stddev-sans-first:0.93 01:58:34 INFO - PROCESS | 19401 | Values: 103.0 109.0 111.0 112.0 112.0 112.0 111.0 111.0 111.0 111.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:121.50 stddev:14.39 (11.8%) stddev-sans-first:14.14 01:58:34 INFO - PROCESS | 19401 | Values: 142.0 117.0 121.0 154.0 116.0 116.0 122.0 120.0 144.0 114.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.50 stddev:1.51 (0.9%) stddev-sans-first:1.51 01:58:34 INFO - PROCESS | 19401 | Values: 162.0 162.0 161.0 160.0 161.0 159.0 162.0 159.0 158.0 162.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#3] audio-fft Cycles:10 Average:80.40 Median:76.50 stddev:10.43 (13.6%) stddev-sans-first:10.80 01:58:34 INFO - PROCESS | 19401 | Values: 74.0 75.0 74.0 107.0 76.0 77.0 77.0 76.0 90.0 78.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:11.28 (13.8%) stddev-sans-first:11.70 01:58:34 INFO - PROCESS | 19401 | Values: 82.0 83.0 111.0 82.0 81.0 82.0 100.0 82.0 82.0 103.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:113.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:58:34 INFO - PROCESS | 19401 | Values: 113.0 113.0 113.0 112.0 112.0 113.0 112.0 113.0 112.0 112.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 01:58:34 INFO - PROCESS | 19401 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:58:34 INFO - PROCESS | 19401 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 93.0 94.0 93.0 93.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:1.17 01:58:34 INFO - PROCESS | 19401 | Values: 56.0 53.0 53.0 53.0 53.0 55.0 56.0 54.0 55.0 55.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#9] json-stringify-tinderbox Cycles:10 Average:52.80 Median:53.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 01:58:34 INFO - PROCESS | 19401 | Values: 52.0 52.0 54.0 54.0 52.0 52.0 53.0 53.0 53.0 53.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:3.79 (4.6%) stddev-sans-first:3.89 01:58:34 INFO - PROCESS | 19401 | Values: 79.0 77.0 83.0 81.0 80.0 84.0 90.0 80.0 85.0 79.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:130.00 stddev:13.70 (10.5%) stddev-sans-first:14.08 01:58:34 INFO - PROCESS | 19401 | Values: 121.0 124.0 130.0 120.0 130.0 119.0 134.0 120.0 159.0 150.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.00 stddev:2.26 (1.5%) stddev-sans-first:2.35 01:58:34 INFO - PROCESS | 19401 | Values: 157.0 156.0 155.0 156.0 156.0 154.0 160.0 156.0 156.0 151.0 01:58:34 INFO - PROCESS | 19401 | 01:58:34 INFO - PROCESS | 19401 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:60.00 stddev:2.96 (4.9%) stddev-sans-first:3.11 01:58:34 INFO - PROCESS | 19401 | Values: 60.0 59.0 68.0 60.0 65.0 60.0 60.0 60.0 59.0 60.0 01:58:34 INFO - PROCESS | 19401 | -------- Summary: end -------- 01:58:34 INFO - PROCESS | 19401 | 01:58:35 INFO - TEST-INFO | 19401: exit 0 01:58:35 INFO - TEST-OK | kraken | took 60454ms 01:58:35 INFO - SUITE-END | took 1175s 01:58:35 INFO - Completed test suite (00:19:35) 01:58:35 INFO - javascript benchmark 01:58:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7754.887977827882, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3403.778754380965, 3424.058383944415, 3424.075499615102, 3450.051235910126, 3480.4257297545905, 5671.8298451046485, 5728.140778883169, 5746.48281654651, 5758.539316854647, 5767.8269651910405, 5663.3204015518095, 5678.119891416837, 5704.3154821421485, 5710.200571919934, 5720.256366672327, 5121.828197022588, 5174.611904107188, 5180.585553155757, 5180.818671346504, 5218.6868787872845, 5078.13671675816, 5102.260172275018, 5233.162693968966, 5244.921326180111, 5279.076161671711, 5168.48315168482, 5202.219667049954, 5292.073887069767, 5294.92057619136, 5301.443348448415, 5304.522592966651, 5311.044012077825, 5314.787408503656, 5315.229291752674, 5322.5209731124, 5000.899982000376, 5137.075326441239, 5197.064528384889, 5250.949810038008, 5267.631265811395, 5585.190147428641, 5619.129034999582, 5649.915251271234, 5657.6322539035245, 5678.205051292823, 6145.262568491765, 6184.226971628546, 6197.628142311431, 6203.0, 6207.689615519206, 6240.282367527747, 6241.032639940817, 6250.0312451569625, 6257.937420625826, 6261.561690681654, 5525.944740552623, 5549.0, 5764.827055188351, 5804.941950580483, 5814.883702325972, 6310.1796766420075, 6320.810375688737, 6337.6197428154455, 6338.58799178052, 6341.270753863272, 6090.756369745249, 6093.756249750049, 6100.145979562864, 6100.176476175749, 6101.481374083252, 5927.703614819242, 5952.494038006818, 6129.356417576179, 6193.256809182927, 6197.318294987548, 6031.24609423822, 6045.909311360333, 6053.152558641794, 6068.939310606926, 6085.056816193497, 5882.088276317178, 5900.822975310747, 5902.704864756745, 6085.36103709113, 6094.268687757498, 4686.203345431285, 4703.529647035338, 4732.195526760459, 4737.313089601988, 4763.69036012658, 4107.404426358161, 4128.6284234419045, 4141.213169497786, 4224.598663126998, 4272.551382104896, 5881.382454842265, 5886.440788125121, 5958.970205148947, 5960.552958528127, 5979.01346277868, 6197.070439434121, 6201.317855035943, 6205.069239614004, 6208.782692605737, 6210.130581718563, 5614.6631202128, 5960.821175364746, 5971.104334349795, 5985.940140598538, 5986.2517185351835, 5041.092603331435, 5216.634835561475, 5238.92141617876, 5250.107481728115, 5302.125149350391, 6300.9684951574945, 6321.525885558602, 6367.204099487564, 6374.203224596926, 6379.3620637936765, 6155.261368635793, 6197.442230199304, 6219.533534984985, 6226.875462490634, 6235.937640623536, 6123.112148738319, 6147.200863887666, 6195.690215489298, 6232.501399888089, 6341.270753863365, 6073.605215660968, 6075.574709770451, 6078.817635470943, 6087.878242435215, 6123.908141377972, 6175.289841668266, 6204.472619827366, 6210.192674952408, 6213.689315534296, 6216.347283535345, 5696.572757043321, 5762.596618236683, 5974.0, 5979.893719661876, 6057.848553786191, 6039.0, 6048.60684055535, 6050.213472248755, 6073.0, 6099.024156134997, 5988.520918326436, 6034.668093254738, 6049.78825741097, 6052.66710330936, 6052.75788968454, 5795.94204057954, 5830.504407125272, 5856.355800861987, 5956.404359564009, 5970.522358211246, 5911.261092363455, 5912.911306330495, 5923.111533269872, 5925.0, 5946.643201407929], "value": 5663.362325454691, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.2587412587412, 798.3493452835938, 821.8397412504562, 864.4640322999737, 887.8268737596171, 31004.689953100464, 44041.0, 45032.09935801282, 45059.54940450599, 45154.54845451545, 41417.171656566854, 45301.0, 45534.77232613832, 45569.088618227615, 45641.0, 7812.257835505618, 8907.51008694523, 9004.594793234288, 9020.77448063797, 9028.0, 7871.921280787176, 7940.563269020202, 7947.086085100201, 10681.41252231127, 10907.400092994882, 11046.171537134707, 11047.337159770439, 11064.723381915435, 11065.225434219608, 11065.391403472806, 10943.23397362185, 10957.06864916483, 10965.780684386307, 10972.835407468894, 10976.231663783537, 10244.897551024544, 10286.434246116462, 10298.9485052575, 10302.072813446826, 10305.0, 43196.78401607972, 43671.56328436707, 43691.126177476275, 43747.78126109381, 43788.3431748524, 4174.147662457468, 4225.133847561243, 4259.680523960716, 4351.934720979188, 4364.192624364503, 30544.54183187254, 30954.0, 31020.689793102232, 31634.36731265385, 32291.83854080738, 3667.3582123128613, 3763.284975854579, 3778.9055273618105, 3784.3188226119287, 3851.0372406898277, 243079.0, 244165.0, 244187.0, 244997.0, 245729.0, 54112.729436352565, 54649.0, 54664.18003729947, 54709.179362309595, 54717.179242311395, 56674.7166264166, 56682.0, 56904.43095568991, 56911.71544142253, 56996.715016424656, 15944.681106377808, 16086.83913160877, 16097.356105755638, 16101.19494025294, 16101.27544260511, 13624.455021799016, 13631.0, 13645.0, 13653.795193072112, 13657.0, 12178.391080445943, 12385.752284954431, 12856.485740570273, 13238.404271807793, 13589.796153057712, 5476.863078423071, 5575.0, 5664.575156863251, 5676.631018983753, 5733.856653583611, 973.3575839945602, 974.5176137811828, 983.1250187333279, 998.4308943901906, 1000.3147843726924, 28059.0, 28121.859390703325, 28295.151145465257, 28686.426271474455, 28788.568171477444, 1050.9421981790922, 1074.5433190893839, 1078.3799315393524, 1095.6767753512734, 1098.1763677242068, 14556.490522831862, 14681.0, 14724.411023559152, 14819.110853348619, 14831.555053348417, 268288.0, 268313.0, 268625.0, 268782.0, 269432.0, 54142.729286353315, 54155.72922135364, 54218.18672719912, 54227.45772542224, 54298.0, 1480.4670318685264, 1495.1477657734986, 1500.8949373543746, 1542.930568124437, 1544.3513724235847, 25628.231153065437, 26850.731492684823, 27142.321441964108, 27183.592246115928, 27240.72759272382, 41221.1755764889, 41441.37837932494, 41446.37830432606, 41541.37687934744, 41568.792156039024, 261123.0, 263599.0, 263819.0, 264155.0, 264843.0, 34632.987544635114, 34787.0, 34986.12534686653, 35032.29935401329, 35149.64850351566, 42126.1574768509, 42602.0, 42747.57252427436, 42827.357589635554, 44105.77947110244, 32311.35377292488, 32794.50808237926, 32867.50698739569, 32906.50640240446, 33113.0, 32168.356632866744, 32727.0, 33143.33713325768, 33256.339492841, 33695.831520842235, 37734.0, 38309.4253586202, 38390.04024899288, 38567.80716096402, 38617.6138238614, 32687.50968735423, 33250.0, 33289.334213315116, 33317.66682333242, 34122.48816267808, 25561.360965976, 26323.73676263213, 26458.338541536614, 26611.600825988015, 27009.86495067512], "value": 18721.08719262485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.95920407959187, 447.42282455632227, 453.73910001749005, 460.7788261634415, 473.47207863232495, 18711.4386568403, 19128.23487060516, 20520.17919283229, 20529.0, 20703.275385361514, 21132.366029019115, 21770.238041668545, 21804.89097554514, 21868.45328866775, 21991.780082199173, 5097.745112744366, 6497.675116244192, 6773.932260677404, 6802.897956530656, 6811.659417029129, 6713.127293451845, 6725.66371681414, 6746.797596072101, 6748.39264466198, 6782.287859774727, 6457.063725759762, 6693.0, 6724.798256052301, 6736.05695202672, 6766.357196066366, 6404.7117879695525, 6616.636085015322, 6694.062831203635, 6745.426638735713, 6754.628495432749, 6517.576357536745, 6525.445337146348, 6528.738850445977, 6534.967325163391, 6535.901961470534, 24203.757962420328, 24467.510649786906, 24485.38786530351, 24610.507789844283, 24711.62932556013, 2833.4616422879585, 3166.5250212468086, 3226.9838650806596, 3232.692894175073, 3247.9675203247903, 16153.143673939398, 16275.83724162755, 16537.66924661512, 16614.75077873833, 17173.570660733458, 2305.2738387407912, 2367.1005018093015, 2370.134900761227, 2415.7342692303832, 2424.151546958568, 112750.43624781906, 116134.99999999916, 116472.0, 117097.41451292775, 117236.0, 14084.871857597309, 16467.176641167895, 18061.819381806275, 18394.26422943094, 18597.34909278196, 30895.0731478056, 31155.68844311573, 31189.844050780055, 31232.37535249282, 31263.53104703386, 10354.585816567404, 10506.264561480775, 10584.788304233873, 10641.893581064245, 10781.191410644233, 8826.117388261251, 8881.689140880038, 8884.200421961925, 9109.954450227706, 9112.589933453011, 9110.27117830572, 9121.77195570116, 9303.76740581491, 9395.0, 9517.333786634868, 3727.5154229949935, 3867.651911327994, 3948.8617898373996, 3955.545112312121, 4055.1889622075705, 958.712386284112, 963.8602402651717, 966.5360626899128, 967.1344146988406, 969.8448248280241, 19921.0, 20897.47756306074, 20938.0, 21334.78665213359, 21432.142714291567, 972.5088830140875, 975.8292298847673, 980.5538479991586, 1001.62439085343, 1016.3800081950004, 11154.10767138627, 11230.66308010761, 11646.301221926711, 11945.58190463347, 12062.87937120635, 574093.0, 604093.0, 604479.0, 610930.0, 617124.0, 109824.0, 110838.44580777045, 111568.0, 113246.43376783228, 115015.0, 1340.0753480098701, 1340.5978206538, 1363.5091367107634, 1377.9517716880061, 1383.2184815579367, 13823.447062117402, 17924.0, 18352.17415216345, 19375.90312048431, 19402.223911043966, 49092.50907490879, 50082.74958625183, 50200.0, 50804.491955079975, 51194.44027798521, 61818.0, 63469.682651586445, 63838.36161638324, 63880.0, 64104.35895640984, 11752.35362055061, 12045.33750643688, 12117.69705757363, 12350.81473777876, 12395.566155184886, 12647.430865611253, 12747.362631868184, 13232.272225027717, 14104.0, 14169.36237869319, 12266.632001039983, 12339.69150771238, 12344.691382715504, 12375.504979800708, 12790.0, 11559.826602600799, 11664.358460284766, 11672.88327116718, 11818.881811181778, 11823.881761182278, 11497.655070347902, 11734.0, 12000.459979300778, 12025.4588543514, 12441.688957776129, 11935.82096268574, 11940.76118477643, 12002.1598488105, 12361.196522226026, 12452.377381130726, 11164.385958772345, 12206.87793122093, 12243.632691019284, 12344.259344439002, 12428.13003089775], "value": 11287.520996547863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.9775903361444, 1543.603039249479, 1568.3256199834073, 1571.4735563586198, 1573.457157280738, 10596.576136954522, 11345.37600431978, 11351.489182986765, 11351.659450216497, 11355.659330220096, 10948.781024379508, 11288.492017859195, 11290.322580645166, 11303.26528775629, 11337.319760814356, 2293.117149897289, 2317.698699169114, 2325.0699720112007, 2335.2760644200353, 2338.812894968407, 2287.0965968442456, 2368.08828600989, 2394.8084153267696, 2397.6883005209384, 2409.578323793338, 2238.104758096758, 2275.84069115162, 2283.805876500491, 2348.365941195876, 2349.7297810751725, 2270.3416009357265, 2271.670607761882, 2276.8975396107217, 2278.065992942894, 2280.84034117611, 2347.213683416058, 2349.34218418843, 2363.5981883079917, 2364.042562762084, 2364.231624721955, 11322.660320190407, 11422.200445968785, 11425.200235983484, 11437.714057148554, 11440.42797860112, 5730.369659337512, 5828.3297420796725, 5854.946109700252, 5863.061910094364, 5863.970680146572, 3147.7796554241213, 3192.808431494118, 3327.1183136468853, 3366.596008478998, 3390.762646614738, 1291.4963164365904, 1293.8484748573683, 1307.0654482045384, 1312.5406107862268, 1344.3748656874502, 14760.409583616642, 15139.697206055927, 15689.686206275925, 16809.0, 16845.15774211297, 4502.594766471033, 4576.839810606612, 4670.602998745077, 4683.7423941682855, 4695.835645752382, 12699.111062225555, 12700.11099223064, 12710.173838700455, 12718.745625087446, 12719.491220351267, 4936.605071594264, 5106.183010718267, 5692.48767610917, 5801.680907550125, 5824.504917082011, 5149.716765577929, 5420.105682562412, 5440.0, 5447.4824891635235, 5467.125259958388, 3662.7069834413182, 3715.8327875245677, 3758.1168425420005, 3760.793156376371, 3764.435334699817, 1046.8168070587617, 1054.4991129213563, 1060.411471633251, 1063.0751246415668, 1068.9251752377259, 965.8792650918635, 992.3153024413132, 993.7962717642865, 998.8002399520125, 1011.0698157694939, 6779.966100169468, 6837.521373503807, 6850.451963842881, 6892.069570607904, 6951.89572156418, 1013.3261381181579, 1030.0883717909703, 1037.8391349340864, 1058.7353161709573, 1059.597353005853, 4395.362672412482, 4412.4705035395955, 4419.359192917073, 4464.464264288241, 4515.164694531522, 13948.16311021342, 14368.497102601359, 14458.204798736171, 14458.638534036523, 14463.92768036153, 14491.637709057148, 14671.413143474141, 14705.0, 14717.55847324582, 14743.483978060716, 8923.464592124623, 10602.257841951143, 10638.308509946828, 10658.520366583522, 10717.464126793786, 5929.851753706192, 6593.505487088583, 6650.102236198051, 6686.0973768540625, 6720.899186512304, 11350.659480215607, 11506.82739758921, 11773.529058837894, 11799.35103569312, 11819.881801181878, 11790.410479476164, 11806.704832378915, 11837.644870653894, 11945.0, 12009.939950300193, 8769.780755481164, 8882.955585222033, 8929.73210803677, 8938.86591701138, 8940.284777217938, 9942.15491683215, 9964.601415943282, 9971.202303815822, 9995.950020249853, 10055.195584353089, 8875.866861997205, 8957.417767845069, 8989.685361012333, 9121.635134594542, 9295.907040929775, 8753.824923501366, 8829.16122968317, 8879.511626860585, 8889.422187557788, 9093.681721139994, 8264.83470330578, 8291.58542072906, 8332.0, 8332.083470818327, 8344.541050242295, 5968.403159683997, 6063.272407311151, 6158.784442544489, 6180.6909654517995, 6267.561270711007, 6181.505479561534, 6248.843778905563, 6267.561270711007, 6307.96846015767, 6372.745090196526], "value": 5195.56153957502, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.957304269573, 434.19023521133084, 437.2501160509725, 442.27687730560547, 442.32766195383016, 5211.827338848757, 5290.444503327149, 5347.759350829212, 5350.224217488462, 5358.3569971603465, 5211.843644690656, 5216.347956505437, 5247.737613119348, 5252.505060096461, 5278.577713782898, 4377.430933978579, 4434.711743736663, 4457.353683715875, 4464.732116073038, 4485.34962430449, 4469.307257375112, 4474.545772623894, 4509.503954564995, 4512.2329204035395, 4544.431946006749, 4449.755263460508, 4466.79899404526, 4468.932966005513, 4495.707778994371, 4499.167653984007, 4384.561543845622, 4384.671149663788, 4423.955760442386, 4490.663200259961, 4508.346289787979, 4113.197926404352, 4129.15352352767, 4145.730527515732, 4147.274227010261, 4151.14901445203, 5090.516400941905, 5121.769520371555, 5134.204198349262, 5137.588992880561, 5181.145111056671, 4874.366332376769, 5034.270030845507, 5087.26234695967, 5134.64057515974, 5156.510131537498, 5436.565074794007, 5481.4651897468775, 5506.366767821712, 5523.309586301712, 5523.751431185566, 4591.931121033187, 4604.562566556206, 4612.723236605814, 4618.861434156981, 4665.4168228971375, 5507.779688812443, 5650.29371328584, 5701.14482827575, 5752.6836024019085, 5776.6534007959235, 4716.976415117902, 4735.266033764703, 4771.212749896297, 4787.760611969387, 4809.5430934061205, 4869.123557759566, 4893.06416150307, 4925.21196608541, 4944.047101394929, 4955.4796746341835, 4930.457649658606, 5065.240213967861, 5091.8981620367385, 5122.92315615266, 5145.614078944094, 5384.757685904144, 5395.757190926418, 5470.100846551255, 5496.642718223383, 5520.61984503874, 1629.8533132017938, 1641.7291146960617, 1660.4188534012999, 1683.4612923864245, 1698.6432849101827, 1395.4697215058416, 1439.4242303078852, 1467.7284702330103, 1477.793108964746, 1496.393960446021, 5348.705821179795, 5360.276362690986, 5372.489613486712, 5374.91937620936, 5447.210154527651, 5639.3232812062815, 5682.318121825408, 5707.400722924116, 5744.856378590485, 5752.0, 5197.284895984316, 5382.4886635769535, 5411.160205530138, 5435.456454354533, 5441.537469315073, 3011.217083558247, 3024.017194411781, 3024.7163391639174, 3026.2888221267986, 3036.3320069584656, 5882.176495290662, 5898.734556944948, 5908.970455147697, 5911.674857882772, 5931.673757943355, 5619.6347237430255, 5628.746706398222, 5801.970990145022, 5813.796517121965, 5834.154047663065, 5652.236948012048, 5709.3719690834805, 5777.88444231113, 5800.1299805029585, 5832.300123984979, 5603.35561410443, 5612.410696876933, 5637.887242255214, 5662.207290979184, 5677.574181936454, 5493.670379777226, 5536.114221724666, 5617.410171931889, 5619.960307343154, 5623.268975033219, 5844.444777746107, 5901.822945311475, 5902.940970590239, 5912.408759124053, 5920.970395147997, 4740.976295118502, 4756.096341695067, 4765.26138448541, 4777.7372244525495, 4791.425028996543, 5339.332583427072, 5642.71786410686, 5697.23087383198, 5710.17202505626, 5715.828525144252, 5553.639358357228, 5576.888462230651, 5595.5803314752375, 5602.607817452739, 5633.718314084362, 5344.518993290622, 5561.805336813192, 5567.079357621614, 5579.442055794388, 5584.86037849057, 5566.717645765379, 5580.609357345109, 5583.855309661591, 5597.328320601554, 5606.747696353756, 5577.609567330248, 5589.860253493533, 5643.633163844337, 5667.4332566743, 5698.2592263005545, 5147.0, 5398.541124004503, 5423.62034657586, 5428.7557059931605, 5500.80747173847], "value": 4487.863142317923, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.9957450212748, 856.7558245899916, 913.9634414623415, 915.3501014279859, 935.8689783430317, 17338.739918901225, 17873.405852398253, 17932.55168620785, 18304.450866473995, 18512.074396280164, 15020.699586008273, 15074.397024119022, 17171.82828171718, 17838.732419013726, 17934.730979035325, 895.0870112485277, 910.2399496420497, 911.544227886057, 912.0104686415248, 913.0139449394671, 871.7646235516438, 898.1691934960136, 905.529124855075, 905.741863568883, 906.4380084347714, 943.9103285187896, 947.327397547742, 947.9715608531756, 950.3110245072302, 951.286535098676, 941.5151197133482, 941.6751220828803, 941.7928055827707, 945.08799008956, 945.3004776465435, 689.9724011039552, 691.7751730687546, 692.3595674001579, 692.3699433515477, 692.6986760759086, 17403.477895663025, 17550.648987020315, 17588.47234582952, 18532.81467185338, 18769.71845422306, 15775.842241577551, 15961.281742321624, 16009.439669611507, 16147.757783633255, 16347.59131021734, 12292.877071229263, 12504.0, 12608.180468269533, 12679.112462127654, 12729.045321600825, 3884.864029758945, 3887.5140607424073, 3889.9222015559812, 3896.415537669344, 3959.1685745993377, 87496.56251718765, 88463.0, 89044.0, 90974.09025909723, 92091.53954230253, 11981.0, 12224.511019559119, 12226.449809758582, 12229.816552751716, 12272.631821045383, 24135.275941721775, 24156.275311740676, 24175.637365439532, 24195.395115122265, 24350.147744828846, 8713.0, 8784.648614055366, 8785.868211976825, 8982.371234013557, 9047.502387368626, 4749.95250047502, 4911.45973942866, 4953.72754498506, 5055.292259083732, 5065.468125846806, 3828.8851334459455, 3834.386498160281, 3903.0632648164237, 3907.1208977979727, 3957.6635985941516, 591.8313280714975, 592.6947621974687, 689.36233983565, 721.5778769419948, 728.9744858929912, 838.1785849867165, 861.3539845116163, 865.4201684871151, 892.6474042753076, 899.3434792601438, 10825.350478971286, 10830.729231769268, 11010.39442830652, 11235.606753763579, 11621.186516943733, 809.6113865344668, 818.2104269380077, 821.7616891101513, 827.4456114403364, 833.2667252817482, 5428.67427954324, 5493.066178749622, 5549.112142057252, 5611.186377975171, 5618.101103823368, 62135.0, 62721.0, 63076.684616576626, 80126.5993670028, 87041.56479217563, 57258.0, 58316.708416457644, 66933.66533167304, 72107.63946180236, 74878.25121748712, 54322.72838635781, 56002.71998639981, 59627.105593416134, 65305.0, 65725.67137164283, 11387.601433949772, 11654.359010254517, 11967.76064478723, 11985.28088314704, 12106.334151621746, 41239.0, 42762.00665953478, 43417.3487397683, 43522.56477435185, 44422.777886110365, 42516.0, 46296.30555541737, 46691.0, 47622.76188619035, 48840.511594885014, 13162.407691653707, 13409.597712068653, 13466.326683665582, 13859.584212473643, 14000.43998240059, 15521.611959701098, 16041.67916641684, 16083.75874361909, 16246.025238485729, 16285.185740713154, 13783.724325513233, 13865.168089914638, 13874.167549947035, 13912.443502259795, 15310.081395116329, 14248.216348100954, 14342.354594043501, 14439.0, 15531.22343882824, 15676.216189190267, 13312.667183320495, 13328.200307981551, 13439.193648381128, 13556.0, 13919.373628186553, 10252.948735256276, 10276.075153235946, 10389.272750907365, 10569.207309451667, 10811.837822432513, 11404.94297528507, 11475.598354057567, 11566.132540059698, 11730.882691173321, 11831.704207394883], "value": 7793.610042522284, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 111.0, 112.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 121.0, 154.0, 116.0, 116.0, 122.0, 120.0, 144.0, 114.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 159.0, 162.0, 159.0, 158.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 107.0, 76.0, 77.0, 77.0, 76.0, 90.0, 78.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 111.0, 82.0, 81.0, 82.0, 100.0, 82.0, 82.0, 103.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 53.0, 53.0, 55.0, 56.0, 54.0, 55.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 54.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 83.0, 81.0, 80.0, 84.0, 90.0, 80.0, 85.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 124.0, 130.0, 120.0, 130.0, 119.0, 134.0, 120.0, 159.0, 150.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 155.0, 156.0, 156.0, 154.0, 160.0, 156.0, 156.0, 151.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 68.0, 60.0, 65.0, 60.0, 60.0, 60.0, 59.0, 60.0], "value": 61.1, "unit": "score"}]}]} 01:58:35 INFO - Return code: 0 01:58:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:58:35 ERROR - # TBPL SUCCESS # 01:58:35 INFO - Running post-action listener: _resource_record_post_action 01:58:35 INFO - [mozharness: 2017-04-16 08:58:35.815748Z] Finished run-tests step (success) 01:58:35 INFO - Running post-run listener: _resource_record_post_run 01:58:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 364867584; Read time: 24; Write time: 232604 01:58:35 INFO - TinderboxPrint: CPU usage
13.1% 01:58:35 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 01:58:35 INFO - TinderboxPrint: I/O write bytes / time
364,867,584 / 232,604 01:58:35 INFO - TinderboxPrint: CPU idle
8,270.7 (86.9%) 01:58:35 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 01:58:35 INFO - TinderboxPrint: Swap in / out
0 / 0 01:58:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110309376; Read time: 0; Write time: 84004 01:58:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253779968; Read time: 24; Write time: 148552 01:58:36 INFO - Running post-run listener: _upload_blobber_files 01:58:36 INFO - Blob upload gear active. 01:58:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:58:36 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 01:58:36 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'] 01:58:36 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 01:58:36 INFO - (blobuploader) - INFO - Open directory for files ... 01:58:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:58:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:58:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:37 INFO - (blobuploader) - INFO - Done attempting. 01:58:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:58:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:58:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:40 INFO - (blobuploader) - INFO - Done attempting. 01:58:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:58:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:58:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:41 INFO - (blobuploader) - INFO - Done attempting. 01:58:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:58:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:58:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:42 INFO - (blobuploader) - INFO - Done attempting. 01:58:42 INFO - (blobuploader) - INFO - Iteration through files over. 01:58:42 INFO - Return code: 0 01:58:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:58:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:58:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b7885ac2fec5346a92ea87e1dd873bc3f611fe341fa5d92820634e4e89889317d547db7a5d115ae21812ca29d1144fc6f254319f3af5e0a117f0e8207118de7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/30c3a700e5dcfa840ff34973fefb82258c1c8acad7b749d1e30e4e293993de072d4e4380da1e42d4512f7da1218a3eaace699332be5676574d57a111dbd5c48f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/41f50d5b3a4a564e89a4cee0dfe0057f9876a287210197b956496ca4fb3ef5425e16571d241d876fbaf698a3c348f6d56b6c3c39e402fec7cbceab968d829b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cb85ea63223007a263f1ae42e3a6f261d91a1e5d4201300017da0e9156b9a271d709cfd2960080e98c0ea83d07667b5a7a0adb9023b538767c79229ede2291f0"} 01:58:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:58:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:58:42 INFO - Contents: 01:58:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b7885ac2fec5346a92ea87e1dd873bc3f611fe341fa5d92820634e4e89889317d547db7a5d115ae21812ca29d1144fc6f254319f3af5e0a117f0e8207118de7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/30c3a700e5dcfa840ff34973fefb82258c1c8acad7b749d1e30e4e293993de072d4e4380da1e42d4512f7da1218a3eaace699332be5676574d57a111dbd5c48f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/41f50d5b3a4a564e89a4cee0dfe0057f9876a287210197b956496ca4fb3ef5425e16571d241d876fbaf698a3c348f6d56b6c3c39e402fec7cbceab968d829b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cb85ea63223007a263f1ae42e3a6f261d91a1e5d4201300017da0e9156b9a271d709cfd2960080e98c0ea83d07667b5a7a0adb9023b538767c79229ede2291f0"} 01:58:42 INFO - Running post-run listener: copy_logs_to_upload_dir 01:58:42 INFO - Copying logs to upload dir... 01:58:42 INFO - mkdir: /builds/slave/test/build/upload/logs 01:58:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.720763 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-16 01:58:41.755931) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-16 01:58:41.760153) ========= 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=fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b7885ac2fec5346a92ea87e1dd873bc3f611fe341fa5d92820634e4e89889317d547db7a5d115ae21812ca29d1144fc6f254319f3af5e0a117f0e8207118de7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/30c3a700e5dcfa840ff34973fefb82258c1c8acad7b749d1e30e4e293993de072d4e4380da1e42d4512f7da1218a3eaace699332be5676574d57a111dbd5c48f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/41f50d5b3a4a564e89a4cee0dfe0057f9876a287210197b956496ca4fb3ef5425e16571d241d876fbaf698a3c348f6d56b6c3c39e402fec7cbceab968d829b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cb85ea63223007a263f1ae42e3a6f261d91a1e5d4201300017da0e9156b9a271d709cfd2960080e98c0ea83d07667b5a7a0adb9023b538767c79229ede2291f0"} build_url:https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/IfTaqtP1QSKf74Efh2AlUw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b7885ac2fec5346a92ea87e1dd873bc3f611fe341fa5d92820634e4e89889317d547db7a5d115ae21812ca29d1144fc6f254319f3af5e0a117f0e8207118de7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/30c3a700e5dcfa840ff34973fefb82258c1c8acad7b749d1e30e4e293993de072d4e4380da1e42d4512f7da1218a3eaace699332be5676574d57a111dbd5c48f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/41f50d5b3a4a564e89a4cee0dfe0057f9876a287210197b956496ca4fb3ef5425e16571d241d876fbaf698a3c348f6d56b6c3c39e402fec7cbceab968d829b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cb85ea63223007a263f1ae42e3a6f261d91a1e5d4201300017da0e9156b9a271d709cfd2960080e98c0ea83d07667b5a7a0adb9023b538767c79229ede2291f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-16 01:58:41.791800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 01:58:41.792332) ========= 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=fcadb68e09dcf59683000ff6000001dc-1492331005.255601-1578018662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 01:58:41.876950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-16 01:58:41.877492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-16 01:58:41.877967) ========= ========= Total master_lag: 0.16 =========