builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1502707661.17 results: success (0) revision: f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:41.165390) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:41.165773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:41.166050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:41.190257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:41.190516) ========= 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=826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 03:47:43-- 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% 220M=0s 2017-08-14 03:47:43 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097682 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:41.304811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:41.305099) ========= 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=826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018640 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:41.361109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 03:47:41.361396) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf --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=826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 03:47:43,739 truncating revision to first 12 chars 2017-08-14 03:47:43,740 Setting DEBUG logging. 2017-08-14 03:47:43,740 attempt 1/10 2017-08-14 03:47:43,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f667fdab3ac0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 03:47:44,593 unpacking tar archive at: mozilla-central-f667fdab3ac0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.197562 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 03:47:42.571432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:42.571733) ========= script_repo_revision: f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:42.575140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:42.575415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 03:47:42.584328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-14 03:47:42.584648) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:47:45 INFO - MultiFileLogger online at 20170814 03:47:45 in /builds/slave/test 03:47:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:47:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:47:45 INFO - {'append_to_log': False, 03:47:45 INFO - 'base_work_dir': '/builds/slave/test', 03:47:45 INFO - 'blob_upload_branch': 'Firefox', 03:47:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:47:45 INFO - 'branch': 'Firefox', 03:47:45 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:45 INFO - 'code_coverage': False, 03:47:45 INFO - 'config_files': ('talos/linux_config.py',), 03:47:45 INFO - 'default_actions': ('clobber', 03:47:45 INFO - 'read-buildbot-config', 03:47:45 INFO - 'download-and-extract', 03:47:45 INFO - 'populate-webroot', 03:47:45 INFO - 'create-virtualenv', 03:47:45 INFO - 'install', 03:47:45 INFO - 'setup-mitmproxy', 03:47:45 INFO - 'run-tests'), 03:47:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:45 INFO - 'disable_ccov_upload': False, 03:47:45 INFO - 'download_minidump_stackwalk': True, 03:47:45 INFO - 'download_symbols': 'ondemand', 03:47:45 INFO - 'enable_stylo': False, 03:47:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:45 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:45 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:45 INFO - 'gecko_profile': False, 03:47:45 INFO - 'gecko_profile_interval': 0, 03:47:45 INFO - 'installer_path': 'installer.exe', 03:47:45 INFO - 'log_level': 'info', 03:47:45 INFO - 'log_name': 'talos', 03:47:45 INFO - 'log_to_console': True, 03:47:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:47:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:47:45 INFO - 'opt_config_files': (), 03:47:45 INFO - 'pip_index': False, 03:47:45 INFO - 'suite': 'dromaeojs-e10s', 03:47:45 INFO - 'system_bits': '32', 03:47:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:45 INFO - 'title': 'talos-linux64-ix-052', 03:47:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:45 INFO - 'use_talos_json': True, 03:47:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:47:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:45 INFO - 'work_dir': 'build'} 03:47:45 INFO - [mozharness: 2017-08-14 10:47:45.066691Z] Running clobber step. 03:47:45 INFO - Running pre-action listener: _resource_record_pre_action 03:47:45 INFO - Running main action method: clobber 03:47:45 INFO - rmtree: /builds/slave/test/build 03:47:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:47:46 INFO - Running post-action listener: _resource_record_post_action 03:47:46 INFO - [mozharness: 2017-08-14 10:47:46.094974Z] Finished clobber step (success) 03:47:46 INFO - [mozharness: 2017-08-14 10:47:46.095075Z] Running read-buildbot-config step. 03:47:46 INFO - Running pre-action listener: _resource_record_pre_action 03:47:46 INFO - Running main action method: read_buildbot_config 03:47:46 INFO - Using buildbot properties: 03:47:46 INFO - { 03:47:46 INFO - "project": "", 03:47:46 INFO - "product": "firefox", 03:47:46 INFO - "who": "archaeopteryx@coole-files.de", 03:47:46 INFO - "installer_path": "public/build/target.tar.bz2", 03:47:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:47:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:47:46 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:47:46 INFO - "stage_platform": "linux64-stylosequential", 03:47:46 INFO - "basedir": "/builds/slave/test", 03:47:46 INFO - "buildnumber": 29, 03:47:46 INFO - "platform": "ubuntu64_hw_styloseq", 03:47:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:47:46 INFO - "slavebuilddir": "test", 03:47:46 INFO - "taskId": "ebR6W2UkS8-fVRGMYOmVYA", 03:47:46 INFO - "branch": "mozilla-central", 03:47:46 INFO - "script_repo_revision": "production", 03:47:46 INFO - "revision": "f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf", 03:47:46 INFO - "slavename": "talos-linux64-ix-052", 03:47:46 INFO - "repo_path": "mozilla-central" 03:47:46 INFO - } 03:47:46 INFO - Finding installer, test and symbols from parent task. 03:47:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebR6W2UkS8-fVRGMYOmVYA'}, attempt #1 03:47:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebR6W2UkS8-fVRGMYOmVYA'}, attempt #1 03:47:46 INFO - Task dependencies: fGT4btJ9Tv6ODISAhtKG1w 03:47:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w'}, attempt #1 03:47:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.tar.bz2 03:47:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.test_packages.json 03:47:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.crashreporter-symbols.zip 03:47:47 INFO - Running post-action listener: _resource_record_post_action 03:47:47 INFO - [mozharness: 2017-08-14 10:47:47.414970Z] Finished read-buildbot-config step (success) 03:47:47 INFO - [mozharness: 2017-08-14 10:47:47.415190Z] Running download-and-extract step. 03:47:47 INFO - Running pre-action listener: _resource_record_pre_action 03:47:47 INFO - Running main action method: download_and_extract 03:47:47 INFO - mkdir: /builds/slave/test/build/tests 03:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:47:47 INFO - trying https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.test_packages.json 03:47:47 INFO - Downloading https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:47:47 INFO - Downloaded 989 bytes. 03:47:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:47:47 INFO - Using the following test package requirements: 03:47:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:47:47 INFO - u'common': [u'target.common.tests.zip'], 03:47:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:47:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:47:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:47:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:47:47 INFO - u'mozbase': [u'target.common.tests.zip'], 03:47:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:47:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:47:47 INFO - u'web-platform': [u'target.common.tests.zip', 03:47:47 INFO - u'target.web-platform.tests.tar.gz'], 03:47:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:47:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:47:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.common.tests.zip 03:47:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:47:47 INFO - Fetch https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.common.tests.zip into memory 03:47:49 INFO - Content-Length response header: 54034645 03:47:49 INFO - Bytes received: 54034645 03:47:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:47:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.common.tests.zip 03:47:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:47:59 INFO - Fetch https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.common.tests.zip into memory 03:48:00 INFO - Content-Length response header: 54034645 03:48:00 INFO - Bytes received: 54034645 03:48:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.talos.tests.zip 03:48:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:48:12 INFO - Fetch https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.talos.tests.zip into memory 03:48:13 INFO - Content-Length response header: 14496050 03:48:13 INFO - Bytes received: 14496050 03:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:13 INFO - trying https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.tar.bz2 03:48:13 INFO - Downloading https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:48:15 INFO - Downloaded 61833624 bytes. 03:48:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.tar.bz2 03:48:15 INFO - mkdir: /builds/slave/test/properties 03:48:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:48:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:48:15 INFO - Contents: 03:48:15 INFO - build_url:https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.tar.bz2 03:48:15 INFO - Running post-action listener: _resource_record_post_action 03:48:15 INFO - Running post-action listener: set_extra_try_arguments 03:48:15 INFO - [mozharness: 2017-08-14 10:48:15.235185Z] Finished download-and-extract step (success) 03:48:15 INFO - [mozharness: 2017-08-14 10:48:15.235413Z] Running populate-webroot step. 03:48:15 INFO - Running pre-action listener: _resource_record_pre_action 03:48:15 INFO - Running main action method: populate_webroot 03:48:15 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:48:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:48:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:48:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:48:15 INFO - 'tests': ['damp', 'tps']}, 03:48:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:48:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:48:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:48:15 INFO - 'other-e10s': {'tests': ['a11yr', 03:48:15 INFO - 'ts_paint', 03:48:15 INFO - 'tpaint', 03:48:15 INFO - 'sessionrestore', 03:48:15 INFO - 'sessionrestore_many_windows', 03:48:15 INFO - 'sessionrestore_no_auto_restore', 03:48:15 INFO - 'tabpaint']}, 03:48:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:48:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:48:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:48:15 INFO - 'tsvgr_opacity', 03:48:15 INFO - 'tart', 03:48:15 INFO - 'tscrollx', 03:48:15 INFO - 'tsvg_static']}, 03:48:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:48:15 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:48:15 INFO - 'talos_options': ['--mitmproxy', 03:48:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:48:15 INFO - '--firstNonBlankPaint'], 03:48:15 INFO - 'tests': ['tp6_google', 03:48:15 INFO - 'tp6_youtube', 03:48:15 INFO - 'tp6_amazon', 03:48:15 INFO - 'tp6_facebook']}, 03:48:15 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:48:15 INFO - 'talos_options': ['--stylo', 03:48:15 INFO - '--mitmproxy', 03:48:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:48:15 INFO - '--firstNonBlankPaint'], 03:48:15 INFO - 'tests': ['tp6_google', 03:48:15 INFO - 'tp6_youtube', 03:48:15 INFO - 'tp6_amazon', 03:48:15 INFO - 'tp6_facebook']}, 03:48:15 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:48:15 INFO - 'talos_options': ['--stylo', 03:48:15 INFO - '--stylo-threads=1', 03:48:15 INFO - '--mitmproxy', 03:48:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:48:15 INFO - '--firstNonBlankPaint'], 03:48:15 INFO - 'tests': ['tp6_google', 03:48:15 INFO - 'tp6_youtube', 03:48:15 INFO - 'tp6_amazon', 03:48:15 INFO - 'tp6_facebook']}, 03:48:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:48:15 INFO - 'talos_options': ['--xperf_path', 03:48:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:15 INFO - 'tests': ['tp5n']}}} 03:48:15 INFO - Running post-action listener: _resource_record_post_action 03:48:15 INFO - [mozharness: 2017-08-14 10:48:15.247925Z] Finished populate-webroot step (success) 03:48:15 INFO - [mozharness: 2017-08-14 10:48:15.248014Z] Running create-virtualenv step. 03:48:15 INFO - Running pre-action listener: _resource_record_pre_action 03:48:15 INFO - Running main action method: create_virtualenv 03:48:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:48:15 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 03:48:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:48:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:48:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:15 INFO - Using real prefix '/usr' 03:48:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:48:15 INFO - Installing distribute.............................................................................................................................................................................................done. 03:48:17 INFO - Installing pip.................done. 03:48:17 INFO - Return code: 0 03:48:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:48:18 INFO - Reading from file tmpfile_stdout 03:48:18 INFO - Output received: 03:48:18 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) 03:48:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:18 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/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:48:18 INFO - Using env: {'DISPLAY': ':0', 03:48:18 INFO - 'HOME': '/home/cltbld', 03:48:18 INFO - 'LANG': 'en_US.UTF-8', 03:48:18 INFO - 'LANGUAGE': 'en_US:en', 03:48:18 INFO - 'LOGNAME': 'cltbld', 03:48:18 INFO - 'MAIL': '/var/mail/cltbld', 03:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:18 INFO - 'MOZ_NO_REMOTE': '1', 03:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:18 INFO - 'NO_EM_RESTART': '1', 03:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:18 INFO - 'PWD': '/builds/slave/test', 03:48:18 INFO - 'SHELL': '/bin/bash', 03:48:18 INFO - 'SHLVL': '1', 03:48:18 INFO - 'TERM': 'linux', 03:48:18 INFO - 'TMOUT': '86400', 03:48:18 INFO - 'USER': 'cltbld', 03:48:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:18 INFO - '_': '/tools/buildbot/bin/python'} 03:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:18 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 03:48:18 INFO - Cleaning up... 03:48:18 INFO - Return code: 0 03:48:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:18 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/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:48:18 INFO - Using env: {'DISPLAY': ':0', 03:48:18 INFO - 'HOME': '/home/cltbld', 03:48:18 INFO - 'LANG': 'en_US.UTF-8', 03:48:18 INFO - 'LANGUAGE': 'en_US:en', 03:48:18 INFO - 'LOGNAME': 'cltbld', 03:48:18 INFO - 'MAIL': '/var/mail/cltbld', 03:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:18 INFO - 'MOZ_NO_REMOTE': '1', 03:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:18 INFO - 'NO_EM_RESTART': '1', 03:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:18 INFO - 'PWD': '/builds/slave/test', 03:48:18 INFO - 'SHELL': '/bin/bash', 03:48:18 INFO - 'SHLVL': '1', 03:48:18 INFO - 'TERM': 'linux', 03:48:18 INFO - 'TMOUT': '86400', 03:48:18 INFO - 'USER': 'cltbld', 03:48:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:18 INFO - '_': '/tools/buildbot/bin/python'} 03:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:18 INFO - Downloading/unpacking psutil>=3.1.1 03:48:18 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 03:48:18 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 03:48:18 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 03:48:18 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 03:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:19 INFO - Installing collected packages: psutil 03:48:19 INFO - Running setup.py install for psutil 03:48:19 INFO - building 'psutil._psutil_linux' extension 03:48:19 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 03:48:19 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 03:48:19 INFO - building 'psutil._psutil_posix' extension 03:48:19 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 03:48:20 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 03:48:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:20 INFO - Successfully installed psutil 03:48:20 INFO - Cleaning up... 03:48:20 INFO - Return code: 0 03:48:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:20 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/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:48:20 INFO - Using env: {'DISPLAY': ':0', 03:48:20 INFO - 'HOME': '/home/cltbld', 03:48:20 INFO - 'LANG': 'en_US.UTF-8', 03:48:20 INFO - 'LANGUAGE': 'en_US:en', 03:48:20 INFO - 'LOGNAME': 'cltbld', 03:48:20 INFO - 'MAIL': '/var/mail/cltbld', 03:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:20 INFO - 'MOZ_NO_REMOTE': '1', 03:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:20 INFO - 'NO_EM_RESTART': '1', 03:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:20 INFO - 'PWD': '/builds/slave/test', 03:48:20 INFO - 'SHELL': '/bin/bash', 03:48:20 INFO - 'SHLVL': '1', 03:48:20 INFO - 'TERM': 'linux', 03:48:20 INFO - 'TMOUT': '86400', 03:48:20 INFO - 'USER': 'cltbld', 03:48:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:20 INFO - '_': '/tools/buildbot/bin/python'} 03:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:48:21 INFO - Installing collected packages: mozsystemmonitor 03:48:21 INFO - Running setup.py install for mozsystemmonitor 03:48:21 INFO - Successfully installed mozsystemmonitor 03:48:21 INFO - Cleaning up... 03:48:21 INFO - Return code: 0 03:48:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:21 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/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:48:21 INFO - Using env: {'DISPLAY': ':0', 03:48:21 INFO - 'HOME': '/home/cltbld', 03:48:21 INFO - 'LANG': 'en_US.UTF-8', 03:48:21 INFO - 'LANGUAGE': 'en_US:en', 03:48:21 INFO - 'LOGNAME': 'cltbld', 03:48:21 INFO - 'MAIL': '/var/mail/cltbld', 03:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:21 INFO - 'MOZ_NO_REMOTE': '1', 03:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:21 INFO - 'NO_EM_RESTART': '1', 03:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:21 INFO - 'PWD': '/builds/slave/test', 03:48:21 INFO - 'SHELL': '/bin/bash', 03:48:21 INFO - 'SHLVL': '1', 03:48:21 INFO - 'TERM': 'linux', 03:48:21 INFO - 'TMOUT': '86400', 03:48:21 INFO - 'USER': 'cltbld', 03:48:21 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:21 INFO - '_': '/tools/buildbot/bin/python'} 03:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:21 INFO - Downloading/unpacking jsonschema==2.5.1 03:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:48: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 03:48: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 03:48: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 03:48: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 03:48:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:23 INFO - warning: no files found matching '*.txt' 03:48:23 INFO - no previously-included directories found matching 'build' 03:48:23 INFO - no previously-included directories found matching 'dist' 03:48:23 INFO - no previously-included directories found matching '.git*' 03:48:23 INFO - Installing collected packages: jsonschema, functools32 03:48:23 INFO - Running setup.py install for functools32 03:48:23 INFO - warning: no files found matching '*.txt' 03:48:23 INFO - no previously-included directories found matching 'build' 03:48:23 INFO - no previously-included directories found matching 'dist' 03:48:23 INFO - no previously-included directories found matching '.git*' 03:48:23 INFO - Successfully installed jsonschema functools32 03:48:23 INFO - Cleaning up... 03:48:23 INFO - Return code: 0 03:48:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:48:23 INFO - Using env: {'DISPLAY': ':0', 03:48:23 INFO - 'HOME': '/home/cltbld', 03:48:23 INFO - 'LANG': 'en_US.UTF-8', 03:48:23 INFO - 'LANGUAGE': 'en_US:en', 03:48:23 INFO - 'LOGNAME': 'cltbld', 03:48:23 INFO - 'MAIL': '/var/mail/cltbld', 03:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:23 INFO - 'MOZ_NO_REMOTE': '1', 03:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:23 INFO - 'NO_EM_RESTART': '1', 03:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:23 INFO - 'PWD': '/builds/slave/test', 03:48:23 INFO - 'SHELL': '/bin/bash', 03:48:23 INFO - 'SHLVL': '1', 03:48:23 INFO - 'TERM': 'linux', 03:48:23 INFO - 'TMOUT': '86400', 03:48:23 INFO - 'USER': 'cltbld', 03:48:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:23 INFO - '_': '/tools/buildbot/bin/python'} 03:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:48:23 INFO - Cleaning up... 03:48:23 INFO - Return code: 0 03:48:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:48:23 INFO - Using env: {'DISPLAY': ':0', 03:48:23 INFO - 'HOME': '/home/cltbld', 03:48:23 INFO - 'LANG': 'en_US.UTF-8', 03:48:23 INFO - 'LANGUAGE': 'en_US:en', 03:48:23 INFO - 'LOGNAME': 'cltbld', 03:48:23 INFO - 'MAIL': '/var/mail/cltbld', 03:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:23 INFO - 'MOZ_NO_REMOTE': '1', 03:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:23 INFO - 'NO_EM_RESTART': '1', 03:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:23 INFO - 'PWD': '/builds/slave/test', 03:48:23 INFO - 'SHELL': '/bin/bash', 03:48:23 INFO - 'SHLVL': '1', 03:48:23 INFO - 'TERM': 'linux', 03:48:23 INFO - 'TMOUT': '86400', 03:48:23 INFO - 'USER': 'cltbld', 03:48:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:23 INFO - '_': '/tools/buildbot/bin/python'} 03:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:48: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 03:48: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 03:48: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 03:48: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 03:48:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:48:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:25 INFO - Downloading docopt-0.6.1.tar.gz 03:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:25 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:25 INFO - Running setup.py install for blobuploader 03:48:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:48:25 INFO - Running setup.py install for requests 03:48:26 INFO - Running setup.py install for docopt 03:48:26 INFO - Successfully installed blobuploader requests docopt 03:48:26 INFO - Cleaning up... 03:48:26 INFO - Return code: 0 03:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:26 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/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:26 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:48:26 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:26 INFO - Using env: {'DISPLAY': ':0', 03:48:26 INFO - 'HOME': '/home/cltbld', 03:48:26 INFO - 'LANG': 'en_US.UTF-8', 03:48:26 INFO - 'LANGUAGE': 'en_US:en', 03:48:26 INFO - 'LOGNAME': 'cltbld', 03:48:26 INFO - 'MAIL': '/var/mail/cltbld', 03:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:26 INFO - 'MOZ_NO_REMOTE': '1', 03:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:26 INFO - 'NO_EM_RESTART': '1', 03:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:26 INFO - 'PWD': '/builds/slave/test', 03:48:26 INFO - 'SHELL': '/bin/bash', 03:48:26 INFO - 'SHLVL': '1', 03:48:26 INFO - 'TERM': 'linux', 03:48:26 INFO - 'TMOUT': '86400', 03:48:26 INFO - 'USER': 'cltbld', 03:48:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:26 INFO - '_': '/tools/buildbot/bin/python'} 03:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:26 INFO - Running setup.py (path:/tmp/pip-BTpgu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:26 INFO - Running setup.py (path:/tmp/pip-4pfsaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:26 INFO - Running setup.py (path:/tmp/pip-7pl0s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:26 INFO - Running setup.py (path:/tmp/pip-7uADxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:26 INFO - Running setup.py (path:/tmp/pip-6bkUks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:26 INFO - Running setup.py (path:/tmp/pip-WwC_WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:26 INFO - Running setup.py (path:/tmp/pip-soBeTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:26 INFO - Running setup.py (path:/tmp/pip-AXkYU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:26 INFO - Running setup.py (path:/tmp/pip-WEsTDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:27 INFO - Running setup.py (path:/tmp/pip-IE4nDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:27 INFO - Running setup.py (path:/tmp/pip-Acmide-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:27 INFO - Running setup.py (path:/tmp/pip-JnWFpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:27 INFO - Running setup.py (path:/tmp/pip-8pQxpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:27 INFO - Running setup.py (path:/tmp/pip-ILLNHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:27 INFO - Running setup.py (path:/tmp/pip-rbgtYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:27 INFO - Running setup.py (path:/tmp/pip-v5YII6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:27 INFO - Running setup.py (path:/tmp/pip-9J_6jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:27 INFO - Running setup.py install for manifestparser 03:48:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:27 INFO - Running setup.py install for mozcrash 03:48:27 INFO - Running setup.py install for mozdebug 03:48:27 INFO - Running setup.py install for mozdevice 03:48:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Running setup.py install for mozfile 03:48:28 INFO - Running setup.py install for mozhttpd 03:48:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Running setup.py install for mozinfo 03:48:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Running setup.py install for mozInstall 03:48:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Running setup.py install for mozleak 03:48:28 INFO - Running setup.py install for mozlog 03:48:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Running setup.py install for moznetwork 03:48:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Running setup.py install for mozprocess 03:48:28 INFO - Running setup.py install for mozprofile 03:48:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:48:28 INFO - Running setup.py install for mozrunner 03:48:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:48:29 INFO - Running setup.py install for mozscreenshot 03:48:29 INFO - Running setup.py install for moztest 03:48:29 INFO - Running setup.py install for mozversion 03:48:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:48:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:29 INFO - Cleaning up... 03:48:29 INFO - Return code: 0 03:48:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:29 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/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:29 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:48:29 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:29 INFO - Using env: {'DISPLAY': ':0', 03:48:29 INFO - 'HOME': '/home/cltbld', 03:48:29 INFO - 'LANG': 'en_US.UTF-8', 03:48:29 INFO - 'LANGUAGE': 'en_US:en', 03:48:29 INFO - 'LOGNAME': 'cltbld', 03:48:29 INFO - 'MAIL': '/var/mail/cltbld', 03:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:29 INFO - 'MOZ_NO_REMOTE': '1', 03:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:29 INFO - 'NO_EM_RESTART': '1', 03:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:29 INFO - 'PWD': '/builds/slave/test', 03:48:29 INFO - 'SHELL': '/bin/bash', 03:48:29 INFO - 'SHLVL': '1', 03:48:29 INFO - 'TERM': 'linux', 03:48:29 INFO - 'TMOUT': '86400', 03:48:29 INFO - 'USER': 'cltbld', 03:48:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:29 INFO - '_': '/tools/buildbot/bin/python'} 03:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:29 INFO - Running setup.py (path:/tmp/pip-QLAZJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:29 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)) 03:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:29 INFO - Running setup.py (path:/tmp/pip-P0fGkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:29 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)) 03:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:29 INFO - Running setup.py (path:/tmp/pip-tVxRUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:29 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)) 03:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:29 INFO - Running setup.py (path:/tmp/pip-FLR4J4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 03:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:29 INFO - Running setup.py (path:/tmp/pip-lU0hC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:29 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)) 03:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:29 INFO - Running setup.py (path:/tmp/pip-UYO_2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:30 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:30 INFO - Running setup.py (path:/tmp/pip-qstTcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:30 INFO - Running setup.py (path:/tmp/pip-jTGFgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:30 INFO - Running setup.py (path:/tmp/pip-oW0qKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:30 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:30 INFO - Running setup.py (path:/tmp/pip-DVJOFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:30 INFO - Running setup.py (path:/tmp/pip-iXQQ7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:30 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:30 INFO - Running setup.py (path:/tmp/pip-iBI6z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:30 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:30 INFO - Running setup.py (path:/tmp/pip-YEDsNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:30 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:30 INFO - Running setup.py (path:/tmp/pip-ylzLIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:30 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:30 INFO - Running setup.py (path:/tmp/pip-FTSOxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:30 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:30 INFO - Running setup.py (path:/tmp/pip-RUhO_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:30 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)) 03:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:30 INFO - Running setup.py (path:/tmp/pip-Tzllz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:30 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)) 03:48:30 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)) 03:48:30 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)) 03:48:30 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)) 03:48:30 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:48:30 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:48:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48: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 03:48: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 03:48: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 03:48: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 03:48:31 INFO - Downloading blessings-1.6.tar.gz 03:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:32 INFO - Installing collected packages: blessings 03:48:32 INFO - Running setup.py install for blessings 03:48:32 INFO - Successfully installed blessings 03:48:32 INFO - Cleaning up... 03:48:32 INFO - Return code: 0 03:48:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:32 INFO - Reading from file tmpfile_stdout 03:48:32 INFO - Current package versions: 03:48:32 INFO - argparse == 1.2.1 03:48:32 INFO - blessings == 1.6 03:48:32 INFO - blobuploader == 1.2.4 03:48:32 INFO - docopt == 0.6.1 03:48:32 INFO - functools32 == 3.2.3-2 03:48:32 INFO - jsonschema == 2.5.1 03:48:32 INFO - manifestparser == 1.1 03:48:32 INFO - mozInstall == 1.13 03:48:32 INFO - mozcrash == 1.0 03:48:32 INFO - mozdebug == 0.1 03:48:32 INFO - mozdevice == 0.51 03:48:32 INFO - mozfile == 1.2 03:48:32 INFO - mozhttpd == 0.7 03:48:32 INFO - mozinfo == 0.10 03:48:32 INFO - mozleak == 0.1 03:48:32 INFO - mozlog == 3.5 03:48:32 INFO - moznetwork == 0.27 03:48:32 INFO - mozprocess == 0.25 03:48:32 INFO - mozprofile == 0.28 03:48:32 INFO - mozrunner == 6.13 03:48:32 INFO - mozscreenshot == 0.1 03:48:32 INFO - mozsystemmonitor == 0.3 03:48:32 INFO - moztest == 0.8 03:48:32 INFO - mozversion == 1.4 03:48:32 INFO - psutil == 3.1.1 03:48:32 INFO - requests == 1.2.3 03:48:32 INFO - wsgiref == 0.1.2 03:48:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:32 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/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:32 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:48:32 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:32 INFO - Using env: {'DISPLAY': ':0', 03:48:32 INFO - 'HOME': '/home/cltbld', 03:48:32 INFO - 'LANG': 'en_US.UTF-8', 03:48:32 INFO - 'LANGUAGE': 'en_US:en', 03:48:32 INFO - 'LOGNAME': 'cltbld', 03:48:32 INFO - 'MAIL': '/var/mail/cltbld', 03:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:32 INFO - 'MOZ_NO_REMOTE': '1', 03:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:32 INFO - 'NO_EM_RESTART': '1', 03:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:32 INFO - 'PWD': '/builds/slave/test', 03:48:32 INFO - 'SHELL': '/bin/bash', 03:48:32 INFO - 'SHLVL': '1', 03:48:32 INFO - 'TERM': 'linux', 03:48:32 INFO - 'TMOUT': '86400', 03:48:32 INFO - 'USER': 'cltbld', 03:48:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:32 INFO - '_': '/tools/buildbot/bin/python'} 03:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:32 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)) 03:48:32 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)) 03:48:32 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)) 03:48:32 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)) 03:48:32 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)) 03:48:32 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)) 03:48:32 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)) 03:48:32 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)) 03:48:32 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)) 03:48:32 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:48:33 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)) 03:48:33 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)) 03:48:33 INFO - Installing collected packages: simplejson 03:48:33 INFO - Running setup.py install for simplejson 03:48:33 INFO - building 'simplejson._speedups' extension 03:48:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:48:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:48:34 INFO - Successfully installed simplejson 03:48:34 INFO - Cleaning up... 03:48:34 INFO - Return code: 0 03:48:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, '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': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', '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 03:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:48:34 INFO - Using env: {'DISPLAY': ':0', 03:48:34 INFO - 'HOME': '/home/cltbld', 03:48:34 INFO - 'LANG': 'en_US.UTF-8', 03:48:34 INFO - 'LANGUAGE': 'en_US:en', 03:48:34 INFO - 'LOGNAME': 'cltbld', 03:48:34 INFO - 'MAIL': '/var/mail/cltbld', 03:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:34 INFO - 'MOZ_NO_REMOTE': '1', 03:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:34 INFO - 'NO_EM_RESTART': '1', 03:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:34 INFO - 'PWD': '/builds/slave/test', 03:48:34 INFO - 'SHELL': '/bin/bash', 03:48:34 INFO - 'SHLVL': '1', 03:48:34 INFO - 'TERM': 'linux', 03:48:34 INFO - 'TMOUT': '86400', 03:48:34 INFO - 'USER': 'cltbld', 03:48:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:34 INFO - '_': '/tools/buildbot/bin/python'} 03:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:48:35 INFO - Cleaning up... 03:48:35 INFO - Return code: 0 03:48:35 INFO - Running post-action listener: _resource_record_post_action 03:48:35 INFO - Running post-action listener: _start_resource_monitoring 03:48:35 INFO - Starting resource monitoring. 03:48:35 INFO - [mozharness: 2017-08-14 10:48:35.103316Z] Finished create-virtualenv step (success) 03:48:35 INFO - [mozharness: 2017-08-14 10:48:35.103826Z] Running install step. 03:48:35 INFO - Running pre-action listener: _resource_record_pre_action 03:48:35 INFO - Running main action method: install 03:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:35 INFO - Reading from file tmpfile_stdout 03:48:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:48:35 INFO - Reading from file tmpfile_stdout 03:48:35 INFO - Output received: 03:48:35 INFO - Usage: mozinstall [options] installer 03:48:35 INFO - Options: 03:48:35 INFO - -h, --help show this help message and exit 03:48:35 INFO - -d DEST, --destination=DEST 03:48:35 INFO - Directory to install application into. [default: 03:48:35 INFO - "/builds/slave/test"] 03:48:35 INFO - --app=APP Application being installed. [default: firefox] 03:48:35 INFO - mkdir: /builds/slave/test/build/application 03:48:35 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'] 03:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:48:53 INFO - Reading from file tmpfile_stdout 03:48:53 INFO - Output received: 03:48:53 INFO - /builds/slave/test/build/application/firefox/firefox 03:48:53 INFO - Running post-action listener: _resource_record_post_action 03:48:53 INFO - [mozharness: 2017-08-14 10:48:53.393361Z] Finished install step (success) 03:48:53 INFO - [mozharness: 2017-08-14 10:48:53.393505Z] Running setup-mitmproxy step. 03:48:53 INFO - Running pre-action listener: _resource_record_pre_action 03:48:53 INFO - Running main action method: setup_mitmproxy 03:48:53 INFO - Skipping: mitmproxy is not required 03:48:53 INFO - Running post-action listener: _resource_record_post_action 03:48:53 INFO - [mozharness: 2017-08-14 10:48:53.394194Z] Finished setup-mitmproxy step (success) 03:48:53 INFO - [mozharness: 2017-08-14 10:48:53.394413Z] Running run-tests step. 03:48:53 INFO - Running pre-action listener: _resource_record_pre_action 03:48:53 INFO - Running pre-action listener: _set_gcov_prefix 03:48:53 INFO - Running main action method: run_tests 03:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:48:53 INFO - Python 2.7.3 03:48:53 INFO - Return code: 0 03:48:53 INFO - grabbing minidump binary from tooltool 03:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:48:53 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 0x1c288a0>, '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 0x1c297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c29c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:48:53 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 03:48:53 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 03:48:53 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 03:48:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:53 INFO - Return code: 0 03:48:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:48:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:48:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:48:53 INFO - ENV: RUST_BACKTRACE is now full 03:48:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:48:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:48:53 INFO - Using env: {'DISPLAY': ':0', 03:48:53 INFO - 'HOME': '/home/cltbld', 03:48:53 INFO - 'LANG': 'en_US.UTF-8', 03:48:53 INFO - 'LANGUAGE': 'en_US:en', 03:48:53 INFO - 'LOGNAME': 'cltbld', 03:48:53 INFO - 'MAIL': '/var/mail/cltbld', 03:48:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:53 INFO - 'MOZ_NO_REMOTE': '1', 03:48:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:53 INFO - 'NO_EM_RESTART': '1', 03:48:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:53 INFO - 'PWD': '/builds/slave/test', 03:48:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:53 INFO - 'RUST_BACKTRACE': 'full', 03:48:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:48:53 INFO - 'SHELL': '/bin/bash', 03:48:53 INFO - 'SHLVL': '1', 03:48:53 INFO - 'STYLO_FORCE_ENABLED': '1', 03:48:53 INFO - 'TERM': 'linux', 03:48:53 INFO - 'TMOUT': '86400', 03:48:53 INFO - 'USER': 'cltbld', 03:48:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392', 03:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:53 INFO - '_': '/tools/buildbot/bin/python'} 03:48:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:48:53 INFO - mozversion application_buildid: 20170814095311 03:48:53 INFO - mozversion application_changeset: f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf 03:48:53 INFO - mozversion application_display_name: Nightly 03:48:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:53 INFO - mozversion application_name: Firefox 03:48:53 INFO - mozversion application_remotingname: firefox 03:48:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:48:53 INFO - mozversion application_vendor: Mozilla 03:48:53 INFO - mozversion application_version: 57.0a1 03:48:53 INFO - mozversion platform_buildid: 20170814095311 03:48:53 INFO - mozversion platform_changeset: f667fdab3ac0b9e10ce396f8cdc33499ced1ffbf 03:48:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:48:53 INFO - mozversion platform_version: 57.0a1 03:48:53 INFO - using testdate: 1502707733 03:48:53 INFO - actual date: 1502707733 03:48:53 INFO - starting webserver on 'localhost:56926' 03:48:53 INFO - SUITE-START | Running 2 tests 03:48:53 INFO - TEST-START | dromaeo_css 03:48:53 INFO - Initialising browser for dromaeo_css test... 03:48:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56926/getInfo.html -profile /tmp/tmpKXON9F/profile 03:48:53 INFO - TEST-INFO | started process 13145 (/builds/slave/test/build/application/firefox/firefox http://localhost:56926/getInfo.html) 03:48:59 INFO - TEST-INFO | 13145: exit 0 03:48:59 INFO - Browser initialized. 03:48:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:59 INFO - TEST-INFO | started process 13373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKXON9F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:00 INFO - PID 13373 | 03:49:00 INFO - PID 13373 | (/builds/slave/test/build/application/firefox/firefox:13427): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:49:00 INFO - PID 13373 | 03:49:10 INFO - PID 13373 | RSS: Main: 168280064 03:49:10 INFO - PID 13373 | 03:52:10 INFO - PID 13373 | Cycle 1(1): loaded http://localhost:56926/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56926/tests/dromaeo/cssquery-ext.html) 03:52:11 INFO - PID 13373 | RSS: Main: 175005696 03:52:11 INFO - PID 13373 | 03:55:13 INFO - PID 13373 | Cycle 1(1): loaded http://localhost:56926/tests/dromaeo/cssquery-ext.html (next: http://localhost:56926/tests/dromaeo/cssquery-jquery.html) 03:55:13 INFO - PID 13373 | RSS: Main: 170680320 03:55:13 INFO - PID 13373 | 03:58:15 INFO - PID 13373 | Cycle 1(1): loaded http://localhost:56926/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56926/tests/dromaeo/cssquery-mootools.html) 03:58:16 INFO - PID 13373 | RSS: Main: 174358528 03:58:16 INFO - PID 13373 | 04:01:18 INFO - PID 13373 | Cycle 1(1): loaded http://localhost:56926/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56926/tests/dromaeo/cssquery-prototype.html) 04:01:18 INFO - PID 13373 | RSS: Main: 173187072 04:01:18 INFO - PID 13373 | 04:04:22 INFO - PID 13373 | Cycle 1(1): loaded http://localhost:56926/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56926/tests/dromaeo/cssquery-yui.html) 04:04:23 INFO - PID 13373 | RSS: Main: 174964736 04:04:23 INFO - PID 13373 | 04:07:25 INFO - PID 13373 | Cycle 1(1): loaded http://localhost:56926/tests/dromaeo/cssquery-yui.html (next: http://localhost:56926/tests/dromaeo/cssquery-dojo.html) 04:07:25 INFO - PID 13373 | RSS: Main: 177676288 04:07:25 INFO - PID 13373 | 04:07:25 INFO - PID 13373 | __start_tp_report 04:07:25 INFO - PID 13373 | _x_x_mozilla_page_load 04:07:25 INFO - PID 13373 | _x_x_mozilla_page_load_details 04:07:25 INFO - PID 13373 | |i|pagename|runs| 04:07:25 INFO - PID 13373 | |0;dojo.html;3116.812991220528;3176.872925082997;3180.8886688965886;3192.744580433565;3217.9356412871743;6122.020476723725;6147.938520614793;6154.569180157391;6206.9689651551735;6322.0832979217985;6250.624962502242;6302.054691796221;6304.495640348772;6337.1761670982705;6375.936240637592;5664.745086471098;5699.430056994299;5738.7991420300295;5772.653640781546;5831;5571.8328450146355;5639.774409023655;5767.884642307151;5772.45161709639;5780;5668.914966275509;5672.914906276409;5742.425757424245;5760.567957403169;5765.82702518923;5651.9717401413145;5701.401352857932;5755.539556835443;5760.567957403169;5762.366139724627;5553.250311208016;5617.719114044281;5617.8033768817895;5637.943620563783;5686;6139.938600613981;6158.414950579688;6170.382961703838;6195.411435913581;6242.812715618538;6629.502787290972;6640.535162538624;6698.497612679069;6718.328167183291;6721.227058888241;6580.835479113012;6663.966680166568;6681.432078273353;6687.164104486939;6762.425193858528;6162.198914141133;6176.3514830943;6177.135201071854;6182.783602573933;6184.938150618526;6716.832079197961;6795.898061529081;6800.31996800316;6818.727250910008;6833.180018397824;6483.740650373932;6493.577917435446;6504.804855854332;6507.772227971998;6508.642024688687;6583.868322633616;6607.273199948002;6614.603123812587;6614.86770264592;6623.172103487064;6592.274849766618;6608.900866487006;6619.106420633249;6621.966890165519;6625.3043430440075;5873.794417195378;6673.632950187786;6673.799786006428;6754.952982287753;6771.052052712625;5453.890922181534;5499.587530935196;5516.448355164452;5518.255035570227;5531.115021596525;4548.4541854977615;4601.194790911577;4662.393888794503;4701.3888194535175;4724.692894961817;5793.246877905845;5807.593468457252;5811.215485909433;5811.4479124483105;5819.825405237765;6681.832954176184;6709.429698475684;6779.49153813466;6787.6266805325195;6795.286494918061;5686.60193786431;5729.656220626775;5814;5819.447152520504;5821.18503409523;5890.852728681732;5899.026660600953;5913.645181289136;5915.822525324247;5916.171735956969;6507.934920650828;6510.283868774431;6542.378474045054;6545.476361891037;6550.737970481223;6637.402633762985;6752.561083529555;6758.2565917748025;6774.729010839511;6777;6369.172007638977;6437.452816510649;6542.672866356758;6549.410553050248;6551.115599394211;6538.215414150332;6587.80236592903;6595.604263744191;6688.197416310074;6700.195976482853;6788.321167883172;6804.863902722017;6823.55646882951;6829.351211634887;6839.794806155824;6507.804765857032;6539.509536784855;6613.173353330833;6619.3380661933425;6628.602283862983;6476.222853257451;6534.934650653433;6542.378474044958;6576.145101136822;6605.042268871083;6371.585846919936;6442.065900444503;6486.4486518646445;6530.934690653033;6531.575447595891;6564.5076619254705;6572.277049524644;6626.27111017778;6639.734410623714;6666.966665166643;6362.968185159045;6363.745450181941;6462.063000864754;6463.062855885964;6466.288708242184 04:07:25 INFO - PID 13373 | |1;ext.html;804.7103042904554;850.5194565070734;864.602282949843;878.9956050219748;1169.1231576317762;30299.848500757493;30873.691263087363;30948.535771963412;41386.17227655445;42057;41719.58280417195;42069.15861682765;42116.57883421165;42143.78928105363;42214.36678449818;5749.942500575004;7559.622018899046;7693.692252309929;7718.305352518272;7746.9225307746765;5750.626209296403;7475.289847464483;7671.693132274702;7683.5389876607305;7703.807404814868;7657.387409007294;7702.614869256543;7732.884006739903;7745.264199901;7749.30256276935;7608.782594784836;7649.847003059936;7668.38652907766;7672.271134242238;7727.304542591166;7517.661705223278;7569.167391586921;7625.80935476612;7632.3130918217075;7634.198409167013;38009.0497737556;38277.234455311016;38347.80826095852;38357.80821095905;38959.22081558353;3209.2618697699427;3257.2345498807763;3268.297316077055;3269.1990462336644;3271.8527666255077;30446.391072178652;30712.078637640905;30836.383272334653;30858.691413085806;31000;4781.737004464753;4980.651354405193;4984.0281145176705;4998.250262460624;5018.7992480300745;197443;197666;198032;198608.99999999854;198802;48044;48200;48506.02987940222;48542.27186592204;48599.27101093486;50015;50403.49596503988;50548.74725626349;50626.49373506291;50634;14553;14816.3332650031;14816.555503334917;14825.40698372053;14826.555203343916;11344.716382090513;11960.700982475508;12004.939975300067;12013.579524716768;12037.398130093461;11643.301401915744;13095.345232738326;13121.803172952414;13377.264250466318;13404.463821447032;5476.3702174250475;5502.752376143083;5564.972175139179;5599.32808063035;5600.64611334903;995.1541189988596;998.6953979036318;1004.1013293102632;1019.230480986865;1019.5361110694616;22602.208922687627;22863;23030.65454018191;23032.539349212922;23344.883275583852;1094.5512339940585;1095.0910744082391;1102.1458369763498;1104.304288298383;1114.9442527873737;12363.32001739895;12374.81437778434;12619.432125554373;12733.936330318289;12826.294553799444;240919;242391;242784;243087;243354;52835.20747188795;53143.46856531385;53165;53246.20130698042;53261.73369133207;1515.0379509011857;1516.2646116633423;1546.9690606187812;1554.5414102839688;1554.9300281487133;23009.194678186184;23240.3027909163;23396.53206935886;23462.64806027945;23644.881775591013;38761.224775504896;39102.6089739099;39155.216895662496;39163.608363916;39214.80392598019;223844;225836;226185;231849;232452;38156.236875261784;38306.425403618414;38475.230495389376;38560.80719596384;38575.42136867893;45867;46473.53526464692;46730.53269467262;47522;47934.04131917412;34133.317333653686;34538.82730586331;34613.48079778856;34687.306253874274;34833.30333393368;33966.32067358688;34531;34800.65199347974;34988.650113499556;35510.28979420449;37054.6294537062;37158.628413715516;37295.81352093222;37533.4369984445;37537;32509.512357314186;32793.34413311768;33290;33357.83321083379;33424;24144.154954576505;24254.393640159138;24423.26730198097;24766.133185338425;24791.87604061968 04:07:25 INFO - PID 13373 | |2;jquery.html;582.0570675505681;590.6308557151779;591.2550186764676;594.4145017158098;597.1550256387212;22481.3255602332;22890.65664015041;23205.419864503376;23246.30261092166;23285.417864553394;26766.59850102245;27428.725712742867;27441.313967150832;27448.588271175897;27464.45071098577;6378.968105159468;6483.773067942623;6485.2541957675;6527.608343499382;6536.182977127859;6217.129601855744;6491.902621460682;6531.771388001421;6534.8693026139445;6535.215774107114;6497.93502064978;6501.837454063639;6502.6098434093865;6505.219373675142;6505.479561635081;6471.126397936266;6474.352564743512;6481.449076828475;6481.48148148147;6482.902756458657;6030.698465076773;6035;6041.063635136561;6043.848903777397;6045.939540604581;30516.694833051606;30624.693753062405;30691.232719181975;30798.23004424885;30976.845115774504;1959.2456904091885;1988.4829944214464;1989.2142603671468;1989.2440872468514;1991.5021244688828;19068;19492.415227543195;19514.316998905113;19519.31682391124;19630.41108766739;2368.706276480438;2401.30362194965;2426.0417135231482;2437.2566367257978;2464.5194187133516;136548;140305.298473508;141121;141251;141607;14236.857631423552;15006.62483437901;15074.321655525528;15074.849251507563;15802.68394632124;19558.217671293274;20170.394888153085;22875;23229.41926451852;23578.646320305208;10278.537465814057;10311.22665800068;10512.21158413122;10610.57557697699;10669.57321707123;9688.46713430754;9775.120239178508;9870.30907836459;9928.205743540644;9982.35114717541;9390.732251146008;9485.762855928657;9524.380915240487;9556.904430955741;9645.71062868115;2728.6725592928974;2734.234414363981;2755.8484283364605;2770.598263251817;2852.7575156111548;967.3277072434731;980.7597138700921;981.1660088924357;992.9950350248347;997.9051990060933;18901.43295701131;23851.7614823853;24641.876790615934;26239.344016399362;26320;1034.7620047389144;1042.2027149230844;1048.3447845096814;1050.9632162874263;1055.3984228989557;11320.490577924013;11396.259243149168;11461.312321260584;11495.482703278372;11541;507807;518873;518951;521279;532811;120912;124771;127100;127362;127403.36298318449;1247.457356050121;1264.487882407608;1296.9610911672664;1299.3503248375812;1303.328785675378;20579;20673.17307307751;20801.271955481487;20907.477313067295;21358.679619806026;56054.719726401105;57187;58116;58955.11567326579;60900.390996089474;68267;68413.26346946067;68588.6570567144;68758;68776.6561167211;14840.554783356516;15103.54689359321;15111.54665360041;15218.847811522186;15258;23951.640725389483;24277.150299739424;24316.878415607807;24391.878040609685;24494.510109798062;17006.149692515573;17238.224279907685;17270.654586907942;17345.56636084108;17506;16183.919080404523;17442.9127854365;17529.912350438168;17678;17976.91011544934;18258.45224643263;18417.815821842145;18428;18651.253949842398;20061.29785457502;14066.156030638194;14720.19038952825;14823.481178158712;14834.62913427173;14946.476873309382;17345.132743363032;17348.219330130425;17506;17680.73478897792;17729.290828367237 04:07:25 INFO - PID 13373 | |3;mootools.html;1327.7809161488356;1355.586546103438;1361.0676686469772;1378.779779894793;1382.97925531117;12400;14137.505187318433;14662.633434164138;14762.261886905651;14772.11367317959;12512.937435312811;13455.798163027563;14861.405543778235;14926.104433733983;14951.252437378114;2655.6547648805627;2697.5818748094075;2702.3244188952763;2703.405250844811;2704.5537486314734;2527.330257481769;2553.9744602553924;2611.9216423507323;2614.3986883016823;2716.769074628659;2666.6133410655443;2695.029789275859;2698;2698.3389069677955;2698.9055383061595;2596.6883973923063;2628.6976997645324;2640.049582150424;2641.8546979916096;2649.470105978812;2571.909983150581;2583.651207087038;2586.8447893126286;2600.479904019204;2603.7005744339262;14251.64370890736;14255.215963122024;14255.358508867126;14282.64293392663;14307.356168972421;7200.567965922061;7388.224236455202;7395.4083673306;7445.478816482849;7506.061742282215;5068.467810879842;5186.351706036746;5233.607479439057;5284.128118860383;5313.57491400687;1948.6297603455298;1961.205711686769;1964.6758284882976;1967.4982879365814;1987.3044434447972;24303.14938977145;24564.385890352707;24586.50826983468;24594.139205127736;24622.384440388956;6498.675066246763;6509.1863517060365;6529.673516324165;6637.734490620418;6645.568038077509;16442.095684737455;16576.585585360463;16669.83330166707;16701.83298167027;16717.749233761504;6901.654917254117;6981.476389270825;6982.47631427645;6983.615901125385;6983.89524157138;6258.687065646699;6260.843478913063;6696.8995465068065;7036.401905838061;7097.290270972861;4869.537393947569;5057.72182529957;5071.290019397287;5082.644214904921;5108.438071812097;1314.6384744195423;1358.9388477518535;1471.2643678160919;1477.8374378818537;1479.5635287590187;928.1785619726455;935.6818681648273;939.3424602778083;944.5607792376578;950.1401231885155;8283.461574997606;8469.491830490068;8548.786280343042;8598.39811213209;8641;990.405756546081;998.5456617239139;1000.0799264676369;1003.4280460137797;1004.2116938203475;4598.97700511502;5086.898262034739;5525.806596769094;5530.05988981866;5581.134924086773;19460.80539194618;20170.39488815338;20244.089015994316;20289.18843246283;20440.897795511224;19397.418077457416;20151.899240503997;20217.393478195678;20223.191072357236;20244;10804.24370294072;10819.13446924244;10889.945550272198;10942.288751231144;10943.398113103696;8024.197580241929;8281.337493000425;8292.83414331722;8396.832063358821;8433.451825631315;16799.160041998097;17134.40029598958;17209.655806884042;17370.565735856704;17381.391651292142;17821.821781782015;18049.639007220045;18186.54533636617;18187.727184091986;18270.360537381126;10659.733506662396;10806.135509159405;10843.566257349617;10919.890801092206;10933.83599245996;13250.403731832284;13405.66485837862;13408.061435699798;13474.663133421744;13490.190588564717;10986.505607247533;11067.446627668745;11180.552777888794;11240.662780116609;11295.152863535104;10770.62302819429;10795.784084318113;10820.513076911715;10850.67447976562;11064.834027489433;9435;9483.66807161746;9522.714318570454;9523.142917137491;9550.570224340061;7354.264573542603;7407.518511296748;7482.139553951365;7498.137714162941;7498.58757768328;7180;7383.556986580822;7420.257974202536;7544.66049027806;7571.697132114654 04:07:25 INFO - PID 13373 | |4;prototype.html;497.25319715940384;500.7768969646587;521.3326941514861;525.3433208489388;528.2683483375524;6270.905936410946;6284.905726414102;6299.685015749217;6313.337099604544;6339.841503962403;5937.435943585352;6121.32665406806;6193.47355474784;6219.440250377465;6232.813015609528;4962.975185124069;4973.975130124362;4993.700377977333;5000.399952005764;5006.474320196382;4859.829905953275;4963.726995015273;4981.825636102737;4986.476419975905;5026.924596131061;4907.779149938261;4912.263160525932;4938.48145944676;4968.105740966625;5015.122353588125;4927.926081108786;4930.4330002049865;4937.284093806378;4946.208606622923;5015.172496538067;4432.468103827561;4463.709858859196;4488.775561221926;4494.730316181007;4548.181327361073;6022.608530445507;6069.484093852028;6081.726322315506;6088.756449742005;6142.447179753799;5646.237757902672;5668.319801623831;5719.855054354617;5787.3923238059815;5803.591509523542;6539.247986481568;6554.24626167992;6562.3266067153045;6638.369354911276;6642.767503137367;4866.416030076378;4887.582601045692;4923.556879880792;4939.703617782944;4946.925796113062;6853.7943861684225;6870.45036397087;6921.723131074801;6941.930580694179;6970.268121847234;4990.6506544541535;5003.924941125886;5042.672226305352;5052.797888084436;5064.696118232918;5109.718965456861;5129.461406552333;5145.588352931832;5164.406093299243;5168.121419358718;5684.914726279109;5723.141528770718;5758.337791154071;5773.451522105477;5797.768089276382;6522.869542609216;6549.803505894831;6581.769638062645;6675.264431247911;6721.924492081243;1695.9224949437087;1704.9344159900063;1728.9221985010704;1747.7028905086165;1759.9560010999828;1199.280431740966;1199.904007679401;1208.9637310880687;1213.4782043721284;1223.321056813477;5646.6047376684055;5713.857228554306;5715.428457154251;5733.31200255972;5764.924627134228;6483.3516648335735;6684.888793392029;6710.664466776641;6731.057651928734;6735.595864248161;5691.630044047124;5697.299727724561;5750.396208398141;5809.128630705343;5814.302283725895;3569.0185199069942;3594.353016457063;3599.0642432967616;3636.8545258189906;3641.8725344612812;6583.604983700993;6639.43564796988;6642.202935647753;6655.267920528738;6667.466602671775;6994.615296158659;7008.26413226614;7036.120484939383;7048.894266586005;7075.620254050514;6579.671016449159;6612.537122401386;6617.536772425884;6626.469882409396;6652.268250492442;6813.182418109858;6847.452203823782;6858.759943401957;6892.172939247323;6909.170899492093;6773.6951837168435;6788.728450862108;6792.21889482696;6828.5902845829405;6838.7264509419065;6551.21385433751;6565;6580.440662543738;6623.735050598115;6645.534812563267;5477.68599997012;5547.1679248111495;5548.223248745098;5575.944240557543;5583.469570390806;6594.8351291218105;6860.965695171492;6871.793846184622;6885.931140688529;6921.584704917721;6367.93632063692;6488.70800813974;6552.051576790368;6622.801315960529;6635.170603674541;6617.900731489128;6633.70148343316;6643.069970204272;6644.60132392058;6683.966580167068;6578.736850525926;6588.604683718992;6591.703373348115;6599.769008084694;6636.767713130017;6604.735810567716;6659.267480577036;6697.3302669734585;6707.195136583641;6747.460203183831;6289.937100628935;6336.619802811846;6363.840903977438;6427.389398007182;6429.6142231466265 04:07:25 INFO - PID 13373 | |5;yui.html;870.9346798990074;895.2032690905091;896.4666023715887;927.3740225347891;930.9953450232748;18336;19195.32816351428;19281.807181928176;19331.806681933176;21523.67714484284;21748.238811641597;22001.339959801233;22038.449038773997;22279.886005699733;22299.996500157493;966.7244835221945;983.9754006149868;984.1339621133428;985.7190700650316;988.1255089246033;1022.5551884930042;1060.448566745292;1064.1858977881927;1064.297563608019;1067.023673338894;1098.0337303173237;1100.6477927063343;1101.0200921180156;1101.928374655649;1113.4766659669942;1095.0801326885455;1095.912327013841;1096.4736926275432;1096.956121755133;1109.7059279290995;799.2806474173291;800.0599295827437;800.9159038301011;802.3060053054124;813.1665043330634;19375;19822.603547929106;20541.38375848727;20585.485362865897;20757.5848483031;21561.1375544978;21647.134114635395;21832.23587174441;21889.67165492519;21951.451213719785;16505.17474126289;16626.085565293903;16641.835071544996;17411.73882391765;18015;3747.4378843173467;3758.774473531597;3758.8684396046006;3759.774413535197;3765.8870233892753;129075.35462322722;129418.41163176684;130751;131989;135087;16884.155792210342;17134.657306853795;17684.204210810545;17751.378701745376;17772.644547108986;32259.61274066189;32440.188995274835;32467.18832029218;32572.511412328833;32716.18209544733;7640.121386040565;7981.521108733495;8260.256576908107;8436.40945133847;8593.78515537104;3797.6392242736897;3890;3893.1824316893203;3900.297946369624;3903.941440878389;5101.285819985205;5216.26972223889;5241.659292145999;5242.266082748418;5298.814541491107;1076.10683133001;1102.9834552481718;1104.1222228328338;1106.0322218059198;1106.3859557945257;699.993000070003;707.1655446573093;707.4764674141098;720.3624792059065;722.6856317501904;11991.580294689644;12274.570390036484;12809.61571152867;12829.871701283055;13601;702.8875379939185;706.4948561778353;715.2954339975121;718.7053308143636;723.2116992478224;5410.756515956791;5431.6740995540395;5453.809116680897;5504.4770746778995;5627.662340259516;106150.46924765327;111753;112430.43784781024;113022;114601;97840.51079744556;97997;99322;99541;101795;86295.56852215699;86810;86988;87182;87707.68438473428;9942.30403871751;10042;10054.597816087275;10080.092791648787;10464.424456654957;41539.58460415357;41762.53831116018;41813;42090;42599;51363.743181283855;51541;52279.73860130675;52825.735871320394;53562.46437535575;15834.208289585244;16137.75793363077;16186.514404567883;16294.42969496062;16347.264373103477;18327.54181145482;18363.63272734511;18482.168302426155;18511.166997485416;18566.628667426845;16409.67180656404;16650.666986659955;16662.58343541421;16785.16074196261;16813.579660508585;16056.67886642284;16397.59006024859;16408.17959102064;16484.587885302964;16497.257623406735;15594.064356138668;15698.529044128694;15817.130057846929;15842.049477031414;15948.362065517713;12376.381180941096;12424.130310878152;12503.124781265587;12510.87489125097;12596.496140154291;13133.802992955305;13451.798223026859;13555.661108472366;13752.793708094587;13942.093763905314 04:07:25 INFO - PID 13373 | __end_tp_report 04:07:25 INFO - PID 13373 | __start_cc_report 04:07:25 INFO - PID 13373 | _x_x_mozilla_cycle_collect,384 04:07:25 INFO - PID 13373 | __end_cc_report 04:07:25 INFO - PID 13373 | __startTimestamp1502708845255__endTimestamp 04:07:25 INFO - PID 13373 | 04:07:25 INFO - PID 13373 | ------- Summary: start ------- 04:07:25 INFO - PID 13373 | Number of tests: 6 04:07:25 INFO - PID 13373 | 04:07:25 INFO - PID 13373 | [#0] dojo.html Cycles:165 Average:6157.92 Median:6462.06 stddev:722.05 (11.2%) stddev-sans-first:683.72 04:07:25 INFO - PID 13373 | Values: 3116.8 3176.9 3180.9 3192.7 3217.9 6122.0 6147.9 6154.6 6207.0 6322.1 6250.6 6302.1 6304.5 6337.2 6375.9 5664.7 5699.4 5738.8 5772.7 5831.0 5571.8 5639.8 5767.9 5772.5 5780.0 5668.9 5672.9 5742.4 5760.6 5765.8 5652.0 5701.4 5755.5 5760.6 5762.4 5553.3 5617.7 5617.8 5637.9 5686.0 6139.9 6158.4 6170.4 6195.4 6242.8 6629.5 6640.5 6698.5 6718.3 6721.2 6580.8 6664.0 6681.4 6687.2 6762.4 6162.2 6176.4 6177.1 6182.8 6184.9 6716.8 6795.9 6800.3 6818.7 6833.2 6483.7 6493.6 6504.8 6507.8 6508.6 6583.9 6607.3 6614.6 6614.9 6623.2 6592.3 6608.9 6619.1 6622.0 6625.3 5873.8 6673.6 6673.8 6755.0 6771.1 5453.9 5499.6 5516.4 5518.3 5531.1 4548.5 4601.2 4662.4 4701.4 4724.7 5793.2 5807.6 5811.2 5811.4 5819.8 6681.8 6709.4 6779.5 6787.6 6795.3 5686.6 5729.7 5814.0 5819.4 5821.2 5890.9 5899.0 5913.6 5915.8 5916.2 6507.9 6510.3 6542.4 6545.5 6550.7 6637.4 6752.6 6758.3 6774.7 6777.0 6369.2 6437.5 6542.7 6549.4 6551.1 6538.2 6587.8 6595.6 6688.2 6700.2 6788.3 6804.9 6823.6 6829.4 6839.8 6507.8 6539.5 6613.2 6619.3 6628.6 6476.2 6534.9 6542.4 6576.1 6605.0 6371.6 6442.1 6486.4 6530.9 6531.6 6564.5 6572.3 6626.3 6639.7 6667.0 6363.0 6363.7 6462.1 6463.1 6466.3 04:07:25 INFO - PID 13373 | 04:07:25 INFO - PID 13373 | [#1] ext.html Cycles:180 Average:39162.29 Median:35249.47 stddev:58093.89 (164.8%) stddev-sans-first:58185.47 04:07:25 INFO - PID 13373 | Values: 804.7 850.5 864.6 879.0 1169.1 30299.8 30873.7 30948.5 41386.2 42057.0 41719.6 42069.2 42116.6 42143.8 42214.4 5749.9 7559.6 7693.7 7718.3 7746.9 5750.6 7475.3 7671.7 7683.5 7703.8 7657.4 7702.6 7732.9 7745.3 7749.3 7608.8 7649.8 7668.4 7672.3 7727.3 7517.7 7569.2 7625.8 7632.3 7634.2 38009.0 38277.2 38347.8 38357.8 38959.2 3209.3 3257.2 3268.3 3269.2 3271.9 30446.4 30712.1 30836.4 30858.7 31000.0 4781.7 4980.7 4984.0 4998.3 5018.8 197443.0 197666.0 198032.0 198609.0 198802.0 48044.0 48200.0 48506.0 48542.3 48599.3 50015.0 50403.5 50548.7 50626.5 50634.0 14553.0 14816.3 14816.6 14825.4 14826.6 11344.7 11960.7 12004.9 12013.6 12037.4 11643.3 13095.3 13121.8 13377.3 13404.5 5476.4 5502.8 5565.0 5599.3 5600.6 995.2 998.7 1004.1 1019.2 1019.5 22602.2 22863.0 23030.7 23032.5 23344.9 1094.6 1095.1 1102.1 1104.3 1114.9 12363.3 12374.8 12619.4 12733.9 12826.3 240919.0 242391.0 242784.0 243087.0 243354.0 52835.2 53143.5 53165.0 53246.2 53261.7 1515.0 1516.3 1547.0 1554.5 1554.9 23009.2 23240.3 23396.5 23462.6 23644.9 38761.2 39102.6 39155.2 39163.6 39214.8 223844.0 225836.0 226185.0 231849.0 232452.0 38156.2 38306.4 38475.2 38560.8 38575.4 45867.0 46473.5 46730.5 47522.0 47934.0 34133.3 34538.8 34613.5 34687.3 34833.3 33966.3 34531.0 34800.7 34988.7 35510.3 37054.6 37158.6 37295.8 37533.4 37537.0 32509.5 32793.3 33290.0 33357.8 33424.0 24144.2 24254.4 24423.3 24766.1 24791.9 04:07:25 INFO - PID 13373 | 04:07:25 INFO - PID 13373 | [#2] jquery.html Cycles:180 Average:36222.75 Median:12973.68 stddev:87476.55 (674.3%) stddev-sans-first:87681.02 04:07:25 INFO - PID 13373 | Values: 582.1 590.6 591.3 594.4 597.2 22481.3 22890.7 23205.4 23246.3 23285.4 26766.6 27428.7 27441.3 27448.6 27464.5 6379.0 6483.8 6485.3 6527.6 6536.2 6217.1 6491.9 6531.8 6534.9 6535.2 6497.9 6501.8 6502.6 6505.2 6505.5 6471.1 6474.4 6481.4 6481.5 6482.9 6030.7 6035.0 6041.1 6043.8 6045.9 30516.7 30624.7 30691.2 30798.2 30976.8 1959.2 1988.5 1989.2 1989.2 1991.5 19068.0 19492.4 19514.3 19519.3 19630.4 2368.7 2401.3 2426.0 2437.3 2464.5 136548.0 140305.3 141121.0 141251.0 141607.0 14236.9 15006.6 15074.3 15074.8 15802.7 19558.2 20170.4 22875.0 23229.4 23578.6 10278.5 10311.2 10512.2 10610.6 10669.6 9688.5 9775.1 9870.3 9928.2 9982.4 9390.7 9485.8 9524.4 9556.9 9645.7 2728.7 2734.2 2755.8 2770.6 2852.8 967.3 980.8 981.2 993.0 997.9 18901.4 23851.8 24641.9 26239.3 26320.0 1034.8 1042.2 1048.3 1051.0 1055.4 11320.5 11396.3 11461.3 11495.5 11541.0 507807.0 518873.0 518951.0 521279.0 532811.0 120912.0 124771.0 127100.0 127362.0 127403.4 1247.5 1264.5 1297.0 1299.4 1303.3 20579.0 20673.2 20801.3 20907.5 21358.7 56054.7 57187.0 58116.0 58955.1 60900.4 68267.0 68413.3 68588.7 68758.0 68776.7 14840.6 15103.5 15111.5 15218.8 15258.0 23951.6 24277.2 24316.9 24391.9 24494.5 17006.1 17238.2 17270.7 17345.6 17506.0 16183.9 17442.9 17529.9 17678.0 17976.9 18258.5 18417.8 18428.0 18651.3 20061.3 14066.2 14720.2 14823.5 14834.6 14946.5 17345.1 17348.2 17506.0 17680.7 17729.3 04:07:25 INFO - PID 13373 | 04:07:25 INFO - PID 13373 | [#3] mootools.html Cycles:180 Average:8901.84 Median:2577.78 stddev:6200.86 (240.6%) stddev-sans-first:6192.14 04:07:25 INFO - PID 13373 | Values: 1327.8 1355.6 1361.1 1378.8 1383.0 12400.0 14137.5 14662.6 14762.3 14772.1 12512.9 13455.8 14861.4 14926.1 14951.3 2655.7 2697.6 2702.3 2703.4 2704.6 2527.3 2554.0 2611.9 2614.4 2716.8 2666.6 2695.0 2698.0 2698.3 2698.9 2596.7 2628.7 2640.0 2641.9 2649.5 2571.9 2583.7 2586.8 2600.5 2603.7 14251.6 14255.2 14255.4 14282.6 14307.4 7200.6 7388.2 7395.4 7445.5 7506.1 5068.5 5186.4 5233.6 5284.1 5313.6 1948.6 1961.2 1964.7 1967.5 1987.3 24303.1 24564.4 24586.5 24594.1 24622.4 6498.7 6509.2 6529.7 6637.7 6645.6 16442.1 16576.6 16669.8 16701.8 16717.7 6901.7 6981.5 6982.5 6983.6 6983.9 6258.7 6260.8 6696.9 7036.4 7097.3 4869.5 5057.7 5071.3 5082.6 5108.4 1314.6 1358.9 1471.3 1477.8 1479.6 928.2 935.7 939.3 944.6 950.1 8283.5 8469.5 8548.8 8598.4 8641.0 990.4 998.5 1000.1 1003.4 1004.2 4599.0 5086.9 5525.8 5530.1 5581.1 19460.8 20170.4 20244.1 20289.2 20440.9 19397.4 20151.9 20217.4 20223.2 20244.0 10804.2 10819.1 10889.9 10942.3 10943.4 8024.2 8281.3 8292.8 8396.8 8433.5 16799.2 17134.4 17209.7 17370.6 17381.4 17821.8 18049.6 18186.5 18187.7 18270.4 10659.7 10806.1 10843.6 10919.9 10933.8 13250.4 13405.7 13408.1 13474.7 13490.2 10986.5 11067.4 11180.6 11240.7 11295.2 10770.6 10795.8 10820.5 10850.7 11064.8 9435.0 9483.7 9522.7 9523.1 9550.6 7354.3 7407.5 7482.1 7498.1 7498.6 7180.0 7383.6 7420.3 7544.7 7571.7 04:07:25 INFO - PID 13373 | 04:07:25 INFO - PID 13373 | [#4] prototype.html Cycles:180 Average:5568.84 Median:6131.89 stddev:1571.54 (25.6%) stddev-sans-first:1529.15 04:07:25 INFO - PID 13373 | Values: 497.3 500.8 521.3 525.3 528.3 6270.9 6284.9 6299.7 6313.3 6339.8 5937.4 6121.3 6193.5 6219.4 6232.8 4963.0 4974.0 4993.7 5000.4 5006.5 4859.8 4963.7 4981.8 4986.5 5026.9 4907.8 4912.3 4938.5 4968.1 5015.1 4927.9 4930.4 4937.3 4946.2 5015.2 4432.5 4463.7 4488.8 4494.7 4548.2 6022.6 6069.5 6081.7 6088.8 6142.4 5646.2 5668.3 5719.9 5787.4 5803.6 6539.2 6554.2 6562.3 6638.4 6642.8 4866.4 4887.6 4923.6 4939.7 4946.9 6853.8 6870.5 6921.7 6941.9 6970.3 4990.7 5003.9 5042.7 5052.8 5064.7 5109.7 5129.5 5145.6 5164.4 5168.1 5684.9 5723.1 5758.3 5773.5 5797.8 6522.9 6549.8 6581.8 6675.3 6721.9 1695.9 1704.9 1728.9 1747.7 1760.0 1199.3 1199.9 1209.0 1213.5 1223.3 5646.6 5713.9 5715.4 5733.3 5764.9 6483.4 6684.9 6710.7 6731.1 6735.6 5691.6 5697.3 5750.4 5809.1 5814.3 3569.0 3594.4 3599.1 3636.9 3641.9 6583.6 6639.4 6642.2 6655.3 6667.5 6994.6 7008.3 7036.1 7048.9 7075.6 6579.7 6612.5 6617.5 6626.5 6652.3 6813.2 6847.5 6858.8 6892.2 6909.2 6773.7 6788.7 6792.2 6828.6 6838.7 6551.2 6565.0 6580.4 6623.7 6645.5 5477.7 5547.2 5548.2 5575.9 5583.5 6594.8 6861.0 6871.8 6885.9 6921.6 6367.9 6488.7 6552.1 6622.8 6635.2 6617.9 6633.7 6643.1 6644.6 6684.0 6578.7 6588.6 6591.7 6599.8 6636.8 6604.7 6659.3 6697.3 6707.2 6747.5 6289.9 6336.6 6363.8 6427.4 6429.6 04:07:25 INFO - PID 13373 | 04:07:25 INFO - PID 13373 | [#5] yui.html Cycles:180 Average:23369.11 Median:20181.99 stddev:32378.33 (160.4%) stddev-sans-first:32425.09 04:07:25 INFO - PID 13373 | Values: 870.9 895.2 896.5 927.4 931.0 18336.0 19195.3 19281.8 19331.8 21523.7 21748.2 22001.3 22038.4 22279.9 22300.0 966.7 984.0 984.1 985.7 988.1 1022.6 1060.4 1064.2 1064.3 1067.0 1098.0 1100.6 1101.0 1101.9 1113.5 1095.1 1095.9 1096.5 1097.0 1109.7 799.3 800.1 800.9 802.3 813.2 19375.0 19822.6 20541.4 20585.5 20757.6 21561.1 21647.1 21832.2 21889.7 21951.5 16505.2 16626.1 16641.8 17411.7 18015.0 3747.4 3758.8 3758.9 3759.8 3765.9 129075.4 129418.4 130751.0 131989.0 135087.0 16884.2 17134.7 17684.2 17751.4 17772.6 32259.6 32440.2 32467.2 32572.5 32716.2 7640.1 7981.5 8260.3 8436.4 8593.8 3797.6 3890.0 3893.2 3900.3 3903.9 5101.3 5216.3 5241.7 5242.3 5298.8 1076.1 1103.0 1104.1 1106.0 1106.4 700.0 707.2 707.5 720.4 722.7 11991.6 12274.6 12809.6 12829.9 13601.0 702.9 706.5 715.3 718.7 723.2 5410.8 5431.7 5453.8 5504.5 5627.7 106150.5 111753.0 112430.4 113022.0 114601.0 97840.5 97997.0 99322.0 99541.0 101795.0 86295.6 86810.0 86988.0 87182.0 87707.7 9942.3 10042.0 10054.6 10080.1 10464.4 41539.6 41762.5 41813.0 42090.0 42599.0 51363.7 51541.0 52279.7 52825.7 53562.5 15834.2 16137.8 16186.5 16294.4 16347.3 18327.5 18363.6 18482.2 18511.2 18566.6 16409.7 16650.7 16662.6 16785.2 16813.6 16056.7 16397.6 16408.2 16484.6 16497.3 15594.1 15698.5 15817.1 15842.0 15948.4 12376.4 12424.1 12503.1 12510.9 12596.5 13133.8 13451.8 13555.7 13752.8 13942.1 04:07:25 INFO - PID 13373 | -------- Summary: end -------- 04:07:25 INFO - PID 13373 | 04:07:25 INFO - TEST-INFO | 13373: exit 0 04:07:25 INFO - TEST-OK | dromaeo_css | took 1112158ms 04:07:25 INFO - TEST-START | kraken 04:07:25 INFO - Initialising browser for kraken test... 04:07:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56926/getInfo.html -profile /tmp/tmp3_UE4W/profile 04:07:25 INFO - TEST-INFO | started process 13741 (/builds/slave/test/build/application/firefox/firefox http://localhost:56926/getInfo.html) 04:07:31 INFO - TEST-INFO | 13741: exit 0 04:07:31 INFO - Browser initialized. 04:07:31 INFO - Running cycle 1/1 for kraken test... 04:07:31 INFO - TEST-INFO | started process 13976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3_UE4W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:32 INFO - PID 13976 | 04:07:32 INFO - PID 13976 | (/builds/slave/test/build/application/firefox/firefox:14030): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:07:32 INFO - PID 13976 | 04:07:42 INFO - PID 13976 | RSS: Main: 167952384 04:07:42 INFO - PID 13976 | 04:07:45 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56926/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:46 INFO - PID 13976 | RSS: Main: 174186496 04:07:46 INFO - PID 13976 | 04:07:49 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56926/tests/kraken/driver.html?testName=audio-dft) 04:07:49 INFO - PID 13976 | RSS: Main: 178364416 04:07:49 INFO - PID 13976 | 04:07:52 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56926/tests/kraken/driver.html?testName=audio-fft) 04:07:53 INFO - PID 13976 | RSS: Main: 172146688 04:07:53 INFO - PID 13976 | 04:07:55 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56926/tests/kraken/driver.html?testName=audio-oscillator) 04:07:56 INFO - PID 13976 | RSS: Main: 172642304 04:07:56 INFO - PID 13976 | 04:07:58 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56926/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:59 INFO - PID 13976 | RSS: Main: 172789760 04:07:59 INFO - PID 13976 | 04:08:02 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56926/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:02 INFO - PID 13976 | RSS: Main: 174002176 04:08:02 INFO - PID 13976 | 04:08:06 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56926/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:07 INFO - PID 13976 | RSS: Main: 173920256 04:08:07 INFO - PID 13976 | 04:08:09 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56926/tests/kraken/driver.html?testName=json-parse-financial) 04:08:10 INFO - PID 13976 | RSS: Main: 174731264 04:08:10 INFO - PID 13976 | 04:08:12 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56926/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:12 INFO - PID 13976 | RSS: Main: 174776320 04:08:12 INFO - PID 13976 | 04:08:14 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56926/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:15 INFO - PID 13976 | RSS: Main: 174579712 04:08:15 INFO - PID 13976 | 04:08:17 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56926/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:18 INFO - PID 13976 | RSS: Main: 174473216 04:08:18 INFO - PID 13976 | 04:08:20 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:21 INFO - PID 13976 | RSS: Main: 174870528 04:08:21 INFO - PID 13976 | 04:08:24 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:25 INFO - PID 13976 | RSS: Main: 174858240 04:08:25 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | Cycle 1(1): loaded http://localhost:56926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56926/tests/kraken/driver.html?testName=ai-astar) 04:08:27 INFO - PID 13976 | RSS: Main: 176254976 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | __start_tp_report 04:08:27 INFO - PID 13976 | _x_x_mozilla_page_load 04:08:27 INFO - PID 13976 | _x_x_mozilla_page_load_details 04:08:27 INFO - PID 13976 | |i|pagename|runs| 04:08:27 INFO - PID 13976 | |0;ai-astar;105;108;101;110;115;112;110;101;108;113 04:08:27 INFO - PID 13976 | |1;audio-beat-detection;147;121;145;183;117;144;139;124;170;118 04:08:27 INFO - PID 13976 | |2;audio-dft;164;162;165;162;165;169;166;167;171;165 04:08:27 INFO - PID 13976 | |3;audio-fft;75;76;84;170;75;75;74;79;96;75 04:08:27 INFO - PID 13976 | |4;audio-oscillator;79;78;130;82;78;82;142;85;79;126 04:08:27 INFO - PID 13976 | |5;imaging-gaussian-blur;114;114;118;113;114;114;114;113;116;115 04:08:27 INFO - PID 13976 | |6;imaging-darkroom;150;150;151;161;151;150;153;151;150;152 04:08:27 INFO - PID 13976 | |7;imaging-desaturate;96;94;94;93;94;94;101;93;93;94 04:08:27 INFO - PID 13976 | |8;json-parse-financial;56;58;55;56;56;55;55;70;55;55 04:08:27 INFO - PID 13976 | |9;json-stringify-tinderbox;54;53;57;54;54;58;54;54;54;56 04:08:27 INFO - PID 13976 | |10;stanford-crypto-aes;78;79;78;78;78;82;81;85;76;78 04:08:27 INFO - PID 13976 | |11;stanford-crypto-ccm;137;128;138;125;138;125;122;125;129;173 04:08:27 INFO - PID 13976 | |12;stanford-crypto-pbkdf2;178;182;180;180;182;191;188;181;181;176 04:08:27 INFO - PID 13976 | |13;stanford-crypto-sha256-iterative;72;69;71;67;75;78;67;67;78;71 04:08:27 INFO - PID 13976 | __end_tp_report 04:08:27 INFO - PID 13976 | __start_cc_report 04:08:27 INFO - PID 13976 | _x_x_mozilla_cycle_collect,993 04:08:27 INFO - PID 13976 | __end_cc_report 04:08:27 INFO - PID 13976 | __startTimestamp1502708907592__endTimestamp 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | ------- Summary: start ------- 04:08:27 INFO - PID 13976 | Number of tests: 14 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:4.76 (4.3%) stddev-sans-first:4.90 04:08:27 INFO - PID 13976 | Values: 105.0 108.0 101.0 110.0 115.0 112.0 110.0 101.0 108.0 113.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:144.50 stddev:22.27 (15.4%) stddev-sans-first:23.51 04:08:27 INFO - PID 13976 | Values: 147.0 121.0 145.0 183.0 117.0 144.0 139.0 124.0 170.0 118.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:2.84 (1.7%) stddev-sans-first:2.95 04:08:27 INFO - PID 13976 | Values: 164.0 162.0 165.0 162.0 165.0 169.0 166.0 167.0 171.0 165.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#3] audio-fft Cycles:10 Average:87.90 Median:75.50 stddev:29.63 (39.2%) stddev-sans-first:31.06 04:08:27 INFO - PID 13976 | Values: 75.0 76.0 84.0 170.0 75.0 75.0 74.0 79.0 96.0 75.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:79.00 stddev:25.63 (32.4%) stddev-sans-first:26.42 04:08:27 INFO - PID 13976 | Values: 79.0 78.0 130.0 82.0 78.0 82.0 142.0 85.0 79.0 126.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.51 (1.3%) stddev-sans-first:1.59 04:08:27 INFO - PID 13976 | Values: 114.0 114.0 118.0 113.0 114.0 114.0 114.0 113.0 116.0 115.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:151.00 stddev:3.35 (2.2%) stddev-sans-first:3.48 04:08:27 INFO - PID 13976 | Values: 150.0 150.0 151.0 161.0 151.0 150.0 153.0 151.0 150.0 152.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:2.41 (2.6%) stddev-sans-first:2.51 04:08:27 INFO - PID 13976 | Values: 96.0 94.0 94.0 93.0 94.0 94.0 101.0 93.0 93.0 94.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.00 stddev:4.63 (8.3%) stddev-sans-first:4.89 04:08:27 INFO - PID 13976 | Values: 56.0 58.0 55.0 56.0 56.0 55.0 55.0 70.0 55.0 55.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:54.00 stddev:1.62 (3.0%) stddev-sans-first:1.69 04:08:27 INFO - PID 13976 | Values: 54.0 53.0 57.0 54.0 54.0 58.0 54.0 54.0 54.0 56.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:2.63 (3.3%) stddev-sans-first:2.74 04:08:27 INFO - PID 13976 | Values: 78.0 79.0 78.0 78.0 78.0 82.0 81.0 85.0 76.0 78.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.00 stddev:14.94 (11.2%) stddev-sans-first:15.81 04:08:27 INFO - PID 13976 | Values: 137.0 128.0 138.0 125.0 138.0 125.0 122.0 125.0 129.0 173.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:181.50 stddev:4.46 (2.5%) stddev-sans-first:4.50 04:08:27 INFO - PID 13976 | Values: 178.0 182.0 180.0 180.0 182.0 191.0 188.0 181.0 181.0 176.0 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:4.28 (6.0%) stddev-sans-first:4.53 04:08:27 INFO - PID 13976 | Values: 72.0 69.0 71.0 67.0 75.0 78.0 67.0 67.0 78.0 71.0 04:08:27 INFO - PID 13976 | -------- Summary: end -------- 04:08:27 INFO - PID 13976 | 04:08:27 INFO - PID 13976 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:08:28 INFO - TEST-INFO | 13976: exit 0 04:08:28 INFO - TEST-OK | kraken | took 62377ms 04:08:28 INFO - SUITE-END | took 1174s 04:08:28 INFO - Completed test suite (00:19:34) 04:08:28 INFO - javascript benchmark 04:08:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8523.729027927666, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.812991220528, 3176.872925082997, 3180.8886688965886, 3192.744580433565, 3217.9356412871743, 6122.020476723725, 6147.938520614793, 6154.569180157391, 6206.9689651551735, 6322.0832979217985, 6250.624962502242, 6302.054691796221, 6304.495640348772, 6337.1761670982705, 6375.936240637592, 5664.745086471098, 5699.430056994299, 5738.7991420300295, 5772.653640781546, 5831.0, 5571.8328450146355, 5639.774409023655, 5767.884642307151, 5772.45161709639, 5780.0, 5668.914966275509, 5672.914906276409, 5742.425757424245, 5760.567957403169, 5765.82702518923, 5651.9717401413145, 5701.401352857932, 5755.539556835443, 5760.567957403169, 5762.366139724627, 5553.250311208016, 5617.719114044281, 5617.8033768817895, 5637.943620563783, 5686.0, 6139.938600613981, 6158.414950579688, 6170.382961703838, 6195.411435913581, 6242.812715618538, 6629.502787290972, 6640.535162538624, 6698.497612679069, 6718.328167183291, 6721.227058888241, 6580.835479113012, 6663.966680166568, 6681.432078273353, 6687.164104486939, 6762.425193858528, 6162.198914141133, 6176.3514830943, 6177.135201071854, 6182.783602573933, 6184.938150618526, 6716.832079197961, 6795.898061529081, 6800.31996800316, 6818.727250910008, 6833.180018397824, 6483.740650373932, 6493.577917435446, 6504.804855854332, 6507.772227971998, 6508.642024688687, 6583.868322633616, 6607.273199948002, 6614.603123812587, 6614.86770264592, 6623.172103487064, 6592.274849766618, 6608.900866487006, 6619.106420633249, 6621.966890165519, 6625.3043430440075, 5873.794417195378, 6673.632950187786, 6673.799786006428, 6754.952982287753, 6771.052052712625, 5453.890922181534, 5499.587530935196, 5516.448355164452, 5518.255035570227, 5531.115021596525, 4548.4541854977615, 4601.194790911577, 4662.393888794503, 4701.3888194535175, 4724.692894961817, 5793.246877905845, 5807.593468457252, 5811.215485909433, 5811.4479124483105, 5819.825405237765, 6681.832954176184, 6709.429698475684, 6779.49153813466, 6787.6266805325195, 6795.286494918061, 5686.60193786431, 5729.656220626775, 5814.0, 5819.447152520504, 5821.18503409523, 5890.852728681732, 5899.026660600953, 5913.645181289136, 5915.822525324247, 5916.171735956969, 6507.934920650828, 6510.283868774431, 6542.378474045054, 6545.476361891037, 6550.737970481223, 6637.402633762985, 6752.561083529555, 6758.2565917748025, 6774.729010839511, 6777.0, 6369.172007638977, 6437.452816510649, 6542.672866356758, 6549.410553050248, 6551.115599394211, 6538.215414150332, 6587.80236592903, 6595.604263744191, 6688.197416310074, 6700.195976482853, 6788.321167883172, 6804.863902722017, 6823.55646882951, 6829.351211634887, 6839.794806155824, 6507.804765857032, 6539.509536784855, 6613.173353330833, 6619.3380661933425, 6628.602283862983, 6476.222853257451, 6534.934650653433, 6542.378474044958, 6576.145101136822, 6605.042268871083, 6371.585846919936, 6442.065900444503, 6486.4486518646445, 6530.934690653033, 6531.575447595891, 6564.5076619254705, 6572.277049524644, 6626.27111017778, 6639.734410623714, 6666.966665166643, 6362.968185159045, 6363.745450181941, 6462.063000864754, 6463.062855885964, 6466.288708242184], "value": 6104.358729155823, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.7103042904554, 850.5194565070734, 864.602282949843, 878.9956050219748, 1169.1231576317762, 30299.848500757493, 30873.691263087363, 30948.535771963412, 41386.17227655445, 42057.0, 41719.58280417195, 42069.15861682765, 42116.57883421165, 42143.78928105363, 42214.36678449818, 5749.942500575004, 7559.622018899046, 7693.692252309929, 7718.305352518272, 7746.9225307746765, 5750.626209296403, 7475.289847464483, 7671.693132274702, 7683.5389876607305, 7703.807404814868, 7657.387409007294, 7702.614869256543, 7732.884006739903, 7745.264199901, 7749.30256276935, 7608.782594784836, 7649.847003059936, 7668.38652907766, 7672.271134242238, 7727.304542591166, 7517.661705223278, 7569.167391586921, 7625.80935476612, 7632.3130918217075, 7634.198409167013, 38009.0497737556, 38277.234455311016, 38347.80826095852, 38357.80821095905, 38959.22081558353, 3209.2618697699427, 3257.2345498807763, 3268.297316077055, 3269.1990462336644, 3271.8527666255077, 30446.391072178652, 30712.078637640905, 30836.383272334653, 30858.691413085806, 31000.0, 4781.737004464753, 4980.651354405193, 4984.0281145176705, 4998.250262460624, 5018.7992480300745, 197443.0, 197666.0, 198032.0, 198608.99999999854, 198802.0, 48044.0, 48200.0, 48506.02987940222, 48542.27186592204, 48599.27101093486, 50015.0, 50403.49596503988, 50548.74725626349, 50626.49373506291, 50634.0, 14553.0, 14816.3332650031, 14816.555503334917, 14825.40698372053, 14826.555203343916, 11344.716382090513, 11960.700982475508, 12004.939975300067, 12013.579524716768, 12037.398130093461, 11643.301401915744, 13095.345232738326, 13121.803172952414, 13377.264250466318, 13404.463821447032, 5476.3702174250475, 5502.752376143083, 5564.972175139179, 5599.32808063035, 5600.64611334903, 995.1541189988596, 998.6953979036318, 1004.1013293102632, 1019.230480986865, 1019.5361110694616, 22602.208922687627, 22863.0, 23030.65454018191, 23032.539349212922, 23344.883275583852, 1094.5512339940585, 1095.0910744082391, 1102.1458369763498, 1104.304288298383, 1114.9442527873737, 12363.32001739895, 12374.81437778434, 12619.432125554373, 12733.936330318289, 12826.294553799444, 240919.0, 242391.0, 242784.0, 243087.0, 243354.0, 52835.20747188795, 53143.46856531385, 53165.0, 53246.20130698042, 53261.73369133207, 1515.0379509011857, 1516.2646116633423, 1546.9690606187812, 1554.5414102839688, 1554.9300281487133, 23009.194678186184, 23240.3027909163, 23396.53206935886, 23462.64806027945, 23644.881775591013, 38761.224775504896, 39102.6089739099, 39155.216895662496, 39163.608363916, 39214.80392598019, 223844.0, 225836.0, 226185.0, 231849.0, 232452.0, 38156.236875261784, 38306.425403618414, 38475.230495389376, 38560.80719596384, 38575.42136867893, 45867.0, 46473.53526464692, 46730.53269467262, 47522.0, 47934.04131917412, 34133.317333653686, 34538.82730586331, 34613.48079778856, 34687.306253874274, 34833.30333393368, 33966.32067358688, 34531.0, 34800.65199347974, 34988.650113499556, 35510.28979420449, 37054.6294537062, 37158.628413715516, 37295.81352093222, 37533.4369984445, 37537.0, 32509.512357314186, 32793.34413311768, 33290.0, 33357.83321083379, 33424.0, 24144.154954576505, 24254.393640159138, 24423.26730198097, 24766.133185338425, 24791.87604061968], "value": 17232.798513701502, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.0570675505681, 590.6308557151779, 591.2550186764676, 594.4145017158098, 597.1550256387212, 22481.3255602332, 22890.65664015041, 23205.419864503376, 23246.30261092166, 23285.417864553394, 26766.59850102245, 27428.725712742867, 27441.313967150832, 27448.588271175897, 27464.45071098577, 6378.968105159468, 6483.773067942623, 6485.2541957675, 6527.608343499382, 6536.182977127859, 6217.129601855744, 6491.902621460682, 6531.771388001421, 6534.8693026139445, 6535.215774107114, 6497.93502064978, 6501.837454063639, 6502.6098434093865, 6505.219373675142, 6505.479561635081, 6471.126397936266, 6474.352564743512, 6481.449076828475, 6481.48148148147, 6482.902756458657, 6030.698465076773, 6035.0, 6041.063635136561, 6043.848903777397, 6045.939540604581, 30516.694833051606, 30624.693753062405, 30691.232719181975, 30798.23004424885, 30976.845115774504, 1959.2456904091885, 1988.4829944214464, 1989.2142603671468, 1989.2440872468514, 1991.5021244688828, 19068.0, 19492.415227543195, 19514.316998905113, 19519.31682391124, 19630.41108766739, 2368.706276480438, 2401.30362194965, 2426.0417135231482, 2437.2566367257978, 2464.5194187133516, 136548.0, 140305.298473508, 141121.0, 141251.0, 141607.0, 14236.857631423552, 15006.62483437901, 15074.321655525528, 15074.849251507563, 15802.68394632124, 19558.217671293274, 20170.394888153085, 22875.0, 23229.41926451852, 23578.646320305208, 10278.537465814057, 10311.22665800068, 10512.21158413122, 10610.57557697699, 10669.57321707123, 9688.46713430754, 9775.120239178508, 9870.30907836459, 9928.205743540644, 9982.35114717541, 9390.732251146008, 9485.762855928657, 9524.380915240487, 9556.904430955741, 9645.71062868115, 2728.6725592928974, 2734.234414363981, 2755.8484283364605, 2770.598263251817, 2852.7575156111548, 967.3277072434731, 980.7597138700921, 981.1660088924357, 992.9950350248347, 997.9051990060933, 18901.43295701131, 23851.7614823853, 24641.876790615934, 26239.344016399362, 26320.0, 1034.7620047389144, 1042.2027149230844, 1048.3447845096814, 1050.9632162874263, 1055.3984228989557, 11320.490577924013, 11396.259243149168, 11461.312321260584, 11495.482703278372, 11541.0, 507807.0, 518873.0, 518951.0, 521279.0, 532811.0, 120912.0, 124771.0, 127100.0, 127362.0, 127403.36298318449, 1247.457356050121, 1264.487882407608, 1296.9610911672664, 1299.3503248375812, 1303.328785675378, 20579.0, 20673.17307307751, 20801.271955481487, 20907.477313067295, 21358.679619806026, 56054.719726401105, 57187.0, 58116.0, 58955.11567326579, 60900.390996089474, 68267.0, 68413.26346946067, 68588.6570567144, 68758.0, 68776.6561167211, 14840.554783356516, 15103.54689359321, 15111.54665360041, 15218.847811522186, 15258.0, 23951.640725389483, 24277.150299739424, 24316.878415607807, 24391.878040609685, 24494.510109798062, 17006.149692515573, 17238.224279907685, 17270.654586907942, 17345.56636084108, 17506.0, 16183.919080404523, 17442.9127854365, 17529.912350438168, 17678.0, 17976.91011544934, 18258.45224643263, 18417.815821842145, 18428.0, 18651.253949842398, 20061.29785457502, 14066.156030638194, 14720.19038952825, 14823.481178158712, 14834.62913427173, 14946.476873309382, 17345.132743363032, 17348.219330130425, 17506.0, 17680.73478897792, 17729.290828367237], "value": 12251.963543558395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.7809161488356, 1355.586546103438, 1361.0676686469772, 1378.779779894793, 1382.97925531117, 12400.0, 14137.505187318433, 14662.633434164138, 14762.261886905651, 14772.11367317959, 12512.937435312811, 13455.798163027563, 14861.405543778235, 14926.104433733983, 14951.252437378114, 2655.6547648805627, 2697.5818748094075, 2702.3244188952763, 2703.405250844811, 2704.5537486314734, 2527.330257481769, 2553.9744602553924, 2611.9216423507323, 2614.3986883016823, 2716.769074628659, 2666.6133410655443, 2695.029789275859, 2698.0, 2698.3389069677955, 2698.9055383061595, 2596.6883973923063, 2628.6976997645324, 2640.049582150424, 2641.8546979916096, 2649.470105978812, 2571.909983150581, 2583.651207087038, 2586.8447893126286, 2600.479904019204, 2603.7005744339262, 14251.64370890736, 14255.215963122024, 14255.358508867126, 14282.64293392663, 14307.356168972421, 7200.567965922061, 7388.224236455202, 7395.4083673306, 7445.478816482849, 7506.061742282215, 5068.467810879842, 5186.351706036746, 5233.607479439057, 5284.128118860383, 5313.57491400687, 1948.6297603455298, 1961.205711686769, 1964.6758284882976, 1967.4982879365814, 1987.3044434447972, 24303.14938977145, 24564.385890352707, 24586.50826983468, 24594.139205127736, 24622.384440388956, 6498.675066246763, 6509.1863517060365, 6529.673516324165, 6637.734490620418, 6645.568038077509, 16442.095684737455, 16576.585585360463, 16669.83330166707, 16701.83298167027, 16717.749233761504, 6901.654917254117, 6981.476389270825, 6982.47631427645, 6983.615901125385, 6983.89524157138, 6258.687065646699, 6260.843478913063, 6696.8995465068065, 7036.401905838061, 7097.290270972861, 4869.537393947569, 5057.72182529957, 5071.290019397287, 5082.644214904921, 5108.438071812097, 1314.6384744195423, 1358.9388477518535, 1471.2643678160919, 1477.8374378818537, 1479.5635287590187, 928.1785619726455, 935.6818681648273, 939.3424602778083, 944.5607792376578, 950.1401231885155, 8283.461574997606, 8469.491830490068, 8548.786280343042, 8598.39811213209, 8641.0, 990.405756546081, 998.5456617239139, 1000.0799264676369, 1003.4280460137797, 1004.2116938203475, 4598.97700511502, 5086.898262034739, 5525.806596769094, 5530.05988981866, 5581.134924086773, 19460.80539194618, 20170.39488815338, 20244.089015994316, 20289.18843246283, 20440.897795511224, 19397.418077457416, 20151.899240503997, 20217.393478195678, 20223.191072357236, 20244.0, 10804.24370294072, 10819.13446924244, 10889.945550272198, 10942.288751231144, 10943.398113103696, 8024.197580241929, 8281.337493000425, 8292.83414331722, 8396.832063358821, 8433.451825631315, 16799.160041998097, 17134.40029598958, 17209.655806884042, 17370.565735856704, 17381.391651292142, 17821.821781782015, 18049.639007220045, 18186.54533636617, 18187.727184091986, 18270.360537381126, 10659.733506662396, 10806.135509159405, 10843.566257349617, 10919.890801092206, 10933.83599245996, 13250.403731832284, 13405.66485837862, 13408.061435699798, 13474.663133421744, 13490.190588564717, 10986.505607247533, 11067.446627668745, 11180.552777888794, 11240.662780116609, 11295.152863535104, 10770.62302819429, 10795.784084318113, 10820.513076911715, 10850.67447976562, 11064.834027489433, 9435.0, 9483.66807161746, 9522.714318570454, 9523.142917137491, 9550.570224340061, 7354.264573542603, 7407.518511296748, 7482.139553951365, 7498.137714162941, 7498.58757768328, 7180.0, 7383.556986580822, 7420.257974202536, 7544.66049027806, 7571.697132114654], "value": 6461.487826080115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.25319715940384, 500.7768969646587, 521.3326941514861, 525.3433208489388, 528.2683483375524, 6270.905936410946, 6284.905726414102, 6299.685015749217, 6313.337099604544, 6339.841503962403, 5937.435943585352, 6121.32665406806, 6193.47355474784, 6219.440250377465, 6232.813015609528, 4962.975185124069, 4973.975130124362, 4993.700377977333, 5000.399952005764, 5006.474320196382, 4859.829905953275, 4963.726995015273, 4981.825636102737, 4986.476419975905, 5026.924596131061, 4907.779149938261, 4912.263160525932, 4938.48145944676, 4968.105740966625, 5015.122353588125, 4927.926081108786, 4930.4330002049865, 4937.284093806378, 4946.208606622923, 5015.172496538067, 4432.468103827561, 4463.709858859196, 4488.775561221926, 4494.730316181007, 4548.181327361073, 6022.608530445507, 6069.484093852028, 6081.726322315506, 6088.756449742005, 6142.447179753799, 5646.237757902672, 5668.319801623831, 5719.855054354617, 5787.3923238059815, 5803.591509523542, 6539.247986481568, 6554.24626167992, 6562.3266067153045, 6638.369354911276, 6642.767503137367, 4866.416030076378, 4887.582601045692, 4923.556879880792, 4939.703617782944, 4946.925796113062, 6853.7943861684225, 6870.45036397087, 6921.723131074801, 6941.930580694179, 6970.268121847234, 4990.6506544541535, 5003.924941125886, 5042.672226305352, 5052.797888084436, 5064.696118232918, 5109.718965456861, 5129.461406552333, 5145.588352931832, 5164.406093299243, 5168.121419358718, 5684.914726279109, 5723.141528770718, 5758.337791154071, 5773.451522105477, 5797.768089276382, 6522.869542609216, 6549.803505894831, 6581.769638062645, 6675.264431247911, 6721.924492081243, 1695.9224949437087, 1704.9344159900063, 1728.9221985010704, 1747.7028905086165, 1759.9560010999828, 1199.280431740966, 1199.904007679401, 1208.9637310880687, 1213.4782043721284, 1223.321056813477, 5646.6047376684055, 5713.857228554306, 5715.428457154251, 5733.31200255972, 5764.924627134228, 6483.3516648335735, 6684.888793392029, 6710.664466776641, 6731.057651928734, 6735.595864248161, 5691.630044047124, 5697.299727724561, 5750.396208398141, 5809.128630705343, 5814.302283725895, 3569.0185199069942, 3594.353016457063, 3599.0642432967616, 3636.8545258189906, 3641.8725344612812, 6583.604983700993, 6639.43564796988, 6642.202935647753, 6655.267920528738, 6667.466602671775, 6994.615296158659, 7008.26413226614, 7036.120484939383, 7048.894266586005, 7075.620254050514, 6579.671016449159, 6612.537122401386, 6617.536772425884, 6626.469882409396, 6652.268250492442, 6813.182418109858, 6847.452203823782, 6858.759943401957, 6892.172939247323, 6909.170899492093, 6773.6951837168435, 6788.728450862108, 6792.21889482696, 6828.5902845829405, 6838.7264509419065, 6551.21385433751, 6565.0, 6580.440662543738, 6623.735050598115, 6645.534812563267, 5477.68599997012, 5547.1679248111495, 5548.223248745098, 5575.944240557543, 5583.469570390806, 6594.8351291218105, 6860.965695171492, 6871.793846184622, 6885.931140688529, 6921.584704917721, 6367.93632063692, 6488.70800813974, 6552.051576790368, 6622.801315960529, 6635.170603674541, 6617.900731489128, 6633.70148343316, 6643.069970204272, 6644.60132392058, 6683.966580167068, 6578.736850525926, 6588.604683718992, 6591.703373348115, 6599.769008084694, 6636.767713130017, 6604.735810567716, 6659.267480577036, 6697.3302669734585, 6707.195136583641, 6747.460203183831, 6289.937100628935, 6336.619802811846, 6363.840903977438, 6427.389398007182, 6429.6142231466265], "value": 5102.276522412054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [870.9346798990074, 895.2032690905091, 896.4666023715887, 927.3740225347891, 930.9953450232748, 18336.0, 19195.32816351428, 19281.807181928176, 19331.806681933176, 21523.67714484284, 21748.238811641597, 22001.339959801233, 22038.449038773997, 22279.886005699733, 22299.996500157493, 966.7244835221945, 983.9754006149868, 984.1339621133428, 985.7190700650316, 988.1255089246033, 1022.5551884930042, 1060.448566745292, 1064.1858977881927, 1064.297563608019, 1067.023673338894, 1098.0337303173237, 1100.6477927063343, 1101.0200921180156, 1101.928374655649, 1113.4766659669942, 1095.0801326885455, 1095.912327013841, 1096.4736926275432, 1096.956121755133, 1109.7059279290995, 799.2806474173291, 800.0599295827437, 800.9159038301011, 802.3060053054124, 813.1665043330634, 19375.0, 19822.603547929106, 20541.38375848727, 20585.485362865897, 20757.5848483031, 21561.1375544978, 21647.134114635395, 21832.23587174441, 21889.67165492519, 21951.451213719785, 16505.17474126289, 16626.085565293903, 16641.835071544996, 17411.73882391765, 18015.0, 3747.4378843173467, 3758.774473531597, 3758.8684396046006, 3759.774413535197, 3765.8870233892753, 129075.35462322722, 129418.41163176684, 130751.0, 131989.0, 135087.0, 16884.155792210342, 17134.657306853795, 17684.204210810545, 17751.378701745376, 17772.644547108986, 32259.61274066189, 32440.188995274835, 32467.18832029218, 32572.511412328833, 32716.18209544733, 7640.121386040565, 7981.521108733495, 8260.256576908107, 8436.40945133847, 8593.78515537104, 3797.6392242736897, 3890.0, 3893.1824316893203, 3900.297946369624, 3903.941440878389, 5101.285819985205, 5216.26972223889, 5241.659292145999, 5242.266082748418, 5298.814541491107, 1076.10683133001, 1102.9834552481718, 1104.1222228328338, 1106.0322218059198, 1106.3859557945257, 699.993000070003, 707.1655446573093, 707.4764674141098, 720.3624792059065, 722.6856317501904, 11991.580294689644, 12274.570390036484, 12809.61571152867, 12829.871701283055, 13601.0, 702.8875379939185, 706.4948561778353, 715.2954339975121, 718.7053308143636, 723.2116992478224, 5410.756515956791, 5431.6740995540395, 5453.809116680897, 5504.4770746778995, 5627.662340259516, 106150.46924765327, 111753.0, 112430.43784781024, 113022.0, 114601.0, 97840.51079744556, 97997.0, 99322.0, 99541.0, 101795.0, 86295.56852215699, 86810.0, 86988.0, 87182.0, 87707.68438473428, 9942.30403871751, 10042.0, 10054.597816087275, 10080.092791648787, 10464.424456654957, 41539.58460415357, 41762.53831116018, 41813.0, 42090.0, 42599.0, 51363.743181283855, 51541.0, 52279.73860130675, 52825.735871320394, 53562.46437535575, 15834.208289585244, 16137.75793363077, 16186.514404567883, 16294.42969496062, 16347.264373103477, 18327.54181145482, 18363.63272734511, 18482.168302426155, 18511.166997485416, 18566.628667426845, 16409.67180656404, 16650.666986659955, 16662.58343541421, 16785.16074196261, 16813.579660508585, 16056.67886642284, 16397.59006024859, 16408.17959102064, 16484.587885302964, 16497.257623406735, 15594.064356138668, 15698.529044128694, 15817.130057846929, 15842.049477031414, 15948.362065517713, 12376.381180941096, 12424.130310878152, 12503.124781265587, 12510.87489125097, 12596.496140154291, 13133.802992955305, 13451.798223026859, 13555.661108472366, 13752.793708094587, 13942.093763905314], "value": 9025.124517237311, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 108.0, 101.0, 110.0, 115.0, 112.0, 110.0, 101.0, 108.0, 113.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 145.0, 183.0, 117.0, 144.0, 139.0, 124.0, 170.0, 118.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 165.0, 162.0, 165.0, 169.0, 166.0, 167.0, 171.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 84.0, 170.0, 75.0, 75.0, 74.0, 79.0, 96.0, 75.0], "value": 87.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 130.0, 82.0, 78.0, 82.0, 142.0, 85.0, 79.0, 126.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 118.0, 113.0, 114.0, 114.0, 114.0, 113.0, 116.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 161.0, 151.0, 150.0, 153.0, 151.0, 150.0, 152.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 93.0, 94.0, 94.0, 101.0, 93.0, 93.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 55.0, 56.0, 56.0, 55.0, 55.0, 70.0, 55.0, 55.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 57.0, 54.0, 54.0, 58.0, 54.0, 54.0, 54.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 78.0, 82.0, 81.0, 85.0, 76.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 128.0, 138.0, 125.0, 138.0, 125.0, 122.0, 125.0, 129.0, 173.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 182.0, 180.0, 180.0, 182.0, 191.0, 188.0, 181.0, 181.0, 176.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 71.0, 67.0, 75.0, 78.0, 67.0, 67.0, 78.0, 71.0], "value": 71.5, "unit": "score"}]}]} 04:08:28 INFO - Return code: 0 04:08:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:08:28 INFO - # TBPL SUCCESS # 04:08:28 INFO - Running post-action listener: _package_coverage_data 04:08:28 INFO - Running post-action listener: _resource_record_post_action 04:08:28 INFO - [mozharness: 2017-08-14 11:08:28.866652Z] Finished run-tests step (success) 04:08:28 INFO - Running post-run listener: _resource_record_post_run 04:08:28 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 433041408; Read time: 0; Write time: 315084 04:08:28 INFO - TinderboxPrint: CPU usage
13.1% 04:08:28 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:08:28 INFO - TinderboxPrint: I/O write bytes / time
433,041,408 / 315,084 04:08:28 INFO - TinderboxPrint: CPU idle
8,262.1 (86.9%) 04:08:28 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 04:08:28 INFO - TinderboxPrint: Swap in / out
0 / 0 04:08:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106393600; Read time: 0; Write time: 109612 04:08:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:08:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 325369856; Read time: 0; Write time: 205424 04:08:29 INFO - Running post-run listener: _upload_blobber_files 04:08:29 INFO - Blob upload gear active. 04:08:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:08:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:08:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:08:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:30 INFO - (blobuploader) - INFO - Done attempting. 04:08:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:08:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:08:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:31 INFO - (blobuploader) - INFO - Done attempting. 04:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:38 INFO - (blobuploader) - INFO - Done attempting. 04:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:39 INFO - (blobuploader) - INFO - Done attempting. 04:08:39 INFO - (blobuploader) - INFO - Iteration through files over. 04:08:39 INFO - Return code: 0 04:08:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:08:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:08:39 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e05966d985b66ea4d5967af37872bd3cdc5ff5f9cf2146ad5c308342d11e097743916fb0a41de0f8e695f6a15d88971703c748208858d3c2d6b8283d200be9a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d51917dbe733a0e0f514b96bd31908f491eafcbe3b91ec9ac3028b0a751eb6e35e1287d5b58c42569dfeeea57bae12dd41142dfe5e4c0a13be8aa11fd187077", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ef500efed0795b1e16d321ee214a1ee621d0fb4971a5101ce92c424176db4d49ac4fdc93dd86134d77313cc4ec72c4fadea9bb61e5d99f9dccc87f29633006b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e78349f551aade3c042b8049627c70d42f9c976fd9fc557507bf336b802e24bead24aa7ec5f46aee53ce0726aaeb447921e30ca7069c505a323fd06ee336104"} 04:08:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:08:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:08:39 INFO - Contents: 04:08:39 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e05966d985b66ea4d5967af37872bd3cdc5ff5f9cf2146ad5c308342d11e097743916fb0a41de0f8e695f6a15d88971703c748208858d3c2d6b8283d200be9a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d51917dbe733a0e0f514b96bd31908f491eafcbe3b91ec9ac3028b0a751eb6e35e1287d5b58c42569dfeeea57bae12dd41142dfe5e4c0a13be8aa11fd187077", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ef500efed0795b1e16d321ee214a1ee621d0fb4971a5101ce92c424176db4d49ac4fdc93dd86134d77313cc4ec72c4fadea9bb61e5d99f9dccc87f29633006b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e78349f551aade3c042b8049627c70d42f9c976fd9fc557507bf336b802e24bead24aa7ec5f46aee53ce0726aaeb447921e30ca7069c505a323fd06ee336104"} 04:08:39 INFO - Running post-run listener: copy_logs_to_upload_dir 04:08:39 INFO - Copying logs to upload dir... 04:08:39 INFO - mkdir: /builds/slave/test/build/upload/logs 04:08:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.533548 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-14 04:08:36.998536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 04:08:37.005657) ========= 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=826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e05966d985b66ea4d5967af37872bd3cdc5ff5f9cf2146ad5c308342d11e097743916fb0a41de0f8e695f6a15d88971703c748208858d3c2d6b8283d200be9a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d51917dbe733a0e0f514b96bd31908f491eafcbe3b91ec9ac3028b0a751eb6e35e1287d5b58c42569dfeeea57bae12dd41142dfe5e4c0a13be8aa11fd187077", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ef500efed0795b1e16d321ee214a1ee621d0fb4971a5101ce92c424176db4d49ac4fdc93dd86134d77313cc4ec72c4fadea9bb61e5d99f9dccc87f29633006b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e78349f551aade3c042b8049627c70d42f9c976fd9fc557507bf336b802e24bead24aa7ec5f46aee53ce0726aaeb447921e30ca7069c505a323fd06ee336104"} build_url:https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/fGT4btJ9Tv6ODISAhtKG1w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e05966d985b66ea4d5967af37872bd3cdc5ff5f9cf2146ad5c308342d11e097743916fb0a41de0f8e695f6a15d88971703c748208858d3c2d6b8283d200be9a7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d51917dbe733a0e0f514b96bd31908f491eafcbe3b91ec9ac3028b0a751eb6e35e1287d5b58c42569dfeeea57bae12dd41142dfe5e4c0a13be8aa11fd187077", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ef500efed0795b1e16d321ee214a1ee621d0fb4971a5101ce92c424176db4d49ac4fdc93dd86134d77313cc4ec72c4fadea9bb61e5d99f9dccc87f29633006b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e78349f551aade3c042b8049627c70d42f9c976fd9fc557507bf336b802e24bead24aa7ec5f46aee53ce0726aaeb447921e30ca7069c505a323fd06ee336104"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 04:08:37.033167) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:08:37.033495) ========= 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=826874ccc97bd7bf541b4875000001d5-1502707115.546882-939870392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:08:37.112148) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 04:08:37.112463) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 04:08:37.112768) ========= ========= Total master_lag: 0.04 =========