builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1502651802.32 results: success (0) revision: e928c65095ed32151bbe6e462eda3e8c79edca9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:42.322058) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:42.322524) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:42.322836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:42.412720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:42.413033) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-13 12:16:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2017-08-13 12:16:43 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:42.564748) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:42.565076) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017235 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:42.614908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:42.615247) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e928c65095ed32151bbe6e462eda3e8c79edca9f --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 e928c65095ed32151bbe6e462eda3e8c79edca9f --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=a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-13 12:16:43,238 truncating revision to first 12 chars 2017-08-13 12:16:43,238 Setting DEBUG logging. 2017-08-13 12:16:43,238 attempt 1/10 2017-08-13 12:16:43,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e928c65095ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-13 12:16:43,547 unpacking tar archive at: mozilla-central-e928c65095ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661277 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:43.290692) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:43.291028) ========= script_repo_revision: e928c65095ed32151bbe6e462eda3e8c79edca9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:43.291434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:43.291732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 12:16:43.298829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-13 12:16:43.299155) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:44 INFO - MultiFileLogger online at 20170813 12:16:44 in /builds/slave/test 12:16:44 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 12:16:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:44 INFO - {'append_to_log': False, 12:16:44 INFO - 'base_work_dir': '/builds/slave/test', 12:16:44 INFO - 'blob_upload_branch': 'Firefox', 12:16:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:44 INFO - 'branch': 'Firefox', 12:16:44 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:44 INFO - 'code_coverage': False, 12:16:44 INFO - 'config_files': ('talos/linux_config.py',), 12:16:44 INFO - 'default_actions': ('clobber', 12:16:44 INFO - 'read-buildbot-config', 12:16:44 INFO - 'download-and-extract', 12:16:44 INFO - 'populate-webroot', 12:16:44 INFO - 'create-virtualenv', 12:16:44 INFO - 'install', 12:16:44 INFO - 'setup-mitmproxy', 12:16:44 INFO - 'run-tests'), 12:16:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:44 INFO - 'disable_ccov_upload': False, 12:16:44 INFO - 'download_minidump_stackwalk': True, 12:16:44 INFO - 'download_symbols': 'ondemand', 12:16:44 INFO - 'enable_stylo': False, 12:16:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:44 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:44 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:44 INFO - 'gecko_profile': False, 12:16:44 INFO - 'gecko_profile_interval': 0, 12:16:44 INFO - 'installer_path': 'installer.exe', 12:16:44 INFO - 'log_level': 'info', 12:16:44 INFO - 'log_name': 'talos', 12:16:44 INFO - 'log_to_console': True, 12:16:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:44 INFO - 'opt_config_files': (), 12:16:44 INFO - 'pip_index': False, 12:16:44 INFO - 'suite': 'dromaeojs-e10s', 12:16:44 INFO - 'system_bits': '32', 12:16:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:44 INFO - 'title': 'talos-linux64-ix-062', 12:16:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:44 INFO - 'use_talos_json': True, 12:16:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:44 INFO - 'work_dir': 'build'} 12:16:44 INFO - [mozharness: 2017-08-13 19:16:44.023117Z] Running clobber step. 12:16:44 INFO - Running pre-action listener: _resource_record_pre_action 12:16:44 INFO - Running main action method: clobber 12:16:44 INFO - rmtree: /builds/slave/test/build 12:16:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:45 INFO - Running post-action listener: _resource_record_post_action 12:16:45 INFO - [mozharness: 2017-08-13 19:16:45.050700Z] Finished clobber step (success) 12:16:45 INFO - [mozharness: 2017-08-13 19:16:45.050804Z] Running read-buildbot-config step. 12:16:45 INFO - Running pre-action listener: _resource_record_pre_action 12:16:45 INFO - Running main action method: read_buildbot_config 12:16:45 INFO - Using buildbot properties: 12:16:45 INFO - { 12:16:45 INFO - "project": "", 12:16:45 INFO - "product": "firefox", 12:16:45 INFO - "who": "archaeopteryx@coole-files.de", 12:16:45 INFO - "installer_path": "public/build/target.tar.bz2", 12:16:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 12:16:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:16:45 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 12:16:45 INFO - "stage_platform": "linux64-stylosequential", 12:16:45 INFO - "basedir": "/builds/slave/test", 12:16:45 INFO - "buildnumber": 187, 12:16:45 INFO - "platform": "ubuntu64_hw_styloseq", 12:16:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:16:45 INFO - "slavebuilddir": "test", 12:16:45 INFO - "taskId": "WacfBSNiTxaLRjSzqSqI6Q", 12:16:45 INFO - "branch": "mozilla-central", 12:16:45 INFO - "script_repo_revision": "production", 12:16:45 INFO - "revision": "e928c65095ed32151bbe6e462eda3e8c79edca9f", 12:16:45 INFO - "slavename": "talos-linux64-ix-062", 12:16:45 INFO - "repo_path": "mozilla-central" 12:16:45 INFO - } 12:16:45 INFO - Finding installer, test and symbols from parent task. 12:16:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WacfBSNiTxaLRjSzqSqI6Q'}, attempt #1 12:16:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WacfBSNiTxaLRjSzqSqI6Q'}, attempt #1 12:16:45 INFO - Task dependencies: BsDPRDcqRr-vcnnocc2HeA 12:16:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA'}, attempt #1 12:16:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.tar.bz2 12:16:46 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.test_packages.json 12:16:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.crashreporter-symbols.zip 12:16:46 INFO - Running post-action listener: _resource_record_post_action 12:16:46 INFO - [mozharness: 2017-08-13 19:16:46.398032Z] Finished read-buildbot-config step (success) 12:16:46 INFO - [mozharness: 2017-08-13 19:16:46.398255Z] Running download-and-extract step. 12:16:46 INFO - Running pre-action listener: _resource_record_pre_action 12:16:46 INFO - Running main action method: download_and_extract 12:16:46 INFO - mkdir: /builds/slave/test/build/tests 12:16:46 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')]} 12:16:46 INFO - trying https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.test_packages.json 12:16:46 INFO - Downloading https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:16:46 INFO - Downloaded 989 bytes. 12:16:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:16:46 INFO - Using the following test package requirements: 12:16:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:16:46 INFO - u'common': [u'target.common.tests.zip'], 12:16:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:16:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:16:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:16:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:16:46 INFO - u'mozbase': [u'target.common.tests.zip'], 12:16:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:16:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:16:46 INFO - u'web-platform': [u'target.common.tests.zip', 12:16:46 INFO - u'target.web-platform.tests.tar.gz'], 12:16:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:16:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:16:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.common.tests.zip 12:16:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:16:46 INFO - Fetch https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.common.tests.zip into memory 12:16:49 INFO - Content-Length response header: 54034547 12:16:49 INFO - Bytes received: 54034547 12:17:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:17:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.common.tests.zip 12:17:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:17:00 INFO - Fetch https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.common.tests.zip into memory 12:17:01 INFO - Content-Length response header: 54034547 12:17:01 INFO - Bytes received: 54034547 12:17:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.talos.tests.zip 12:17:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:17:13 INFO - Fetch https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.talos.tests.zip into memory 12:17:14 INFO - Content-Length response header: 14496050 12:17:14 INFO - Bytes received: 14496050 12:17:14 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')]} 12:17:14 INFO - trying https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.tar.bz2 12:17:14 INFO - Downloading https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:17:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:17:17 INFO - Downloaded 61786172 bytes. 12:17:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.tar.bz2 12:17:17 INFO - mkdir: /builds/slave/test/properties 12:17:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:17 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:17 INFO - Contents: 12:17:17 INFO - build_url:https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.tar.bz2 12:17:17 INFO - Running post-action listener: _resource_record_post_action 12:17:17 INFO - Running post-action listener: set_extra_try_arguments 12:17:17 INFO - [mozharness: 2017-08-13 19:17:17.310264Z] Finished download-and-extract step (success) 12:17:17 INFO - [mozharness: 2017-08-13 19:17:17.310495Z] Running populate-webroot step. 12:17:17 INFO - Running pre-action listener: _resource_record_pre_action 12:17:17 INFO - Running main action method: populate_webroot 12:17:17 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:17:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:17:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:17:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:17:17 INFO - 'tests': ['damp', 'tps']}, 12:17:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:17:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:17:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:17:17 INFO - 'other-e10s': {'tests': ['a11yr', 12:17:17 INFO - 'ts_paint', 12:17:17 INFO - 'tpaint', 12:17:17 INFO - 'sessionrestore', 12:17:17 INFO - 'sessionrestore_many_windows', 12:17:17 INFO - 'sessionrestore_no_auto_restore', 12:17:17 INFO - 'tabpaint']}, 12:17:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:17:17 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 12:17:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:17:17 INFO - 'tsvgr_opacity', 12:17:17 INFO - 'tart', 12:17:17 INFO - 'tscrollx', 12:17:17 INFO - 'tsvg_static']}, 12:17:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:17:17 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:17:17 INFO - 'talos_options': ['--mitmproxy', 12:17:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:17:17 INFO - '--firstNonBlankPaint'], 12:17:17 INFO - 'tests': ['tp6_google', 12:17:17 INFO - 'tp6_youtube', 12:17:17 INFO - 'tp6_amazon', 12:17:17 INFO - 'tp6_facebook']}, 12:17:17 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:17:17 INFO - 'talos_options': ['--stylo', 12:17:17 INFO - '--mitmproxy', 12:17:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:17:17 INFO - '--firstNonBlankPaint'], 12:17:17 INFO - 'tests': ['tp6_google', 12:17:17 INFO - 'tp6_youtube', 12:17:17 INFO - 'tp6_amazon', 12:17:17 INFO - 'tp6_facebook']}, 12:17:17 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:17:17 INFO - 'talos_options': ['--stylo', 12:17:17 INFO - '--stylo-threads=1', 12:17:17 INFO - '--mitmproxy', 12:17:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:17:17 INFO - '--firstNonBlankPaint'], 12:17:17 INFO - 'tests': ['tp6_google', 12:17:17 INFO - 'tp6_youtube', 12:17:17 INFO - 'tp6_amazon', 12:17:17 INFO - 'tp6_facebook']}, 12:17:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:17:17 INFO - 'talos_options': ['--xperf_path', 12:17:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:17 INFO - 'tests': ['tp5n']}}} 12:17:17 INFO - Running post-action listener: _resource_record_post_action 12:17:17 INFO - [mozharness: 2017-08-13 19:17:17.325666Z] Finished populate-webroot step (success) 12:17:17 INFO - [mozharness: 2017-08-13 19:17:17.325757Z] Running create-virtualenv step. 12:17:17 INFO - Running pre-action listener: _resource_record_pre_action 12:17:17 INFO - Running main action method: create_virtualenv 12:17:17 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:17 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 12:17:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:17:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:17 INFO - Using real prefix '/usr' 12:17:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:17 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:19 INFO - Installing pip.................done. 12:17:19 INFO - Return code: 0 12:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:17:20 INFO - Reading from file tmpfile_stdout 12:17:20 INFO - Output received: 12:17:20 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) 12:17:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17: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')]} 12:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17: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', 'pip>=1.5'] in /builds/slave/test/build 12:17: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 pip>=1.5 12:17:20 INFO - Using env: {'DISPLAY': ':0', 12:17:20 INFO - 'HOME': '/home/cltbld', 12:17:20 INFO - 'LANG': 'en_US.UTF-8', 12:17:20 INFO - 'LANGUAGE': 'en_US:en', 12:17:20 INFO - 'LOGNAME': 'cltbld', 12:17:20 INFO - 'MAIL': '/var/mail/cltbld', 12:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:20 INFO - 'MOZ_NO_REMOTE': '1', 12:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:20 INFO - 'NO_EM_RESTART': '1', 12:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:20 INFO - 'PWD': '/builds/slave/test', 12:17:20 INFO - 'SHELL': '/bin/bash', 12:17:20 INFO - 'SHLVL': '1', 12:17:20 INFO - 'TERM': 'linux', 12:17:20 INFO - 'TMOUT': '86400', 12:17:20 INFO - 'USER': 'cltbld', 12:17:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:20 INFO - '_': '/tools/buildbot/bin/python'} 12:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:20 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 12:17:20 INFO - Cleaning up... 12:17:20 INFO - Return code: 0 12:17:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17: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')]} 12:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17: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', '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 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:17: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 psutil>=3.1.1 12:17:20 INFO - Using env: {'DISPLAY': ':0', 12:17:20 INFO - 'HOME': '/home/cltbld', 12:17:20 INFO - 'LANG': 'en_US.UTF-8', 12:17:20 INFO - 'LANGUAGE': 'en_US:en', 12:17:20 INFO - 'LOGNAME': 'cltbld', 12:17:20 INFO - 'MAIL': '/var/mail/cltbld', 12:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:20 INFO - 'MOZ_NO_REMOTE': '1', 12:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:20 INFO - 'NO_EM_RESTART': '1', 12:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:20 INFO - 'PWD': '/builds/slave/test', 12:17:20 INFO - 'SHELL': '/bin/bash', 12:17:20 INFO - 'SHLVL': '1', 12:17:20 INFO - 'TERM': 'linux', 12:17:20 INFO - 'TMOUT': '86400', 12:17:20 INFO - 'USER': 'cltbld', 12:17:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:20 INFO - '_': '/tools/buildbot/bin/python'} 12:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:20 INFO - Downloading/unpacking psutil>=3.1.1 12:17: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 12:17: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 12:17: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 12:17: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 12:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:21 INFO - Installing collected packages: psutil 12:17:21 INFO - Running setup.py install for psutil 12:17:21 INFO - building 'psutil._psutil_linux' extension 12:17:21 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 12:17:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:17:22 INFO - building 'psutil._psutil_posix' extension 12:17:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:17:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:17:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:22 INFO - Successfully installed psutil 12:17:22 INFO - Cleaning up... 12:17:22 INFO - Return code: 0 12:17:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:17:22 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')]} 12:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:22 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')]} 12:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17:22 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 12:17:22 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 12:17:22 INFO - Using env: {'DISPLAY': ':0', 12:17:22 INFO - 'HOME': '/home/cltbld', 12:17:22 INFO - 'LANG': 'en_US.UTF-8', 12:17:22 INFO - 'LANGUAGE': 'en_US:en', 12:17:22 INFO - 'LOGNAME': 'cltbld', 12:17:22 INFO - 'MAIL': '/var/mail/cltbld', 12:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:22 INFO - 'MOZ_NO_REMOTE': '1', 12:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:22 INFO - 'NO_EM_RESTART': '1', 12:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:22 INFO - 'PWD': '/builds/slave/test', 12:17:22 INFO - 'SHELL': '/bin/bash', 12:17:22 INFO - 'SHLVL': '1', 12:17:22 INFO - 'TERM': 'linux', 12:17:22 INFO - 'TMOUT': '86400', 12:17:22 INFO - 'USER': 'cltbld', 12:17:22 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:22 INFO - '_': '/tools/buildbot/bin/python'} 12:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:17:23 INFO - Installing collected packages: mozsystemmonitor 12:17:23 INFO - Running setup.py install for mozsystemmonitor 12:17:23 INFO - Successfully installed mozsystemmonitor 12:17:23 INFO - Cleaning up... 12:17:23 INFO - Return code: 0 12:17:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17: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')]} 12:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17: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', '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 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:17: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 jsonschema==2.5.1 12:17:23 INFO - Using env: {'DISPLAY': ':0', 12:17:23 INFO - 'HOME': '/home/cltbld', 12:17:23 INFO - 'LANG': 'en_US.UTF-8', 12:17:23 INFO - 'LANGUAGE': 'en_US:en', 12:17:23 INFO - 'LOGNAME': 'cltbld', 12:17:23 INFO - 'MAIL': '/var/mail/cltbld', 12:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:23 INFO - 'MOZ_NO_REMOTE': '1', 12:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:23 INFO - 'NO_EM_RESTART': '1', 12:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:23 INFO - 'PWD': '/builds/slave/test', 12:17:23 INFO - 'SHELL': '/bin/bash', 12:17:23 INFO - 'SHLVL': '1', 12:17:23 INFO - 'TERM': 'linux', 12:17:23 INFO - 'TMOUT': '86400', 12:17:23 INFO - 'USER': 'cltbld', 12:17:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:23 INFO - '_': '/tools/buildbot/bin/python'} 12:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:24 INFO - Downloading/unpacking jsonschema==2.5.1 12:17:24 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 12:17:24 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 12:17:24 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 12:17:24 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 12:17:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:17:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:17: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 12:17: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 12:17: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 12:17: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 12:17:25 INFO - Downloading functools32-3.2.3-2.tar.gz 12:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:17:25 INFO - warning: no files found matching '*.txt' 12:17:25 INFO - no previously-included directories found matching 'build' 12:17:25 INFO - no previously-included directories found matching 'dist' 12:17:25 INFO - no previously-included directories found matching '.git*' 12:17:25 INFO - Installing collected packages: jsonschema, functools32 12:17:25 INFO - Running setup.py install for functools32 12:17:25 INFO - warning: no files found matching '*.txt' 12:17:25 INFO - no previously-included directories found matching 'build' 12:17:25 INFO - no previously-included directories found matching 'dist' 12:17:25 INFO - no previously-included directories found matching '.git*' 12:17:25 INFO - Successfully installed jsonschema functools32 12:17:25 INFO - Cleaning up... 12:17:25 INFO - Return code: 0 12:17:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:17:25 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')]} 12:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:25 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')]} 12:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17:25 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 12:17:25 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 12:17:25 INFO - Using env: {'DISPLAY': ':0', 12:17:25 INFO - 'HOME': '/home/cltbld', 12:17:25 INFO - 'LANG': 'en_US.UTF-8', 12:17:25 INFO - 'LANGUAGE': 'en_US:en', 12:17:25 INFO - 'LOGNAME': 'cltbld', 12:17:25 INFO - 'MAIL': '/var/mail/cltbld', 12:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:25 INFO - 'MOZ_NO_REMOTE': '1', 12:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:25 INFO - 'NO_EM_RESTART': '1', 12:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:25 INFO - 'PWD': '/builds/slave/test', 12:17:25 INFO - 'SHELL': '/bin/bash', 12:17:25 INFO - 'SHLVL': '1', 12:17:25 INFO - 'TERM': 'linux', 12:17:25 INFO - 'TMOUT': '86400', 12:17:25 INFO - 'USER': 'cltbld', 12:17:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:25 INFO - '_': '/tools/buildbot/bin/python'} 12:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:17:25 INFO - Cleaning up... 12:17:25 INFO - Return code: 0 12:17:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:25 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')]} 12:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:25 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')]} 12:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17:25 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 12:17:25 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 12:17:25 INFO - Using env: {'DISPLAY': ':0', 12:17:25 INFO - 'HOME': '/home/cltbld', 12:17:25 INFO - 'LANG': 'en_US.UTF-8', 12:17:25 INFO - 'LANGUAGE': 'en_US:en', 12:17:25 INFO - 'LOGNAME': 'cltbld', 12:17:25 INFO - 'MAIL': '/var/mail/cltbld', 12:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:25 INFO - 'MOZ_NO_REMOTE': '1', 12:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:25 INFO - 'NO_EM_RESTART': '1', 12:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:25 INFO - 'PWD': '/builds/slave/test', 12:17:25 INFO - 'SHELL': '/bin/bash', 12:17:25 INFO - 'SHLVL': '1', 12:17:25 INFO - 'TERM': 'linux', 12:17:25 INFO - 'TMOUT': '86400', 12:17:25 INFO - 'USER': 'cltbld', 12:17:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:25 INFO - '_': '/tools/buildbot/bin/python'} 12:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:25 INFO - Downloading/unpacking blobuploader==1.2.4 12:17: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 12:17: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 12:17: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 12:17: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 12:17:27 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:27 INFO - Downloading docopt-0.6.1.tar.gz 12:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:27 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:27 INFO - Running setup.py install for blobuploader 12:17:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:27 INFO - Running setup.py install for requests 12:17:28 INFO - Running setup.py install for docopt 12:17:28 INFO - Successfully installed blobuploader requests docopt 12:17:28 INFO - Cleaning up... 12:17:28 INFO - Return code: 0 12:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:28 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')]} 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:28 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')]} 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:28 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 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17:28 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 12:17:28 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 12:17:28 INFO - Using env: {'DISPLAY': ':0', 12:17:28 INFO - 'HOME': '/home/cltbld', 12:17:28 INFO - 'LANG': 'en_US.UTF-8', 12:17:28 INFO - 'LANGUAGE': 'en_US:en', 12:17:28 INFO - 'LOGNAME': 'cltbld', 12:17:28 INFO - 'MAIL': '/var/mail/cltbld', 12:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:28 INFO - 'MOZ_NO_REMOTE': '1', 12:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:28 INFO - 'NO_EM_RESTART': '1', 12:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:28 INFO - 'PWD': '/builds/slave/test', 12:17:28 INFO - 'SHELL': '/bin/bash', 12:17:28 INFO - 'SHLVL': '1', 12:17:28 INFO - 'TERM': 'linux', 12:17:28 INFO - 'TMOUT': '86400', 12:17:28 INFO - 'USER': 'cltbld', 12:17:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:28 INFO - '_': '/tools/buildbot/bin/python'} 12:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:28 INFO - Running setup.py (path:/tmp/pip-u7Wiqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:28 INFO - Running setup.py (path:/tmp/pip-yFpSko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:28 INFO - Running setup.py (path:/tmp/pip-FqeMjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:28 INFO - Running setup.py (path:/tmp/pip-Wvy9Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:28 INFO - Running setup.py (path:/tmp/pip-OrckcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:28 INFO - Running setup.py (path:/tmp/pip-T9tbsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:28 INFO - Running setup.py (path:/tmp/pip-79cVHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:28 INFO - Running setup.py (path:/tmp/pip-4Qm6z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:29 INFO - Running setup.py (path:/tmp/pip-nO3jcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:29 INFO - Running setup.py (path:/tmp/pip-pwVkZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:29 INFO - Running setup.py (path:/tmp/pip-9v0SbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:29 INFO - Running setup.py (path:/tmp/pip-SeHOhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:29 INFO - Running setup.py (path:/tmp/pip-kx0rwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:29 INFO - Running setup.py (path:/tmp/pip-SaGQeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:29 INFO - Running setup.py (path:/tmp/pip-Olpfec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:29 INFO - Running setup.py (path:/tmp/pip-6EPwdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:29 INFO - Running setup.py (path:/tmp/pip-V5Joye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:29 INFO - Running setup.py install for manifestparser 12:17:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:29 INFO - Running setup.py install for mozcrash 12:17:29 INFO - Running setup.py install for mozdebug 12:17:30 INFO - Running setup.py install for mozdevice 12:17:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:30 INFO - Running setup.py install for mozfile 12:17:30 INFO - Running setup.py install for mozhttpd 12:17:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:30 INFO - Running setup.py install for mozinfo 12:17:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:30 INFO - Running setup.py install for mozInstall 12:17:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:30 INFO - Running setup.py install for mozleak 12:17:30 INFO - Running setup.py install for mozlog 12:17:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:30 INFO - Running setup.py install for moznetwork 12:17:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:30 INFO - Running setup.py install for mozprocess 12:17:30 INFO - Running setup.py install for mozprofile 12:17:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:31 INFO - Running setup.py install for mozrunner 12:17:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:31 INFO - Running setup.py install for mozscreenshot 12:17:31 INFO - Running setup.py install for moztest 12:17:31 INFO - Running setup.py install for mozversion 12:17:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:31 INFO - Cleaning up... 12:17:31 INFO - Return code: 0 12:17:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:31 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')]} 12:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:31 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')]} 12:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:31 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 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17:31 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 12:17:31 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 12:17:31 INFO - Using env: {'DISPLAY': ':0', 12:17:31 INFO - 'HOME': '/home/cltbld', 12:17:31 INFO - 'LANG': 'en_US.UTF-8', 12:17:31 INFO - 'LANGUAGE': 'en_US:en', 12:17:31 INFO - 'LOGNAME': 'cltbld', 12:17:31 INFO - 'MAIL': '/var/mail/cltbld', 12:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:31 INFO - 'MOZ_NO_REMOTE': '1', 12:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:31 INFO - 'NO_EM_RESTART': '1', 12:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:31 INFO - 'PWD': '/builds/slave/test', 12:17:31 INFO - 'SHELL': '/bin/bash', 12:17:31 INFO - 'SHLVL': '1', 12:17:31 INFO - 'TERM': 'linux', 12:17:31 INFO - 'TMOUT': '86400', 12:17:31 INFO - 'USER': 'cltbld', 12:17:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:31 INFO - '_': '/tools/buildbot/bin/python'} 12:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:31 INFO - Running setup.py (path:/tmp/pip-Nb4vl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:31 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)) 12:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:31 INFO - Running setup.py (path:/tmp/pip-_v6pqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:31 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)) 12:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:31 INFO - Running setup.py (path:/tmp/pip-mHMYs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:31 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)) 12:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:31 INFO - Running setup.py (path:/tmp/pip-J0WAnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:31 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)) 12:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:31 INFO - Running setup.py (path:/tmp/pip-4vm04e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:32 INFO - Running setup.py (path:/tmp/pip-B99IoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:32 INFO - Running setup.py (path:/tmp/pip-sk2MrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:32 INFO - Running setup.py (path:/tmp/pip-7TTqL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:32 INFO - Running setup.py (path:/tmp/pip-5UuwMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:32 INFO - Running setup.py (path:/tmp/pip-joke8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:32 INFO - Running setup.py (path:/tmp/pip-RCHa4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:32 INFO - Running setup.py (path:/tmp/pip-BgP4KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:32 INFO - Running setup.py (path:/tmp/pip-LITBvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:32 INFO - Running setup.py (path:/tmp/pip-m_ZzKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:32 INFO - Running setup.py (path:/tmp/pip-dFzyHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:32 INFO - Running setup.py (path:/tmp/pip-xEEjTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:32 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)) 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:32 INFO - Running setup.py (path:/tmp/pip-YVf4pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:32 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)) 12:17:32 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)) 12:17:32 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)) 12:17:32 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)) 12:17:32 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)) 12:17:32 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)) 12:17:32 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)) 12:17:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17: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 12:17: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 12:17: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 12:17: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 12:17:34 INFO - Downloading blessings-1.6.tar.gz 12:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:34 INFO - Installing collected packages: blessings 12:17:34 INFO - Running setup.py install for blessings 12:17:34 INFO - Successfully installed blessings 12:17:34 INFO - Cleaning up... 12:17:34 INFO - Return code: 0 12:17:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:34 INFO - Reading from file tmpfile_stdout 12:17:34 INFO - Current package versions: 12:17:34 INFO - argparse == 1.2.1 12:17:34 INFO - blessings == 1.6 12:17:34 INFO - blobuploader == 1.2.4 12:17:34 INFO - docopt == 0.6.1 12:17:34 INFO - functools32 == 3.2.3-2 12:17:34 INFO - jsonschema == 2.5.1 12:17:34 INFO - manifestparser == 1.1 12:17:34 INFO - mozInstall == 1.13 12:17:34 INFO - mozcrash == 1.0 12:17:34 INFO - mozdebug == 0.1 12:17:34 INFO - mozdevice == 0.51 12:17:34 INFO - mozfile == 1.2 12:17:34 INFO - mozhttpd == 0.7 12:17:34 INFO - mozinfo == 0.10 12:17:34 INFO - mozleak == 0.1 12:17:34 INFO - mozlog == 3.5 12:17:34 INFO - moznetwork == 0.27 12:17:34 INFO - mozprocess == 0.25 12:17:34 INFO - mozprofile == 0.28 12:17:34 INFO - mozrunner == 6.13 12:17:34 INFO - mozscreenshot == 0.1 12:17:34 INFO - mozsystemmonitor == 0.3 12:17:34 INFO - moztest == 0.8 12:17:34 INFO - mozversion == 1.4 12:17:34 INFO - psutil == 3.1.1 12:17:34 INFO - requests == 1.2.3 12:17:34 INFO - wsgiref == 0.1.2 12:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17: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')]} 12:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:34 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 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17:34 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 12:17:34 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 12:17:34 INFO - Using env: {'DISPLAY': ':0', 12:17:34 INFO - 'HOME': '/home/cltbld', 12:17:34 INFO - 'LANG': 'en_US.UTF-8', 12:17:34 INFO - 'LANGUAGE': 'en_US:en', 12:17:34 INFO - 'LOGNAME': 'cltbld', 12:17:34 INFO - 'MAIL': '/var/mail/cltbld', 12:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:34 INFO - 'MOZ_NO_REMOTE': '1', 12:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:34 INFO - 'NO_EM_RESTART': '1', 12:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:34 INFO - 'PWD': '/builds/slave/test', 12:17:34 INFO - 'SHELL': '/bin/bash', 12:17:34 INFO - 'SHLVL': '1', 12:17:34 INFO - 'TERM': 'linux', 12:17:34 INFO - 'TMOUT': '86400', 12:17:34 INFO - 'USER': 'cltbld', 12:17:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:34 INFO - '_': '/tools/buildbot/bin/python'} 12:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:34 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)) 12:17:34 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)) 12:17:34 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)) 12:17:34 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)) 12:17:34 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)) 12:17:34 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)) 12:17:34 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)) 12:17:34 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)) 12:17:34 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)) 12:17:34 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:17:34 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 12:17:34 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 12:17:34 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 12:17:34 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 12:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:17:35 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)) 12:17:35 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)) 12:17:35 INFO - Installing collected packages: simplejson 12:17:35 INFO - Running setup.py install for simplejson 12:17:36 INFO - building 'simplejson._speedups' extension 12:17:36 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 12:17:36 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 12:17:36 INFO - Successfully installed simplejson 12:17:36 INFO - Cleaning up... 12:17:36 INFO - Return code: 0 12:17:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:17:36 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')]} 12:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:36 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')]} 12:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:36 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 0x1f1b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', '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 12:17:36 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 12:17:36 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 12:17:36 INFO - Using env: {'DISPLAY': ':0', 12:17:36 INFO - 'HOME': '/home/cltbld', 12:17:36 INFO - 'LANG': 'en_US.UTF-8', 12:17:36 INFO - 'LANGUAGE': 'en_US:en', 12:17:36 INFO - 'LOGNAME': 'cltbld', 12:17:36 INFO - 'MAIL': '/var/mail/cltbld', 12:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:36 INFO - 'MOZ_NO_REMOTE': '1', 12:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:36 INFO - 'NO_EM_RESTART': '1', 12:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:36 INFO - 'PWD': '/builds/slave/test', 12:17:36 INFO - 'SHELL': '/bin/bash', 12:17:36 INFO - 'SHLVL': '1', 12:17:36 INFO - 'TERM': 'linux', 12:17:36 INFO - 'TMOUT': '86400', 12:17:36 INFO - 'USER': 'cltbld', 12:17:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:36 INFO - '_': '/tools/buildbot/bin/python'} 12:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:17:37 INFO - Cleaning up... 12:17:37 INFO - Return code: 0 12:17:37 INFO - Running post-action listener: _resource_record_post_action 12:17:37 INFO - Running post-action listener: _start_resource_monitoring 12:17:37 INFO - Starting resource monitoring. 12:17:37 INFO - [mozharness: 2017-08-13 19:17:37.245033Z] Finished create-virtualenv step (success) 12:17:37 INFO - [mozharness: 2017-08-13 19:17:37.245638Z] Running install step. 12:17:37 INFO - Running pre-action listener: _resource_record_pre_action 12:17:37 INFO - Running main action method: install 12:17:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:37 INFO - Reading from file tmpfile_stdout 12:17:37 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:37 INFO - Reading from file tmpfile_stdout 12:17:37 INFO - Output received: 12:17:37 INFO - Usage: mozinstall [options] installer 12:17:37 INFO - Options: 12:17:37 INFO - -h, --help show this help message and exit 12:17:37 INFO - -d DEST, --destination=DEST 12:17:37 INFO - Directory to install application into. [default: 12:17:37 INFO - "/builds/slave/test"] 12:17:37 INFO - --app=APP Application being installed. [default: firefox] 12:17:37 INFO - mkdir: /builds/slave/test/build/application 12:17:37 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'] 12:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:17:55 INFO - Reading from file tmpfile_stdout 12:17:55 INFO - Output received: 12:17:55 INFO - /builds/slave/test/build/application/firefox/firefox 12:17:55 INFO - Running post-action listener: _resource_record_post_action 12:17:55 INFO - [mozharness: 2017-08-13 19:17:55.496796Z] Finished install step (success) 12:17:55 INFO - [mozharness: 2017-08-13 19:17:55.497051Z] Running setup-mitmproxy step. 12:17:55 INFO - Running pre-action listener: _resource_record_pre_action 12:17:55 INFO - Running main action method: setup_mitmproxy 12:17:55 INFO - Skipping: mitmproxy is not required 12:17:55 INFO - Running post-action listener: _resource_record_post_action 12:17:55 INFO - [mozharness: 2017-08-13 19:17:55.498304Z] Finished setup-mitmproxy step (success) 12:17:55 INFO - [mozharness: 2017-08-13 19:17:55.498526Z] Running run-tests step. 12:17:55 INFO - Running pre-action listener: _resource_record_pre_action 12:17:55 INFO - Running pre-action listener: _set_gcov_prefix 12:17:55 INFO - Running main action method: run_tests 12:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:17:55 INFO - Python 2.7.3 12:17:55 INFO - Return code: 0 12:17:55 INFO - grabbing minidump binary from tooltool 12:17:55 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')]} 12:17:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22878a0>, '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 0x22887a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2288c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:17:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:17:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:17:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:17:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:17:55 INFO - Return code: 0 12:17:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:17:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:17:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:17:55 INFO - ENV: RUST_BACKTRACE is now full 12:17:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:17:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:17:55 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/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 12:17:55 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/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 12:17:55 INFO - Using env: {'DISPLAY': ':0', 12:17:55 INFO - 'HOME': '/home/cltbld', 12:17:55 INFO - 'LANG': 'en_US.UTF-8', 12:17:55 INFO - 'LANGUAGE': 'en_US:en', 12:17:55 INFO - 'LOGNAME': 'cltbld', 12:17:55 INFO - 'MAIL': '/var/mail/cltbld', 12:17:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:55 INFO - 'MOZ_NO_REMOTE': '1', 12:17:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:55 INFO - 'NO_EM_RESTART': '1', 12:17:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:55 INFO - 'PWD': '/builds/slave/test', 12:17:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:55 INFO - 'RUST_BACKTRACE': 'full', 12:17:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:17:55 INFO - 'SHELL': '/bin/bash', 12:17:55 INFO - 'SHLVL': '1', 12:17:55 INFO - 'STYLO_FORCE_ENABLED': '1', 12:17:55 INFO - 'TERM': 'linux', 12:17:55 INFO - 'TMOUT': '86400', 12:17:55 INFO - 'USER': 'cltbld', 12:17:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703', 12:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:55 INFO - '_': '/tools/buildbot/bin/python'} 12:17:55 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/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 12:17:55 INFO - mozversion application_buildid: 20170813182723 12:17:55 INFO - mozversion application_changeset: e928c65095ed32151bbe6e462eda3e8c79edca9f 12:17:55 INFO - mozversion application_display_name: Nightly 12:17:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:17:55 INFO - mozversion application_name: Firefox 12:17:55 INFO - mozversion application_remotingname: firefox 12:17:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:17:55 INFO - mozversion application_vendor: Mozilla 12:17:55 INFO - mozversion application_version: 57.0a1 12:17:55 INFO - mozversion platform_buildid: 20170813182723 12:17:55 INFO - mozversion platform_changeset: e928c65095ed32151bbe6e462eda3e8c79edca9f 12:17:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:17:55 INFO - mozversion platform_version: 57.0a1 12:17:55 INFO - using testdate: 1502651875 12:17:55 INFO - actual date: 1502651875 12:17:55 INFO - starting webserver on 'localhost:57084' 12:17:55 INFO - SUITE-START | Running 2 tests 12:17:55 INFO - TEST-START | dromaeo_css 12:17:55 INFO - Initialising browser for dromaeo_css test... 12:17:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57084/getInfo.html -profile /tmp/tmpkTaeAx/profile 12:17:55 INFO - TEST-INFO | started process 6074 (/builds/slave/test/build/application/firefox/firefox http://localhost:57084/getInfo.html) 12:18:01 INFO - TEST-INFO | 6074: exit 0 12:18:01 INFO - Browser initialized. 12:18:01 INFO - Running cycle 1/1 for dromaeo_css test... 12:18:01 INFO - TEST-INFO | started process 6304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkTaeAx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:02 INFO - PID 6304 | 12:18:02 INFO - PID 6304 | (/builds/slave/test/build/application/firefox/firefox:6358): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:18:02 INFO - PID 6304 | 12:18:13 INFO - PID 6304 | RSS: Main: 167759872 12:18:13 INFO - PID 6304 | 12:21:13 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:57084/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57084/tests/dromaeo/cssquery-ext.html) 12:21:14 INFO - PID 6304 | RSS: Main: 175046656 12:21:14 INFO - PID 6304 | 12:24:15 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:57084/tests/dromaeo/cssquery-ext.html (next: http://localhost:57084/tests/dromaeo/cssquery-jquery.html) 12:24:16 INFO - PID 6304 | RSS: Main: 171909120 12:24:16 INFO - PID 6304 | 12:27:18 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:57084/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57084/tests/dromaeo/cssquery-mootools.html) 12:27:18 INFO - PID 6304 | RSS: Main: 174256128 12:27:18 INFO - PID 6304 | 12:30:20 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:57084/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57084/tests/dromaeo/cssquery-prototype.html) 12:30:21 INFO - PID 6304 | RSS: Main: 172449792 12:30:21 INFO - PID 6304 | 12:33:25 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:57084/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57084/tests/dromaeo/cssquery-yui.html) 12:33:25 INFO - PID 6304 | RSS: Main: 176136192 12:33:25 INFO - PID 6304 | 12:36:27 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:57084/tests/dromaeo/cssquery-yui.html (next: http://localhost:57084/tests/dromaeo/cssquery-dojo.html) 12:36:28 INFO - PID 6304 | RSS: Main: 176709632 12:36:28 INFO - PID 6304 | 12:36:28 INFO - PID 6304 | __start_tp_report 12:36:28 INFO - PID 6304 | _x_x_mozilla_page_load 12:36:28 INFO - PID 6304 | _x_x_mozilla_page_load_details 12:36:28 INFO - PID 6304 | |i|pagename|runs| 12:36:28 INFO - PID 6304 | |0;dojo.html;3135.388599223151;3136.4668006438906;3165.699258570435;3174.4762114251143;3192.2338638726696;6083.78706745264;6258.123862659231;6277.278113016999;6281.748730050793;6299.212598425197;6073.63558186508;6192.102145188945;6196.039613859859;6200.720967556459;6216.937830621692;5601.047821870292;5655.519280861132;5663.8584035399035;5665.745041473123;5701.401352857953;5713.257276554063;5728.942710572904;5757.42425757423;5768.36547979724;5771.971140144294;5516.779328826842;5583.4137415571595;5592.133219350966;5722.62802917809;5795.449432303924;5649.971750141264;5704.629199102045;5734.283214598176;5740.7703691852275;5758.733078722675;5536.169574563807;5621.915671264935;5629.324481062258;5695.857603559903;5716.371199168088;5987.730552125165;6118.449339559461;6177.876442471171;6180.5982611130585;6190.288116866573;6661.63361015144;6763.154605674291;6763.729450821961;6803.081583986148;6809.114815074058;6721.361470660328;6732.124823772878;6758.391744742948;6838.179418469766;6851;6091.208142941434;6162.815115546541;6180.8763824723255;6282.183316168915;6364.522660800412;6869.347411995853;6883.586984780829;6893.655317234118;6914.1702995639835;6935.514513983972;6355.237371515448;6458.354164583504;6519.902201466982;6547.738090476423;6608.900866487006;6532.118164047888;6580.144581204413;6655.267920528738;6700.396964273239;6722.697478613474;6559.508036897252;6595.4393876521035;6627.834304142435;6628.502862285348;6641.867162656817;6587.736490540325;6631.834204144839;6641.767538136142;6647.069410282565;6649.102371179829;5239.423663397023;5331.840044798662;5378.7041712705395;5399.83800485986;5417.133258678593;4610.9308360374625;4623.491415944243;4638;4644.814207431732;4660.7436590987145;5734.942650573525;5767.538596912237;5821.970890145522;5824.912626310609;5856.414358564195;6578.80263592093;6679.532432729759;6685.532012759158;6695.631740254235;6696.1629796275465;5726.112452569859;5729;5732.484076433141;5737.426257374229;5741.19623252745;5851.151583020438;5860.09168578871;5872.882542349129;5876.118582212703;5880.588358814842;6494.772682956074;6532.836679082966;6534.8366290843105;6536.215654121441;6555.6066636002;6649.73401063952;6677.031830384664;6765.357291057342;6789.083473730983;6789.524733268821;6433.903491447726;6457.61254324742;6530.216374035146;6534.215894092549;6540.738370465128;6408.551401401857;6420.871582568229;6460.321666224979;6544.443722283469;6562;6594.901076483952;6606.735730570724;6623;6722.529422940347;6794.830129246809;6480.935190648222;6485.15692959931;6533.738650453929;6550.312217217123;6563.146790917151;6390.9041364378645;6491;6493.610383377012;6500.902486462802;6580.736770529125;6412.2625898022325;6414.743410263537;6430.967845160932;6432.453241474527;6439.388258115471;6389.648569328546;6484.773032943825;6544.640044797582;6620.371064749033;6666.26671066192;6252.187215661935;6298;6347;6347.5556711029785;6347.904781428375 12:36:28 INFO - PID 6304 | |1;ext.html;802.7792357101796;845.9238668519833;867.8047439326152;870.4211699220023;1157.33453264373;31008.844955775217;41158.58841411585;41481.377779333336;41788;41858.58141418589;40926;41174;41185.794071029675;41196.38205426921;41610.58389416105;7211.567305961633;7591.848163036736;7723.266289702469;7751.961240193791;7810.336121429686;7681.462297639167;7782.299593036626;7798.571078590675;7829.295363417291;7842.058952925629;7764;7766.805829854242;7831.804204894866;7848.646810893495;7853.921460785376;7776.7666969990705;7777.650005749755;7822.843543129134;7842.098158711764;7849.097353804328;7648.617569121521;7716.074071111502;7717.112532058829;7727.845443091163;7730.420218483636;38927.805360973296;39151.8042409789;39166.41250381246;39186;39201.60798392008;3444.156181735491;3461.7403694722743;3478.4956181353814;3483.3555792178527;3488.7906725596545;30943.38113237745;31066.689333106606;31095;31106;31112.222194445094;5004.299398084271;5009.148444764399;5027.371578552681;5048.091343558158;5049.747512624391;182938;184267;184810;185240;186559;45801.54198458039;46622.76688616535;46637.30044049342;46841.53158468372;50782;53091;53091.46908530865;53097.46902531003;53284.467155328726;53476.465235347925;14958;15053.397864085533;15071.849281507044;15196.088234705732;15245.313960871566;12562.748745025048;12575.748485030248;12585.685357865943;12586.748265034648;12692.873071269354;14373.712525749426;14398.712025759636;14405.207713575644;14488.927555362156;14593.635159120895;5696.572757043238;5749.223854779635;5786.392428795;5889.587728858939;5946.940530594725;960.2653969713175;972.5234635028927;979.1481411172325;996.4320337407609;1005.8843233028149;22780;22879.542409151723;22958.540829183323;22968.196113136295;23026.769732302462;1061.7312311787493;1072.9570817167225;1075.5052675769077;1078.9352638841694;1084.1543595995136;12180.730923455036;12289.631311060682;15753.921230394004;15865.68268634644;16469.83530164683;234675;234882;235611;236246;236958;56938;58018;58246.70876645589;58522.7073864628;58659;1423.985760142406;1465.4301171154968;1482.3551754986615;1483.4956114920763;1487.196913666608;26898.51596462315;27233.72766272312;27437.725622743517;27527.31181720473;27835.44329113447;38338;38699.22601547897;38716;38728;38735;148065;201801;207048;209499;210033;37192.44211336886;37199.442008369355;37203.813980931;37514;37535.81232093822;44511.332330014426;46090.769546152056;46099.76950115228;46102.769486152356;46400.30399543942;32948.50577241295;33621.66378336185;33663.663363367035;33689.494657579664;33875.983720488424;33093.17267068342;33344.49983250302;34301.48547771735;34320.65679343174;34570.13574660553;36365;36365.81817090898;36399.27201456009;36470.27059458849;38134.2373152541;33032;33142.66857331396;33153.33693326168;33480.33039339151;34085.65914340825;23650.29049128529;23996.40008999789;24593.631095533223;24609.630855536823;24755.235686961147 12:36:28 INFO - PID 6304 | |2;jquery.html;565.8274226360958;573.0086949577234;577.662067690401;578.1530058464349;586.882623475305;21555.67666485004;22495;22537.21119760809;22573.322800315975;22574.661380079313;25500.362490937736;25772.871135644295;25956.610650840204;25990.350241243978;25999;6576.539642225046;6731.293214212511;6733.461323094165;6734.46124310054;6736.191657001166;6062.939370606282;6386.904196437057;6644.103046088789;6653.168353955755;6667.633280169589;6611.504137189706;6633.8341541461605;6637.236717777445;6646.501512386566;6649.933500665004;6600.80197594073;6616.702248398834;6625.73497060117;6625.966870165618;6631.602103873783;6104.694765261719;6157.96921015392;6160.630362178284;6168.87662246757;6179.16581261533;28729.28176795576;29261.70738292611;29536.26159346012;29611;29667.703322966925;1806.846418054467;1906.447130332216;1907.3801014670287;1907.7043058325983;1910.961780764377;19439.805601943943;19963.101660425316;20020.69968950467;20023.49941251466;20081.497962550908;2379.568801646793;2408.903643854244;2446.5718499262734;2527.545041892459;2534.037065914959;132982;139973.30013349868;141100;141146.99999999898;141245;14306.499272525412;14897.702045959237;15094.773578396333;15170.393184272727;15194;23067.192648257565;23578.646320305208;24174.51650966971;24202;24207.273781786575;9095.408798428081;9099.909000910038;9104.590293436811;9191.494467804201;9358.11097945694;8215.753527394188;8302.086770455246;8312.25189732927;8313.501189928624;8350.580401331788;9203.4938078405;9263.166315031545;9332.926713428044;9503.809923801624;9564.856527152098;2596.7792737617137;2609.8647088516555;2747.5603903375363;2749.5188342040065;2852.3297025199063;885.5882014862991;923.1875949164827;938.0478814003792;945.8297506448905;946.2146418472652;18753.874767513993;19271;19425.962556694518;19682.507937301394;19710.40868773939;988.8862780780303;1003.4932359158578;1004.5579944824254;1006.572206812102;1011.9089281964658;10566.471676416148;10712.625058123083;10730.463476826128;10773.084287835465;11039.503222354853;443800;446519;457303;458789;461936;108514.45742771236;114871;114979.85020149859;116227;117122;1176.8528933883265;1187.3706935324292;1222.2666400159833;1228.5270170984236;1230.0897335971495;17156.742648860527;17173.484795456156;17391.130443477523;17622.735658965383;17647.117644117487;56564.7171764155;57156;57342.426575733705;57403.42596574148;58866.41133588781;68578.48504392075;69198.65400673165;69729.30270697227;71015.64492177713;71221.28778712146;14467.27663616836;14493.130412175304;14646.63383415423;14736.26318684083;14763;22845;22849.543009140056;22980.4254893629;23023;23228.651570226797;17806.46580602584;17819.376321828673;17835.554111147325;18412.539686507407;18416.447506574823;15576.84423155754;15701.136437496047;16272.91863540722;16696.833031670012;16806.747898781283;17250.396236131674;17963.371282005068;18139.637207255517;18298.45104646863;18591.2563497464;14094.718105637625;14449.927750361181;14529.636759081108;14530.273486325852;14778.18719970412;17289.65420691554;17349.132543373034;17552.297908083532;17642.73535896937;17697.734533982257 12:36:28 INFO - PID 6304 | |3;mootools.html;1360.122720845055;1367.1865240182087;1370.6299299189216;1397.5946975377142;1411.6118067531422;14139;14290.499832505864;14724.263786810658;14749.631259218511;14774.63063423415;14587.562373128796;14852.18312992785;14869.702605947874;14887.851121488782;14955.177465239434;2647.827891187076;2701.18964310707;2708.9322766930886;2710.390162213496;2712.498187835247;2586.6766654168227;2648.8278261912915;2743.396452780385;2761.4339060492553;2772.542530482478;2639.85480798556;2652.4827658606578;2673;2694.9461010779773;2698.689650690176;2617.6858776946697;2648.245250103721;2670.4792565449743;2695.299222202222;2702.8918843246347;2504.5491811473926;2541.0471073347494;2557.399011232359;2558.2708927955628;2562.5387430262545;14048.367823447968;14175.78736318956;14302.499412520512;14320.856791432056;14438.639034024129;7309.122905251404;7602.353799926957;7611.885821712679;7620.542767433972;7624.42816788743;4875.098106850209;5038.3198268234055;5164.793408263665;5208.2968799212;5306.495882891119;1893.8863668179954;1912.2733361322607;1943.7570303712037;1954.8436125109956;1962.2641509433963;21900.89049554758;22098.88950555253;22111.226107086335;22169.77830221693;22232.333030008966;6267.623942563369;6281.277653069864;6355.491560675135;6504.317046710122;6543.280239173687;15444.691106178037;15448.150351730537;15454.536363909101;15474.684651804722;15491.845081549265;7138.892916606255;7398.778036658909;7405.703771849066;7416.0729908761405;7418.109826820816;5998.3701711320555;6648.368405001517;6834.555753875982;6837.940119281519;6855.6572171391235;4622.976885115553;5138.460461651547;5228.869278268074;5234.0840352938085;5268.341457317835;1418.4964337660188;1472.2491529320123;1475.3287254299269;1482.6441654003177;1483.7996870422571;895.7984453498041;904.977375565603;909.1317791509225;914.8216097860986;916.9638308711113;8343.541105239148;8358.414910956297;8365.330773538102;8413.663453461793;8493.320534357237;968.6948611187454;975.7316737896994;987.9407235565889;990.390909590611;997.9950100249453;4590.403247577793;4808.543188397097;5028.472010438852;5224;5241.109011468059;19000.23999040023;19888.204471820965;20196.899015504827;20248.595028099357;20259.696104558443;18797.530061748294;19464.22143114288;19818.009099545252;19844;19888.60222795565;9892.258080643836;10210.795784084277;10285.99999999985;10331.535080921376;10362.844557331646;8370.707025254087;8512.148785121686;8668.609912553824;8691.913080869363;8975.730728078168;17130.057846818545;17550;17565.385211518045;17638.91180544089;17734.113294334973;17510.474685759447;17512.82487175163;17728.202230899384;18066.36767713124;18377.72433413473;10552;10730.248882578144;10859.402732849769;10884.61903833362;10917.344959302467;11903.40482975865;12053.156279060382;12402.81395779082;13113.541026064042;13644.795328069888;10945.890541094806;11010.174236932102;11206.327620342805;11376.43117844088;11381.203315767816;10576;10617.96242645059;10889.237753357189;10987.175961802737;11058.115350771757;9417.199538039344;9497.385444474317;9557.330986830855;9637.036296370306;9651.662191823252;7205.243449437734;7287.41700663935;7315.817104572216;7351.963240183979;7403.629818508945;7165.176004759519;7204.027456293334;7250.9637451812405;7273;7327.963360183378 12:36:28 INFO - PID 6304 | |4;prototype.html;502.69838097141695;503.53973476916934;517.7463043108877;523.4895976422986;529.8966701493208;6304.369563043693;6310.349653145684;6319.6524191169465;6328.746850126001;6355.52333574982;5996.730147143378;6139.6009259398215;6145.631262124264;6182.290625624623;6192.628442293466;4963.652544321899;4976.427710813248;5007.223880298559;5009.522190953678;5021.1213037718435;4895.241237608158;4994.5255200756055;5021.087769093917;5024.723640199788;5025.793809485734;4930.876728081808;4948.604111671058;4966.850994470172;4968.205087186051;4997.350344455216;4988.5260900214425;4989.176785830334;5006.899862002776;5019.774110165033;5026.019926114409;4465.325502936399;4471.195184866723;4479.745671212066;4484.484284307281;4487.730736155809;6019.789307374221;6076.3316035236085;6100.010994612608;6121.724522396458;6138.662373569452;5772.509336706385;5779.306483222041;5800.129980502916;5802.796902108448;5805.883882322372;6611.735530578771;6616.239132499728;6616.88259756878;6626.304238055031;6638.17022872141;4909.386326709161;4917.975410122962;4930.137225985474;4984.975075124637;5003.3495645565845;6927.376536111774;7015;7038.284349485857;7071.858562828715;7086.610236436943;5052.545270925634;5054.317667114966;5074.517920797518;5076.82231121909;5111.744412779346;5066.214736715815;5130.179171332569;5138.691678499227;5146.922796158061;5153.453963810842;5678.488935995781;5728.283964504437;5742.885142297131;5766.192733017381;5779.248697669276;6542.149520562391;6615.4046135848;6647.767328143492;6650.767223147167;6714;1683.2004797720986;1723.603571178636;1724.8706347024024;1755.3680674957004;1767.5050985724017;1189.9107566932514;1195.7728031673955;1229.2562999385423;1238.9690257743448;1252.6242127361936;5740.694479140645;5756.107803290497;5777.959967205859;5787.652740835563;5840.970795146082;6632.369924857131;6697.464202863759;6735.259121496631;6738.157730283715;6814.250432452426;5753.194552762533;5791.362950075489;5802.65184088956;5827.475527202572;5841.88316233673;3581.7435015940314;3610.6208848070573;3613.8915832525067;3622.2755448909797;3622.492851000862;6447.6131432114225;6502.154719886479;6523.478121750343;6598.944168932948;6615;6883.65581720912;6904.965475172592;6925.549839260432;7001.299870012958;7047.154341479055;6462.935370646422;6468.935310646927;6470.320616335217;6615.536912416181;6621.668916554153;6613.206415230011;6659.500537459613;6675.198976122896;6830.180378354629;6862.696087743313;6562.475001999733;6715.93284067153;6765.737585321413;6810.8637827244165;6817.522773405814;6536.0522724205675;6572.4084832365315;6604.207495100619;6611.834704132435;6628.204615446178;5012.573931215888;5084.745762711924;5104.2343648453025;5106.208537676666;5119.6416250862085;6791.185057792899;6835.555688880207;6859.211190713132;6880.621565813928;6901.378875901193;6639.966800165968;6661.633610151294;6683.732650693918;6693.431058360094;6708.228553716385;6355.648410088112;6581.506387020897;6587.80236592903;6647.135872336758;6667.299933507106;6299.937000629935;6312.589681670676;6380.712867921047;6461.64460954652;6463.515236357198;6392.1235444049435;6493;6538.880505281642;6544.8363790905605;6617.172853393326;6237.5633705641985;6263.217097862767;6283.8114856554375;6295.859407801369;6361.759456906044 12:36:28 INFO - PID 6304 | |5;yui.html;869.9217070463661;887.467519488307;898.3352319283728;901;909.2862103248951;17745.20146593403;18324.816751832495;18335.449936501893;18347.174377153027;18378.632427351444;20598.352131829455;21633;22418;22528.54942901145;22662.09351625937;1041.4948749856314;1067.2475904487317;1069.1874175626501;1069.3744159666605;1069.5026812532171;1003.7791685829106;1045.8431235314727;1055.0451841083832;1055.2771351624162;1066.6000249906285;1082.220801023262;1127.025123268371;1127.7631697343568;1127.937963412012;1128.2609890521721;1072.0940805019745;1114.9609763658314;1115.2917897135296;1116.3023110555903;1120.3725913488431;778.4978688745784;807.0275318241563;814.8899898513744;816.9223923727236;818.6397984886631;20452.38642840717;20546.17815287387;20587.691184632244;20692.172313107458;20805;20945.790542094688;21375.251866184764;21388.893055534623;21399;21485.248016319354;17021.40425085116;17061;17193.914030429893;17201.225944832513;17355.305787768473;3604.873829415984;3653.780773153619;3656.762310449812;3659.451082337644;3661.8901432957055;117968.41015794952;118059;121698.99999999911;122248;122341;16725.6654866902;17044.573885652957;17349.306027759;17355.826441735422;17510.824891751174;29873.850630747143;29913.551296730566;30753.692463075084;30942.69057309443;30960.535591966138;8568.186022327993;8609.655613775503;8705.956470217609;8737.30101591871;8755.036945935943;3739.121306492972;3770.377887648507;3931.803409829497;3995.06116062725;4001.459802926626;5012.674176178537;5120.564751996122;5142.202958541432;5223.738813059408;5241.3489750728395;1044.7910417916446;1071.0842229893485;1075.5482697267166;1080.4111759091313;1085.5440714899762;587.3597778421541;601.4076135007015;605.8182545236411;614.6250787019915;622.9345918678564;10929;11238.21332506733;11322.547098115983;12009.09931755122;12091.697707557205;605.3946053946054;608.9086637004485;614.2628845385556;615.6275453350748;639.1212083385345;5267.104592219332;5309.283246761638;5310.628256022042;5313.415524292324;5366.812161574326;109708.4514577422;111047.44476277567;113669.43165284286;113787.43106284416;114335;91290.54354728184;93717.5314123425;100674;100832;101504.49247753713;79108;83042.58478707689;83680;86890.1310986882;88689.55655221811;11193.27243729155;11458.427078645867;11811.940940295244;12112.75774484523;12459.626211213677;36458.63541364553;36523.63476365202;36584.634153658124;37624;38127.80936095302;53781;70289.64855175691;70771;72780.6360968213;73320.63339683268;15907.28417221251;16706.24821882994;16779.16104194761;16873.493795186165;16909.23908424099;16965.830341696426;17078.48764537066;17098.401555945482;17128.65742685164;17143.399981000606;16105.919470402572;16247.350105995627;16270.105144217181;16275.51173464798;16409.507714768577;16330.591735206239;16373;16507.752383714494;16545.586360341087;16622.916885415496;15664.37342506287;16421.58946026359;16477.423290184786;16613.41853035138;17063.829361706223;12188.75622487563;12393.62819115428;12677.20189414537;12693.619191423903;13235.47058117703;12985.415656295678;13190;13449.125806822525;13572;13995.300234988006 12:36:28 INFO - PID 6304 | __end_tp_report 12:36:28 INFO - PID 6304 | __start_cc_report 12:36:28 INFO - PID 6304 | _x_x_mozilla_cycle_collect,365 12:36:28 INFO - PID 6304 | __end_cc_report 12:36:28 INFO - PID 6304 | __startTimestamp1502652988008__endTimestamp 12:36:28 INFO - PID 6304 | 12:36:28 INFO - PID 6304 | ------- Summary: start ------- 12:36:28 INFO - PID 6304 | Number of tests: 6 12:36:28 INFO - PID 6304 | 12:36:28 INFO - PID 6304 | [#0] dojo.html Cycles:165 Average:6133.86 Median:6390.90 stddev:727.39 (11.4%) stddev-sans-first:690.54 12:36:28 INFO - PID 6304 | Values: 3135.4 3136.5 3165.7 3174.5 3192.2 6083.8 6258.1 6277.3 6281.7 6299.2 6073.6 6192.1 6196.0 6200.7 6216.9 5601.0 5655.5 5663.9 5665.7 5701.4 5713.3 5728.9 5757.4 5768.4 5772.0 5516.8 5583.4 5592.1 5722.6 5795.4 5650.0 5704.6 5734.3 5740.8 5758.7 5536.2 5621.9 5629.3 5695.9 5716.4 5987.7 6118.4 6177.9 6180.6 6190.3 6661.6 6763.2 6763.7 6803.1 6809.1 6721.4 6732.1 6758.4 6838.2 6851.0 6091.2 6162.8 6180.9 6282.2 6364.5 6869.3 6883.6 6893.7 6914.2 6935.5 6355.2 6458.4 6519.9 6547.7 6608.9 6532.1 6580.1 6655.3 6700.4 6722.7 6559.5 6595.4 6627.8 6628.5 6641.9 6587.7 6631.8 6641.8 6647.1 6649.1 5239.4 5331.8 5378.7 5399.8 5417.1 4610.9 4623.5 4638.0 4644.8 4660.7 5734.9 5767.5 5822.0 5824.9 5856.4 6578.8 6679.5 6685.5 6695.6 6696.2 5726.1 5729.0 5732.5 5737.4 5741.2 5851.2 5860.1 5872.9 5876.1 5880.6 6494.8 6532.8 6534.8 6536.2 6555.6 6649.7 6677.0 6765.4 6789.1 6789.5 6433.9 6457.6 6530.2 6534.2 6540.7 6408.6 6420.9 6460.3 6544.4 6562.0 6594.9 6606.7 6623.0 6722.5 6794.8 6480.9 6485.2 6533.7 6550.3 6563.1 6390.9 6491.0 6493.6 6500.9 6580.7 6412.3 6414.7 6431.0 6432.5 6439.4 6389.6 6484.8 6544.6 6620.4 6666.3 6252.2 6298.0 6347.0 6347.6 6347.9 12:36:28 INFO - PID 6304 | 12:36:28 INFO - PID 6304 | [#1] ext.html Cycles:180 Average:38150.81 Median:36434.77 stddev:53636.38 (147.2%) stddev-sans-first:53713.53 12:36:28 INFO - PID 6304 | Values: 802.8 845.9 867.8 870.4 1157.3 31008.8 41158.6 41481.4 41788.0 41858.6 40926.0 41174.0 41185.8 41196.4 41610.6 7211.6 7591.8 7723.3 7752.0 7810.3 7681.5 7782.3 7798.6 7829.3 7842.1 7764.0 7766.8 7831.8 7848.6 7853.9 7776.8 7777.7 7822.8 7842.1 7849.1 7648.6 7716.1 7717.1 7727.8 7730.4 38927.8 39151.8 39166.4 39186.0 39201.6 3444.2 3461.7 3478.5 3483.4 3488.8 30943.4 31066.7 31095.0 31106.0 31112.2 5004.3 5009.1 5027.4 5048.1 5049.7 182938.0 184267.0 184810.0 185240.0 186559.0 45801.5 46622.8 46637.3 46841.5 50782.0 53091.0 53091.5 53097.5 53284.5 53476.5 14958.0 15053.4 15071.8 15196.1 15245.3 12562.7 12575.7 12585.7 12586.7 12692.9 14373.7 14398.7 14405.2 14488.9 14593.6 5696.6 5749.2 5786.4 5889.6 5946.9 960.3 972.5 979.1 996.4 1005.9 22780.0 22879.5 22958.5 22968.2 23026.8 1061.7 1073.0 1075.5 1078.9 1084.2 12180.7 12289.6 15753.9 15865.7 16469.8 234675.0 234882.0 235611.0 236246.0 236958.0 56938.0 58018.0 58246.7 58522.7 58659.0 1424.0 1465.4 1482.4 1483.5 1487.2 26898.5 27233.7 27437.7 27527.3 27835.4 38338.0 38699.2 38716.0 38728.0 38735.0 148065.0 201801.0 207048.0 209499.0 210033.0 37192.4 37199.4 37203.8 37514.0 37535.8 44511.3 46090.8 46099.8 46102.8 46400.3 32948.5 33621.7 33663.7 33689.5 33876.0 33093.2 33344.5 34301.5 34320.7 34570.1 36365.0 36365.8 36399.3 36470.3 38134.2 33032.0 33142.7 33153.3 33480.3 34085.7 23650.3 23996.4 24593.6 24609.6 24755.2 12:36:28 INFO - PID 6304 | 12:36:28 INFO - PID 6304 | [#2] jquery.html Cycles:180 Average:33627.90 Median:12979.11 stddev:77045.41 (593.6%) stddev-sans-first:77221.55 12:36:28 INFO - PID 6304 | Values: 565.8 573.0 577.7 578.2 586.9 21555.7 22495.0 22537.2 22573.3 22574.7 25500.4 25772.9 25956.6 25990.4 25999.0 6576.5 6731.3 6733.5 6734.5 6736.2 6062.9 6386.9 6644.1 6653.2 6667.6 6611.5 6633.8 6637.2 6646.5 6649.9 6600.8 6616.7 6625.7 6626.0 6631.6 6104.7 6158.0 6160.6 6168.9 6179.2 28729.3 29261.7 29536.3 29611.0 29667.7 1806.8 1906.4 1907.4 1907.7 1911.0 19439.8 19963.1 20020.7 20023.5 20081.5 2379.6 2408.9 2446.6 2527.5 2534.0 132982.0 139973.3 141100.0 141147.0 141245.0 14306.5 14897.7 15094.8 15170.4 15194.0 23067.2 23578.6 24174.5 24202.0 24207.3 9095.4 9099.9 9104.6 9191.5 9358.1 8215.8 8302.1 8312.3 8313.5 8350.6 9203.5 9263.2 9332.9 9503.8 9564.9 2596.8 2609.9 2747.6 2749.5 2852.3 885.6 923.2 938.0 945.8 946.2 18753.9 19271.0 19426.0 19682.5 19710.4 988.9 1003.5 1004.6 1006.6 1011.9 10566.5 10712.6 10730.5 10773.1 11039.5 443800.0 446519.0 457303.0 458789.0 461936.0 108514.5 114871.0 114979.9 116227.0 117122.0 1176.9 1187.4 1222.3 1228.5 1230.1 17156.7 17173.5 17391.1 17622.7 17647.1 56564.7 57156.0 57342.4 57403.4 58866.4 68578.5 69198.7 69729.3 71015.6 71221.3 14467.3 14493.1 14646.6 14736.3 14763.0 22845.0 22849.5 22980.4 23023.0 23228.7 17806.5 17819.4 17835.6 18412.5 18416.4 15576.8 15701.1 16272.9 16696.8 16806.7 17250.4 17963.4 18139.6 18298.5 18591.3 14094.7 14449.9 14529.6 14530.3 14778.2 17289.7 17349.1 17552.3 17642.7 17697.7 12:36:28 INFO - PID 6304 | 12:36:28 INFO - PID 6304 | [#3] mootools.html Cycles:180 Average:8775.15 Median:2628.77 stddev:5977.23 (227.4%) stddev-sans-first:5968.03 12:36:28 INFO - PID 6304 | Values: 1360.1 1367.2 1370.6 1397.6 1411.6 14139.0 14290.5 14724.3 14749.6 14774.6 14587.6 14852.2 14869.7 14887.9 14955.2 2647.8 2701.2 2708.9 2710.4 2712.5 2586.7 2648.8 2743.4 2761.4 2772.5 2639.9 2652.5 2673.0 2694.9 2698.7 2617.7 2648.2 2670.5 2695.3 2702.9 2504.5 2541.0 2557.4 2558.3 2562.5 14048.4 14175.8 14302.5 14320.9 14438.6 7309.1 7602.4 7611.9 7620.5 7624.4 4875.1 5038.3 5164.8 5208.3 5306.5 1893.9 1912.3 1943.8 1954.8 1962.3 21900.9 22098.9 22111.2 22169.8 22232.3 6267.6 6281.3 6355.5 6504.3 6543.3 15444.7 15448.2 15454.5 15474.7 15491.8 7138.9 7398.8 7405.7 7416.1 7418.1 5998.4 6648.4 6834.6 6837.9 6855.7 4623.0 5138.5 5228.9 5234.1 5268.3 1418.5 1472.2 1475.3 1482.6 1483.8 895.8 905.0 909.1 914.8 917.0 8343.5 8358.4 8365.3 8413.7 8493.3 968.7 975.7 987.9 990.4 998.0 4590.4 4808.5 5028.5 5224.0 5241.1 19000.2 19888.2 20196.9 20248.6 20259.7 18797.5 19464.2 19818.0 19844.0 19888.6 9892.3 10210.8 10286.0 10331.5 10362.8 8370.7 8512.1 8668.6 8691.9 8975.7 17130.1 17550.0 17565.4 17638.9 17734.1 17510.5 17512.8 17728.2 18066.4 18377.7 10552.0 10730.2 10859.4 10884.6 10917.3 11903.4 12053.2 12402.8 13113.5 13644.8 10945.9 11010.2 11206.3 11376.4 11381.2 10576.0 10618.0 10889.2 10987.2 11058.1 9417.2 9497.4 9557.3 9637.0 9651.7 7205.2 7287.4 7315.8 7352.0 7403.6 7165.2 7204.0 7251.0 7273.0 7328.0 12:36:28 INFO - PID 6304 | 12:36:28 INFO - PID 6304 | [#4] prototype.html Cycles:180 Average:5549.32 Median:6139.13 stddev:1560.64 (25.4%) stddev-sans-first:1518.35 12:36:28 INFO - PID 6304 | Values: 502.7 503.5 517.7 523.5 529.9 6304.4 6310.3 6319.7 6328.7 6355.5 5996.7 6139.6 6145.6 6182.3 6192.6 4963.7 4976.4 5007.2 5009.5 5021.1 4895.2 4994.5 5021.1 5024.7 5025.8 4930.9 4948.6 4966.9 4968.2 4997.4 4988.5 4989.2 5006.9 5019.8 5026.0 4465.3 4471.2 4479.7 4484.5 4487.7 6019.8 6076.3 6100.0 6121.7 6138.7 5772.5 5779.3 5800.1 5802.8 5805.9 6611.7 6616.2 6616.9 6626.3 6638.2 4909.4 4918.0 4930.1 4985.0 5003.3 6927.4 7015.0 7038.3 7071.9 7086.6 5052.5 5054.3 5074.5 5076.8 5111.7 5066.2 5130.2 5138.7 5146.9 5153.5 5678.5 5728.3 5742.9 5766.2 5779.2 6542.1 6615.4 6647.8 6650.8 6714.0 1683.2 1723.6 1724.9 1755.4 1767.5 1189.9 1195.8 1229.3 1239.0 1252.6 5740.7 5756.1 5778.0 5787.7 5841.0 6632.4 6697.5 6735.3 6738.2 6814.3 5753.2 5791.4 5802.7 5827.5 5841.9 3581.7 3610.6 3613.9 3622.3 3622.5 6447.6 6502.2 6523.5 6598.9 6615.0 6883.7 6905.0 6925.5 7001.3 7047.2 6462.9 6468.9 6470.3 6615.5 6621.7 6613.2 6659.5 6675.2 6830.2 6862.7 6562.5 6715.9 6765.7 6810.9 6817.5 6536.1 6572.4 6604.2 6611.8 6628.2 5012.6 5084.7 5104.2 5106.2 5119.6 6791.2 6835.6 6859.2 6880.6 6901.4 6640.0 6661.6 6683.7 6693.4 6708.2 6355.6 6581.5 6587.8 6647.1 6667.3 6299.9 6312.6 6380.7 6461.6 6463.5 6392.1 6493.0 6538.9 6544.8 6617.2 6237.6 6263.2 6283.8 6295.9 6361.8 12:36:28 INFO - PID 6304 | 12:36:28 INFO - PID 6304 | [#5] yui.html Cycles:180 Average:23177.78 Median:17355.57 stddev:31686.22 (182.6%) stddev-sans-first:31730.83 12:36:28 INFO - PID 6304 | Values: 869.9 887.5 898.3 901.0 909.3 17745.2 18324.8 18335.4 18347.2 18378.6 20598.4 21633.0 22418.0 22528.5 22662.1 1041.5 1067.2 1069.2 1069.4 1069.5 1003.8 1045.8 1055.0 1055.3 1066.6 1082.2 1127.0 1127.8 1127.9 1128.3 1072.1 1115.0 1115.3 1116.3 1120.4 778.5 807.0 814.9 816.9 818.6 20452.4 20546.2 20587.7 20692.2 20805.0 20945.8 21375.3 21388.9 21399.0 21485.2 17021.4 17061.0 17193.9 17201.2 17355.3 3604.9 3653.8 3656.8 3659.5 3661.9 117968.4 118059.0 121699.0 122248.0 122341.0 16725.7 17044.6 17349.3 17355.8 17510.8 29873.9 29913.6 30753.7 30942.7 30960.5 8568.2 8609.7 8706.0 8737.3 8755.0 3739.1 3770.4 3931.8 3995.1 4001.5 5012.7 5120.6 5142.2 5223.7 5241.3 1044.8 1071.1 1075.5 1080.4 1085.5 587.4 601.4 605.8 614.6 622.9 10929.0 11238.2 11322.5 12009.1 12091.7 605.4 608.9 614.3 615.6 639.1 5267.1 5309.3 5310.6 5313.4 5366.8 109708.5 111047.4 113669.4 113787.4 114335.0 91290.5 93717.5 100674.0 100832.0 101504.5 79108.0 83042.6 83680.0 86890.1 88689.6 11193.3 11458.4 11811.9 12112.8 12459.6 36458.6 36523.6 36584.6 37624.0 38127.8 53781.0 70289.6 70771.0 72780.6 73320.6 15907.3 16706.2 16779.2 16873.5 16909.2 16965.8 17078.5 17098.4 17128.7 17143.4 16105.9 16247.4 16270.1 16275.5 16409.5 16330.6 16373.0 16507.8 16545.6 16622.9 15664.4 16421.6 16477.4 16613.4 17063.8 12188.8 12393.6 12677.2 12693.6 13235.5 12985.4 13190.0 13449.1 13572.0 13995.3 12:36:28 INFO - PID 6304 | -------- Summary: end -------- 12:36:28 INFO - PID 6304 | 12:36:28 INFO - TEST-INFO | 6304: exit 0 12:36:28 INFO - TEST-OK | dromaeo_css | took 1112900ms 12:36:28 INFO - TEST-START | kraken 12:36:28 INFO - Initialising browser for kraken test... 12:36:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57084/getInfo.html -profile /tmp/tmprhwGpc/profile 12:36:28 INFO - TEST-INFO | started process 6686 (/builds/slave/test/build/application/firefox/firefox http://localhost:57084/getInfo.html) 12:36:34 INFO - TEST-INFO | 6686: exit 0 12:36:34 INFO - Browser initialized. 12:36:34 INFO - Running cycle 1/1 for kraken test... 12:36:34 INFO - TEST-INFO | started process 6924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprhwGpc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:35 INFO - PID 6924 | 12:36:35 INFO - PID 6924 | (/builds/slave/test/build/application/firefox/firefox:6978): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:36:35 INFO - PID 6924 | 12:36:45 INFO - PID 6924 | RSS: Main: 168087552 12:36:45 INFO - PID 6924 | 12:36:48 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57084/tests/kraken/driver.html?testName=audio-beat-detection) 12:36:49 INFO - PID 6924 | RSS: Main: 173875200 12:36:49 INFO - PID 6924 | 12:36:51 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57084/tests/kraken/driver.html?testName=audio-dft) 12:36:52 INFO - PID 6924 | RSS: Main: 178044928 12:36:52 INFO - PID 6924 | 12:36:55 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57084/tests/kraken/driver.html?testName=audio-fft) 12:36:56 INFO - PID 6924 | RSS: Main: 172134400 12:36:56 INFO - PID 6924 | 12:36:58 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57084/tests/kraken/driver.html?testName=audio-oscillator) 12:36:59 INFO - PID 6924 | RSS: Main: 172257280 12:36:59 INFO - PID 6924 | 12:37:01 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57084/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:02 INFO - PID 6924 | RSS: Main: 172806144 12:37:02 INFO - PID 6924 | 12:37:05 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57084/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:05 INFO - PID 6924 | RSS: Main: 174096384 12:37:05 INFO - PID 6924 | 12:37:09 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57084/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:10 INFO - PID 6924 | RSS: Main: 172761088 12:37:10 INFO - PID 6924 | 12:37:12 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57084/tests/kraken/driver.html?testName=json-parse-financial) 12:37:13 INFO - PID 6924 | RSS: Main: 173817856 12:37:13 INFO - PID 6924 | 12:37:15 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57084/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:15 INFO - PID 6924 | RSS: Main: 174071808 12:37:15 INFO - PID 6924 | 12:37:17 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57084/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:18 INFO - PID 6924 | RSS: Main: 174276608 12:37:18 INFO - PID 6924 | 12:37:20 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57084/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:21 INFO - PID 6924 | RSS: Main: 174002176 12:37:21 INFO - PID 6924 | 12:37:23 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:37:24 INFO - PID 6924 | RSS: Main: 174481408 12:37:24 INFO - PID 6924 | 12:37:27 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:28 INFO - PID 6924 | RSS: Main: 174399488 12:37:28 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | Cycle 1(1): loaded http://localhost:57084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57084/tests/kraken/driver.html?testName=ai-astar) 12:37:30 INFO - PID 6924 | RSS: Main: 175579136 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | __start_tp_report 12:37:30 INFO - PID 6924 | _x_x_mozilla_page_load 12:37:30 INFO - PID 6924 | _x_x_mozilla_page_load_details 12:37:30 INFO - PID 6924 | |i|pagename|runs| 12:37:30 INFO - PID 6924 | |0;ai-astar;102;109;103;108;117;118;108;99;108;108 12:37:30 INFO - PID 6924 | |1;audio-beat-detection;142;119;152;168;125;147;150;132;176;128 12:37:30 INFO - PID 6924 | |2;audio-dft;168;171;165;163;162;165;183;167;162;166 12:37:30 INFO - PID 6924 | |3;audio-fft;84;90;84;174;77;76;76;82;164;77 12:37:30 INFO - PID 6924 | |4;audio-oscillator;81;81;127;81;79;87;134;79;84;136 12:37:30 INFO - PID 6924 | |5;imaging-gaussian-blur;114;118;117;115;116;115;113;115;115;114 12:37:30 INFO - PID 6924 | |6;imaging-darkroom;150;150;160;155;153;154;156;152;152;152 12:37:30 INFO - PID 6924 | |7;imaging-desaturate;98;94;94;99;99;100;97;95;94;95 12:37:30 INFO - PID 6924 | |8;json-parse-financial;56;56;60;59;56;58;58;60;55;56 12:37:30 INFO - PID 6924 | |9;json-stringify-tinderbox;63;55;55;55;54;55;62;55;56;55 12:37:30 INFO - PID 6924 | |10;stanford-crypto-aes;78;77;77;84;83;76;77;81;84;78 12:37:30 INFO - PID 6924 | |11;stanford-crypto-ccm;130;132;125;123;136;123;128;130;126;159 12:37:30 INFO - PID 6924 | |12;stanford-crypto-pbkdf2;175;183;179;181;178;177;173;180;172;170 12:37:30 INFO - PID 6924 | |13;stanford-crypto-sha256-iterative;70;70;68;69;69;72;69;70;67;75 12:37:30 INFO - PID 6924 | __end_tp_report 12:37:30 INFO - PID 6924 | __start_cc_report 12:37:30 INFO - PID 6924 | _x_x_mozilla_cycle_collect,969 12:37:30 INFO - PID 6924 | __end_cc_report 12:37:30 INFO - PID 6924 | __startTimestamp1502653050572__endTimestamp 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | ------- Summary: start ------- 12:37:30 INFO - PID 6924 | Number of tests: 14 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.50 stddev:6.00 (5.5%) stddev-sans-first:5.96 12:37:30 INFO - PID 6924 | Values: 102.0 109.0 103.0 108.0 117.0 118.0 108.0 99.0 108.0 108.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:148.50 stddev:18.56 (12.5%) stddev-sans-first:19.67 12:37:30 INFO - PID 6924 | Values: 142.0 119.0 152.0 168.0 125.0 147.0 150.0 132.0 176.0 128.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#2] audio-dft Cycles:10 Average:167.20 Median:166.50 stddev:6.21 (3.7%) stddev-sans-first:6.58 12:37:30 INFO - PID 6924 | Values: 168.0 171.0 165.0 163.0 162.0 165.0 183.0 167.0 162.0 166.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#3] audio-fft Cycles:10 Average:98.40 Median:79.50 stddev:37.55 (47.2%) stddev-sans-first:39.47 12:37:30 INFO - PID 6924 | Values: 84.0 90.0 84.0 174.0 77.0 76.0 76.0 82.0 164.0 77.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:81.00 stddev:24.66 (30.4%) stddev-sans-first:25.48 12:37:30 INFO - PID 6924 | Values: 81.0 81.0 127.0 81.0 79.0 87.0 134.0 79.0 84.0 136.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.48 (1.3%) stddev-sans-first:1.50 12:37:30 INFO - PID 6924 | Values: 114.0 118.0 117.0 115.0 116.0 115.0 113.0 115.0 115.0 114.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#6] imaging-darkroom Cycles:10 Average:153.40 Median:153.50 stddev:3.03 (2.0%) stddev-sans-first:2.95 12:37:30 INFO - PID 6924 | Values: 150.0 150.0 160.0 155.0 153.0 154.0 156.0 152.0 152.0 152.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:2.37 (2.5%) stddev-sans-first:2.45 12:37:30 INFO - PID 6924 | Values: 98.0 94.0 94.0 99.0 99.0 100.0 97.0 95.0 94.0 95.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:1.84 (3.2%) stddev-sans-first:1.88 12:37:30 INFO - PID 6924 | Values: 56.0 56.0 60.0 59.0 56.0 58.0 58.0 60.0 55.0 56.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:55.00 stddev:3.21 (5.8%) stddev-sans-first:2.39 12:37:30 INFO - PID 6924 | Values: 63.0 55.0 55.0 55.0 54.0 55.0 62.0 55.0 56.0 55.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.50 stddev:3.17 (4.0%) stddev-sans-first:3.32 12:37:30 INFO - PID 6924 | Values: 78.0 77.0 77.0 84.0 83.0 76.0 77.0 81.0 84.0 78.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:130.00 stddev:10.59 (8.1%) stddev-sans-first:11.22 12:37:30 INFO - PID 6924 | Values: 130.0 132.0 125.0 123.0 136.0 123.0 128.0 130.0 126.0 159.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:178.50 stddev:4.21 (2.4%) stddev-sans-first:4.42 12:37:30 INFO - PID 6924 | Values: 175.0 183.0 179.0 181.0 178.0 177.0 173.0 180.0 172.0 170.0 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:2.23 (3.2%) stddev-sans-first:2.37 12:37:30 INFO - PID 6924 | Values: 70.0 70.0 68.0 69.0 69.0 72.0 69.0 70.0 67.0 75.0 12:37:30 INFO - PID 6924 | -------- Summary: end -------- 12:37:30 INFO - PID 6924 | 12:37:30 INFO - PID 6924 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:37:31 INFO - TEST-INFO | 6924: exit 0 12:37:31 INFO - TEST-OK | kraken | took 62473ms 12:37:31 INFO - SUITE-END | took 1175s 12:37:31 INFO - Completed test suite (00:19:35) 12:37:31 INFO - javascript benchmark 12:37:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8457.532267268834, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.388599223151, 3136.4668006438906, 3165.699258570435, 3174.4762114251143, 3192.2338638726696, 6083.78706745264, 6258.123862659231, 6277.278113016999, 6281.748730050793, 6299.212598425197, 6073.63558186508, 6192.102145188945, 6196.039613859859, 6200.720967556459, 6216.937830621692, 5601.047821870292, 5655.519280861132, 5663.8584035399035, 5665.745041473123, 5701.401352857953, 5713.257276554063, 5728.942710572904, 5757.42425757423, 5768.36547979724, 5771.971140144294, 5516.779328826842, 5583.4137415571595, 5592.133219350966, 5722.62802917809, 5795.449432303924, 5649.971750141264, 5704.629199102045, 5734.283214598176, 5740.7703691852275, 5758.733078722675, 5536.169574563807, 5621.915671264935, 5629.324481062258, 5695.857603559903, 5716.371199168088, 5987.730552125165, 6118.449339559461, 6177.876442471171, 6180.5982611130585, 6190.288116866573, 6661.63361015144, 6763.154605674291, 6763.729450821961, 6803.081583986148, 6809.114815074058, 6721.361470660328, 6732.124823772878, 6758.391744742948, 6838.179418469766, 6851.0, 6091.208142941434, 6162.815115546541, 6180.8763824723255, 6282.183316168915, 6364.522660800412, 6869.347411995853, 6883.586984780829, 6893.655317234118, 6914.1702995639835, 6935.514513983972, 6355.237371515448, 6458.354164583504, 6519.902201466982, 6547.738090476423, 6608.900866487006, 6532.118164047888, 6580.144581204413, 6655.267920528738, 6700.396964273239, 6722.697478613474, 6559.508036897252, 6595.4393876521035, 6627.834304142435, 6628.502862285348, 6641.867162656817, 6587.736490540325, 6631.834204144839, 6641.767538136142, 6647.069410282565, 6649.102371179829, 5239.423663397023, 5331.840044798662, 5378.7041712705395, 5399.83800485986, 5417.133258678593, 4610.9308360374625, 4623.491415944243, 4638.0, 4644.814207431732, 4660.7436590987145, 5734.942650573525, 5767.538596912237, 5821.970890145522, 5824.912626310609, 5856.414358564195, 6578.80263592093, 6679.532432729759, 6685.532012759158, 6695.631740254235, 6696.1629796275465, 5726.112452569859, 5729.0, 5732.484076433141, 5737.426257374229, 5741.19623252745, 5851.151583020438, 5860.09168578871, 5872.882542349129, 5876.118582212703, 5880.588358814842, 6494.772682956074, 6532.836679082966, 6534.8366290843105, 6536.215654121441, 6555.6066636002, 6649.73401063952, 6677.031830384664, 6765.357291057342, 6789.083473730983, 6789.524733268821, 6433.903491447726, 6457.61254324742, 6530.216374035146, 6534.215894092549, 6540.738370465128, 6408.551401401857, 6420.871582568229, 6460.321666224979, 6544.443722283469, 6562.0, 6594.901076483952, 6606.735730570724, 6623.0, 6722.529422940347, 6794.830129246809, 6480.935190648222, 6485.15692959931, 6533.738650453929, 6550.312217217123, 6563.146790917151, 6390.9041364378645, 6491.0, 6493.610383377012, 6500.902486462802, 6580.736770529125, 6412.2625898022325, 6414.743410263537, 6430.967845160932, 6432.453241474527, 6439.388258115471, 6389.648569328546, 6484.773032943825, 6544.640044797582, 6620.371064749033, 6666.26671066192, 6252.187215661935, 6298.0, 6347.0, 6347.5556711029785, 6347.904781428375], "value": 6079.343430841626, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.7792357101796, 845.9238668519833, 867.8047439326152, 870.4211699220023, 1157.33453264373, 31008.844955775217, 41158.58841411585, 41481.377779333336, 41788.0, 41858.58141418589, 40926.0, 41174.0, 41185.794071029675, 41196.38205426921, 41610.58389416105, 7211.567305961633, 7591.848163036736, 7723.266289702469, 7751.961240193791, 7810.336121429686, 7681.462297639167, 7782.299593036626, 7798.571078590675, 7829.295363417291, 7842.058952925629, 7764.0, 7766.805829854242, 7831.804204894866, 7848.646810893495, 7853.921460785376, 7776.7666969990705, 7777.650005749755, 7822.843543129134, 7842.098158711764, 7849.097353804328, 7648.617569121521, 7716.074071111502, 7717.112532058829, 7727.845443091163, 7730.420218483636, 38927.805360973296, 39151.8042409789, 39166.41250381246, 39186.0, 39201.60798392008, 3444.156181735491, 3461.7403694722743, 3478.4956181353814, 3483.3555792178527, 3488.7906725596545, 30943.38113237745, 31066.689333106606, 31095.0, 31106.0, 31112.222194445094, 5004.299398084271, 5009.148444764399, 5027.371578552681, 5048.091343558158, 5049.747512624391, 182938.0, 184267.0, 184810.0, 185240.0, 186559.0, 45801.54198458039, 46622.76688616535, 46637.30044049342, 46841.53158468372, 50782.0, 53091.0, 53091.46908530865, 53097.46902531003, 53284.467155328726, 53476.465235347925, 14958.0, 15053.397864085533, 15071.849281507044, 15196.088234705732, 15245.313960871566, 12562.748745025048, 12575.748485030248, 12585.685357865943, 12586.748265034648, 12692.873071269354, 14373.712525749426, 14398.712025759636, 14405.207713575644, 14488.927555362156, 14593.635159120895, 5696.572757043238, 5749.223854779635, 5786.392428795, 5889.587728858939, 5946.940530594725, 960.2653969713175, 972.5234635028927, 979.1481411172325, 996.4320337407609, 1005.8843233028149, 22780.0, 22879.542409151723, 22958.540829183323, 22968.196113136295, 23026.769732302462, 1061.7312311787493, 1072.9570817167225, 1075.5052675769077, 1078.9352638841694, 1084.1543595995136, 12180.730923455036, 12289.631311060682, 15753.921230394004, 15865.68268634644, 16469.83530164683, 234675.0, 234882.0, 235611.0, 236246.0, 236958.0, 56938.0, 58018.0, 58246.70876645589, 58522.7073864628, 58659.0, 1423.985760142406, 1465.4301171154968, 1482.3551754986615, 1483.4956114920763, 1487.196913666608, 26898.51596462315, 27233.72766272312, 27437.725622743517, 27527.31181720473, 27835.44329113447, 38338.0, 38699.22601547897, 38716.0, 38728.0, 38735.0, 148065.0, 201801.0, 207048.0, 209499.0, 210033.0, 37192.44211336886, 37199.442008369355, 37203.813980931, 37514.0, 37535.81232093822, 44511.332330014426, 46090.769546152056, 46099.76950115228, 46102.769486152356, 46400.30399543942, 32948.50577241295, 33621.66378336185, 33663.663363367035, 33689.494657579664, 33875.983720488424, 33093.17267068342, 33344.49983250302, 34301.48547771735, 34320.65679343174, 34570.13574660553, 36365.0, 36365.81817090898, 36399.27201456009, 36470.27059458849, 38134.2373152541, 33032.0, 33142.66857331396, 33153.33693326168, 33480.33039339151, 34085.65914340825, 23650.29049128529, 23996.40008999789, 24593.631095533223, 24609.630855536823, 24755.235686961147], "value": 17494.008893457503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.8274226360958, 573.0086949577234, 577.662067690401, 578.1530058464349, 586.882623475305, 21555.67666485004, 22495.0, 22537.21119760809, 22573.322800315975, 22574.661380079313, 25500.362490937736, 25772.871135644295, 25956.610650840204, 25990.350241243978, 25999.0, 6576.539642225046, 6731.293214212511, 6733.461323094165, 6734.46124310054, 6736.191657001166, 6062.939370606282, 6386.904196437057, 6644.103046088789, 6653.168353955755, 6667.633280169589, 6611.504137189706, 6633.8341541461605, 6637.236717777445, 6646.501512386566, 6649.933500665004, 6600.80197594073, 6616.702248398834, 6625.73497060117, 6625.966870165618, 6631.602103873783, 6104.694765261719, 6157.96921015392, 6160.630362178284, 6168.87662246757, 6179.16581261533, 28729.28176795576, 29261.70738292611, 29536.26159346012, 29611.0, 29667.703322966925, 1806.846418054467, 1906.447130332216, 1907.3801014670287, 1907.7043058325983, 1910.961780764377, 19439.805601943943, 19963.101660425316, 20020.69968950467, 20023.49941251466, 20081.497962550908, 2379.568801646793, 2408.903643854244, 2446.5718499262734, 2527.545041892459, 2534.037065914959, 132982.0, 139973.30013349868, 141100.0, 141146.99999999898, 141245.0, 14306.499272525412, 14897.702045959237, 15094.773578396333, 15170.393184272727, 15194.0, 23067.192648257565, 23578.646320305208, 24174.51650966971, 24202.0, 24207.273781786575, 9095.408798428081, 9099.909000910038, 9104.590293436811, 9191.494467804201, 9358.11097945694, 8215.753527394188, 8302.086770455246, 8312.25189732927, 8313.501189928624, 8350.580401331788, 9203.4938078405, 9263.166315031545, 9332.926713428044, 9503.809923801624, 9564.856527152098, 2596.7792737617137, 2609.8647088516555, 2747.5603903375363, 2749.5188342040065, 2852.3297025199063, 885.5882014862991, 923.1875949164827, 938.0478814003792, 945.8297506448905, 946.2146418472652, 18753.874767513993, 19271.0, 19425.962556694518, 19682.507937301394, 19710.40868773939, 988.8862780780303, 1003.4932359158578, 1004.5579944824254, 1006.572206812102, 1011.9089281964658, 10566.471676416148, 10712.625058123083, 10730.463476826128, 10773.084287835465, 11039.503222354853, 443800.0, 446519.0, 457303.0, 458789.0, 461936.0, 108514.45742771236, 114871.0, 114979.85020149859, 116227.0, 117122.0, 1176.8528933883265, 1187.3706935324292, 1222.2666400159833, 1228.5270170984236, 1230.0897335971495, 17156.742648860527, 17173.484795456156, 17391.130443477523, 17622.735658965383, 17647.117644117487, 56564.7171764155, 57156.0, 57342.426575733705, 57403.42596574148, 58866.41133588781, 68578.48504392075, 69198.65400673165, 69729.30270697227, 71015.64492177713, 71221.28778712146, 14467.27663616836, 14493.130412175304, 14646.63383415423, 14736.26318684083, 14763.0, 22845.0, 22849.543009140056, 22980.4254893629, 23023.0, 23228.651570226797, 17806.46580602584, 17819.376321828673, 17835.554111147325, 18412.539686507407, 18416.447506574823, 15576.84423155754, 15701.136437496047, 16272.91863540722, 16696.833031670012, 16806.747898781283, 17250.396236131674, 17963.371282005068, 18139.637207255517, 18298.45104646863, 18591.2563497464, 14094.718105637625, 14449.927750361181, 14529.636759081108, 14530.273486325852, 14778.18719970412, 17289.65420691554, 17349.132543373034, 17552.297908083532, 17642.73535896937, 17697.734533982257], "value": 11803.92470070533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.122720845055, 1367.1865240182087, 1370.6299299189216, 1397.5946975377142, 1411.6118067531422, 14139.0, 14290.499832505864, 14724.263786810658, 14749.631259218511, 14774.63063423415, 14587.562373128796, 14852.18312992785, 14869.702605947874, 14887.851121488782, 14955.177465239434, 2647.827891187076, 2701.18964310707, 2708.9322766930886, 2710.390162213496, 2712.498187835247, 2586.6766654168227, 2648.8278261912915, 2743.396452780385, 2761.4339060492553, 2772.542530482478, 2639.85480798556, 2652.4827658606578, 2673.0, 2694.9461010779773, 2698.689650690176, 2617.6858776946697, 2648.245250103721, 2670.4792565449743, 2695.299222202222, 2702.8918843246347, 2504.5491811473926, 2541.0471073347494, 2557.399011232359, 2558.2708927955628, 2562.5387430262545, 14048.367823447968, 14175.78736318956, 14302.499412520512, 14320.856791432056, 14438.639034024129, 7309.122905251404, 7602.353799926957, 7611.885821712679, 7620.542767433972, 7624.42816788743, 4875.098106850209, 5038.3198268234055, 5164.793408263665, 5208.2968799212, 5306.495882891119, 1893.8863668179954, 1912.2733361322607, 1943.7570303712037, 1954.8436125109956, 1962.2641509433963, 21900.89049554758, 22098.88950555253, 22111.226107086335, 22169.77830221693, 22232.333030008966, 6267.623942563369, 6281.277653069864, 6355.491560675135, 6504.317046710122, 6543.280239173687, 15444.691106178037, 15448.150351730537, 15454.536363909101, 15474.684651804722, 15491.845081549265, 7138.892916606255, 7398.778036658909, 7405.703771849066, 7416.0729908761405, 7418.109826820816, 5998.3701711320555, 6648.368405001517, 6834.555753875982, 6837.940119281519, 6855.6572171391235, 4622.976885115553, 5138.460461651547, 5228.869278268074, 5234.0840352938085, 5268.341457317835, 1418.4964337660188, 1472.2491529320123, 1475.3287254299269, 1482.6441654003177, 1483.7996870422571, 895.7984453498041, 904.977375565603, 909.1317791509225, 914.8216097860986, 916.9638308711113, 8343.541105239148, 8358.414910956297, 8365.330773538102, 8413.663453461793, 8493.320534357237, 968.6948611187454, 975.7316737896994, 987.9407235565889, 990.390909590611, 997.9950100249453, 4590.403247577793, 4808.543188397097, 5028.472010438852, 5224.0, 5241.109011468059, 19000.23999040023, 19888.204471820965, 20196.899015504827, 20248.595028099357, 20259.696104558443, 18797.530061748294, 19464.22143114288, 19818.009099545252, 19844.0, 19888.60222795565, 9892.258080643836, 10210.795784084277, 10285.99999999985, 10331.535080921376, 10362.844557331646, 8370.707025254087, 8512.148785121686, 8668.609912553824, 8691.913080869363, 8975.730728078168, 17130.057846818545, 17550.0, 17565.385211518045, 17638.91180544089, 17734.113294334973, 17510.474685759447, 17512.82487175163, 17728.202230899384, 18066.36767713124, 18377.72433413473, 10552.0, 10730.248882578144, 10859.402732849769, 10884.61903833362, 10917.344959302467, 11903.40482975865, 12053.156279060382, 12402.81395779082, 13113.541026064042, 13644.795328069888, 10945.890541094806, 11010.174236932102, 11206.327620342805, 11376.43117844088, 11381.203315767816, 10576.0, 10617.96242645059, 10889.237753357189, 10987.175961802737, 11058.115350771757, 9417.199538039344, 9497.385444474317, 9557.330986830855, 9637.036296370306, 9651.662191823252, 7205.243449437734, 7287.41700663935, 7315.817104572216, 7351.963240183979, 7403.629818508945, 7165.176004759519, 7204.027456293334, 7250.9637451812405, 7273.0, 7327.963360183378], "value": 6411.622918135177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.69838097141695, 503.53973476916934, 517.7463043108877, 523.4895976422986, 529.8966701493208, 6304.369563043693, 6310.349653145684, 6319.6524191169465, 6328.746850126001, 6355.52333574982, 5996.730147143378, 6139.6009259398215, 6145.631262124264, 6182.290625624623, 6192.628442293466, 4963.652544321899, 4976.427710813248, 5007.223880298559, 5009.522190953678, 5021.1213037718435, 4895.241237608158, 4994.5255200756055, 5021.087769093917, 5024.723640199788, 5025.793809485734, 4930.876728081808, 4948.604111671058, 4966.850994470172, 4968.205087186051, 4997.350344455216, 4988.5260900214425, 4989.176785830334, 5006.899862002776, 5019.774110165033, 5026.019926114409, 4465.325502936399, 4471.195184866723, 4479.745671212066, 4484.484284307281, 4487.730736155809, 6019.789307374221, 6076.3316035236085, 6100.010994612608, 6121.724522396458, 6138.662373569452, 5772.509336706385, 5779.306483222041, 5800.129980502916, 5802.796902108448, 5805.883882322372, 6611.735530578771, 6616.239132499728, 6616.88259756878, 6626.304238055031, 6638.17022872141, 4909.386326709161, 4917.975410122962, 4930.137225985474, 4984.975075124637, 5003.3495645565845, 6927.376536111774, 7015.0, 7038.284349485857, 7071.858562828715, 7086.610236436943, 5052.545270925634, 5054.317667114966, 5074.517920797518, 5076.82231121909, 5111.744412779346, 5066.214736715815, 5130.179171332569, 5138.691678499227, 5146.922796158061, 5153.453963810842, 5678.488935995781, 5728.283964504437, 5742.885142297131, 5766.192733017381, 5779.248697669276, 6542.149520562391, 6615.4046135848, 6647.767328143492, 6650.767223147167, 6714.0, 1683.2004797720986, 1723.603571178636, 1724.8706347024024, 1755.3680674957004, 1767.5050985724017, 1189.9107566932514, 1195.7728031673955, 1229.2562999385423, 1238.9690257743448, 1252.6242127361936, 5740.694479140645, 5756.107803290497, 5777.959967205859, 5787.652740835563, 5840.970795146082, 6632.369924857131, 6697.464202863759, 6735.259121496631, 6738.157730283715, 6814.250432452426, 5753.194552762533, 5791.362950075489, 5802.65184088956, 5827.475527202572, 5841.88316233673, 3581.7435015940314, 3610.6208848070573, 3613.8915832525067, 3622.2755448909797, 3622.492851000862, 6447.6131432114225, 6502.154719886479, 6523.478121750343, 6598.944168932948, 6615.0, 6883.65581720912, 6904.965475172592, 6925.549839260432, 7001.299870012958, 7047.154341479055, 6462.935370646422, 6468.935310646927, 6470.320616335217, 6615.536912416181, 6621.668916554153, 6613.206415230011, 6659.500537459613, 6675.198976122896, 6830.180378354629, 6862.696087743313, 6562.475001999733, 6715.93284067153, 6765.737585321413, 6810.8637827244165, 6817.522773405814, 6536.0522724205675, 6572.4084832365315, 6604.207495100619, 6611.834704132435, 6628.204615446178, 5012.573931215888, 5084.745762711924, 5104.2343648453025, 5106.208537676666, 5119.6416250862085, 6791.185057792899, 6835.555688880207, 6859.211190713132, 6880.621565813928, 6901.378875901193, 6639.966800165968, 6661.633610151294, 6683.732650693918, 6693.431058360094, 6708.228553716385, 6355.648410088112, 6581.506387020897, 6587.80236592903, 6647.135872336758, 6667.299933507106, 6299.937000629935, 6312.589681670676, 6380.712867921047, 6461.64460954652, 6463.515236357198, 6392.1235444049435, 6493.0, 6538.880505281642, 6544.8363790905605, 6617.172853393326, 6237.5633705641985, 6263.217097862767, 6283.8114856554375, 6295.859407801369, 6361.759456906044], "value": 5088.004001173711, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.9217070463661, 887.467519488307, 898.3352319283728, 901.0, 909.2862103248951, 17745.20146593403, 18324.816751832495, 18335.449936501893, 18347.174377153027, 18378.632427351444, 20598.352131829455, 21633.0, 22418.0, 22528.54942901145, 22662.09351625937, 1041.4948749856314, 1067.2475904487317, 1069.1874175626501, 1069.3744159666605, 1069.5026812532171, 1003.7791685829106, 1045.8431235314727, 1055.0451841083832, 1055.2771351624162, 1066.6000249906285, 1082.220801023262, 1127.025123268371, 1127.7631697343568, 1127.937963412012, 1128.2609890521721, 1072.0940805019745, 1114.9609763658314, 1115.2917897135296, 1116.3023110555903, 1120.3725913488431, 778.4978688745784, 807.0275318241563, 814.8899898513744, 816.9223923727236, 818.6397984886631, 20452.38642840717, 20546.17815287387, 20587.691184632244, 20692.172313107458, 20805.0, 20945.790542094688, 21375.251866184764, 21388.893055534623, 21399.0, 21485.248016319354, 17021.40425085116, 17061.0, 17193.914030429893, 17201.225944832513, 17355.305787768473, 3604.873829415984, 3653.780773153619, 3656.762310449812, 3659.451082337644, 3661.8901432957055, 117968.41015794952, 118059.0, 121698.99999999911, 122248.0, 122341.0, 16725.6654866902, 17044.573885652957, 17349.306027759, 17355.826441735422, 17510.824891751174, 29873.850630747143, 29913.551296730566, 30753.692463075084, 30942.69057309443, 30960.535591966138, 8568.186022327993, 8609.655613775503, 8705.956470217609, 8737.30101591871, 8755.036945935943, 3739.121306492972, 3770.377887648507, 3931.803409829497, 3995.06116062725, 4001.459802926626, 5012.674176178537, 5120.564751996122, 5142.202958541432, 5223.738813059408, 5241.3489750728395, 1044.7910417916446, 1071.0842229893485, 1075.5482697267166, 1080.4111759091313, 1085.5440714899762, 587.3597778421541, 601.4076135007015, 605.8182545236411, 614.6250787019915, 622.9345918678564, 10929.0, 11238.21332506733, 11322.547098115983, 12009.09931755122, 12091.697707557205, 605.3946053946054, 608.9086637004485, 614.2628845385556, 615.6275453350748, 639.1212083385345, 5267.104592219332, 5309.283246761638, 5310.628256022042, 5313.415524292324, 5366.812161574326, 109708.4514577422, 111047.44476277567, 113669.43165284286, 113787.43106284416, 114335.0, 91290.54354728184, 93717.5314123425, 100674.0, 100832.0, 101504.49247753713, 79108.0, 83042.58478707689, 83680.0, 86890.1310986882, 88689.55655221811, 11193.27243729155, 11458.427078645867, 11811.940940295244, 12112.75774484523, 12459.626211213677, 36458.63541364553, 36523.63476365202, 36584.634153658124, 37624.0, 38127.80936095302, 53781.0, 70289.64855175691, 70771.0, 72780.6360968213, 73320.63339683268, 15907.28417221251, 16706.24821882994, 16779.16104194761, 16873.493795186165, 16909.23908424099, 16965.830341696426, 17078.48764537066, 17098.401555945482, 17128.65742685164, 17143.399981000606, 16105.919470402572, 16247.350105995627, 16270.105144217181, 16275.51173464798, 16409.507714768577, 16330.591735206239, 16373.0, 16507.752383714494, 16545.586360341087, 16622.916885415496, 15664.37342506287, 16421.58946026359, 16477.423290184786, 16613.41853035138, 17063.829361706223, 12188.75622487563, 12393.62819115428, 12677.20189414537, 12693.619191423903, 13235.47058117703, 12985.415656295678, 13190.0, 13449.125806822525, 13572.0, 13995.300234988006], "value": 8936.088703010426, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 103.0, 108.0, 117.0, 118.0, 108.0, 99.0, 108.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 119.0, 152.0, 168.0, 125.0, 147.0, 150.0, 132.0, 176.0, 128.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 165.0, 163.0, 162.0, 165.0, 183.0, 167.0, 162.0, 166.0], "value": 167.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 84.0, 174.0, 77.0, 76.0, 76.0, 82.0, 164.0, 77.0], "value": 98.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 127.0, 81.0, 79.0, 87.0, 134.0, 79.0, 84.0, 136.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 117.0, 115.0, 116.0, 115.0, 113.0, 115.0, 115.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 160.0, 155.0, 153.0, 154.0, 156.0, 152.0, 152.0, 152.0], "value": 153.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 99.0, 99.0, 100.0, 97.0, 95.0, 94.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 60.0, 59.0, 56.0, 58.0, 58.0, 60.0, 55.0, 56.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 55.0, 55.0, 55.0, 54.0, 55.0, 62.0, 55.0, 56.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 84.0, 83.0, 76.0, 77.0, 81.0, 84.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 125.0, 123.0, 136.0, 123.0, 128.0, 130.0, 126.0, 159.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 183.0, 179.0, 181.0, 178.0, 177.0, 173.0, 180.0, 172.0, 170.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 69.0, 69.0, 72.0, 69.0, 70.0, 67.0, 75.0], "value": 69.9, "unit": "score"}]}]} 12:37:31 INFO - Return code: 0 12:37:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:37:31 INFO - # TBPL SUCCESS # 12:37:31 INFO - Running post-action listener: _package_coverage_data 12:37:31 INFO - Running post-action listener: _resource_record_post_action 12:37:31 INFO - [mozharness: 2017-08-13 19:37:31.845567Z] Finished run-tests step (success) 12:37:31 INFO - Running post-run listener: _resource_record_post_run 12:37:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432906240; Read time: 8; Write time: 296344 12:37:31 INFO - TinderboxPrint: CPU usage
13.2% 12:37:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:37:31 INFO - TinderboxPrint: I/O write bytes / time
432,906,240 / 296,344 12:37:31 INFO - TinderboxPrint: CPU idle
8,262.8 (86.8%) 12:37:31 INFO - TinderboxPrint: CPU user
1,203.1 (12.6%) 12:37:31 INFO - TinderboxPrint: Swap in / out
0 / 0 12:37:31 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107159552; Read time: 0; Write time: 96632 12:37:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:37:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 325746688; Read time: 0; Write time: 199712 12:37:32 INFO - Running post-run listener: _upload_blobber_files 12:37:32 INFO - Blob upload gear active. 12:37:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:37:32 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 12:37:32 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'] 12:37:32 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 12:37:32 INFO - (blobuploader) - INFO - Open directory for files ... 12:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:37:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:33 INFO - (blobuploader) - INFO - Done attempting. 12:37:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:37:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:37:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:34 INFO - (blobuploader) - INFO - Done attempting. 12:37:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:37:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:37:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:41 INFO - (blobuploader) - INFO - Done attempting. 12:37:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:37:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:37:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:42 INFO - (blobuploader) - INFO - Done attempting. 12:37:42 INFO - (blobuploader) - INFO - Iteration through files over. 12:37:42 INFO - Return code: 0 12:37:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:37:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:37:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6643e7ff2968a2c4d0c37df07aab895f045686ea65944be0ce23e16f2a1320e5b9c7719255928b11206b671de18c373624fc89200c5b8b5fd950ddddb7c9800c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/133cf7370c77c8554ea22ae3f30df74f629fa2870214806591cc5854a43909c78f92e8d7b1b8353fb9faa08dc2e6789e440ea5a7fdaba47dba00c350a98e4d3e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79cb34ce9555a2fe25db0bda1c119c96e4cc42f15850688393cc3bcd11b81aa07893c9f32cfa5ab345357b85ed6ea2ac4b26b00f02ef85c784897232c3bc6bba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38db3c1407666d84aace04b84922dcc3fe00805e4c05ace938c036efdc2e9fb016e1fc9e0315662446a75d3bfb69ebd6a4146fbfe2ac864f9d83703614ff6b1e"} 12:37:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:37:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:37:42 INFO - Contents: 12:37:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6643e7ff2968a2c4d0c37df07aab895f045686ea65944be0ce23e16f2a1320e5b9c7719255928b11206b671de18c373624fc89200c5b8b5fd950ddddb7c9800c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/133cf7370c77c8554ea22ae3f30df74f629fa2870214806591cc5854a43909c78f92e8d7b1b8353fb9faa08dc2e6789e440ea5a7fdaba47dba00c350a98e4d3e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79cb34ce9555a2fe25db0bda1c119c96e4cc42f15850688393cc3bcd11b81aa07893c9f32cfa5ab345357b85ed6ea2ac4b26b00f02ef85c784897232c3bc6bba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38db3c1407666d84aace04b84922dcc3fe00805e4c05ace938c036efdc2e9fb016e1fc9e0315662446a75d3bfb69ebd6a4146fbfe2ac864f9d83703614ff6b1e"} 12:37:42 INFO - Running post-run listener: copy_logs_to_upload_dir 12:37:42 INFO - Copying logs to upload dir... 12:37:42 INFO - mkdir: /builds/slave/test/build/upload/logs 12:37:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.807412 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-13 12:37:42.120326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 12:37:42.124396) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703 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/6643e7ff2968a2c4d0c37df07aab895f045686ea65944be0ce23e16f2a1320e5b9c7719255928b11206b671de18c373624fc89200c5b8b5fd950ddddb7c9800c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/133cf7370c77c8554ea22ae3f30df74f629fa2870214806591cc5854a43909c78f92e8d7b1b8353fb9faa08dc2e6789e440ea5a7fdaba47dba00c350a98e4d3e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79cb34ce9555a2fe25db0bda1c119c96e4cc42f15850688393cc3bcd11b81aa07893c9f32cfa5ab345357b85ed6ea2ac4b26b00f02ef85c784897232c3bc6bba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38db3c1407666d84aace04b84922dcc3fe00805e4c05ace938c036efdc2e9fb016e1fc9e0315662446a75d3bfb69ebd6a4146fbfe2ac864f9d83703614ff6b1e"} build_url:https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/BsDPRDcqRr-vcnnocc2HeA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6643e7ff2968a2c4d0c37df07aab895f045686ea65944be0ce23e16f2a1320e5b9c7719255928b11206b671de18c373624fc89200c5b8b5fd950ddddb7c9800c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/133cf7370c77c8554ea22ae3f30df74f629fa2870214806591cc5854a43909c78f92e8d7b1b8353fb9faa08dc2e6789e440ea5a7fdaba47dba00c350a98e4d3e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79cb34ce9555a2fe25db0bda1c119c96e4cc42f15850688393cc3bcd11b81aa07893c9f32cfa5ab345357b85ed6ea2ac4b26b00f02ef85c784897232c3bc6bba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38db3c1407666d84aace04b84922dcc3fe00805e4c05ace938c036efdc2e9fb016e1fc9e0315662446a75d3bfb69ebd6a4146fbfe2ac864f9d83703614ff6b1e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 12:37:42.149767) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 12:37:42.150124) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1502651642.791327-1686356703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 12:37:42.234140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 12:37:42.234470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 12:37:42.234796) ========= ========= Total master_lag: 0.17 =========