builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1502750823.51 results: success (0) revision: 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:03.514595) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:03.515020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:03.515573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:03.608952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:03.609226) ========= 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=337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 15:47:03-- 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% 53.8M=0s 2017-08-14 15:47:04 (53.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111564 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:03.766801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:03.767095) ========= 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=337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019477 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:03.848469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:03.848800) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 --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 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 --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=337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 15:47:04,261 truncating revision to first 12 chars 2017-08-14 15:47:04,261 Setting DEBUG logging. 2017-08-14 15:47:04,261 attempt 1/10 2017-08-14 15:47:04,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/824d4f269c63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 15:47:04,555 unpacking tar archive at: mozilla-central-824d4f269c63/testing/mozharness/ program finished with exit code 0 elapsedTime=0.605124 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:04.481267) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:04.481553) ========= script_repo_revision: 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:04.481923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:04.482188) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:04.496642) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-08-14 15:47:04.496911) ========= /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=337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:04 INFO - MultiFileLogger online at 20170814 15:47:04 in /builds/slave/test 15:47:04 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 15:47:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:04 INFO - {'append_to_log': False, 15:47:04 INFO - 'base_work_dir': '/builds/slave/test', 15:47:04 INFO - 'blob_upload_branch': 'Firefox', 15:47:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:04 INFO - 'branch': 'Firefox', 15:47:04 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:04 INFO - 'code_coverage': False, 15:47:04 INFO - 'config_files': ('talos/linux_config.py',), 15:47:04 INFO - 'default_actions': ('clobber', 15:47:04 INFO - 'read-buildbot-config', 15:47:04 INFO - 'download-and-extract', 15:47:04 INFO - 'populate-webroot', 15:47:04 INFO - 'create-virtualenv', 15:47:04 INFO - 'install', 15:47:04 INFO - 'setup-mitmproxy', 15:47:04 INFO - 'run-tests'), 15:47:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:04 INFO - 'disable_ccov_upload': False, 15:47:04 INFO - 'download_minidump_stackwalk': True, 15:47:04 INFO - 'download_symbols': 'ondemand', 15:47:04 INFO - 'enable_stylo': False, 15:47:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:04 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:04 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:04 INFO - 'gecko_profile': False, 15:47:04 INFO - 'gecko_profile_interval': 0, 15:47:04 INFO - 'installer_path': 'installer.exe', 15:47:04 INFO - 'log_level': 'info', 15:47:04 INFO - 'log_name': 'talos', 15:47:04 INFO - 'log_to_console': True, 15:47:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:04 INFO - 'opt_config_files': (), 15:47:04 INFO - 'pip_index': False, 15:47:04 INFO - 'suite': 'dromaeojs-e10s', 15:47:04 INFO - 'system_bits': '32', 15:47:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:04 INFO - 'title': 'talos-linux64-ix-060', 15:47:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:04 INFO - 'use_talos_json': True, 15:47:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:04 INFO - 'work_dir': 'build'} 15:47:04 INFO - [mozharness: 2017-08-14 22:47:04.998709Z] Running clobber step. 15:47:04 INFO - Running pre-action listener: _resource_record_pre_action 15:47:04 INFO - Running main action method: clobber 15:47:04 INFO - rmtree: /builds/slave/test/build 15:47:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:06 INFO - Running post-action listener: _resource_record_post_action 15:47:06 INFO - [mozharness: 2017-08-14 22:47:06.020495Z] Finished clobber step (success) 15:47:06 INFO - [mozharness: 2017-08-14 22:47:06.020598Z] Running read-buildbot-config step. 15:47:06 INFO - Running pre-action listener: _resource_record_pre_action 15:47:06 INFO - Running main action method: read_buildbot_config 15:47:06 INFO - Using buildbot properties: 15:47:06 INFO - { 15:47:06 INFO - "project": "", 15:47:06 INFO - "product": "firefox", 15:47:06 INFO - "who": "kwierso@gmail.com", 15:47:06 INFO - "installer_path": "public/build/target.tar.bz2", 15:47:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 15:47:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:47:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 15:47:06 INFO - "stage_platform": "linux64-stylo", 15:47:06 INFO - "basedir": "/builds/slave/test", 15:47:06 INFO - "buildnumber": 30, 15:47:06 INFO - "platform": "ubuntu64_hw_stylo", 15:47:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:47:06 INFO - "slavebuilddir": "test", 15:47:06 INFO - "taskId": "VI-yfVjgR1uvnaM3D_R2Og", 15:47:06 INFO - "branch": "mozilla-central", 15:47:06 INFO - "script_repo_revision": "production", 15:47:06 INFO - "revision": "824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5", 15:47:06 INFO - "slavename": "talos-linux64-ix-060", 15:47:06 INFO - "repo_path": "mozilla-central" 15:47:06 INFO - } 15:47:06 INFO - Finding installer, test and symbols from parent task. 15:47:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VI-yfVjgR1uvnaM3D_R2Og'}, attempt #1 15:47:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VI-yfVjgR1uvnaM3D_R2Og'}, attempt #1 15:47:06 INFO - Task dependencies: D65EYMoBSGC1-IshLAOwxA 15:47:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA'}, attempt #1 15:47:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 15:47:07 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json 15:47:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.crashreporter-symbols.zip 15:47:07 INFO - Running post-action listener: _resource_record_post_action 15:47:07 INFO - [mozharness: 2017-08-14 22:47:07.441861Z] Finished read-buildbot-config step (success) 15:47:07 INFO - [mozharness: 2017-08-14 22:47:07.442082Z] Running download-and-extract step. 15:47:07 INFO - Running pre-action listener: _resource_record_pre_action 15:47:07 INFO - Running main action method: download_and_extract 15:47:07 INFO - mkdir: /builds/slave/test/build/tests 15:47:07 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')]} 15:47:07 INFO - trying https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json 15:47:07 INFO - Downloading https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:47:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:47:08 INFO - Downloaded 989 bytes. 15:47:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:47:08 INFO - Using the following test package requirements: 15:47:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:47:08 INFO - u'common': [u'target.common.tests.zip'], 15:47:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:47:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:47:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:47:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:47:08 INFO - u'mozbase': [u'target.common.tests.zip'], 15:47:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:47:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:47:08 INFO - u'web-platform': [u'target.common.tests.zip', 15:47:08 INFO - u'target.web-platform.tests.tar.gz'], 15:47:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:47:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:47:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip 15:47:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:47:08 INFO - Fetch https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip into memory 15:47:13 INFO - Content-Length response header: 54034241 15:47:13 INFO - Bytes received: 54034241 15:47:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:47:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip 15:47:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:47:24 INFO - Fetch https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip into memory 15:47:29 INFO - Content-Length response header: 54034241 15:47:29 INFO - Bytes received: 54034241 15:47:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.talos.tests.zip 15:47:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:47:41 INFO - Fetch https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.talos.tests.zip into memory 15:47:44 INFO - Content-Length response header: 14496050 15:47:44 INFO - Bytes received: 14496050 15:47:44 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')]} 15:47:44 INFO - trying https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 15:47:44 INFO - Downloading https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:47:52 INFO - Downloaded 61711460 bytes. 15:47:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 15:47:52 INFO - mkdir: /builds/slave/test/properties 15:47:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:47:52 INFO - Writing to file /builds/slave/test/properties/build_url 15:47:52 INFO - Contents: 15:47:52 INFO - build_url:https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 15:47:52 INFO - Running post-action listener: _resource_record_post_action 15:47:52 INFO - Running post-action listener: set_extra_try_arguments 15:47:52 INFO - [mozharness: 2017-08-14 22:47:52.260357Z] Finished download-and-extract step (success) 15:47:52 INFO - [mozharness: 2017-08-14 22:47:52.260586Z] Running populate-webroot step. 15:47:52 INFO - Running pre-action listener: _resource_record_pre_action 15:47:52 INFO - Running main action method: populate_webroot 15:47:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:47:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:47:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:47:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:47:52 INFO - 'tests': ['damp', 'tps']}, 15:47:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:47:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:47:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:47:52 INFO - 'other-e10s': {'tests': ['a11yr', 15:47:52 INFO - 'ts_paint', 15:47:52 INFO - 'tpaint', 15:47:52 INFO - 'sessionrestore', 15:47:52 INFO - 'sessionrestore_many_windows', 15:47:52 INFO - 'sessionrestore_no_auto_restore', 15:47:52 INFO - 'tabpaint']}, 15:47:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:47:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:47:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:47:52 INFO - 'tsvgr_opacity', 15:47:52 INFO - 'tart', 15:47:52 INFO - 'tscrollx', 15:47:52 INFO - 'tsvg_static']}, 15:47:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:47:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:47:52 INFO - 'talos_options': ['--mitmproxy', 15:47:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:47:52 INFO - '--firstNonBlankPaint'], 15:47:52 INFO - 'tests': ['tp6_google', 15:47:52 INFO - 'tp6_youtube', 15:47:52 INFO - 'tp6_amazon', 15:47:52 INFO - 'tp6_facebook']}, 15:47:52 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:47:52 INFO - 'talos_options': ['--stylo', 15:47:52 INFO - '--mitmproxy', 15:47:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:47:52 INFO - '--firstNonBlankPaint'], 15:47:52 INFO - 'tests': ['tp6_google', 15:47:52 INFO - 'tp6_youtube', 15:47:52 INFO - 'tp6_amazon', 15:47:52 INFO - 'tp6_facebook']}, 15:47:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:47:52 INFO - 'talos_options': ['--stylo', 15:47:52 INFO - '--stylo-threads=1', 15:47:52 INFO - '--mitmproxy', 15:47:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:47:52 INFO - '--firstNonBlankPaint'], 15:47:52 INFO - 'tests': ['tp6_google', 15:47:52 INFO - 'tp6_youtube', 15:47:52 INFO - 'tp6_amazon', 15:47:52 INFO - 'tp6_facebook']}, 15:47:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:47:52 INFO - 'talos_options': ['--xperf_path', 15:47:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:52 INFO - 'tests': ['tp5n']}}} 15:47:52 INFO - Running post-action listener: _resource_record_post_action 15:47:52 INFO - [mozharness: 2017-08-14 22:47:52.271995Z] Finished populate-webroot step (success) 15:47:52 INFO - [mozharness: 2017-08-14 22:47:52.272085Z] Running create-virtualenv step. 15:47:52 INFO - Running pre-action listener: _resource_record_pre_action 15:47:52 INFO - Running main action method: create_virtualenv 15:47:52 INFO - Creating virtualenv /builds/slave/test/build/venv 15:47:52 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 15:47:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:47:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:47:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:52 INFO - Using real prefix '/usr' 15:47:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:47:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:54 INFO - Installing pip.................done. 15:47:54 INFO - Return code: 0 15:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:47:55 INFO - Reading from file tmpfile_stdout 15:47:55 INFO - Output received: 15:47:55 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) 15:47:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47: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')]} 15:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:55 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:47:55 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 15:47:55 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 15:47:55 INFO - Using env: {'DISPLAY': ':0', 15:47:55 INFO - 'HOME': '/home/cltbld', 15:47:55 INFO - 'LANG': 'en_US.UTF-8', 15:47:55 INFO - 'LANGUAGE': 'en_US:en', 15:47:55 INFO - 'LOGNAME': 'cltbld', 15:47:55 INFO - 'MAIL': '/var/mail/cltbld', 15:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:55 INFO - 'MOZ_NO_REMOTE': '1', 15:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:55 INFO - 'NO_EM_RESTART': '1', 15:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:55 INFO - 'PWD': '/builds/slave/test', 15:47:55 INFO - 'SHELL': '/bin/bash', 15:47:55 INFO - 'SHLVL': '1', 15:47:55 INFO - 'TERM': 'linux', 15:47:55 INFO - 'TMOUT': '86400', 15:47:55 INFO - 'USER': 'cltbld', 15:47:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:55 INFO - '_': '/tools/buildbot/bin/python'} 15:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:55 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 15:47:55 INFO - Cleaning up... 15:47:55 INFO - Return code: 0 15:47:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:47: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')]} 15:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47: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')]} 15:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:55 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:47:55 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 15:47:55 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 15:47:55 INFO - Using env: {'DISPLAY': ':0', 15:47:55 INFO - 'HOME': '/home/cltbld', 15:47:55 INFO - 'LANG': 'en_US.UTF-8', 15:47:55 INFO - 'LANGUAGE': 'en_US:en', 15:47:55 INFO - 'LOGNAME': 'cltbld', 15:47:55 INFO - 'MAIL': '/var/mail/cltbld', 15:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:55 INFO - 'MOZ_NO_REMOTE': '1', 15:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:55 INFO - 'NO_EM_RESTART': '1', 15:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:55 INFO - 'PWD': '/builds/slave/test', 15:47:55 INFO - 'SHELL': '/bin/bash', 15:47:55 INFO - 'SHLVL': '1', 15:47:55 INFO - 'TERM': 'linux', 15:47:55 INFO - 'TMOUT': '86400', 15:47:55 INFO - 'USER': 'cltbld', 15:47:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:55 INFO - '_': '/tools/buildbot/bin/python'} 15:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:55 INFO - Downloading/unpacking psutil>=3.1.1 15:47:55 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 15:47:55 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 15:47:55 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 15:47:55 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 15:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:56 INFO - Installing collected packages: psutil 15:47:56 INFO - Running setup.py install for psutil 15:47:56 INFO - building 'psutil._psutil_linux' extension 15:47:56 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 15:47:56 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 15:47:56 INFO - building 'psutil._psutil_posix' extension 15:47:56 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 15:47:57 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 15:47:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:57 INFO - Successfully installed psutil 15:47:57 INFO - Cleaning up... 15:47:57 INFO - Return code: 0 15:47:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:47:57 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')]} 15:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:57 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')]} 15:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:57 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:47:57 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 15:47:57 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 15:47:57 INFO - Using env: {'DISPLAY': ':0', 15:47:57 INFO - 'HOME': '/home/cltbld', 15:47:57 INFO - 'LANG': 'en_US.UTF-8', 15:47:57 INFO - 'LANGUAGE': 'en_US:en', 15:47:57 INFO - 'LOGNAME': 'cltbld', 15:47:57 INFO - 'MAIL': '/var/mail/cltbld', 15:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:57 INFO - 'MOZ_NO_REMOTE': '1', 15:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:57 INFO - 'NO_EM_RESTART': '1', 15:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:57 INFO - 'PWD': '/builds/slave/test', 15:47:57 INFO - 'SHELL': '/bin/bash', 15:47:57 INFO - 'SHLVL': '1', 15:47:57 INFO - 'TERM': 'linux', 15:47:57 INFO - 'TMOUT': '86400', 15:47:57 INFO - 'USER': 'cltbld', 15:47:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:57 INFO - '_': '/tools/buildbot/bin/python'} 15:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:47:57 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 15:47:57 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 15:47:57 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 15:47:57 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 15:47:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:47:58 INFO - Installing collected packages: mozsystemmonitor 15:47:58 INFO - Running setup.py install for mozsystemmonitor 15:47:58 INFO - Successfully installed mozsystemmonitor 15:47:58 INFO - Cleaning up... 15:47:58 INFO - Return code: 0 15:47:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:47:58 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')]} 15:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:58 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')]} 15:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:58 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:47:58 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 15:47:58 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 15:47:58 INFO - Using env: {'DISPLAY': ':0', 15:47:58 INFO - 'HOME': '/home/cltbld', 15:47:58 INFO - 'LANG': 'en_US.UTF-8', 15:47:58 INFO - 'LANGUAGE': 'en_US:en', 15:47:58 INFO - 'LOGNAME': 'cltbld', 15:47:58 INFO - 'MAIL': '/var/mail/cltbld', 15:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:58 INFO - 'MOZ_NO_REMOTE': '1', 15:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:58 INFO - 'NO_EM_RESTART': '1', 15:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:58 INFO - 'PWD': '/builds/slave/test', 15:47:58 INFO - 'SHELL': '/bin/bash', 15:47:58 INFO - 'SHLVL': '1', 15:47:58 INFO - 'TERM': 'linux', 15:47:58 INFO - 'TMOUT': '86400', 15:47:58 INFO - 'USER': 'cltbld', 15:47:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:58 INFO - '_': '/tools/buildbot/bin/python'} 15:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:59 INFO - Downloading/unpacking jsonschema==2.5.1 15:47:59 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 15:47:59 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 15:47:59 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 15:47:59 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 15:48:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:48:00 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 15:48:00 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 15:48:00 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 15:48:00 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 15:48:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:00 INFO - warning: no files found matching '*.txt' 15:48:00 INFO - no previously-included directories found matching 'build' 15:48:00 INFO - no previously-included directories found matching 'dist' 15:48:00 INFO - no previously-included directories found matching '.git*' 15:48:00 INFO - Installing collected packages: jsonschema, functools32 15:48:00 INFO - Running setup.py install for functools32 15:48:00 INFO - warning: no files found matching '*.txt' 15:48:00 INFO - no previously-included directories found matching 'build' 15:48:00 INFO - no previously-included directories found matching 'dist' 15:48:00 INFO - no previously-included directories found matching '.git*' 15:48:00 INFO - Successfully installed jsonschema functools32 15:48:00 INFO - Cleaning up... 15:48:00 INFO - Return code: 0 15:48:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:48:00 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')]} 15:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:00 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')]} 15:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:00 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:48:00 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 15:48:00 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 15:48:00 INFO - Using env: {'DISPLAY': ':0', 15:48:00 INFO - 'HOME': '/home/cltbld', 15:48:00 INFO - 'LANG': 'en_US.UTF-8', 15:48:00 INFO - 'LANGUAGE': 'en_US:en', 15:48:00 INFO - 'LOGNAME': 'cltbld', 15:48:00 INFO - 'MAIL': '/var/mail/cltbld', 15:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:00 INFO - 'MOZ_NO_REMOTE': '1', 15:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:00 INFO - 'NO_EM_RESTART': '1', 15:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:00 INFO - 'PWD': '/builds/slave/test', 15:48:00 INFO - 'SHELL': '/bin/bash', 15:48:00 INFO - 'SHLVL': '1', 15:48:00 INFO - 'TERM': 'linux', 15:48:00 INFO - 'TMOUT': '86400', 15:48:00 INFO - 'USER': 'cltbld', 15:48:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:00 INFO - '_': '/tools/buildbot/bin/python'} 15:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:48:00 INFO - Cleaning up... 15:48:00 INFO - Return code: 0 15:48:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48:00 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')]} 15:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:00 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')]} 15:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:00 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:48:00 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 15:48:00 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 15:48:00 INFO - Using env: {'DISPLAY': ':0', 15:48:00 INFO - 'HOME': '/home/cltbld', 15:48:00 INFO - 'LANG': 'en_US.UTF-8', 15:48:00 INFO - 'LANGUAGE': 'en_US:en', 15:48:00 INFO - 'LOGNAME': 'cltbld', 15:48:00 INFO - 'MAIL': '/var/mail/cltbld', 15:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:00 INFO - 'MOZ_NO_REMOTE': '1', 15:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:00 INFO - 'NO_EM_RESTART': '1', 15:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:00 INFO - 'PWD': '/builds/slave/test', 15:48:00 INFO - 'SHELL': '/bin/bash', 15:48:00 INFO - 'SHLVL': '1', 15:48:00 INFO - 'TERM': 'linux', 15:48:00 INFO - 'TMOUT': '86400', 15:48:00 INFO - 'USER': 'cltbld', 15:48:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:00 INFO - '_': '/tools/buildbot/bin/python'} 15:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:48:01 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 15:48:01 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 15:48:01 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 15:48:01 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 15:48:02 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48:02 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 15:48:02 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 15:48:02 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 15:48:02 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 15:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48:02 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 15:48:02 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 15:48:02 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 15:48:02 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 15:48:02 INFO - Downloading docopt-0.6.1.tar.gz 15:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:02 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:02 INFO - Running setup.py install for blobuploader 15:48:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:02 INFO - Running setup.py install for requests 15:48:03 INFO - Running setup.py install for docopt 15:48:03 INFO - Successfully installed blobuploader requests docopt 15:48:03 INFO - Cleaning up... 15:48:03 INFO - Return code: 0 15:48:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:03 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')]} 15:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:03 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')]} 15:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:03 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:48:03 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 15:48:03 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 15:48:03 INFO - Using env: {'DISPLAY': ':0', 15:48:03 INFO - 'HOME': '/home/cltbld', 15:48:03 INFO - 'LANG': 'en_US.UTF-8', 15:48:03 INFO - 'LANGUAGE': 'en_US:en', 15:48:03 INFO - 'LOGNAME': 'cltbld', 15:48:03 INFO - 'MAIL': '/var/mail/cltbld', 15:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:03 INFO - 'MOZ_NO_REMOTE': '1', 15:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:03 INFO - 'NO_EM_RESTART': '1', 15:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:03 INFO - 'PWD': '/builds/slave/test', 15:48:03 INFO - 'SHELL': '/bin/bash', 15:48:03 INFO - 'SHLVL': '1', 15:48:03 INFO - 'TERM': 'linux', 15:48:03 INFO - 'TMOUT': '86400', 15:48:03 INFO - 'USER': 'cltbld', 15:48:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:03 INFO - '_': '/tools/buildbot/bin/python'} 15:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:03 INFO - Running setup.py (path:/tmp/pip-I1zTCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:03 INFO - Running setup.py (path:/tmp/pip-KJdew5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:03 INFO - Running setup.py (path:/tmp/pip-9dbQsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:03 INFO - Running setup.py (path:/tmp/pip-OUuEKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:03 INFO - Running setup.py (path:/tmp/pip-rA4VsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:03 INFO - Running setup.py (path:/tmp/pip-1DAwUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:03 INFO - Running setup.py (path:/tmp/pip-J_p7ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:04 INFO - Running setup.py (path:/tmp/pip-fp1wOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:04 INFO - Running setup.py (path:/tmp/pip-gs80LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:04 INFO - Running setup.py (path:/tmp/pip-lE0lV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:04 INFO - Running setup.py (path:/tmp/pip-G52qRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:04 INFO - Running setup.py (path:/tmp/pip-hfgIHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:04 INFO - Running setup.py (path:/tmp/pip-AyBvbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:04 INFO - Running setup.py (path:/tmp/pip-56q8WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:04 INFO - Running setup.py (path:/tmp/pip-TxEQOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:04 INFO - Running setup.py (path:/tmp/pip-LnBAE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:04 INFO - Running setup.py (path:/tmp/pip-kCvyxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:04 INFO - Running setup.py install for manifestparser 15:48:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:04 INFO - Running setup.py install for mozcrash 15:48:04 INFO - Running setup.py install for mozdebug 15:48:05 INFO - Running setup.py install for mozdevice 15:48:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:05 INFO - Running setup.py install for mozfile 15:48:05 INFO - Running setup.py install for mozhttpd 15:48:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:05 INFO - Running setup.py install for mozinfo 15:48:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:05 INFO - Running setup.py install for mozInstall 15:48:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:05 INFO - Running setup.py install for mozleak 15:48:05 INFO - Running setup.py install for mozlog 15:48:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:05 INFO - Running setup.py install for moznetwork 15:48:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:05 INFO - Running setup.py install for mozprocess 15:48:06 INFO - Running setup.py install for mozprofile 15:48:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:06 INFO - Running setup.py install for mozrunner 15:48:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:06 INFO - Running setup.py install for mozscreenshot 15:48:06 INFO - Running setup.py install for moztest 15:48:06 INFO - Running setup.py install for mozversion 15:48:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:06 INFO - Cleaning up... 15:48:06 INFO - Return code: 0 15:48:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:06 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')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 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')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:48:06 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 15:48:06 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 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:06 INFO - Running setup.py (path:/tmp/pip-YFl0j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:06 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)) 15:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:06 INFO - Running setup.py (path:/tmp/pip-BqMhpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:06 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)) 15:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:06 INFO - Running setup.py (path:/tmp/pip-0jhwNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:07 INFO - Running setup.py (path:/tmp/pip-m1IlSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:07 INFO - Running setup.py (path:/tmp/pip-w_y2u9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:07 INFO - Running setup.py (path:/tmp/pip-6R2S5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:07 INFO - Running setup.py (path:/tmp/pip-E0hPsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:07 INFO - Running setup.py (path:/tmp/pip-pFEt7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:07 INFO - Running setup.py (path:/tmp/pip-SbadXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:07 INFO - Running setup.py (path:/tmp/pip-_Xec_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:07 INFO - Running setup.py (path:/tmp/pip-ML66jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:07 INFO - Running setup.py (path:/tmp/pip-Ojh2Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:07 INFO - Running setup.py (path:/tmp/pip-J9CL9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:07 INFO - Running setup.py (path:/tmp/pip-T8xdy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:07 INFO - Running setup.py (path:/tmp/pip-I7ouTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:07 INFO - Running setup.py (path:/tmp/pip-3TuhNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:07 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)) 15:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:07 INFO - Running setup.py (path:/tmp/pip-spLSzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:08 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)) 15:48:08 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)) 15:48:08 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)) 15:48:08 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)) 15:48:08 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)) 15:48:08 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)) 15:48:08 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)) 15:48:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:08 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 15:48:08 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 15:48:08 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 15:48:08 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 15:48:09 INFO - Downloading blessings-1.6.tar.gz 15:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:09 INFO - Installing collected packages: blessings 15:48:09 INFO - Running setup.py install for blessings 15:48:09 INFO - Successfully installed blessings 15:48:09 INFO - Cleaning up... 15:48:09 INFO - Return code: 0 15:48:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:09 INFO - Reading from file tmpfile_stdout 15:48:09 INFO - Current package versions: 15:48:09 INFO - argparse == 1.2.1 15:48:09 INFO - blessings == 1.6 15:48:09 INFO - blobuploader == 1.2.4 15:48:09 INFO - docopt == 0.6.1 15:48:09 INFO - functools32 == 3.2.3-2 15:48:09 INFO - jsonschema == 2.5.1 15:48:09 INFO - manifestparser == 1.1 15:48:09 INFO - mozInstall == 1.13 15:48:09 INFO - mozcrash == 1.0 15:48:09 INFO - mozdebug == 0.1 15:48:09 INFO - mozdevice == 0.51 15:48:09 INFO - mozfile == 1.2 15:48:09 INFO - mozhttpd == 0.7 15:48:09 INFO - mozinfo == 0.10 15:48:09 INFO - mozleak == 0.1 15:48:09 INFO - mozlog == 3.5 15:48:09 INFO - moznetwork == 0.27 15:48:09 INFO - mozprocess == 0.25 15:48:09 INFO - mozprofile == 0.28 15:48:09 INFO - mozrunner == 6.13 15:48:09 INFO - mozscreenshot == 0.1 15:48:09 INFO - mozsystemmonitor == 0.3 15:48:09 INFO - moztest == 0.8 15:48:09 INFO - mozversion == 1.4 15:48:09 INFO - psutil == 3.1.1 15:48:09 INFO - requests == 1.2.3 15:48:09 INFO - wsgiref == 0.1.2 15:48:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:09 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')]} 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:09 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')]} 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:09 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:48:09 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 15:48:09 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 15:48:09 INFO - Using env: {'DISPLAY': ':0', 15:48:09 INFO - 'HOME': '/home/cltbld', 15:48:09 INFO - 'LANG': 'en_US.UTF-8', 15:48:09 INFO - 'LANGUAGE': 'en_US:en', 15:48:09 INFO - 'LOGNAME': 'cltbld', 15:48:09 INFO - 'MAIL': '/var/mail/cltbld', 15:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:09 INFO - 'MOZ_NO_REMOTE': '1', 15:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:09 INFO - 'NO_EM_RESTART': '1', 15:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:09 INFO - 'PWD': '/builds/slave/test', 15:48:09 INFO - 'SHELL': '/bin/bash', 15:48:09 INFO - 'SHLVL': '1', 15:48:09 INFO - 'TERM': 'linux', 15:48:09 INFO - 'TMOUT': '86400', 15:48:09 INFO - 'USER': 'cltbld', 15:48:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:09 INFO - '_': '/tools/buildbot/bin/python'} 15:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:09 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)) 15:48:09 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)) 15:48:09 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)) 15:48:09 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)) 15:48:09 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)) 15:48:09 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)) 15:48:09 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)) 15:48:09 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)) 15:48:09 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)) 15:48:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:48:10 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)) 15:48:10 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)) 15:48:10 INFO - Installing collected packages: simplejson 15:48:10 INFO - Running setup.py install for simplejson 15:48:11 INFO - building 'simplejson._speedups' extension 15:48:11 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 15:48:11 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 15:48:11 INFO - Successfully installed simplejson 15:48:11 INFO - Cleaning up... 15:48:12 INFO - Return code: 0 15:48:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:12 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')]} 15:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:12 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')]} 15:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:12 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 0x27ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, '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': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', '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 15:48:12 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 15:48:12 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 15:48:12 INFO - Using env: {'DISPLAY': ':0', 15:48:12 INFO - 'HOME': '/home/cltbld', 15:48:12 INFO - 'LANG': 'en_US.UTF-8', 15:48:12 INFO - 'LANGUAGE': 'en_US:en', 15:48:12 INFO - 'LOGNAME': 'cltbld', 15:48:12 INFO - 'MAIL': '/var/mail/cltbld', 15:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:12 INFO - 'MOZ_NO_REMOTE': '1', 15:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:12 INFO - 'NO_EM_RESTART': '1', 15:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:12 INFO - 'PWD': '/builds/slave/test', 15:48:12 INFO - 'SHELL': '/bin/bash', 15:48:12 INFO - 'SHLVL': '1', 15:48:12 INFO - 'TERM': 'linux', 15:48:12 INFO - 'TMOUT': '86400', 15:48:12 INFO - 'USER': 'cltbld', 15:48:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:12 INFO - '_': '/tools/buildbot/bin/python'} 15:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:12 INFO - Cleaning up... 15:48:12 INFO - Return code: 0 15:48:12 INFO - Running post-action listener: _resource_record_post_action 15:48:12 INFO - Running post-action listener: _start_resource_monitoring 15:48:12 INFO - Starting resource monitoring. 15:48:12 INFO - [mozharness: 2017-08-14 22:48:12.306238Z] Finished create-virtualenv step (success) 15:48:12 INFO - [mozharness: 2017-08-14 22:48:12.306708Z] Running install step. 15:48:12 INFO - Running pre-action listener: _resource_record_pre_action 15:48:12 INFO - Running main action method: install 15:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:12 INFO - Reading from file tmpfile_stdout 15:48:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:12 INFO - Reading from file tmpfile_stdout 15:48:12 INFO - Output received: 15:48:12 INFO - Usage: mozinstall [options] installer 15:48:12 INFO - Options: 15:48:12 INFO - -h, --help show this help message and exit 15:48:12 INFO - -d DEST, --destination=DEST 15:48:12 INFO - Directory to install application into. [default: 15:48:12 INFO - "/builds/slave/test"] 15:48:12 INFO - --app=APP Application being installed. [default: firefox] 15:48:12 INFO - mkdir: /builds/slave/test/build/application 15:48:12 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'] 15:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:48:30 INFO - Reading from file tmpfile_stdout 15:48:30 INFO - Output received: 15:48:30 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:30 INFO - Running post-action listener: _resource_record_post_action 15:48:30 INFO - [mozharness: 2017-08-14 22:48:30.659880Z] Finished install step (success) 15:48:30 INFO - [mozharness: 2017-08-14 22:48:30.660023Z] Running setup-mitmproxy step. 15:48:30 INFO - Running pre-action listener: _resource_record_pre_action 15:48:30 INFO - Running main action method: setup_mitmproxy 15:48:30 INFO - Skipping: mitmproxy is not required 15:48:30 INFO - Running post-action listener: _resource_record_post_action 15:48:30 INFO - [mozharness: 2017-08-14 22:48:30.660554Z] Finished setup-mitmproxy step (success) 15:48:30 INFO - [mozharness: 2017-08-14 22:48:30.660659Z] Running run-tests step. 15:48:30 INFO - Running pre-action listener: _resource_record_pre_action 15:48:30 INFO - Running pre-action listener: _set_gcov_prefix 15:48:30 INFO - Running main action method: run_tests 15:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:30 INFO - Python 2.7.3 15:48:30 INFO - Return code: 0 15:48:30 INFO - grabbing minidump binary from tooltool 15:48:30 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')]} 15:48:30 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 0x2b5ff00>, '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 0x2b5aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:30 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 15:48:30 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 15:48:30 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 15:48:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:30 INFO - Return code: 0 15:48:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:30 INFO - ENV: RUST_BACKTRACE is now full 15:48:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:30 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/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 15:48:30 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/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 15:48:30 INFO - Using env: {'DISPLAY': ':0', 15:48:30 INFO - 'HOME': '/home/cltbld', 15:48:30 INFO - 'LANG': 'en_US.UTF-8', 15:48:30 INFO - 'LANGUAGE': 'en_US:en', 15:48:30 INFO - 'LOGNAME': 'cltbld', 15:48:30 INFO - 'MAIL': '/var/mail/cltbld', 15:48:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:30 INFO - 'MOZ_NO_REMOTE': '1', 15:48:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:30 INFO - 'NO_EM_RESTART': '1', 15:48:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:30 INFO - 'PWD': '/builds/slave/test', 15:48:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:30 INFO - 'RUST_BACKTRACE': 'full', 15:48:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:48:30 INFO - 'SHELL': '/bin/bash', 15:48:30 INFO - 'SHLVL': '1', 15:48:30 INFO - 'STYLO_FORCE_ENABLED': '1', 15:48:30 INFO - 'TERM': 'linux', 15:48:30 INFO - 'TMOUT': '86400', 15:48:30 INFO - 'USER': 'cltbld', 15:48:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317', 15:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:30 INFO - '_': '/tools/buildbot/bin/python'} 15:48:30 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/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 15:48:31 INFO - mozversion application_buildid: 20170814214233 15:48:31 INFO - mozversion application_changeset: 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 15:48:31 INFO - mozversion application_display_name: Nightly 15:48:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:31 INFO - mozversion application_name: Firefox 15:48:31 INFO - mozversion application_remotingname: firefox 15:48:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:48:31 INFO - mozversion application_vendor: Mozilla 15:48:31 INFO - mozversion application_version: 57.0a1 15:48:31 INFO - mozversion platform_buildid: 20170814214233 15:48:31 INFO - mozversion platform_changeset: 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 15:48:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:48:31 INFO - mozversion platform_version: 57.0a1 15:48:31 INFO - using testdate: 1502750911 15:48:31 INFO - actual date: 1502750911 15:48:31 INFO - starting webserver on 'localhost:52994' 15:48:31 INFO - SUITE-START | Running 2 tests 15:48:31 INFO - TEST-START | dromaeo_css 15:48:31 INFO - Initialising browser for dromaeo_css test... 15:48:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52994/getInfo.html -profile /tmp/tmpQ_wkIQ/profile 15:48:31 INFO - TEST-INFO | started process 12948 (/builds/slave/test/build/application/firefox/firefox http://localhost:52994/getInfo.html) 15:48:37 INFO - TEST-INFO | 12948: exit 0 15:48:37 INFO - Browser initialized. 15:48:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:37 INFO - TEST-INFO | started process 13182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ_wkIQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:38 INFO - PID 13182 | 15:48:38 INFO - PID 13182 | (/builds/slave/test/build/application/firefox/firefox:13237): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:48:38 INFO - PID 13182 | 15:48:48 INFO - PID 13182 | RSS: Main: 168001536 15:48:48 INFO - PID 13182 | 15:51:48 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:52994/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52994/tests/dromaeo/cssquery-ext.html) 15:51:49 INFO - PID 13182 | RSS: Main: 175546368 15:51:49 INFO - PID 13182 | 15:54:51 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:52994/tests/dromaeo/cssquery-ext.html (next: http://localhost:52994/tests/dromaeo/cssquery-jquery.html) 15:54:52 INFO - PID 13182 | RSS: Main: 172974080 15:54:52 INFO - PID 13182 | 15:57:54 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:52994/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52994/tests/dromaeo/cssquery-mootools.html) 15:57:54 INFO - PID 13182 | RSS: Main: 174833664 15:57:54 INFO - PID 13182 | 16:00:56 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:52994/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52994/tests/dromaeo/cssquery-prototype.html) 16:00:57 INFO - PID 13182 | RSS: Main: 173838336 16:00:57 INFO - PID 13182 | 16:04:00 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:52994/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52994/tests/dromaeo/cssquery-yui.html) 16:04:01 INFO - PID 13182 | RSS: Main: 176881664 16:04:01 INFO - PID 13182 | 16:07:03 INFO - PID 13182 | Cycle 1(1): loaded http://localhost:52994/tests/dromaeo/cssquery-yui.html (next: http://localhost:52994/tests/dromaeo/cssquery-dojo.html) 16:07:03 INFO - PID 13182 | RSS: Main: 177569792 16:07:03 INFO - PID 13182 | 16:07:03 INFO - PID 13182 | __start_tp_report 16:07:03 INFO - PID 13182 | _x_x_mozilla_page_load 16:07:03 INFO - PID 13182 | _x_x_mozilla_page_load_details 16:07:03 INFO - PID 13182 | |i|pagename|runs| 16:07:03 INFO - PID 13182 | |0;dojo.html;3151.180693019815;3153.3535625196823;3155.479345907925;3188.218886372839;3201.6958388953058;6110.205673262481;6140.7543698252075;6143.784967526138;6155.876882462354;6206.503479721623;6028.492876780805;6084.574079814415;6113.174721412608;6128.724207410666;6153.046277826944;5511.255980442639;5545.667259964395;5563.332400111992;5594.440555944414;5691.203231547586;5652.576056795736;5694.5729070319685;5716.314042314907;5717.971410142944;5729.598928075036;5508.944910550883;5607.495325420711;5673.404292549285;5765.481106700396;5782.450667186632;5599.076152434844;5608.383077861432;5664.320281566238;5686.886262274773;5703.828885133453;5542.196381524696;5576.414476479952;5629.521490673298;5650.773969041234;5670.461306175906;5893.7053147342895;5932.377100404438;5940.811837632447;5963.731632076524;6151.261848578154;6428.132202152697;6506.284308726036;6539.934600654028;6559.6064236145985;6570.967145164292;6589.209294884597;6589.472842172662;6605.9669701651665;6611.86776264472;6617.371349721769;6093.512518998514;6098.6340819551415;6104.328523862371;6107.4808641265545;6110.052941794029;6663.600183988976;6726.428253598499;6730.93269067303;6733.360330768569;6740.123783908159;6385.297617262097;6409.679516024274;6413.005984072476;6414.679266036679;6424.357564243538;6163.260408750979;6518.380753828379;6527.118838956775;6586.571872828251;6676.031975363545;6520.217573891164;6545.21457425112;6611.570247933869;6628.4697224221945;6678.599284042973;6487.837804054842;6543.312952140052;6567.376099270562;6567.9671601641685;6584.11114499546;5284.867878302996;5292.947070529322;5303.204519322056;5306.336707911511;5309.2301616266195;4586.8394606189295;4636.79134438951;4647.6281897448125;4656.790444430008;4656.837010704609;5688.317401911797;5758.0787074068785;5762.798302059407;5771.624844385102;5782.739776710058;6491.935080649133;6509.414152726183;6604.8348791280605;6611.438027767694;6635.037919501645;5657.773689052392;5683.914741278884;5712.971665100239;5732.57005724564;5738.741756620962;5640.266765320564;5733.426657334317;5745.798897038583;5749.396313387034;5800.825975220666;6438.645874476949;6460.515461340418;6461.741530338733;6531.118299029666;6537.869242615121;6419.358064193543;6503.51223658237;6505.186851643544;6695.966520167368;6721.630310332978;6356.3325850785;6392.840178995562;6403.9359606405205;6408.391202835724;6413.647249401328;6528.955367141235;6536.6731663415685;6538.051982462612;6538.378854008862;6548.116004339353;6597.736090556324;6603.900941485786;6667.899981500378;6695.4978376620975;6706.329367063255;6353.237611486651;6363.268224154282;6454.838629034311;6457.741690332334;6489.286178520265;6202.4107709769305;6294.527910406646;6380.872382552416;6443.96778016107;6462.806115816533;6242.531810114168;6290.559660823698;6291.150694656346;6303.212098487689;6310.716017779303;6429.678516074271;6465.127207827071;6511.446527045065;6515.315891831479;6524.380183882524;6150.815475535562;6203;6215.751369945152;6247.09417134522;6252.09344645033 16:07:03 INFO - PID 13182 | |1;ext.html;838.274892218231;866.1684782608696;891.376036774258;1183.781000514905;1198.0355813570072;30805.537916931236;31375.21561960952;41677.58322416775;42201;42327;42762.35856462156;43094.569054309446;43299.13401731964;43375.78312108443;43464.348034779505;7313.744018959337;7672.7698169054875;7916.445848790587;7917.9208207918045;7934.7222847200355;7726;7799.727009554666;7819;7822.178671239523;7828.178041305638;7740.574268415235;7742.225777422241;7782.533048017137;7806.60966951653;7816.960915195416;7808.648610812499;7813.453058285922;7829.804254893616;7838.137804841492;7846.333061689735;7598.392128629696;7644.46488745788;7651.617419129021;7729.420293478011;7746.41901857363;39981;40232.396514052314;40417.59582404168;40422.59577404247;40503.392449113286;3606;3645.76302540334;3648.1426864686778;3651.087228192952;3653.5250417445827;31488.212794680087;31544.842275788473;31582.842085789653;31801.52297715536;31840.203994900083;5042.3949126104735;5083.669561478492;5118.334616499868;5151.9484805152215;5155.845324640267;190821;192288.9999999986;192298;192488;192836.0358198214;48170.518294816604;48280;48337.516624833304;50097.74951125221;50892;52431;52562.474375255755;52640.21039684408;52679.73660131675;52693.209601856004;15769.921150394175;15896.841031589767;16838.24227909747;16857.747133793004;16928.57678558021;12440.502379904703;12483.687907802196;12503.937480312723;12511.687207819878;12553.937230313973;14449.92775036139;14451.566453006426;14621.488247911484;14698.706025879423;14712.117272963656;6027.638341699512;6079.179310793074;6085.326535202855;6089.847753806191;6114.6942652868065;1018.7198520406947;1027.306568066552;1028.7993841201044;1029.7528593137592;1034.2450011491503;23179.768202317762;23493.295201143992;23850.880745596507;28868.42263154767;29566.852165739034;1098.593520397458;1108.4014632098576;1113.6714669172613;1114.8439218509416;1115.4924509348227;12327.50689972391;12604.432800523815;12611.87388126107;12681.239125652306;12719.173253738663;248681;250326;250414;250982;251280;51321.743391282806;51817.22274165891;51998.22002669963;52023.47976520262;52136.21795673068;1469.177260733971;1479.607903905466;1510.5090845475045;1514.8182218133895;1525.3212320517484;22838.42903927415;23098.614083155066;23124.190653327052;23425.648615271126;23448.64827027562;37894;38197.23605527818;38215.23569528538;38226.426603601525;38308.42537361886;225551;228775;229214;229491;229562;37890.24219515539;37951.24097517979;37993.43009854799;38201.23597528089;38258.426123608726;45282.77358613186;46258;46399.536004640875;46621;46637;34273;34509.482357765155;34702.30595388028;34949.12627184341;35467.645323546436;34110.317793643495;34206.97379078532;34294.48558271578;34561.827190863885;35389.469157962136;37729.05677358088;37757.622423775414;38024.429633554966;38216.23567528578;38237;33553.66446335505;33777.66222337844;33841.32317353688;33929;33969;24424.51150976935;24808.875955620108;24846.751532484443;25268.62097068582;25309.62035569431 16:07:03 INFO - PID 13182 | |2;jquery.html;536.8657835541114;544.1918750655274;557.3868744381181;570.948614624684;577.5293136094083;16718.164091795392;22898.77101228987;23750.64374034391;23868.5226295474;23886.5222695546;18261.178246978885;22465.775342246572;23315.76684233157;23368;23550.057997680073;6172.598781079238;6403.839904002414;6404.103425520431;6405.519586031043;6407.423331900128;5876.853078673024;6254.249490061176;6345.555811093225;6397.712102955355;6400.743970241208;6374.58565193261;6376.394242546974;6376.585521941059;6377.872442551146;6379.425851673349;6273.905891411632;6317.463015643676;6356.841078973016;6371.044343348489;6387.776427825004;5922.615030023035;5934.732937017801;5948.196993405922;5949;5953.493953013955;27988.720112798816;29112.12663620095;29667;29691.406171876657;29849.70150298491;1897.8386837118862;1927.9974413305142;1929.6623090959026;1930.0156919970775;1930.1025023364202;18705.812941870543;19294.71057934132;19305.51736206606;19310.32413865522;19316.130774115198;2304.7234331880113;2317.0963324303534;2332.6734257204007;2393.5930891748444;2397.3407312988893;136084;139597;139717;139869;139949.3002534991;14375.712485750435;14961.476348327757;14973.251337433085;14990.625234369229;15178.696426071638;23040.53918921612;23142.42143946381;23157.53684926292;23175.536489270457;23220.883895580413;10103.494825258707;10170.542325595366;10183.388996660076;10267.640632577824;10347.844782328271;9523;9527.666531671359;9560.426374417557;9687.321887467951;9700.27247956406;7567.545947243183;9019.819603607892;9125.543722813833;9243.768905777275;9244.949166775083;2766.70363598213;2768.349437882096;2826.1804076817903;2828.363618185933;2888.35012122275;957.262907561174;961.7066794627706;963.3304853127149;982.4449186209912;989.6486747204783;18873;19316.034198290028;19401.32095376655;19701.60596788085;19816.40550783479;1015.1929216272933;1021.6730646193296;1029.583018877356;1036.290141253244;1042.0569384706853;10648.414337211529;10870.565177392973;10887.23789334739;10984.670459886216;11140.275882067639;511086;517741;534909;535561;541543;107968;115565.42217289028;115891.42054289674;116311.41844290894;116567;1175.8295047218105;1205.8914697677076;1207.607527553531;1208.4078801387257;1212.5695378140633;17599.20803563817;17747.29010839552;17794.911025445308;20319.288824891057;21614.243501477373;55552.72223638856;56530;57460.1380979294;58128;59699;68531.65734171496;69157.30842691509;69186.30813691799;69223.65388173229;69453.30546694469;12147.149699520949;13316.267605281802;14524.709505810037;14951.102933824006;15024.549263522113;22909.427264318525;23596.646050309602;23601.29196124119;24034.51930961406;24098.63852042256;18656.906715466335;18951.0524473773;19120;19180.328688495836;19248;15524.301406436964;17320.480385588453;17339.2197351117;17764.111794409968;18024.639507210046;19185.712214316518;20232.89883550573;20367;20372.59254814866;20402.59194816125;14464.566063018126;14474.565763027125;14621.19583422922;14644.26778661084;14741.705165896836;16037.438689645807;16131;16177.757333639769;16214.702823774305;18012.36956706509 16:07:03 INFO - PID 13182 | |3;mootools.html;1342.946282148714;1383.9446422143114;1393.804867318575;1401.1523028567717;1406.7256884907445;13493.2578708171;13884.722305553896;13995.160290382584;14009.439622415104;14150.292485375741;14733.631659208526;14847.1091734496;14851.331690073946;14859.92570037151;14912.254387280647;2618.3977685132477;2650.7216742242076;2650.7481789230087;2651.9602205966926;2666.0935282004116;2506.636537702032;2601.765841074303;2723.8229515081557;2725.68654604721;2734.5214587447217;2612.4775044990984;2627.408833012576;2637.9472410551775;2645.3254420122844;2650.695170055449;2596.44176502052;2605.583106702928;2651.0986264669914;2654.522186006518;2661.2814540074073;2439.6706444629926;2471.653968444419;2566.5765148750434;2615.5161295160456;2621.606758986148;14089.506867259597;14117.223552704598;14189.290535473185;14236.928815355857;14250.572482825532;7467.589282589455;7733.4199935004535;7740.342070923978;7744.535327880289;7746.690132394698;4800.399950006249;4992.925106123411;5165.586753059746;5166.276721259027;5177.016366890279;1690.6618676264795;1744.389463687712;1775.8934463932205;1810.3211295764088;1823.5714607067328;21922.123115075377;22030.779692203032;22058.669119963215;22070.117195312167;22110;6231.781887634002;6468.676566171766;6801.42187914023;6951.617661028692;7012.053372794608;15569.299381527859;15590.688186236212;15661.608459788597;15731.685366292839;15734;7312;7413.8146546336775;7417.184109747924;7442.367398771057;7905.802354941057;6925.722971081201;7060.646967651597;7067.787966361017;7087.468439867031;7101.786946391617;5041.823536176216;5057.317262169634;5092.38891333035;5100.438951715309;5138.152204886152;1465.0696807527083;1471.8675319221322;1472.9189894555689;1485.9034162779385;1508.1177511155877;861.4443683823898;885.4819930340694;905.9501727405056;909.3952521573212;912.7859946271576;7346.559206447523;8914.420562663407;9061.728148155566;9194.12655797698;9228.215601673799;933.8319102561468;941.2987324443196;980.7940332530106;989.3766926836047;1009.9899001010043;5110.284560161506;5458.4814442627885;5512.80705175325;5804.448577385142;5875.29496460419;18624;19037.238510459705;19153.521161970784;19300.517487062654;19849.801501985083;19704.90147549253;19869.205231790565;19880.70178947317;19903.30338438177;20025.499362516053;10106.14097801695;10242.53908574116;10279.588816447407;10287.279890407599;10298;8338.77520500491;8388.161183881562;8625.8706119407;8678;8726.30189584819;16650.417235396704;16656.333746649998;16896.40862569804;16945.23746431438;17516.562085947953;17192.22634981454;17293.740593891354;17513.649727005133;17541;17619.55951101233;11645.47595358194;11774.94112529432;11783.646490605295;11843.940780296043;11927.940360298144;13169.209847409185;13228.933855330662;13283.667908301983;13285.734285314433;13304.600861974157;10649.148068154684;10750.13998880072;10762.946185269024;10765.3540787553;10810.29733067348;10272.075513203847;10435.895641043493;10466;10495.737606559896;10625.149988000787;9588;9602;9653.46905920181;9683.709488715349;9791.706248812547;7303.707851685873;7323.084614423197;7341.669624866787;7365;7408.481406301507;7294.96352518234;7339.559626422431;7342.5227360221415;7342.70629174827;7429.554226746196 16:07:03 INFO - PID 13182 | |4;prototype.html;487.1543787305446;499.48655573611956;519.174512525085;522.8745101175718;534.4154581665362;6108.419700128492;6217.129601855732;6219.129321894939;6239.25128984522;6268.655223962686;5931.644101353911;6012.5791194616395;6049.727762250698;6081.148639190517;6088.543359248052;4835.903281934368;4838.846713212622;4863.829765958192;4873.756312184377;4895.5838753705975;4762.238041913277;4862.78117484714;4912.852614421573;4930.137225985456;4930.235813448903;4945.530174633404;5017.724025178613;5042.369703787027;5130.38435387754;5135.204043373283;5075.695458272497;5133.486651334855;5153.819616313449;5188.221766734982;5198.92201616976;4732.408448943882;4748.19280722278;4757.405324334458;4759.190937540627;4764.166270902613;5989.31122920861;6027.638341699512;6094.542909281821;6094.695265236721;6138.8772224555705;5929.2212336298935;5973.820785376446;5982.132590774357;6008.098785182214;6035.426634469718;6453.83865403364;6568.1789776277965;6597.670116494156;6615.867682646368;6644.468442524587;5247.160454327328;5247.449017853109;5268.947310526884;5283.603729720248;5311.150215965427;6849.452043836481;6905.343992320722;6923.238443771181;6954.7575978652985;6975.4070903973225;5400.540954018952;5401.5969938938215;5426.294581704353;5459.754311056012;5499.862503437366;5558.055130627803;5558.610897237236;5570.220169176318;5581.5255703265675;5598.972005139948;5982.012967860342;5985.371535988746;6037.9396206038255;6046.758129674852;6050.42520960508;6553.049807777846;6569.766279465005;6580.539362244693;6596.934030659728;6659.367360100783;1831.432256000644;1870.3453791173254;1881.8400435963097;1889.1593241007895;1948.658984677704;1428.3144090836456;1436.3967133803828;1436.791665208539;1444.2995147353524;1463.817022872141;5751.482366587027;5802.056311135732;5814.825555233349;5821.79623713168;5830.105215804881;6531.8693626127215;6583.572067815577;6637.676813115371;6702.731890724316;6734.831629209309;5788.739506722208;5807.709614519257;5809.128630705428;5876.885250817074;5887.8233652990475;3505.9123521912156;3509.649035096521;3530.9760169551055;3557.6086630470627;3567.162911100785;6536.542442029012;6559.212894452697;6570.375814297634;6576.375244351779;6667.799966001027;6830.419414349736;6869.416099631488;6886.586804791728;6950.895736563955;6958.234594194634;6452.677366131768;6461.418472337512;6528.902066469007;6554.934450655433;6632.403083722488;6644.767433139817;6671.399574038166;6696.464282857262;6700.798976030727;6707.7255321488765;6649.603583247572;6661.800145995628;6679;6698.196216454056;6767.492438067263;6459.609944320444;6481.634203515777;6498.3826536478955;6602.1747281589805;6615.900761488678;4918.975405122951;4939.827106051271;4944.975275123601;4976.357801925428;4986.12742770021;6779.661016949145;6785.355391237825;6825.419839313714;6830.624315662488;6856.382925536725;6557.9344206557325;6582.605043697394;6600.80197594073;6636.83407914806;6671.466282697275;6471.935280647133;6524.3149469305035;6533.771318003847;6571.769988050586;6602.933970660232;6269.247690277196;6319.6208227506495;6358.936410635834;6487.18910136233;6520.250171230179;6410.391012853772;6520.673966301761;6538.823011857721;6594.142761440982;6609.140811694641;6320.5891617044745;6373.7131829066875;6383.457406120532;6415.824167037346;6421.293657697556 16:07:03 INFO - PID 13182 | |5;yui.html;876.360257012381;894.7584152278883;906.1346414174465;912.4753266871546;914.8444764390055;17719.291228350867;18416.631667366662;18460.353887613936;18473.630527389443;22383.55232895341;19496.70754938677;21262.255821046267;21629.351119466442;21630.675539866876;21636.567268654617;1037.4034929915272;1058.201058201057;1059.2267644619394;1063.2238465919884;1065.1798115451097;1047.1099565369414;1047.5443182215722;1048.4705223861938;1049.3546468921634;1056.6882769582992;1122.8091224491816;1123.2586492914677;1123.6179698902372;1123.6572845282185;1130.3161587239724;1105.7622611138604;1112.4048633980863;1113.4154568851377;1113.9777204455866;1125.8705248896358;809.7125520440277;812.1837553258996;813.3290035720554;815.135955886756;822.8148666550038;18570.907145464185;18905;19033.904830475898;19078.23687052516;19246.03769811518;21338.146474141016;21467.57064858694;21552.676709849366;21745.891270543703;21876.562468750537;16567.83432165675;16798.41205557812;16906.239219235165;17070.48788536346;17197.312107515685;3592.676659100667;3616.8734094306838;3617.620149884277;3623.3477973964677;3629.491871138043;125064.37467812603;125711;126542.36728816298;126564.36717816352;128416.35791821075;16918.154092295335;17408.47774566765;17479.912600436917;17535.73696394555;18062.458126256235;32164.19589510234;32213.194670133435;32381;32604.347913041605;32854.178645534055;6968.303169683092;7267.345938865422;7493.4005279577505;8402.41183117176;8594.78513037179;3745.1011757178626;3858.2862170498547;4168.499780026416;4186;4192.895177620523;5228.660137091077;5455.345358556999;5455.645383050089;5457.808976685797;5473.781048758085;1056.4084112896803;1058.3649810114025;1095.802755504017;1097.6816723150198;1105.5964572930823;688.5902887781762;698.9899595085155;699.0876905638089;708.8794904866082;716.1370548489058;11945.402729863472;12443.377831108408;12491.562795302121;13102.475900964046;13237.404316805767;700.7162099349772;700.7302188657403;706.9151701795818;708.0582824842946;709.6097146569366;5495.789757573916;5719.48524632785;5720.3421606515785;6335.841603959938;6496.317886621931;110169;110335.44832275787;116718.38054095067;117254;121399;99747;102878.48560757148;104188;107898;109077.45461272643;92232.53883730539;92481.99999999866;92711;94129;94699.52650236705;12947.093703440669;13302.93348533251;13335.999800015232;13421.26183059902;13453.990950678934;37879.24241515099;38879.6112038876;39275.2144957105;40177.598224018555;40653.59346406498;49703;50232.49767502424;50428.243576347115;50519.24221136759;52091.43725688235;19002.714959275898;19415.126319315383;19444.70832937479;19488;19567.60864782668;20997;21182.364529064154;21389.14443422308;21442.57114857663;21467.355979320644;19148.808511914704;19533.70699439481;19538.31615893437;19635.607287854447;19657.213711451383;17557.209925553125;17638.647227055644;17737.37919172823;17768;17796.110194490484;18823.34118305853;18938.242470301033;18959.620807584048;18975.525611859815;19186.328478503186;12958.481660733465;13528.39122239482;13723.382447789674;13907.235102069078;14260.144391336553;14202.360893759598;14459.349329280418;14589.781153282922;14990;15422.614434639223 16:07:03 INFO - PID 13182 | __end_tp_report 16:07:03 INFO - PID 13182 | __start_cc_report 16:07:03 INFO - PID 13182 | _x_x_mozilla_cycle_collect,370 16:07:03 INFO - PID 13182 | __end_cc_report 16:07:03 INFO - PID 13182 | __startTimestamp1502752023583__endTimestamp 16:07:03 INFO - PID 13182 | 16:07:03 INFO - PID 13182 | ------- Summary: start ------- 16:07:03 INFO - PID 13182 | Number of tests: 6 16:07:03 INFO - PID 13182 | 16:07:03 INFO - PID 13182 | [#0] dojo.html Cycles:165 Average:6052.27 Median:6252.09 stddev:697.19 (11.2%) stddev-sans-first:661.14 16:07:03 INFO - PID 13182 | Values: 3151.2 3153.4 3155.5 3188.2 3201.7 6110.2 6140.8 6143.8 6155.9 6206.5 6028.5 6084.6 6113.2 6128.7 6153.0 5511.3 5545.7 5563.3 5594.4 5691.2 5652.6 5694.6 5716.3 5718.0 5729.6 5508.9 5607.5 5673.4 5765.5 5782.5 5599.1 5608.4 5664.3 5686.9 5703.8 5542.2 5576.4 5629.5 5650.8 5670.5 5893.7 5932.4 5940.8 5963.7 6151.3 6428.1 6506.3 6539.9 6559.6 6571.0 6589.2 6589.5 6606.0 6611.9 6617.4 6093.5 6098.6 6104.3 6107.5 6110.1 6663.6 6726.4 6730.9 6733.4 6740.1 6385.3 6409.7 6413.0 6414.7 6424.4 6163.3 6518.4 6527.1 6586.6 6676.0 6520.2 6545.2 6611.6 6628.5 6678.6 6487.8 6543.3 6567.4 6568.0 6584.1 5284.9 5292.9 5303.2 5306.3 5309.2 4586.8 4636.8 4647.6 4656.8 4656.8 5688.3 5758.1 5762.8 5771.6 5782.7 6491.9 6509.4 6604.8 6611.4 6635.0 5657.8 5683.9 5713.0 5732.6 5738.7 5640.3 5733.4 5745.8 5749.4 5800.8 6438.6 6460.5 6461.7 6531.1 6537.9 6419.4 6503.5 6505.2 6696.0 6721.6 6356.3 6392.8 6403.9 6408.4 6413.6 6529.0 6536.7 6538.1 6538.4 6548.1 6597.7 6603.9 6667.9 6695.5 6706.3 6353.2 6363.3 6454.8 6457.7 6489.3 6202.4 6294.5 6380.9 6444.0 6462.8 6242.5 6290.6 6291.2 6303.2 6310.7 6429.7 6465.1 6511.4 6515.3 6524.4 6150.8 6203.0 6215.8 6247.1 6252.1 16:07:03 INFO - PID 13182 | 16:07:03 INFO - PID 13182 | [#1] ext.html Cycles:180 Average:39704.46 Median:3646.95 stddev:58358.14 (1600.2%) stddev-sans-first:58448.88 16:07:03 INFO - PID 13182 | Values: 838.3 866.2 891.4 1183.8 1198.0 30805.5 31375.2 41677.6 42201.0 42327.0 42762.4 43094.6 43299.1 43375.8 43464.3 7313.7 7672.8 7916.4 7917.9 7934.7 7726.0 7799.7 7819.0 7822.2 7828.2 7740.6 7742.2 7782.5 7806.6 7817.0 7808.6 7813.5 7829.8 7838.1 7846.3 7598.4 7644.5 7651.6 7729.4 7746.4 39981.0 40232.4 40417.6 40422.6 40503.4 3606.0 3645.8 3648.1 3651.1 3653.5 31488.2 31544.8 31582.8 31801.5 31840.2 5042.4 5083.7 5118.3 5151.9 5155.8 190821.0 192289.0 192298.0 192488.0 192836.0 48170.5 48280.0 48337.5 50097.7 50892.0 52431.0 52562.5 52640.2 52679.7 52693.2 15769.9 15896.8 16838.2 16857.7 16928.6 12440.5 12483.7 12503.9 12511.7 12553.9 14449.9 14451.6 14621.5 14698.7 14712.1 6027.6 6079.2 6085.3 6089.8 6114.7 1018.7 1027.3 1028.8 1029.8 1034.2 23179.8 23493.3 23850.9 28868.4 29566.9 1098.6 1108.4 1113.7 1114.8 1115.5 12327.5 12604.4 12611.9 12681.2 12719.2 248681.0 250326.0 250414.0 250982.0 251280.0 51321.7 51817.2 51998.2 52023.5 52136.2 1469.2 1479.6 1510.5 1514.8 1525.3 22838.4 23098.6 23124.2 23425.6 23448.6 37894.0 38197.2 38215.2 38226.4 38308.4 225551.0 228775.0 229214.0 229491.0 229562.0 37890.2 37951.2 37993.4 38201.2 38258.4 45282.8 46258.0 46399.5 46621.0 46637.0 34273.0 34509.5 34702.3 34949.1 35467.6 34110.3 34207.0 34294.5 34561.8 35389.5 37729.1 37757.6 38024.4 38216.2 38237.0 33553.7 33777.7 33841.3 33929.0 33969.0 24424.5 24808.9 24846.8 25268.6 25309.6 16:07:03 INFO - PID 13182 | 16:07:03 INFO - PID 13182 | [#2] jquery.html Cycles:180 Average:35676.83 Median:12672.63 stddev:88507.66 (698.4%) stddev-sans-first:88716.62 16:07:03 INFO - PID 13182 | Values: 536.9 544.2 557.4 570.9 577.5 16718.2 22898.8 23750.6 23868.5 23886.5 18261.2 22465.8 23315.8 23368.0 23550.1 6172.6 6403.8 6404.1 6405.5 6407.4 5876.9 6254.2 6345.6 6397.7 6400.7 6374.6 6376.4 6376.6 6377.9 6379.4 6273.9 6317.5 6356.8 6371.0 6387.8 5922.6 5934.7 5948.2 5949.0 5953.5 27988.7 29112.1 29667.0 29691.4 29849.7 1897.8 1928.0 1929.7 1930.0 1930.1 18705.8 19294.7 19305.5 19310.3 19316.1 2304.7 2317.1 2332.7 2393.6 2397.3 136084.0 139597.0 139717.0 139869.0 139949.3 14375.7 14961.5 14973.3 14990.6 15178.7 23040.5 23142.4 23157.5 23175.5 23220.9 10103.5 10170.5 10183.4 10267.6 10347.8 9523.0 9527.7 9560.4 9687.3 9700.3 7567.5 9019.8 9125.5 9243.8 9244.9 2766.7 2768.3 2826.2 2828.4 2888.4 957.3 961.7 963.3 982.4 989.6 18873.0 19316.0 19401.3 19701.6 19816.4 1015.2 1021.7 1029.6 1036.3 1042.1 10648.4 10870.6 10887.2 10984.7 11140.3 511086.0 517741.0 534909.0 535561.0 541543.0 107968.0 115565.4 115891.4 116311.4 116567.0 1175.8 1205.9 1207.6 1208.4 1212.6 17599.2 17747.3 17794.9 20319.3 21614.2 55552.7 56530.0 57460.1 58128.0 59699.0 68531.7 69157.3 69186.3 69223.7 69453.3 12147.1 13316.3 14524.7 14951.1 15024.5 22909.4 23596.6 23601.3 24034.5 24098.6 18656.9 18951.1 19120.0 19180.3 19248.0 15524.3 17320.5 17339.2 17764.1 18024.6 19185.7 20232.9 20367.0 20372.6 20402.6 14464.6 14474.6 14621.2 14644.3 14741.7 16037.4 16131.0 16177.8 16214.7 18012.4 16:07:03 INFO - PID 13182 | 16:07:03 INFO - PID 13182 | [#3] mootools.html Cycles:180 Average:8790.57 Median:2599.10 stddev:5909.12 (227.4%) stddev-sans-first:5899.19 16:07:03 INFO - PID 13182 | Values: 1342.9 1383.9 1393.8 1401.2 1406.7 13493.3 13884.7 13995.2 14009.4 14150.3 14733.6 14847.1 14851.3 14859.9 14912.3 2618.4 2650.7 2650.7 2652.0 2666.1 2506.6 2601.8 2723.8 2725.7 2734.5 2612.5 2627.4 2637.9 2645.3 2650.7 2596.4 2605.6 2651.1 2654.5 2661.3 2439.7 2471.7 2566.6 2615.5 2621.6 14089.5 14117.2 14189.3 14236.9 14250.6 7467.6 7733.4 7740.3 7744.5 7746.7 4800.4 4992.9 5165.6 5166.3 5177.0 1690.7 1744.4 1775.9 1810.3 1823.6 21922.1 22030.8 22058.7 22070.1 22110.0 6231.8 6468.7 6801.4 6951.6 7012.1 15569.3 15590.7 15661.6 15731.7 15734.0 7312.0 7413.8 7417.2 7442.4 7905.8 6925.7 7060.6 7067.8 7087.5 7101.8 5041.8 5057.3 5092.4 5100.4 5138.2 1465.1 1471.9 1472.9 1485.9 1508.1 861.4 885.5 906.0 909.4 912.8 7346.6 8914.4 9061.7 9194.1 9228.2 933.8 941.3 980.8 989.4 1010.0 5110.3 5458.5 5512.8 5804.4 5875.3 18624.0 19037.2 19153.5 19300.5 19849.8 19704.9 19869.2 19880.7 19903.3 20025.5 10106.1 10242.5 10279.6 10287.3 10298.0 8338.8 8388.2 8625.9 8678.0 8726.3 16650.4 16656.3 16896.4 16945.2 17516.6 17192.2 17293.7 17513.6 17541.0 17619.6 11645.5 11774.9 11783.6 11843.9 11927.9 13169.2 13228.9 13283.7 13285.7 13304.6 10649.1 10750.1 10762.9 10765.4 10810.3 10272.1 10435.9 10466.0 10495.7 10625.1 9588.0 9602.0 9653.5 9683.7 9791.7 7303.7 7323.1 7341.7 7365.0 7408.5 7295.0 7339.6 7342.5 7342.7 7429.6 16:07:03 INFO - PID 13182 | 16:07:03 INFO - PID 13182 | [#4] prototype.html Cycles:180 Average:5588.35 Median:6084.85 stddev:1516.73 (24.9%) stddev-sans-first:1471.87 16:07:03 INFO - PID 13182 | Values: 487.2 499.5 519.2 522.9 534.4 6108.4 6217.1 6219.1 6239.3 6268.7 5931.6 6012.6 6049.7 6081.1 6088.5 4835.9 4838.8 4863.8 4873.8 4895.6 4762.2 4862.8 4912.9 4930.1 4930.2 4945.5 5017.7 5042.4 5130.4 5135.2 5075.7 5133.5 5153.8 5188.2 5198.9 4732.4 4748.2 4757.4 4759.2 4764.2 5989.3 6027.6 6094.5 6094.7 6138.9 5929.2 5973.8 5982.1 6008.1 6035.4 6453.8 6568.2 6597.7 6615.9 6644.5 5247.2 5247.4 5268.9 5283.6 5311.2 6849.5 6905.3 6923.2 6954.8 6975.4 5400.5 5401.6 5426.3 5459.8 5499.9 5558.1 5558.6 5570.2 5581.5 5599.0 5982.0 5985.4 6037.9 6046.8 6050.4 6553.0 6569.8 6580.5 6596.9 6659.4 1831.4 1870.3 1881.8 1889.2 1948.7 1428.3 1436.4 1436.8 1444.3 1463.8 5751.5 5802.1 5814.8 5821.8 5830.1 6531.9 6583.6 6637.7 6702.7 6734.8 5788.7 5807.7 5809.1 5876.9 5887.8 3505.9 3509.6 3531.0 3557.6 3567.2 6536.5 6559.2 6570.4 6576.4 6667.8 6830.4 6869.4 6886.6 6950.9 6958.2 6452.7 6461.4 6528.9 6554.9 6632.4 6644.8 6671.4 6696.5 6700.8 6707.7 6649.6 6661.8 6679.0 6698.2 6767.5 6459.6 6481.6 6498.4 6602.2 6615.9 4919.0 4939.8 4945.0 4976.4 4986.1 6779.7 6785.4 6825.4 6830.6 6856.4 6557.9 6582.6 6600.8 6636.8 6671.5 6471.9 6524.3 6533.8 6571.8 6602.9 6269.2 6319.6 6358.9 6487.2 6520.3 6410.4 6520.7 6538.8 6594.1 6609.1 6320.6 6373.7 6383.5 6415.8 6421.3 16:07:03 INFO - PID 13182 | 16:07:03 INFO - PID 13182 | [#5] yui.html Cycles:180 Average:23992.83 Median:19429.92 stddev:32759.58 (168.6%) stddev-sans-first:32805.50 16:07:03 INFO - PID 13182 | Values: 876.4 894.8 906.1 912.5 914.8 17719.3 18416.6 18460.4 18473.6 22383.6 19496.7 21262.3 21629.4 21630.7 21636.6 1037.4 1058.2 1059.2 1063.2 1065.2 1047.1 1047.5 1048.5 1049.4 1056.7 1122.8 1123.3 1123.6 1123.7 1130.3 1105.8 1112.4 1113.4 1114.0 1125.9 809.7 812.2 813.3 815.1 822.8 18570.9 18905.0 19033.9 19078.2 19246.0 21338.1 21467.6 21552.7 21745.9 21876.6 16567.8 16798.4 16906.2 17070.5 17197.3 3592.7 3616.9 3617.6 3623.3 3629.5 125064.4 125711.0 126542.4 126564.4 128416.4 16918.2 17408.5 17479.9 17535.7 18062.5 32164.2 32213.2 32381.0 32604.3 32854.2 6968.3 7267.3 7493.4 8402.4 8594.8 3745.1 3858.3 4168.5 4186.0 4192.9 5228.7 5455.3 5455.6 5457.8 5473.8 1056.4 1058.4 1095.8 1097.7 1105.6 688.6 699.0 699.1 708.9 716.1 11945.4 12443.4 12491.6 13102.5 13237.4 700.7 700.7 706.9 708.1 709.6 5495.8 5719.5 5720.3 6335.8 6496.3 110169.0 110335.4 116718.4 117254.0 121399.0 99747.0 102878.5 104188.0 107898.0 109077.5 92232.5 92482.0 92711.0 94129.0 94699.5 12947.1 13302.9 13336.0 13421.3 13454.0 37879.2 38879.6 39275.2 40177.6 40653.6 49703.0 50232.5 50428.2 50519.2 52091.4 19002.7 19415.1 19444.7 19488.0 19567.6 20997.0 21182.4 21389.1 21442.6 21467.4 19148.8 19533.7 19538.3 19635.6 19657.2 17557.2 17638.6 17737.4 17768.0 17796.1 18823.3 18938.2 18959.6 18975.5 19186.3 12958.5 13528.4 13723.4 13907.2 14260.1 14202.4 14459.3 14589.8 14990.0 15422.6 16:07:03 INFO - PID 13182 | -------- Summary: end -------- 16:07:03 INFO - PID 13182 | 16:07:04 INFO - TEST-INFO | 13182: exit 0 16:07:04 INFO - TEST-OK | dromaeo_css | took 1113272ms 16:07:04 INFO - TEST-START | kraken 16:07:04 INFO - Initialising browser for kraken test... 16:07:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52994/getInfo.html -profile /tmp/tmp_hqi0S/profile 16:07:04 INFO - TEST-INFO | started process 13559 (/builds/slave/test/build/application/firefox/firefox http://localhost:52994/getInfo.html) 16:07:10 INFO - TEST-INFO | 13559: exit 0 16:07:10 INFO - Browser initialized. 16:07:10 INFO - Running cycle 1/1 for kraken test... 16:07:10 INFO - TEST-INFO | started process 13794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_hqi0S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:11 INFO - PID 13794 | 16:07:11 INFO - PID 13794 | (/builds/slave/test/build/application/firefox/firefox:13849): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:07:11 INFO - PID 13794 | 16:07:21 INFO - PID 13794 | RSS: Main: 167567360 16:07:21 INFO - PID 13794 | 16:07:24 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52994/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:25 INFO - PID 13794 | RSS: Main: 174444544 16:07:25 INFO - PID 13794 | 16:07:27 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52994/tests/kraken/driver.html?testName=audio-dft) 16:07:28 INFO - PID 13794 | RSS: Main: 177983488 16:07:28 INFO - PID 13794 | 16:07:31 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52994/tests/kraken/driver.html?testName=audio-fft) 16:07:32 INFO - PID 13794 | RSS: Main: 171880448 16:07:32 INFO - PID 13794 | 16:07:34 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52994/tests/kraken/driver.html?testName=audio-oscillator) 16:07:35 INFO - PID 13794 | RSS: Main: 172507136 16:07:35 INFO - PID 13794 | 16:07:37 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52994/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:38 INFO - PID 13794 | RSS: Main: 172654592 16:07:38 INFO - PID 13794 | 16:07:41 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52994/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:41 INFO - PID 13794 | RSS: Main: 173838336 16:07:41 INFO - PID 13794 | 16:07:45 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52994/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:45 INFO - PID 13794 | RSS: Main: 173715456 16:07:45 INFO - PID 13794 | 16:07:48 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52994/tests/kraken/driver.html?testName=json-parse-financial) 16:07:49 INFO - PID 13794 | RSS: Main: 174239744 16:07:49 INFO - PID 13794 | 16:07:51 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52994/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:51 INFO - PID 13794 | RSS: Main: 174362624 16:07:51 INFO - PID 13794 | 16:07:53 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52994/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:54 INFO - PID 13794 | RSS: Main: 174170112 16:07:54 INFO - PID 13794 | 16:07:56 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52994/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:57 INFO - PID 13794 | RSS: Main: 173850624 16:07:57 INFO - PID 13794 | 16:07:59 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52994/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:00 INFO - PID 13794 | RSS: Main: 174256128 16:08:00 INFO - PID 13794 | 16:08:03 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52994/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:04 INFO - PID 13794 | RSS: Main: 174387200 16:08:04 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | Cycle 1(1): loaded http://localhost:52994/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52994/tests/kraken/driver.html?testName=ai-astar) 16:08:06 INFO - PID 13794 | RSS: Main: 175841280 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | __start_tp_report 16:08:06 INFO - PID 13794 | _x_x_mozilla_page_load 16:08:06 INFO - PID 13794 | _x_x_mozilla_page_load_details 16:08:06 INFO - PID 13794 | |i|pagename|runs| 16:08:06 INFO - PID 13794 | |0;ai-astar;98;113;100;106;110;109;111;99;109;107 16:08:06 INFO - PID 13794 | |1;audio-beat-detection;148;116;151;175;119;149;151;118;167;125 16:08:06 INFO - PID 13794 | |2;audio-dft;162;164;165;162;163;174;176;168;162;166 16:08:06 INFO - PID 13794 | |3;audio-fft;76;77;82;177;77;75;74;90;184;76 16:08:06 INFO - PID 13794 | |4;audio-oscillator;79;80;134;84;81;79;134;80;82;135 16:08:06 INFO - PID 13794 | |5;imaging-gaussian-blur;113;115;114;113;113;114;118;115;113;114 16:08:06 INFO - PID 13794 | |6;imaging-darkroom;152;150;152;151;152;151;153;155;151;152 16:08:06 INFO - PID 13794 | |7;imaging-desaturate;94;94;94;94;94;99;95;95;94;94 16:08:06 INFO - PID 13794 | |8;json-parse-financial;53;65;53;56;59;54;54;57;54;54 16:08:06 INFO - PID 13794 | |9;json-stringify-tinderbox;55;62;55;59;54;55;55;58;55;59 16:08:06 INFO - PID 13794 | |10;stanford-crypto-aes;80;80;82;81;78;77;78;78;79;81 16:08:06 INFO - PID 13794 | |11;stanford-crypto-ccm;135;127;128;133;134;133;133;141;134;163 16:08:06 INFO - PID 13794 | |12;stanford-crypto-pbkdf2;186;173;177;173;176;177;171;176;178;180 16:08:06 INFO - PID 13794 | |13;stanford-crypto-sha256-iterative;68;69;67;67;72;71;69;70;68;69 16:08:06 INFO - PID 13794 | __end_tp_report 16:08:06 INFO - PID 13794 | __start_cc_report 16:08:06 INFO - PID 13794 | _x_x_mozilla_cycle_collect,959 16:08:06 INFO - PID 13794 | __end_cc_report 16:08:06 INFO - PID 13794 | __startTimestamp1502752086505__endTimestamp 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | ------- Summary: start ------- 16:08:06 INFO - PID 13794 | Number of tests: 14 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#0] ai-astar Cycles:10 Average:106.20 Median:110.50 stddev:5.35 (4.8%) stddev-sans-first:4.78 16:08:06 INFO - PID 13794 | Values: 98.0 113.0 100.0 106.0 110.0 109.0 111.0 99.0 109.0 107.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:150.00 stddev:21.16 (14.1%) stddev-sans-first:22.33 16:08:06 INFO - PID 13794 | Values: 148.0 116.0 151.0 175.0 119.0 149.0 151.0 118.0 167.0 125.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.50 stddev:5.05 (3.1%) stddev-sans-first:5.12 16:08:06 INFO - PID 13794 | Values: 162.0 164.0 165.0 162.0 163.0 174.0 176.0 168.0 162.0 166.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#3] audio-fft Cycles:10 Average:98.80 Median:76.50 stddev:43.34 (56.7%) stddev-sans-first:45.18 16:08:06 INFO - PID 13794 | Values: 76.0 77.0 82.0 177.0 77.0 75.0 74.0 90.0 184.0 76.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:80.00 stddev:25.94 (32.4%) stddev-sans-first:26.71 16:08:06 INFO - PID 13794 | Values: 79.0 80.0 134.0 84.0 81.0 79.0 134.0 80.0 82.0 135.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.55 (1.4%) stddev-sans-first:1.58 16:08:06 INFO - PID 13794 | Values: 113.0 115.0 114.0 113.0 113.0 114.0 118.0 115.0 113.0 114.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 16:08:06 INFO - PID 13794 | Values: 152.0 150.0 152.0 151.0 152.0 151.0 153.0 155.0 151.0 152.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:1.64 16:08:06 INFO - PID 13794 | Values: 94.0 94.0 94.0 94.0 94.0 99.0 95.0 95.0 94.0 94.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:3.73 (6.8%) stddev-sans-first:3.80 16:08:06 INFO - PID 13794 | Values: 53.0 65.0 53.0 56.0 59.0 54.0 54.0 57.0 54.0 54.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:56.50 stddev:2.63 (4.6%) stddev-sans-first:2.71 16:08:06 INFO - PID 13794 | Values: 55.0 62.0 55.0 59.0 54.0 55.0 55.0 58.0 55.0 59.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:1.65 (2.1%) stddev-sans-first:1.73 16:08:06 INFO - PID 13794 | Values: 80.0 80.0 82.0 81.0 78.0 77.0 78.0 78.0 79.0 81.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:134.00 stddev:10.19 (7.6%) stddev-sans-first:10.80 16:08:06 INFO - PID 13794 | Values: 135.0 127.0 128.0 133.0 134.0 133.0 133.0 141.0 134.0 163.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:177.00 stddev:4.22 (2.4%) stddev-sans-first:2.83 16:08:06 INFO - PID 13794 | Values: 186.0 173.0 177.0 173.0 176.0 177.0 171.0 176.0 178.0 180.0 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.63 (2.4%) stddev-sans-first:1.69 16:08:06 INFO - PID 13794 | Values: 68.0 69.0 67.0 67.0 72.0 71.0 69.0 70.0 68.0 69.0 16:08:06 INFO - PID 13794 | -------- Summary: end -------- 16:08:06 INFO - PID 13794 | 16:08:06 INFO - PID 13794 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:08:07 INFO - TEST-INFO | 13794: exit 0 16:08:07 INFO - TEST-OK | kraken | took 62902ms 16:08:07 INFO - SUITE-END | took 1176s 16:08:07 INFO - Completed test suite (00:19:36) 16:08:07 INFO - javascript benchmark 16:08:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8551.753860060511, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.180693019815, 3153.3535625196823, 3155.479345907925, 3188.218886372839, 3201.6958388953058, 6110.205673262481, 6140.7543698252075, 6143.784967526138, 6155.876882462354, 6206.503479721623, 6028.492876780805, 6084.574079814415, 6113.174721412608, 6128.724207410666, 6153.046277826944, 5511.255980442639, 5545.667259964395, 5563.332400111992, 5594.440555944414, 5691.203231547586, 5652.576056795736, 5694.5729070319685, 5716.314042314907, 5717.971410142944, 5729.598928075036, 5508.944910550883, 5607.495325420711, 5673.404292549285, 5765.481106700396, 5782.450667186632, 5599.076152434844, 5608.383077861432, 5664.320281566238, 5686.886262274773, 5703.828885133453, 5542.196381524696, 5576.414476479952, 5629.521490673298, 5650.773969041234, 5670.461306175906, 5893.7053147342895, 5932.377100404438, 5940.811837632447, 5963.731632076524, 6151.261848578154, 6428.132202152697, 6506.284308726036, 6539.934600654028, 6559.6064236145985, 6570.967145164292, 6589.209294884597, 6589.472842172662, 6605.9669701651665, 6611.86776264472, 6617.371349721769, 6093.512518998514, 6098.6340819551415, 6104.328523862371, 6107.4808641265545, 6110.052941794029, 6663.600183988976, 6726.428253598499, 6730.93269067303, 6733.360330768569, 6740.123783908159, 6385.297617262097, 6409.679516024274, 6413.005984072476, 6414.679266036679, 6424.357564243538, 6163.260408750979, 6518.380753828379, 6527.118838956775, 6586.571872828251, 6676.031975363545, 6520.217573891164, 6545.21457425112, 6611.570247933869, 6628.4697224221945, 6678.599284042973, 6487.837804054842, 6543.312952140052, 6567.376099270562, 6567.9671601641685, 6584.11114499546, 5284.867878302996, 5292.947070529322, 5303.204519322056, 5306.336707911511, 5309.2301616266195, 4586.8394606189295, 4636.79134438951, 4647.6281897448125, 4656.790444430008, 4656.837010704609, 5688.317401911797, 5758.0787074068785, 5762.798302059407, 5771.624844385102, 5782.739776710058, 6491.935080649133, 6509.414152726183, 6604.8348791280605, 6611.438027767694, 6635.037919501645, 5657.773689052392, 5683.914741278884, 5712.971665100239, 5732.57005724564, 5738.741756620962, 5640.266765320564, 5733.426657334317, 5745.798897038583, 5749.396313387034, 5800.825975220666, 6438.645874476949, 6460.515461340418, 6461.741530338733, 6531.118299029666, 6537.869242615121, 6419.358064193543, 6503.51223658237, 6505.186851643544, 6695.966520167368, 6721.630310332978, 6356.3325850785, 6392.840178995562, 6403.9359606405205, 6408.391202835724, 6413.647249401328, 6528.955367141235, 6536.6731663415685, 6538.051982462612, 6538.378854008862, 6548.116004339353, 6597.736090556324, 6603.900941485786, 6667.899981500378, 6695.4978376620975, 6706.329367063255, 6353.237611486651, 6363.268224154282, 6454.838629034311, 6457.741690332334, 6489.286178520265, 6202.4107709769305, 6294.527910406646, 6380.872382552416, 6443.96778016107, 6462.806115816533, 6242.531810114168, 6290.559660823698, 6291.150694656346, 6303.212098487689, 6310.716017779303, 6429.678516074271, 6465.127207827071, 6511.446527045065, 6515.315891831479, 6524.380183882524, 6150.815475535562, 6203.0, 6215.751369945152, 6247.09417134522, 6252.09344645033], "value": 6001.676501784655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.274892218231, 866.1684782608696, 891.376036774258, 1183.781000514905, 1198.0355813570072, 30805.537916931236, 31375.21561960952, 41677.58322416775, 42201.0, 42327.0, 42762.35856462156, 43094.569054309446, 43299.13401731964, 43375.78312108443, 43464.348034779505, 7313.744018959337, 7672.7698169054875, 7916.445848790587, 7917.9208207918045, 7934.7222847200355, 7726.0, 7799.727009554666, 7819.0, 7822.178671239523, 7828.178041305638, 7740.574268415235, 7742.225777422241, 7782.533048017137, 7806.60966951653, 7816.960915195416, 7808.648610812499, 7813.453058285922, 7829.804254893616, 7838.137804841492, 7846.333061689735, 7598.392128629696, 7644.46488745788, 7651.617419129021, 7729.420293478011, 7746.41901857363, 39981.0, 40232.396514052314, 40417.59582404168, 40422.59577404247, 40503.392449113286, 3606.0, 3645.76302540334, 3648.1426864686778, 3651.087228192952, 3653.5250417445827, 31488.212794680087, 31544.842275788473, 31582.842085789653, 31801.52297715536, 31840.203994900083, 5042.3949126104735, 5083.669561478492, 5118.334616499868, 5151.9484805152215, 5155.845324640267, 190821.0, 192288.9999999986, 192298.0, 192488.0, 192836.0358198214, 48170.518294816604, 48280.0, 48337.516624833304, 50097.74951125221, 50892.0, 52431.0, 52562.474375255755, 52640.21039684408, 52679.73660131675, 52693.209601856004, 15769.921150394175, 15896.841031589767, 16838.24227909747, 16857.747133793004, 16928.57678558021, 12440.502379904703, 12483.687907802196, 12503.937480312723, 12511.687207819878, 12553.937230313973, 14449.92775036139, 14451.566453006426, 14621.488247911484, 14698.706025879423, 14712.117272963656, 6027.638341699512, 6079.179310793074, 6085.326535202855, 6089.847753806191, 6114.6942652868065, 1018.7198520406947, 1027.306568066552, 1028.7993841201044, 1029.7528593137592, 1034.2450011491503, 23179.768202317762, 23493.295201143992, 23850.880745596507, 28868.42263154767, 29566.852165739034, 1098.593520397458, 1108.4014632098576, 1113.6714669172613, 1114.8439218509416, 1115.4924509348227, 12327.50689972391, 12604.432800523815, 12611.87388126107, 12681.239125652306, 12719.173253738663, 248681.0, 250326.0, 250414.0, 250982.0, 251280.0, 51321.743391282806, 51817.22274165891, 51998.22002669963, 52023.47976520262, 52136.21795673068, 1469.177260733971, 1479.607903905466, 1510.5090845475045, 1514.8182218133895, 1525.3212320517484, 22838.42903927415, 23098.614083155066, 23124.190653327052, 23425.648615271126, 23448.64827027562, 37894.0, 38197.23605527818, 38215.23569528538, 38226.426603601525, 38308.42537361886, 225551.0, 228775.0, 229214.0, 229491.0, 229562.0, 37890.24219515539, 37951.24097517979, 37993.43009854799, 38201.23597528089, 38258.426123608726, 45282.77358613186, 46258.0, 46399.536004640875, 46621.0, 46637.0, 34273.0, 34509.482357765155, 34702.30595388028, 34949.12627184341, 35467.645323546436, 34110.317793643495, 34206.97379078532, 34294.48558271578, 34561.827190863885, 35389.469157962136, 37729.05677358088, 37757.622423775414, 38024.429633554966, 38216.23567528578, 38237.0, 33553.66446335505, 33777.66222337844, 33841.32317353688, 33929.0, 33969.0, 24424.51150976935, 24808.875955620108, 24846.751532484443, 25268.62097068582, 25309.62035569431], "value": 17770.505035745344, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.8657835541114, 544.1918750655274, 557.3868744381181, 570.948614624684, 577.5293136094083, 16718.164091795392, 22898.77101228987, 23750.64374034391, 23868.5226295474, 23886.5222695546, 18261.178246978885, 22465.775342246572, 23315.76684233157, 23368.0, 23550.057997680073, 6172.598781079238, 6403.839904002414, 6404.103425520431, 6405.519586031043, 6407.423331900128, 5876.853078673024, 6254.249490061176, 6345.555811093225, 6397.712102955355, 6400.743970241208, 6374.58565193261, 6376.394242546974, 6376.585521941059, 6377.872442551146, 6379.425851673349, 6273.905891411632, 6317.463015643676, 6356.841078973016, 6371.044343348489, 6387.776427825004, 5922.615030023035, 5934.732937017801, 5948.196993405922, 5949.0, 5953.493953013955, 27988.720112798816, 29112.12663620095, 29667.0, 29691.406171876657, 29849.70150298491, 1897.8386837118862, 1927.9974413305142, 1929.6623090959026, 1930.0156919970775, 1930.1025023364202, 18705.812941870543, 19294.71057934132, 19305.51736206606, 19310.32413865522, 19316.130774115198, 2304.7234331880113, 2317.0963324303534, 2332.6734257204007, 2393.5930891748444, 2397.3407312988893, 136084.0, 139597.0, 139717.0, 139869.0, 139949.3002534991, 14375.712485750435, 14961.476348327757, 14973.251337433085, 14990.625234369229, 15178.696426071638, 23040.53918921612, 23142.42143946381, 23157.53684926292, 23175.536489270457, 23220.883895580413, 10103.494825258707, 10170.542325595366, 10183.388996660076, 10267.640632577824, 10347.844782328271, 9523.0, 9527.666531671359, 9560.426374417557, 9687.321887467951, 9700.27247956406, 7567.545947243183, 9019.819603607892, 9125.543722813833, 9243.768905777275, 9244.949166775083, 2766.70363598213, 2768.349437882096, 2826.1804076817903, 2828.363618185933, 2888.35012122275, 957.262907561174, 961.7066794627706, 963.3304853127149, 982.4449186209912, 989.6486747204783, 18873.0, 19316.034198290028, 19401.32095376655, 19701.60596788085, 19816.40550783479, 1015.1929216272933, 1021.6730646193296, 1029.583018877356, 1036.290141253244, 1042.0569384706853, 10648.414337211529, 10870.565177392973, 10887.23789334739, 10984.670459886216, 11140.275882067639, 511086.0, 517741.0, 534909.0, 535561.0, 541543.0, 107968.0, 115565.42217289028, 115891.42054289674, 116311.41844290894, 116567.0, 1175.8295047218105, 1205.8914697677076, 1207.607527553531, 1208.4078801387257, 1212.5695378140633, 17599.20803563817, 17747.29010839552, 17794.911025445308, 20319.288824891057, 21614.243501477373, 55552.72223638856, 56530.0, 57460.1380979294, 58128.0, 59699.0, 68531.65734171496, 69157.30842691509, 69186.30813691799, 69223.65388173229, 69453.30546694469, 12147.149699520949, 13316.267605281802, 14524.709505810037, 14951.102933824006, 15024.549263522113, 22909.427264318525, 23596.646050309602, 23601.29196124119, 24034.51930961406, 24098.63852042256, 18656.906715466335, 18951.0524473773, 19120.0, 19180.328688495836, 19248.0, 15524.301406436964, 17320.480385588453, 17339.2197351117, 17764.111794409968, 18024.639507210046, 19185.712214316518, 20232.89883550573, 20367.0, 20372.59254814866, 20402.59194816125, 14464.566063018126, 14474.565763027125, 14621.19583422922, 14644.26778661084, 14741.705165896836, 16037.438689645807, 16131.0, 16177.757333639769, 16214.702823774305, 18012.36956706509], "value": 11869.057711851978, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.946282148714, 1383.9446422143114, 1393.804867318575, 1401.1523028567717, 1406.7256884907445, 13493.2578708171, 13884.722305553896, 13995.160290382584, 14009.439622415104, 14150.292485375741, 14733.631659208526, 14847.1091734496, 14851.331690073946, 14859.92570037151, 14912.254387280647, 2618.3977685132477, 2650.7216742242076, 2650.7481789230087, 2651.9602205966926, 2666.0935282004116, 2506.636537702032, 2601.765841074303, 2723.8229515081557, 2725.68654604721, 2734.5214587447217, 2612.4775044990984, 2627.408833012576, 2637.9472410551775, 2645.3254420122844, 2650.695170055449, 2596.44176502052, 2605.583106702928, 2651.0986264669914, 2654.522186006518, 2661.2814540074073, 2439.6706444629926, 2471.653968444419, 2566.5765148750434, 2615.5161295160456, 2621.606758986148, 14089.506867259597, 14117.223552704598, 14189.290535473185, 14236.928815355857, 14250.572482825532, 7467.589282589455, 7733.4199935004535, 7740.342070923978, 7744.535327880289, 7746.690132394698, 4800.399950006249, 4992.925106123411, 5165.586753059746, 5166.276721259027, 5177.016366890279, 1690.6618676264795, 1744.389463687712, 1775.8934463932205, 1810.3211295764088, 1823.5714607067328, 21922.123115075377, 22030.779692203032, 22058.669119963215, 22070.117195312167, 22110.0, 6231.781887634002, 6468.676566171766, 6801.42187914023, 6951.617661028692, 7012.053372794608, 15569.299381527859, 15590.688186236212, 15661.608459788597, 15731.685366292839, 15734.0, 7312.0, 7413.8146546336775, 7417.184109747924, 7442.367398771057, 7905.802354941057, 6925.722971081201, 7060.646967651597, 7067.787966361017, 7087.468439867031, 7101.786946391617, 5041.823536176216, 5057.317262169634, 5092.38891333035, 5100.438951715309, 5138.152204886152, 1465.0696807527083, 1471.8675319221322, 1472.9189894555689, 1485.9034162779385, 1508.1177511155877, 861.4443683823898, 885.4819930340694, 905.9501727405056, 909.3952521573212, 912.7859946271576, 7346.559206447523, 8914.420562663407, 9061.728148155566, 9194.12655797698, 9228.215601673799, 933.8319102561468, 941.2987324443196, 980.7940332530106, 989.3766926836047, 1009.9899001010043, 5110.284560161506, 5458.4814442627885, 5512.80705175325, 5804.448577385142, 5875.29496460419, 18624.0, 19037.238510459705, 19153.521161970784, 19300.517487062654, 19849.801501985083, 19704.90147549253, 19869.205231790565, 19880.70178947317, 19903.30338438177, 20025.499362516053, 10106.14097801695, 10242.53908574116, 10279.588816447407, 10287.279890407599, 10298.0, 8338.77520500491, 8388.161183881562, 8625.8706119407, 8678.0, 8726.30189584819, 16650.417235396704, 16656.333746649998, 16896.40862569804, 16945.23746431438, 17516.562085947953, 17192.22634981454, 17293.740593891354, 17513.649727005133, 17541.0, 17619.55951101233, 11645.47595358194, 11774.94112529432, 11783.646490605295, 11843.940780296043, 11927.940360298144, 13169.209847409185, 13228.933855330662, 13283.667908301983, 13285.734285314433, 13304.600861974157, 10649.148068154684, 10750.13998880072, 10762.946185269024, 10765.3540787553, 10810.29733067348, 10272.075513203847, 10435.895641043493, 10466.0, 10495.737606559896, 10625.149988000787, 9588.0, 9602.0, 9653.46905920181, 9683.709488715349, 9791.706248812547, 7303.707851685873, 7323.084614423197, 7341.669624866787, 7365.0, 7408.481406301507, 7294.96352518234, 7339.559626422431, 7342.5227360221415, 7342.70629174827, 7429.554226746196], "value": 6426.28234064108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.1543787305446, 499.48655573611956, 519.174512525085, 522.8745101175718, 534.4154581665362, 6108.419700128492, 6217.129601855732, 6219.129321894939, 6239.25128984522, 6268.655223962686, 5931.644101353911, 6012.5791194616395, 6049.727762250698, 6081.148639190517, 6088.543359248052, 4835.903281934368, 4838.846713212622, 4863.829765958192, 4873.756312184377, 4895.5838753705975, 4762.238041913277, 4862.78117484714, 4912.852614421573, 4930.137225985456, 4930.235813448903, 4945.530174633404, 5017.724025178613, 5042.369703787027, 5130.38435387754, 5135.204043373283, 5075.695458272497, 5133.486651334855, 5153.819616313449, 5188.221766734982, 5198.92201616976, 4732.408448943882, 4748.19280722278, 4757.405324334458, 4759.190937540627, 4764.166270902613, 5989.31122920861, 6027.638341699512, 6094.542909281821, 6094.695265236721, 6138.8772224555705, 5929.2212336298935, 5973.820785376446, 5982.132590774357, 6008.098785182214, 6035.426634469718, 6453.83865403364, 6568.1789776277965, 6597.670116494156, 6615.867682646368, 6644.468442524587, 5247.160454327328, 5247.449017853109, 5268.947310526884, 5283.603729720248, 5311.150215965427, 6849.452043836481, 6905.343992320722, 6923.238443771181, 6954.7575978652985, 6975.4070903973225, 5400.540954018952, 5401.5969938938215, 5426.294581704353, 5459.754311056012, 5499.862503437366, 5558.055130627803, 5558.610897237236, 5570.220169176318, 5581.5255703265675, 5598.972005139948, 5982.012967860342, 5985.371535988746, 6037.9396206038255, 6046.758129674852, 6050.42520960508, 6553.049807777846, 6569.766279465005, 6580.539362244693, 6596.934030659728, 6659.367360100783, 1831.432256000644, 1870.3453791173254, 1881.8400435963097, 1889.1593241007895, 1948.658984677704, 1428.3144090836456, 1436.3967133803828, 1436.791665208539, 1444.2995147353524, 1463.817022872141, 5751.482366587027, 5802.056311135732, 5814.825555233349, 5821.79623713168, 5830.105215804881, 6531.8693626127215, 6583.572067815577, 6637.676813115371, 6702.731890724316, 6734.831629209309, 5788.739506722208, 5807.709614519257, 5809.128630705428, 5876.885250817074, 5887.8233652990475, 3505.9123521912156, 3509.649035096521, 3530.9760169551055, 3557.6086630470627, 3567.162911100785, 6536.542442029012, 6559.212894452697, 6570.375814297634, 6576.375244351779, 6667.799966001027, 6830.419414349736, 6869.416099631488, 6886.586804791728, 6950.895736563955, 6958.234594194634, 6452.677366131768, 6461.418472337512, 6528.902066469007, 6554.934450655433, 6632.403083722488, 6644.767433139817, 6671.399574038166, 6696.464282857262, 6700.798976030727, 6707.7255321488765, 6649.603583247572, 6661.800145995628, 6679.0, 6698.196216454056, 6767.492438067263, 6459.609944320444, 6481.634203515777, 6498.3826536478955, 6602.1747281589805, 6615.900761488678, 4918.975405122951, 4939.827106051271, 4944.975275123601, 4976.357801925428, 4986.12742770021, 6779.661016949145, 6785.355391237825, 6825.419839313714, 6830.624315662488, 6856.382925536725, 6557.9344206557325, 6582.605043697394, 6600.80197594073, 6636.83407914806, 6671.466282697275, 6471.935280647133, 6524.3149469305035, 6533.771318003847, 6571.769988050586, 6602.933970660232, 6269.247690277196, 6319.6208227506495, 6358.936410635834, 6487.18910136233, 6520.250171230179, 6410.391012853772, 6520.673966301761, 6538.823011857721, 6594.142761440982, 6609.140811694641, 6320.5891617044745, 6373.7131829066875, 6383.457406120532, 6415.824167037346, 6421.293657697556], "value": 5152.897601996764, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.360257012381, 894.7584152278883, 906.1346414174465, 912.4753266871546, 914.8444764390055, 17719.291228350867, 18416.631667366662, 18460.353887613936, 18473.630527389443, 22383.55232895341, 19496.70754938677, 21262.255821046267, 21629.351119466442, 21630.675539866876, 21636.567268654617, 1037.4034929915272, 1058.201058201057, 1059.2267644619394, 1063.2238465919884, 1065.1798115451097, 1047.1099565369414, 1047.5443182215722, 1048.4705223861938, 1049.3546468921634, 1056.6882769582992, 1122.8091224491816, 1123.2586492914677, 1123.6179698902372, 1123.6572845282185, 1130.3161587239724, 1105.7622611138604, 1112.4048633980863, 1113.4154568851377, 1113.9777204455866, 1125.8705248896358, 809.7125520440277, 812.1837553258996, 813.3290035720554, 815.135955886756, 822.8148666550038, 18570.907145464185, 18905.0, 19033.904830475898, 19078.23687052516, 19246.03769811518, 21338.146474141016, 21467.57064858694, 21552.676709849366, 21745.891270543703, 21876.562468750537, 16567.83432165675, 16798.41205557812, 16906.239219235165, 17070.48788536346, 17197.312107515685, 3592.676659100667, 3616.8734094306838, 3617.620149884277, 3623.3477973964677, 3629.491871138043, 125064.37467812603, 125711.0, 126542.36728816298, 126564.36717816352, 128416.35791821075, 16918.154092295335, 17408.47774566765, 17479.912600436917, 17535.73696394555, 18062.458126256235, 32164.19589510234, 32213.194670133435, 32381.0, 32604.347913041605, 32854.178645534055, 6968.303169683092, 7267.345938865422, 7493.4005279577505, 8402.41183117176, 8594.78513037179, 3745.1011757178626, 3858.2862170498547, 4168.499780026416, 4186.0, 4192.895177620523, 5228.660137091077, 5455.345358556999, 5455.645383050089, 5457.808976685797, 5473.781048758085, 1056.4084112896803, 1058.3649810114025, 1095.802755504017, 1097.6816723150198, 1105.5964572930823, 688.5902887781762, 698.9899595085155, 699.0876905638089, 708.8794904866082, 716.1370548489058, 11945.402729863472, 12443.377831108408, 12491.562795302121, 13102.475900964046, 13237.404316805767, 700.7162099349772, 700.7302188657403, 706.9151701795818, 708.0582824842946, 709.6097146569366, 5495.789757573916, 5719.48524632785, 5720.3421606515785, 6335.841603959938, 6496.317886621931, 110169.0, 110335.44832275787, 116718.38054095067, 117254.0, 121399.0, 99747.0, 102878.48560757148, 104188.0, 107898.0, 109077.45461272643, 92232.53883730539, 92481.99999999866, 92711.0, 94129.0, 94699.52650236705, 12947.093703440669, 13302.93348533251, 13335.999800015232, 13421.26183059902, 13453.990950678934, 37879.24241515099, 38879.6112038876, 39275.2144957105, 40177.598224018555, 40653.59346406498, 49703.0, 50232.49767502424, 50428.243576347115, 50519.24221136759, 52091.43725688235, 19002.714959275898, 19415.126319315383, 19444.70832937479, 19488.0, 19567.60864782668, 20997.0, 21182.364529064154, 21389.14443422308, 21442.57114857663, 21467.355979320644, 19148.808511914704, 19533.70699439481, 19538.31615893437, 19635.607287854447, 19657.213711451383, 17557.209925553125, 17638.647227055644, 17737.37919172823, 17768.0, 17796.110194490484, 18823.34118305853, 18938.242470301033, 18959.620807584048, 18975.525611859815, 19186.328478503186, 12958.481660733465, 13528.39122239482, 13723.382447789674, 13907.235102069078, 14260.144391336553, 14202.360893759598, 14459.349329280418, 14589.781153282922, 14990.0, 15422.614434639223], "value": 9330.48365313664, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 113.0, 100.0, 106.0, 110.0, 109.0, 111.0, 99.0, 109.0, 107.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 151.0, 175.0, 119.0, 149.0, 151.0, 118.0, 167.0, 125.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 162.0, 163.0, 174.0, 176.0, 168.0, 162.0, 166.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 82.0, 177.0, 77.0, 75.0, 74.0, 90.0, 184.0, 76.0], "value": 98.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 134.0, 84.0, 81.0, 79.0, 134.0, 80.0, 82.0, 135.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 113.0, 114.0, 118.0, 115.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 152.0, 151.0, 152.0, 151.0, 153.0, 155.0, 151.0, 152.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 65.0, 53.0, 56.0, 59.0, 54.0, 54.0, 57.0, 54.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 55.0, 59.0, 54.0, 55.0, 55.0, 58.0, 55.0, 59.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 82.0, 81.0, 78.0, 77.0, 78.0, 78.0, 79.0, 81.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 127.0, 128.0, 133.0, 134.0, 133.0, 133.0, 141.0, 134.0, 163.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 173.0, 177.0, 173.0, 176.0, 177.0, 171.0, 176.0, 178.0, 180.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 67.0, 72.0, 71.0, 69.0, 70.0, 68.0, 69.0], "value": 69.0, "unit": "score"}]}]} 16:08:07 INFO - Return code: 0 16:08:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:07 INFO - # TBPL SUCCESS # 16:08:07 INFO - Running post-action listener: _package_coverage_data 16:08:07 INFO - Running post-action listener: _resource_record_post_action 16:08:07 INFO - [mozharness: 2017-08-14 23:08:07.797877Z] Finished run-tests step (success) 16:08:07 INFO - Running post-run listener: _resource_record_post_run 16:08:07 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434401280; Read time: 16; Write time: 350204 16:08:07 INFO - TinderboxPrint: CPU usage
13.1% 16:08:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:08:07 INFO - TinderboxPrint: I/O write bytes / time
434,401,280 / 350,204 16:08:07 INFO - TinderboxPrint: CPU idle
8,273.1 (86.8%) 16:08:07 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 16:08:07 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 110751744; Read time: 0; Write time: 108072 16:08:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:08:07 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 323649536; Read time: 0; Write time: 242132 16:08:08 INFO - Running post-run listener: _upload_blobber_files 16:08:08 INFO - Blob upload gear active. 16:08:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:08 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 16:08:08 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'] 16:08:08 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 16:08:08 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:09 INFO - (blobuploader) - INFO - Done attempting. 16:08:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:08:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:08:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:10 INFO - (blobuploader) - INFO - Done attempting. 16:08:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:17 INFO - (blobuploader) - INFO - Done attempting. 16:08:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:18 INFO - (blobuploader) - INFO - Done attempting. 16:08:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:18 INFO - Return code: 0 16:08:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5371d3ad6c244397648bc4e923f50aa6def5d962ac1e63b3598803621d1a2367a626b9c2804455949399468d892618c1e3a1806b03b7e5b909f2075b8a15c223", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bb0826523fc6f4de25602c28e354797a69a510c0e18b01fdfb893deec3a862fa86581f6e787f4f47bd5d3a95599af46708e9e80821093598138d86586d62d39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f429a469774c8bd8336a89cf1ab2ad6b67956fb6b4d728586624947ef93eee0e74a7ef6e9071d2447bdc056875d22073bbeb8b9450ee79face2e6df49553572", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5150f5b8424c17004924b8b32e355ee2fe2e04fd104b611c060974ad304c93653b99d61f0e967c6f369561ba99b9aaff29f69be266a4b3b49c284b0f936a82db"} 16:08:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:18 INFO - Contents: 16:08:18 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5371d3ad6c244397648bc4e923f50aa6def5d962ac1e63b3598803621d1a2367a626b9c2804455949399468d892618c1e3a1806b03b7e5b909f2075b8a15c223", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bb0826523fc6f4de25602c28e354797a69a510c0e18b01fdfb893deec3a862fa86581f6e787f4f47bd5d3a95599af46708e9e80821093598138d86586d62d39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f429a469774c8bd8336a89cf1ab2ad6b67956fb6b4d728586624947ef93eee0e74a7ef6e9071d2447bdc056875d22073bbeb8b9450ee79face2e6df49553572", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5150f5b8424c17004924b8b32e355ee2fe2e04fd104b611c060974ad304c93653b99d61f0e967c6f369561ba99b9aaff29f69be266a4b3b49c284b0f936a82db"} 16:08:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:18 INFO - Copying logs to upload dir... 16:08:18 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.422720 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-08-14 16:08:18.090129) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 16:08:18.097227) ========= 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=337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317 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/5371d3ad6c244397648bc4e923f50aa6def5d962ac1e63b3598803621d1a2367a626b9c2804455949399468d892618c1e3a1806b03b7e5b909f2075b8a15c223", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bb0826523fc6f4de25602c28e354797a69a510c0e18b01fdfb893deec3a862fa86581f6e787f4f47bd5d3a95599af46708e9e80821093598138d86586d62d39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f429a469774c8bd8336a89cf1ab2ad6b67956fb6b4d728586624947ef93eee0e74a7ef6e9071d2447bdc056875d22073bbeb8b9450ee79face2e6df49553572", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5150f5b8424c17004924b8b32e355ee2fe2e04fd104b611c060974ad304c93653b99d61f0e967c6f369561ba99b9aaff29f69be266a4b3b49c284b0f936a82db"} build_url:https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5371d3ad6c244397648bc4e923f50aa6def5d962ac1e63b3598803621d1a2367a626b9c2804455949399468d892618c1e3a1806b03b7e5b909f2075b8a15c223", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bb0826523fc6f4de25602c28e354797a69a510c0e18b01fdfb893deec3a862fa86581f6e787f4f47bd5d3a95599af46708e9e80821093598138d86586d62d39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f429a469774c8bd8336a89cf1ab2ad6b67956fb6b4d728586624947ef93eee0e74a7ef6e9071d2447bdc056875d22073bbeb8b9450ee79face2e6df49553572", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5150f5b8424c17004924b8b32e355ee2fe2e04fd104b611c060974ad304c93653b99d61f0e967c6f369561ba99b9aaff29f69be266a4b3b49c284b0f936a82db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 16:08:18.126777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 16:08:18.127060) ========= 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=337fe3f4b1febe37b85fccc40000019e-1502749233.606735-955279317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 16:08:18.206292) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 16:08:18.206569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 16:08:18.209858) ========= ========= Total master_lag: 0.40 =========