builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1502919079.48 results: success (0) revision: 833f84d0d5c729054a3aa8b3f34735f56fe6436b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:19.482423) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:19.482877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:19.483167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:19.497584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:19.497955) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 14:31:19-- 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% 50.6M=0s 2017-08-16 14:31:20 (50.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:19.640773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:19.641209) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024097 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:19.694126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:19.694511) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 833f84d0d5c729054a3aa8b3f34735f56fe6436b --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 833f84d0d5c729054a3aa8b3f34735f56fe6436b --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=05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 14:31:20,158 truncating revision to first 12 chars 2017-08-16 14:31:20,158 Setting DEBUG logging. 2017-08-16 14:31:20,158 attempt 1/10 2017-08-16 14:31:20,158 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/833f84d0d5c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 14:31:20,480 unpacking tar archive at: mozilla-central-833f84d0d5c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:20.365375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:20.365730) ========= script_repo_revision: 833f84d0d5c729054a3aa8b3f34735f56fe6436b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:20.366111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:20.366374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 14:31:20.378548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-16 14:31:20.378924) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:31:20 INFO - MultiFileLogger online at 20170816 14:31:20 in /builds/slave/test 14:31:20 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 14:31:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:20 INFO - {'append_to_log': False, 14:31:20 INFO - 'base_work_dir': '/builds/slave/test', 14:31:20 INFO - 'blob_upload_branch': 'Firefox', 14:31:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:20 INFO - 'branch': 'Firefox', 14:31:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:20 INFO - 'code_coverage': False, 14:31:20 INFO - 'config_files': ('talos/linux_config.py',), 14:31:20 INFO - 'default_actions': ('clobber', 14:31:20 INFO - 'read-buildbot-config', 14:31:20 INFO - 'download-and-extract', 14:31:20 INFO - 'populate-webroot', 14:31:20 INFO - 'create-virtualenv', 14:31:20 INFO - 'install', 14:31:20 INFO - 'setup-mitmproxy', 14:31:20 INFO - 'run-tests'), 14:31:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:20 INFO - 'disable_ccov_upload': False, 14:31:20 INFO - 'download_minidump_stackwalk': True, 14:31:20 INFO - 'download_symbols': 'ondemand', 14:31:20 INFO - 'enable_stylo': False, 14:31:20 INFO - 'enable_webrender': False, 14:31:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:20 INFO - 'gecko_profile': False, 14:31:20 INFO - 'gecko_profile_interval': 0, 14:31:20 INFO - 'installer_path': 'installer.exe', 14:31:20 INFO - 'log_level': 'info', 14:31:20 INFO - 'log_name': 'talos', 14:31:20 INFO - 'log_to_console': True, 14:31:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:31:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:31:20 INFO - 'opt_config_files': (), 14:31:20 INFO - 'pip_index': False, 14:31:20 INFO - 'suite': 'dromaeojs-e10s', 14:31:20 INFO - 'system_bits': '32', 14:31:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:20 INFO - 'title': 'talos-linux64-ix-069', 14:31:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:20 INFO - 'use_talos_json': True, 14:31:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:20 INFO - 'work_dir': 'build'} 14:31:20 INFO - [mozharness: 2017-08-16 21:31:20.943828Z] Running clobber step. 14:31:20 INFO - Running pre-action listener: _resource_record_pre_action 14:31:20 INFO - Running main action method: clobber 14:31:20 INFO - rmtree: /builds/slave/test/build 14:31:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:22 INFO - Running post-action listener: _resource_record_post_action 14:31:22 INFO - [mozharness: 2017-08-16 21:31:22.670737Z] Finished clobber step (success) 14:31:22 INFO - [mozharness: 2017-08-16 21:31:22.670838Z] Running read-buildbot-config step. 14:31:22 INFO - Running pre-action listener: _resource_record_pre_action 14:31:22 INFO - Running main action method: read_buildbot_config 14:31:22 INFO - Using buildbot properties: 14:31:22 INFO - { 14:31:22 INFO - "project": "", 14:31:22 INFO - "product": "firefox", 14:31:22 INFO - "who": "ryanvm@gmail.com", 14:31:22 INFO - "installer_path": "public/build/target.tar.bz2", 14:31:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 14:31:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:31:22 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 14:31:22 INFO - "stage_platform": "linux64-stylosequential", 14:31:22 INFO - "basedir": "/builds/slave/test", 14:31:22 INFO - "buildnumber": 152, 14:31:22 INFO - "platform": "ubuntu64_hw_styloseq", 14:31:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:31:22 INFO - "slavebuilddir": "test", 14:31:22 INFO - "taskId": "bO8tZsAbQi2cLjw2Bw8euA", 14:31:22 INFO - "branch": "mozilla-central", 14:31:22 INFO - "script_repo_revision": "production", 14:31:22 INFO - "revision": "833f84d0d5c729054a3aa8b3f34735f56fe6436b", 14:31:22 INFO - "slavename": "talos-linux64-ix-069", 14:31:22 INFO - "repo_path": "mozilla-central" 14:31:22 INFO - } 14:31:22 INFO - Finding installer, test and symbols from parent task. 14:31:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO8tZsAbQi2cLjw2Bw8euA'}, attempt #1 14:31:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO8tZsAbQi2cLjw2Bw8euA'}, attempt #1 14:31:23 INFO - Task dependencies: ZbYi7e4SShuLRJRdD3myxg 14:31:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg'}, attempt #1 14:31:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.tar.bz2 14:31:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.test_packages.json 14:31:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.crashreporter-symbols.zip 14:31:24 INFO - Running post-action listener: _resource_record_post_action 14:31:24 INFO - [mozharness: 2017-08-16 21:31:24.018593Z] Finished read-buildbot-config step (success) 14:31:24 INFO - [mozharness: 2017-08-16 21:31:24.018815Z] Running download-and-extract step. 14:31:24 INFO - Running pre-action listener: _resource_record_pre_action 14:31:24 INFO - Running main action method: download_and_extract 14:31:24 INFO - mkdir: /builds/slave/test/build/tests 14:31:24 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')]} 14:31:24 INFO - trying https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.test_packages.json 14:31:24 INFO - Downloading https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:31:24 INFO - Downloaded 989 bytes. 14:31:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:31:24 INFO - Using the following test package requirements: 14:31:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:31:24 INFO - u'common': [u'target.common.tests.zip'], 14:31:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:31:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:31:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:31:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:31:24 INFO - u'mozbase': [u'target.common.tests.zip'], 14:31:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:31:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:31:24 INFO - u'web-platform': [u'target.common.tests.zip', 14:31:24 INFO - u'target.web-platform.tests.tar.gz'], 14:31:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:31:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:31:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.common.tests.zip 14:31:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:31:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.common.tests.zip into memory 14:31:25 INFO - Content-Length response header: 54003921 14:31:25 INFO - Bytes received: 54003921 14:31:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:31:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.common.tests.zip 14:31:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:31:36 INFO - Fetch https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.common.tests.zip into memory 14:31:37 INFO - Content-Length response header: 54003921 14:31:37 INFO - Bytes received: 54003921 14:31:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.talos.tests.zip 14:31:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:31:49 INFO - Fetch https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.talos.tests.zip into memory 14:31:50 INFO - Content-Length response header: 14496050 14:31:50 INFO - Bytes received: 14496050 14:31:50 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')]} 14:31:50 INFO - trying https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.tar.bz2 14:31:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:31:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:31:51 INFO - Downloaded 61710599 bytes. 14:31:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.tar.bz2 14:31:51 INFO - mkdir: /builds/slave/test/properties 14:31:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:51 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:51 INFO - Contents: 14:31:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.tar.bz2 14:31:51 INFO - Running post-action listener: _resource_record_post_action 14:31:51 INFO - Running post-action listener: set_extra_try_arguments 14:31:51 INFO - [mozharness: 2017-08-16 21:31:51.647862Z] Finished download-and-extract step (success) 14:31:51 INFO - [mozharness: 2017-08-16 21:31:51.647960Z] Running populate-webroot step. 14:31:51 INFO - Running pre-action listener: _resource_record_pre_action 14:31:51 INFO - Running main action method: populate_webroot 14:31:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:31:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:31:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:31:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:31:51 INFO - 'tests': ['damp', 'tps']}, 14:31:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:31:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:31:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:31:51 INFO - 'other-e10s': {'tests': ['a11yr', 14:31:51 INFO - 'ts_paint', 14:31:51 INFO - 'tpaint', 14:31:51 INFO - 'sessionrestore', 14:31:51 INFO - 'sessionrestore_many_windows', 14:31:51 INFO - 'sessionrestore_no_auto_restore', 14:31:51 INFO - 'tabpaint']}, 14:31:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:31:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:31:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:31:51 INFO - 'tsvgr_opacity', 14:31:51 INFO - 'tart', 14:31:51 INFO - 'tscrollx', 14:31:51 INFO - 'tsvg_static']}, 14:31:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:31:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:31:51 INFO - 'talos_options': ['--mitmproxy', 14:31:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:31:51 INFO - '--firstNonBlankPaint'], 14:31:51 INFO - 'tests': ['tp6_google', 14:31:51 INFO - 'tp6_youtube', 14:31:51 INFO - 'tp6_amazon', 14:31:51 INFO - 'tp6_facebook']}, 14:31:51 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:31:51 INFO - 'talos_options': ['--stylo', 14:31:51 INFO - '--mitmproxy', 14:31:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:31:51 INFO - '--firstNonBlankPaint'], 14:31:51 INFO - 'tests': ['tp6_google', 14:31:51 INFO - 'tp6_youtube', 14:31:51 INFO - 'tp6_amazon', 14:31:51 INFO - 'tp6_facebook']}, 14:31:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:31:51 INFO - 'talos_options': ['--stylo', 14:31:51 INFO - '--stylo-threads=1', 14:31:51 INFO - '--mitmproxy', 14:31:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:31:51 INFO - '--firstNonBlankPaint'], 14:31:51 INFO - 'tests': ['tp6_google', 14:31:51 INFO - 'tp6_youtube', 14:31:51 INFO - 'tp6_amazon', 14:31:51 INFO - 'tp6_facebook']}, 14:31:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:31:51 INFO - 'talos_options': ['--xperf_path', 14:31:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:51 INFO - 'tests': ['tp5n']}}} 14:31:51 INFO - Running post-action listener: _resource_record_post_action 14:31:51 INFO - [mozharness: 2017-08-16 21:31:51.656871Z] Finished populate-webroot step (success) 14:31:51 INFO - [mozharness: 2017-08-16 21:31:51.656971Z] Running create-virtualenv step. 14:31:51 INFO - Running pre-action listener: _resource_record_pre_action 14:31:51 INFO - Running main action method: create_virtualenv 14:31:51 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31:51 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 14:31:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:31:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:51 INFO - Using real prefix '/usr' 14:31:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:52 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:54 INFO - Installing pip.................done. 14:31:54 INFO - Return code: 0 14:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:31:54 INFO - Reading from file tmpfile_stdout 14:31:54 INFO - Output received: 14:31:54 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) 14:31:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31:54 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')]} 14:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:54 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')]} 14:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:54 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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:31:54 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 14:31:54 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 14:31:54 INFO - Using env: {'DISPLAY': ':0', 14:31:54 INFO - 'HOME': '/home/cltbld', 14:31:54 INFO - 'LANG': 'en_US.UTF-8', 14:31:54 INFO - 'LANGUAGE': 'en_US:en', 14:31:54 INFO - 'LOGNAME': 'cltbld', 14:31:54 INFO - 'MAIL': '/var/mail/cltbld', 14:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:54 INFO - 'MOZ_NO_REMOTE': '1', 14:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:54 INFO - 'NO_EM_RESTART': '1', 14:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:54 INFO - 'PWD': '/builds/slave/test', 14:31:54 INFO - 'SHELL': '/bin/bash', 14:31:54 INFO - 'SHLVL': '1', 14:31:54 INFO - 'TERM': 'linux', 14:31:54 INFO - 'TMOUT': '86400', 14:31:54 INFO - 'USER': 'cltbld', 14:31:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:54 INFO - '_': '/tools/buildbot/bin/python'} 14:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:54 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 14:31:54 INFO - Cleaning up... 14:31:54 INFO - Return code: 0 14:31:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:31:54 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')]} 14:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:54 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')]} 14:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:54 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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:31:54 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 14:31:54 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 14:31:54 INFO - Using env: {'DISPLAY': ':0', 14:31:54 INFO - 'HOME': '/home/cltbld', 14:31:54 INFO - 'LANG': 'en_US.UTF-8', 14:31:54 INFO - 'LANGUAGE': 'en_US:en', 14:31:54 INFO - 'LOGNAME': 'cltbld', 14:31:54 INFO - 'MAIL': '/var/mail/cltbld', 14:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:54 INFO - 'MOZ_NO_REMOTE': '1', 14:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:54 INFO - 'NO_EM_RESTART': '1', 14:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:54 INFO - 'PWD': '/builds/slave/test', 14:31:54 INFO - 'SHELL': '/bin/bash', 14:31:54 INFO - 'SHLVL': '1', 14:31:54 INFO - 'TERM': 'linux', 14:31:54 INFO - 'TMOUT': '86400', 14:31:54 INFO - 'USER': 'cltbld', 14:31:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:54 INFO - '_': '/tools/buildbot/bin/python'} 14:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:54 INFO - Downloading/unpacking psutil>=3.1.1 14:31:54 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 14:31:54 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 14:31:54 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 14:31:54 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 14:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:56 INFO - Installing collected packages: psutil 14:31:56 INFO - Running setup.py install for psutil 14:31:56 INFO - building 'psutil._psutil_linux' extension 14:31: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 14:31: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 14:31:56 INFO - building 'psutil._psutil_posix' extension 14:31: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 14:31: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:31:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:56 INFO - Successfully installed psutil 14:31:56 INFO - Cleaning up... 14:31:56 INFO - Return code: 0 14:31:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:31:56 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')]} 14:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:56 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')]} 14:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:56 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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:31:56 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 14:31:56 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 14:31:56 INFO - Using env: {'DISPLAY': ':0', 14:31:56 INFO - 'HOME': '/home/cltbld', 14:31:56 INFO - 'LANG': 'en_US.UTF-8', 14:31:56 INFO - 'LANGUAGE': 'en_US:en', 14:31:56 INFO - 'LOGNAME': 'cltbld', 14:31:56 INFO - 'MAIL': '/var/mail/cltbld', 14:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:56 INFO - 'MOZ_NO_REMOTE': '1', 14:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:56 INFO - 'NO_EM_RESTART': '1', 14:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:56 INFO - 'PWD': '/builds/slave/test', 14:31:56 INFO - 'SHELL': '/bin/bash', 14:31:56 INFO - 'SHLVL': '1', 14:31:56 INFO - 'TERM': 'linux', 14:31:56 INFO - 'TMOUT': '86400', 14:31:56 INFO - 'USER': 'cltbld', 14:31:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:56 INFO - '_': '/tools/buildbot/bin/python'} 14:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:31:58 INFO - Installing collected packages: mozsystemmonitor 14:31:58 INFO - Running setup.py install for mozsystemmonitor 14:31:58 INFO - Successfully installed mozsystemmonitor 14:31:58 INFO - Cleaning up... 14:31:58 INFO - Return code: 0 14:31:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31: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')]} 14:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31: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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:31: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 14:31: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 14:31:58 INFO - Using env: {'DISPLAY': ':0', 14:31:58 INFO - 'HOME': '/home/cltbld', 14:31:58 INFO - 'LANG': 'en_US.UTF-8', 14:31:58 INFO - 'LANGUAGE': 'en_US:en', 14:31:58 INFO - 'LOGNAME': 'cltbld', 14:31:58 INFO - 'MAIL': '/var/mail/cltbld', 14:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:58 INFO - 'MOZ_NO_REMOTE': '1', 14:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:58 INFO - 'NO_EM_RESTART': '1', 14:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:58 INFO - 'PWD': '/builds/slave/test', 14:31:58 INFO - 'SHELL': '/bin/bash', 14:31:58 INFO - 'SHLVL': '1', 14:31:58 INFO - 'TERM': 'linux', 14:31:58 INFO - 'TMOUT': '86400', 14:31:58 INFO - 'USER': 'cltbld', 14:31:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:58 INFO - '_': '/tools/buildbot/bin/python'} 14:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:58 INFO - Downloading/unpacking jsonschema==2.5.1 14:31:58 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 14:31:58 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 14:31:58 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 14:31:58 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 14:31:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:31:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:31: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 14:31: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 14:31: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 14:31: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 14:31:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:31:59 INFO - warning: no files found matching '*.txt' 14:31:59 INFO - no previously-included directories found matching 'build' 14:31:59 INFO - no previously-included directories found matching 'dist' 14:31:59 INFO - no previously-included directories found matching '.git*' 14:31:59 INFO - Installing collected packages: jsonschema, functools32 14:31:59 INFO - Running setup.py install for functools32 14:31:59 INFO - warning: no files found matching '*.txt' 14:31:59 INFO - no previously-included directories found matching 'build' 14:31:59 INFO - no previously-included directories found matching 'dist' 14:31:59 INFO - no previously-included directories found matching '.git*' 14:31:59 INFO - Successfully installed jsonschema functools32 14:31:59 INFO - Cleaning up... 14:31:59 INFO - Return code: 0 14:31:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:31:59 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')]} 14:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:59 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')]} 14:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:59 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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:31:59 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 14:31:59 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 14:31:59 INFO - Using env: {'DISPLAY': ':0', 14:31:59 INFO - 'HOME': '/home/cltbld', 14:31:59 INFO - 'LANG': 'en_US.UTF-8', 14:31:59 INFO - 'LANGUAGE': 'en_US:en', 14:31:59 INFO - 'LOGNAME': 'cltbld', 14:31:59 INFO - 'MAIL': '/var/mail/cltbld', 14:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:59 INFO - 'MOZ_NO_REMOTE': '1', 14:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:59 INFO - 'NO_EM_RESTART': '1', 14:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:59 INFO - 'PWD': '/builds/slave/test', 14:31:59 INFO - 'SHELL': '/bin/bash', 14:31:59 INFO - 'SHLVL': '1', 14:31:59 INFO - 'TERM': 'linux', 14:31:59 INFO - 'TMOUT': '86400', 14:31:59 INFO - 'USER': 'cltbld', 14:31:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:59 INFO - '_': '/tools/buildbot/bin/python'} 14:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:32:00 INFO - Cleaning up... 14:32:00 INFO - Return code: 0 14:32:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32: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')]} 14:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32: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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:32: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 14:32: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 14:32:00 INFO - Using env: {'DISPLAY': ':0', 14:32:00 INFO - 'HOME': '/home/cltbld', 14:32:00 INFO - 'LANG': 'en_US.UTF-8', 14:32:00 INFO - 'LANGUAGE': 'en_US:en', 14:32:00 INFO - 'LOGNAME': 'cltbld', 14:32:00 INFO - 'MAIL': '/var/mail/cltbld', 14:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:00 INFO - 'MOZ_NO_REMOTE': '1', 14:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:00 INFO - 'NO_EM_RESTART': '1', 14:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:00 INFO - 'PWD': '/builds/slave/test', 14:32:00 INFO - 'SHELL': '/bin/bash', 14:32:00 INFO - 'SHLVL': '1', 14:32:00 INFO - 'TERM': 'linux', 14:32:00 INFO - 'TMOUT': '86400', 14:32:00 INFO - 'USER': 'cltbld', 14:32:00 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:00 INFO - '_': '/tools/buildbot/bin/python'} 14:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:00 INFO - Downloading/unpacking blobuploader==1.2.4 14:32: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 14:32: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 14:32: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 14:32: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 14:32:01 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32: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 14:32: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 14:32: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 14:32: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 14:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32: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 14:32: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 14:32: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 14:32: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 14:32:01 INFO - Downloading docopt-0.6.1.tar.gz 14:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:02 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:02 INFO - Running setup.py install for blobuploader 14:32:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:02 INFO - Running setup.py install for requests 14:32:02 INFO - Running setup.py install for docopt 14:32:02 INFO - Successfully installed blobuploader requests docopt 14:32:02 INFO - Cleaning up... 14:32:02 INFO - Return code: 0 14:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:02 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')]} 14:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:02 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')]} 14:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:02 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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:32:02 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 14:32:02 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 14:32:02 INFO - Using env: {'DISPLAY': ':0', 14:32:02 INFO - 'HOME': '/home/cltbld', 14:32:02 INFO - 'LANG': 'en_US.UTF-8', 14:32:02 INFO - 'LANGUAGE': 'en_US:en', 14:32:02 INFO - 'LOGNAME': 'cltbld', 14:32:02 INFO - 'MAIL': '/var/mail/cltbld', 14:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:02 INFO - 'MOZ_NO_REMOTE': '1', 14:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:02 INFO - 'NO_EM_RESTART': '1', 14:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:02 INFO - 'PWD': '/builds/slave/test', 14:32:02 INFO - 'SHELL': '/bin/bash', 14:32:02 INFO - 'SHLVL': '1', 14:32:02 INFO - 'TERM': 'linux', 14:32:02 INFO - 'TMOUT': '86400', 14:32:02 INFO - 'USER': 'cltbld', 14:32:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:02 INFO - '_': '/tools/buildbot/bin/python'} 14:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:02 INFO - Running setup.py (path:/tmp/pip-4mvgx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:02 INFO - Running setup.py (path:/tmp/pip-9lH6yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:03 INFO - Running setup.py (path:/tmp/pip-HcUtPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:03 INFO - Running setup.py (path:/tmp/pip-RoMiXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:03 INFO - Running setup.py (path:/tmp/pip-EqrUrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:03 INFO - Running setup.py (path:/tmp/pip-I2r0qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:03 INFO - Running setup.py (path:/tmp/pip-j2Qq6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:03 INFO - Running setup.py (path:/tmp/pip-U93fFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:03 INFO - Running setup.py (path:/tmp/pip-0N3a8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:03 INFO - Running setup.py (path:/tmp/pip-wgEsrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:03 INFO - Running setup.py (path:/tmp/pip-B3mOUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:03 INFO - Running setup.py (path:/tmp/pip-KKDD6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:03 INFO - Running setup.py (path:/tmp/pip-Yt7Pqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:03 INFO - Running setup.py (path:/tmp/pip-gY6A8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:04 INFO - Running setup.py (path:/tmp/pip-IHeiLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:04 INFO - Running setup.py (path:/tmp/pip-KvC46s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:04 INFO - Running setup.py (path:/tmp/pip-aXdXF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:04 INFO - Running setup.py install for manifestparser 14:32:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:04 INFO - Running setup.py install for mozcrash 14:32:04 INFO - Running setup.py install for mozdebug 14:32:04 INFO - Running setup.py install for mozdevice 14:32:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:04 INFO - Running setup.py install for mozfile 14:32:04 INFO - Running setup.py install for mozhttpd 14:32:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:04 INFO - Running setup.py install for mozinfo 14:32:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:04 INFO - Running setup.py install for mozInstall 14:32:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Running setup.py install for mozleak 14:32:05 INFO - Running setup.py install for mozlog 14:32:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Running setup.py install for moznetwork 14:32:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Running setup.py install for mozprocess 14:32:05 INFO - Running setup.py install for mozprofile 14:32:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Running setup.py install for mozrunner 14:32:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:32:05 INFO - Running setup.py install for mozscreenshot 14:32:05 INFO - Running setup.py install for moztest 14:32:05 INFO - Running setup.py install for mozversion 14:32:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:32:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:32:06 INFO - Cleaning up... 14:32:06 INFO - Return code: 0 14:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32: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')]} 14:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32: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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:32: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 14:32: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 14:32:06 INFO - Using env: {'DISPLAY': ':0', 14:32:06 INFO - 'HOME': '/home/cltbld', 14:32:06 INFO - 'LANG': 'en_US.UTF-8', 14:32:06 INFO - 'LANGUAGE': 'en_US:en', 14:32:06 INFO - 'LOGNAME': 'cltbld', 14:32:06 INFO - 'MAIL': '/var/mail/cltbld', 14:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:06 INFO - 'MOZ_NO_REMOTE': '1', 14:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:06 INFO - 'NO_EM_RESTART': '1', 14:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:06 INFO - 'PWD': '/builds/slave/test', 14:32:06 INFO - 'SHELL': '/bin/bash', 14:32:06 INFO - 'SHLVL': '1', 14:32:06 INFO - 'TERM': 'linux', 14:32:06 INFO - 'TMOUT': '86400', 14:32:06 INFO - 'USER': 'cltbld', 14:32:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:06 INFO - '_': '/tools/buildbot/bin/python'} 14:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:06 INFO - Running setup.py (path:/tmp/pip-Qh3pFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32: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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:06 INFO - Running setup.py (path:/tmp/pip-oouvHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32: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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:06 INFO - Running setup.py (path:/tmp/pip-xzt9XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:06 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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:06 INFO - Running setup.py (path:/tmp/pip-nPS5US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:06 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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:06 INFO - Running setup.py (path:/tmp/pip-UnSVM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:06 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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:06 INFO - Running setup.py (path:/tmp/pip-8ZHc36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:06 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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:06 INFO - Running setup.py (path:/tmp/pip-hcpHPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:06 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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:06 INFO - Running setup.py (path:/tmp/pip-6XDemu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:06 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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:06 INFO - Running setup.py (path:/tmp/pip-vL8edI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:06 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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:06 INFO - Running setup.py (path:/tmp/pip-o2Us46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:06 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)) 14:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:06 INFO - Running setup.py (path:/tmp/pip-TlDkjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32: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)) 14:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:07 INFO - Running setup.py (path:/tmp/pip-cpeomE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32: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)) 14:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:07 INFO - Running setup.py (path:/tmp/pip-QCqatG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32: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)) 14:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:07 INFO - Running setup.py (path:/tmp/pip-EMuopa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32: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)) 14:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:07 INFO - Running setup.py (path:/tmp/pip-oCqTNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32: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)) 14:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:07 INFO - Running setup.py (path:/tmp/pip-H9lPjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32: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)) 14:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:07 INFO - Running setup.py (path:/tmp/pip-9vSJVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:07 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)) 14:32:07 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)) 14:32:07 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)) 14:32:07 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)) 14:32:07 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)) 14:32:07 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)) 14:32:07 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)) 14:32:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32:07 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 14:32:07 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 14:32:07 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 14:32:07 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 14:32:08 INFO - Downloading blessings-1.6.tar.gz 14:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:32:08 INFO - Installing collected packages: blessings 14:32:08 INFO - Running setup.py install for blessings 14:32:08 INFO - Successfully installed blessings 14:32:08 INFO - Cleaning up... 14:32:08 INFO - Return code: 0 14:32:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:09 INFO - Reading from file tmpfile_stdout 14:32:09 INFO - Current package versions: 14:32:09 INFO - argparse == 1.2.1 14:32:09 INFO - blessings == 1.6 14:32:09 INFO - blobuploader == 1.2.4 14:32:09 INFO - docopt == 0.6.1 14:32:09 INFO - functools32 == 3.2.3-2 14:32:09 INFO - jsonschema == 2.5.1 14:32:09 INFO - manifestparser == 1.1 14:32:09 INFO - mozInstall == 1.13 14:32:09 INFO - mozcrash == 1.0 14:32:09 INFO - mozdebug == 0.1 14:32:09 INFO - mozdevice == 0.51 14:32:09 INFO - mozfile == 1.2 14:32:09 INFO - mozhttpd == 0.7 14:32:09 INFO - mozinfo == 0.10 14:32:09 INFO - mozleak == 0.1 14:32:09 INFO - mozlog == 3.5 14:32:09 INFO - moznetwork == 0.27 14:32:09 INFO - mozprocess == 0.25 14:32:09 INFO - mozprofile == 0.28 14:32:09 INFO - mozrunner == 6.13 14:32:09 INFO - mozscreenshot == 0.1 14:32:09 INFO - mozsystemmonitor == 0.3 14:32:09 INFO - moztest == 0.8 14:32:09 INFO - mozversion == 1.4 14:32:09 INFO - psutil == 3.1.1 14:32:09 INFO - requests == 1.2.3 14:32:09 INFO - wsgiref == 0.1.2 14:32:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32: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')]} 14:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32: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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:32: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 14:32: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 14:32:09 INFO - Using env: {'DISPLAY': ':0', 14:32:09 INFO - 'HOME': '/home/cltbld', 14:32:09 INFO - 'LANG': 'en_US.UTF-8', 14:32:09 INFO - 'LANGUAGE': 'en_US:en', 14:32:09 INFO - 'LOGNAME': 'cltbld', 14:32:09 INFO - 'MAIL': '/var/mail/cltbld', 14:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:09 INFO - 'MOZ_NO_REMOTE': '1', 14:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:09 INFO - 'NO_EM_RESTART': '1', 14:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:09 INFO - 'PWD': '/builds/slave/test', 14:32:09 INFO - 'SHELL': '/bin/bash', 14:32:09 INFO - 'SHLVL': '1', 14:32:09 INFO - 'TERM': 'linux', 14:32:09 INFO - 'TMOUT': '86400', 14:32:09 INFO - 'USER': 'cltbld', 14:32:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:09 INFO - '_': '/tools/buildbot/bin/python'} 14:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32: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)) 14:32: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)) 14:32: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)) 14:32: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)) 14:32: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)) 14:32: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)) 14:32: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)) 14:32: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)) 14:32: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)) 14:32:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:32: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 14:32: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 14:32: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 14:32: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 14:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:32: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)) 14:32: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)) 14:32:10 INFO - Installing collected packages: simplejson 14:32:10 INFO - Running setup.py install for simplejson 14:32:10 INFO - building 'simplejson._speedups' extension 14:32:10 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 14:32: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 14:32:11 INFO - Successfully installed simplejson 14:32:11 INFO - Cleaning up... 14:32:11 INFO - Return code: 0 14:32:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:32:11 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')]} 14:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:11 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')]} 14:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x176b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a12ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', '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 14:32:11 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 14:32:11 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 14:32:11 INFO - Using env: {'DISPLAY': ':0', 14:32:11 INFO - 'HOME': '/home/cltbld', 14:32:11 INFO - 'LANG': 'en_US.UTF-8', 14:32:11 INFO - 'LANGUAGE': 'en_US:en', 14:32:11 INFO - 'LOGNAME': 'cltbld', 14:32:11 INFO - 'MAIL': '/var/mail/cltbld', 14:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:11 INFO - 'MOZ_NO_REMOTE': '1', 14:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:11 INFO - 'NO_EM_RESTART': '1', 14:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:11 INFO - 'PWD': '/builds/slave/test', 14:32:11 INFO - 'SHELL': '/bin/bash', 14:32:11 INFO - 'SHLVL': '1', 14:32:11 INFO - 'TERM': 'linux', 14:32:11 INFO - 'TMOUT': '86400', 14:32:11 INFO - 'USER': 'cltbld', 14:32:11 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:11 INFO - '_': '/tools/buildbot/bin/python'} 14:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:32:11 INFO - Cleaning up... 14:32:11 INFO - Return code: 0 14:32:11 INFO - Running post-action listener: _resource_record_post_action 14:32:11 INFO - Running post-action listener: _start_resource_monitoring 14:32:11 INFO - Starting resource monitoring. 14:32:11 INFO - [mozharness: 2017-08-16 21:32:11.763802Z] Finished create-virtualenv step (success) 14:32:11 INFO - [mozharness: 2017-08-16 21:32:11.764310Z] Running install step. 14:32:11 INFO - Running pre-action listener: _resource_record_pre_action 14:32:11 INFO - Running main action method: install 14:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:11 INFO - Reading from file tmpfile_stdout 14:32:11 INFO - Detecting whether we're running mozinstall >=1.0... 14:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:32:12 INFO - Reading from file tmpfile_stdout 14:32:12 INFO - Output received: 14:32:12 INFO - Usage: mozinstall [options] installer 14:32:12 INFO - Options: 14:32:12 INFO - -h, --help show this help message and exit 14:32:12 INFO - -d DEST, --destination=DEST 14:32:12 INFO - Directory to install application into. [default: 14:32:12 INFO - "/builds/slave/test"] 14:32:12 INFO - --app=APP Application being installed. [default: firefox] 14:32:12 INFO - mkdir: /builds/slave/test/build/application 14:32: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'] 14:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:32:30 INFO - Reading from file tmpfile_stdout 14:32:30 INFO - Output received: 14:32:30 INFO - /builds/slave/test/build/application/firefox/firefox 14:32:30 INFO - Running post-action listener: _resource_record_post_action 14:32:30 INFO - [mozharness: 2017-08-16 21:32:30.054858Z] Finished install step (success) 14:32:30 INFO - [mozharness: 2017-08-16 21:32:30.055112Z] Running setup-mitmproxy step. 14:32:30 INFO - Running pre-action listener: _resource_record_pre_action 14:32:30 INFO - Running main action method: setup_mitmproxy 14:32:30 INFO - Skipping: mitmproxy is not required 14:32:30 INFO - Running post-action listener: _resource_record_post_action 14:32:30 INFO - [mozharness: 2017-08-16 21:32:30.056264Z] Finished setup-mitmproxy step (success) 14:32:30 INFO - [mozharness: 2017-08-16 21:32:30.056491Z] Running run-tests step. 14:32:30 INFO - Running pre-action listener: _resource_record_pre_action 14:32:30 INFO - Running pre-action listener: _set_gcov_prefix 14:32:30 INFO - Running main action method: run_tests 14:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:30 INFO - Python 2.7.3 14:32:30 INFO - Return code: 0 14:32:30 INFO - grabbing minidump binary from tooltool 14:32: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')]} 14:32: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 0x1a100b0>, '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 0x1a10fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a11440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32: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 14:32: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 14:32: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 14:32:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:30 INFO - Return code: 0 14:32:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:32:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:30 INFO - ENV: RUST_BACKTRACE is now full 14:32:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:32:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32: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/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 14:32: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/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 14:32:30 INFO - Using env: {'DISPLAY': ':0', 14:32:30 INFO - 'HOME': '/home/cltbld', 14:32:30 INFO - 'LANG': 'en_US.UTF-8', 14:32:30 INFO - 'LANGUAGE': 'en_US:en', 14:32:30 INFO - 'LOGNAME': 'cltbld', 14:32:30 INFO - 'MAIL': '/var/mail/cltbld', 14:32:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:30 INFO - 'MOZ_NO_REMOTE': '1', 14:32:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:30 INFO - 'NO_EM_RESTART': '1', 14:32:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:30 INFO - 'PWD': '/builds/slave/test', 14:32:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:30 INFO - 'RUST_BACKTRACE': 'full', 14:32:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:32:30 INFO - 'SHELL': '/bin/bash', 14:32:30 INFO - 'SHLVL': '1', 14:32:30 INFO - 'STYLO_FORCE_ENABLED': '1', 14:32:30 INFO - 'TERM': 'linux', 14:32:30 INFO - 'TMOUT': '86400', 14:32:30 INFO - 'USER': 'cltbld', 14:32:30 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296', 14:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:30 INFO - '_': '/tools/buildbot/bin/python'} 14:32: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/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 14:32:30 INFO - mozversion application_buildid: 20170816203421 14:32:30 INFO - mozversion application_changeset: 833f84d0d5c729054a3aa8b3f34735f56fe6436b 14:32:30 INFO - mozversion application_display_name: Nightly 14:32:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:30 INFO - mozversion application_name: Firefox 14:32:30 INFO - mozversion application_remotingname: firefox 14:32:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:32:30 INFO - mozversion application_vendor: Mozilla 14:32:30 INFO - mozversion application_version: 57.0a1 14:32:30 INFO - mozversion platform_buildid: 20170816203421 14:32:30 INFO - mozversion platform_changeset: 833f84d0d5c729054a3aa8b3f34735f56fe6436b 14:32:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:32:30 INFO - mozversion platform_version: 57.0a1 14:32:30 INFO - using testdate: 1502919150 14:32:30 INFO - actual date: 1502919150 14:32:30 INFO - starting webserver on 'localhost:55866' 14:32:30 INFO - SUITE-START | Running 2 tests 14:32:30 INFO - TEST-START | dromaeo_css 14:32:30 INFO - Initialising browser for dromaeo_css test... 14:32:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55866/getInfo.html -profile /tmp/tmpTlmHhb/profile 14:32:30 INFO - TEST-INFO | started process 20364 (/builds/slave/test/build/application/firefox/firefox http://localhost:55866/getInfo.html) 14:32:36 INFO - TEST-INFO | 20364: exit 0 14:32:36 INFO - Browser initialized. 14:32:36 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:36 INFO - TEST-INFO | started process 20598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTlmHhb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:37 INFO - PID 20598 | 14:32:37 INFO - PID 20598 | (/builds/slave/test/build/application/firefox/firefox:20653): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:32:37 INFO - PID 20598 | 14:32:47 INFO - PID 20598 | RSS: Main: 167952384 14:32:47 INFO - PID 20598 | 14:35:47 INFO - PID 20598 | Cycle 1(1): loaded http://localhost:55866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55866/tests/dromaeo/cssquery-ext.html) 14:35:48 INFO - PID 20598 | RSS: Main: 174981120 14:35:48 INFO - PID 20598 | 14:38:50 INFO - PID 20598 | Cycle 1(1): loaded http://localhost:55866/tests/dromaeo/cssquery-ext.html (next: http://localhost:55866/tests/dromaeo/cssquery-jquery.html) 14:38:50 INFO - PID 20598 | RSS: Main: 172703744 14:38:50 INFO - PID 20598 | 14:41:52 INFO - PID 20598 | Cycle 1(1): loaded http://localhost:55866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55866/tests/dromaeo/cssquery-mootools.html) 14:41:53 INFO - PID 20598 | RSS: Main: 174571520 14:41:53 INFO - PID 20598 | 14:44:55 INFO - PID 20598 | Cycle 1(1): loaded http://localhost:55866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55866/tests/dromaeo/cssquery-prototype.html) 14:44:55 INFO - PID 20598 | RSS: Main: 173113344 14:44:55 INFO - PID 20598 | 14:47:59 INFO - PID 20598 | Cycle 1(1): loaded http://localhost:55866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55866/tests/dromaeo/cssquery-yui.html) 14:48:00 INFO - PID 20598 | RSS: Main: 176459776 14:48:00 INFO - PID 20598 | 14:51:01 INFO - PID 20598 | Cycle 1(1): loaded http://localhost:55866/tests/dromaeo/cssquery-yui.html (next: http://localhost:55866/tests/dromaeo/cssquery-dojo.html) 14:51:02 INFO - PID 20598 | RSS: Main: 177123328 14:51:02 INFO - PID 20598 | 14:51:02 INFO - PID 20598 | __start_tp_report 14:51:02 INFO - PID 20598 | _x_x_mozilla_page_load 14:51:02 INFO - PID 20598 | _x_x_mozilla_page_load_details 14:51:02 INFO - PID 20598 | |i|pagename|runs| 14:51:02 INFO - PID 20598 | |0;dojo.html;3149.5748074010003;3165.2245199926024;3181.347823696142;3187.8884239051636;3210.1653570071776;6094.2991555971075;6099.878002439948;6160.106784516248;6189;6238.0642903564485;6103.969480152593;6163.476104531109;6167.81496555103;6176.073588961658;6188.071789231618;5564.276644036269;5648.293963254583;5653.1237658162845;5670.631408958425;5689.431056894319;5658.009848276535;5661.8584535386735;5674.631148975303;5678.517326027272;5690.7439165237665;5713.285839270091;5754.913676294859;5782.768689252446;5806.796762113327;5860.824175274749;5700.572457065695;5713.5714821388565;5725.055365864669;5797.594168408213;5809.593328467009;5450.482204190595;5523.889522209533;5582;5600.551955843523;5634.380218176038;6023.27720673522;6096.664683442409;6115.602485838451;6127.938720612781;6131.172291740602;6552.213734351908;6614.7023383947835;6641.800745977628;6668.233153187397;6685.565438246498;6539.28067912534;6645.136132302818;6650.9667451662435;6727.966360168168;6742.932570674328;6047.606905551125;6151.077338399231;6235.158253635701;6237.781677641261;6243.906341404837;6769.42459890905;6826.078479405316;6871.4502839773695;6880.793576192722;6883.449324054063;6366.808995730135;6470.870582588416;6520.315366886409;6527.836804079936;6619.139511863427;6417.647029413333;6447.451966582799;6537.411632953057;6641.169853768279;6743.898841517381;6531.510136739764;6556.868862622721;6595.274519802818;6622.2715501294815;6677.998300255001;6512.511561632802;6625.204975402886;6651.833704157435;6665.866682666319;6670.932650775852;5360.115580929103;5368.1679339702405;5441.047816632074;5448.073827449343;5481.725913704299;4472.642188624902;4524.864254072383;4531.592156705912;4539.7049191802425;4653.906921861611;5738.942610573924;5818.330891947396;5821.330546987151;5823.155642431909;5823.650580965155;6664.900026499607;6715.630640314829;6727.29363416844;6732.427743641845;6732.764353247613;5777.595568310178;5801.100829371454;5859.765609375662;5888.263967004124;5889.1755154278435;5739.598228124075;5817.447342502455;5832.504237139806;5903.173555702205;5988.131720900445;6363.9045414318825;6395.360463953567;6399.072134540465;6425.1968503937005;6561.803145905535;6583.506237032146;6649.301823308483;6658.334166583497;6662.56693314933;6690.632015239208;6409.391107844747;6507.6746162692625;6533.314002029909;6536.182977127859;6544.6727663615675;6415.679216039272;6433.292337842927;6514.446272066927;6522.412982831568;6558.540902136805;6545.934540654723;6565.80302590923;6607.00894865774;6642.734290628321;6731.091302674076;6324.367563243823;6344.9048264277;6357.904631430625;6366.108744775827;6448.355164483514;6448.677566121582;6477.028445733178;6486.967565162144;6492;6492.253390859923;6348.301686814354;6404.1674582304;6405.071264666504;6420.6147631142285;6427.132337134427;6407.359264073555;6509.772157974448;6549.6070235786;6554.57395269325;6567.802965911031;6141.263048434216;6259.78090766821;6263.123162757309;6270.0908368287255;6270.278917924497 14:51:02 INFO - PID 20598 | |1;ext.html;701.4388489208632;761.3642608421967;781.8162731758035;797.5972134072292;1142.6343570057586;30617.846910765442;31156.376872462537;41316.58683413165;41530.792346038266;41880.581194188046;42662.14675706484;42796.35805462913;42813.14373712524;42893.78553107238;42907;7409.5183813052245;7438.070241219848;7569.280918312779;7580.090389153309;7605.315521603055;7450.441216908726;7548.5848278344665;7549.320561149495;7549.7357592483995;7557.735479258227;7553.5090219135855;7564.470487065908;7607.733729319475;7609.048868891388;7612.543247405146;7484.438667099962;7526.9247307526775;7548.433867459935;7549.962250188769;7560.810979725496;7438.66526006331;7473.177950425449;7477.1775104738435;7515.699372025112;7523.09722833258;37314.25371492582;37549;37607.24785504275;37731;37771.43342849832;3453.861845526176;3493.196564790087;3495.7902525848276;3496.370653282408;3498.6851183393615;31377.372452551048;31378.843105784552;31572.526412103838;31723.52414713781;31743.682563174305;4926.5812405945535;4928.28539861718;4939.2838038484215;5018.949810501885;5031;195404;196552;196916;197148;198125.99999999854;48445.5155448441;48515.272270915964;48516.51483485191;48533;48657.756711216214;51214;51216;51225.48774512282;51310;51420;13488.258145802076;13751.587452376445;16375.508734737978;16695.83304166967;16727.16364181786;13535.32323383827;13665.590032299047;13804.723905521832;13808.928660700974;13812.240326781923;14664;14708.852911470962;14718.705625887636;14722.263886805616;14877.404903803943;5714;5733.426657334317;5821.417858214145;5854.565631420244;5941.643501389844;995.6017592962872;1010.5503051142172;1021;1022.5807418958192;1030.062642994871;22974.540509189723;23544.64683029756;29355.85322073376;29437;30133.69866301353;1072.7961687279392;1077.8275475923972;1087.2974385781527;1095.5727266366123;1098.7253186703324;12498.562550310695;12753.362331883369;12768;12934.741305173844;13029.739405211843;235284;238967;240104;240394;240697;52067.47932520627;52109;52184.47815521796;52279.47720522822;52426.73786631119;1412.901096923226;1455.6142622205125;1464.3849583174879;1470.2575199524172;1501.9474318398804;22530.887345563166;28086.2978425541;28148.43703125967;28788.712112878602;29184.124476265744;51318.48681513286;51689.741551292005;51760;51770.22344664758;51927;219019;220153;220760;220806;222402;36740.44889326609;37356.25287494289;37687.434688479145;37804.05489862776;37888.62111378961;45577.088458231316;46686;46860.53139468562;47034.52965470438;47234.76382618065;33802.49296260607;34002.489962651074;34156.14609634779;34257.31485370328;34939.82530087333;32993;33311.333773324885;33743.4938475928;33896;34030;36522.26955460929;36846.44730328993;36863.07842303964;36912.81543592265;37157.25685486329;32622.836885816367;32885.67114328826;32900.177495561846;33201.335973279914;33399;23372.532549349256;24282;24584.385390365384;24997.750022499542;25642.230733077293 14:51:02 INFO - PID 20598 | |2;jquery.html;556.2046273828423;557.6932687022137;569.5984331046612;572.9026065568853;578.8205656246564;21829.235976740798;22784;22808.42978925528;22880;23052.423689407773;26889.596656050126;27547.898084076664;27619.585706214424;27692.446151076965;27726.168214953585;6565.704543295563;6698.564593301444;6722.663866806664;6738.595684258936;6745.291744366845;6041.214642096521;6528.249251336109;6543.280239173687;6572.441342485894;6595.241547222059;6519.348065193466;6559.967200163993;6561.80314590563;6566.409023187936;6584.572002819801;6472.158619379474;6482.513811464159;6493.123428337185;6521.706523206467;6558.180227471518;6082.361352058058;6093.817185484442;6103.115048318014;6114.082887566856;6120.724567394478;29657.555136672967;29992.400151997055;30204.8489757552;30362.392752145053;30418.391632167233;1857.1457129720345;1913.3972798568407;1917;1917.3960202536157;1918.012223704793;19296.4211073668;19798.307059252857;19978.80021199784;20005.1997920083;20023.399298021082;2416.093964763214;2471.6416119662726;2523.772860442569;2528.266802627236;2534.569123249052;146397;147482;148000.25999869933;148064;148258;13524.391402386917;14835.554933352018;14887.553373398816;15212.1633310169;15442.613934651723;23856;23982;24027.879860600933;24032.158874439312;24062.037518499415;10425.810579778179;10535.525026496296;10543.789124217627;10555.888822235584;10642.521086551124;8211.71259005932;8695.391322607356;9546.570404331822;9662.75843103928;9708.126268635715;9046.638134474548;9303.953480232556;9399;9412;9485.715428537154;2673.5989601559922;2686.6775986881307;2751.954257382182;2754.4215714699735;2764.543850264724;947.6825263536655;966.2221911361421;977.9070988256104;979.2068424576116;989.2432289298692;19699.901500492404;19955.700664490043;20251.59496810085;20526.897365513374;20927;1043.7912417516375;1044.6761503933806;1048.8636477257908;1050.5955207245113;1058.5659879449388;11050.557977680963;11503.769924601462;13715.519956801663;14036.157830530201;14165.362558684885;512957;518607;522582;525623;529094;127393;131573;131699;132442;133845;1279.4626256972094;1284.6659868434274;1316.6115995781267;1317.4071667749743;1326.8341457317836;22407;22591.887040564692;22790.430239244153;22866;22969.310920672408;60205.69897150486;61946;61963.6901815488;62166;63394.36605633885;81789.59105204436;83810.58094709487;83960.16039839524;84398;85936.14063859281;21052.68420973656;21869.12523499042;21964.450888727908;22115;22181.223657171922;24412.75587244105;24565.63151552764;24808.379790505383;25049.248522544352;25627.87186064058;19539.70690439673;19565;19614;19876.60246795085;19895;16027.919860400623;17372.391966281626;17771.289148433916;17842.821571784636;18125.184366703266;17543.649127017645;17756.733648995534;19914.402567922985;20009;20076.69884951756;20933.26733564318;21283.574328513034;21687.34937951864;21727.674084888422;21810.563788724456;17558.561035974202;18515.444536663923;18908;19240.23039078421;19259.711104333164 14:51:02 INFO - PID 20598 | |3;mootools.html;1308.2216081431548;1376.7590671632468;1399.125546533417;1408.1902905829138;1410.985890141099;14182.858171418282;14408.35162417691;14791.334389952452;14802.259887005646;14814;14097.78853317201;14402.49591264306;14405.423783048665;14413.495527656534;14440.133591984488;2656.6944801347804;2694.8652567371555;2704.3374373278475;2705.350715828197;2713.036871910473;2573.4853029394103;2672.706002339741;2723.6867760207633;2726.1821453563953;2727.972720272792;2661.7471340222646;2679.383741739401;2726.5501192303245;2729.7679697225662;2732.603772453003;2617.4765046990583;2644.841309521435;2656.893724251028;2665.746754058361;2668.132856821541;2565.537084398979;2576.4847030593955;2586.6766654168227;2588.0553597936805;2588.6634737484005;14150.433982640681;14309.141451512942;14360.928195359062;14459.13245205291;14477.493287734878;7466.178720340758;7776.261255180749;7788.610569471561;7794.805129871798;7814.570198639072;5034.395872495324;5116.461916461916;5197.350331208599;5239.738013099368;5287.524122828925;1767.4167524716813;1767.646470705864;1808.9819101809076;1829.3780114760912;1839.7424360589528;24078.63882041771;24328.878355608107;24403;24500.264992050266;24565.263042108767;6453.386928241809;6503.902441463382;6657.833554161185;6689.632070236184;6733.730650773914;16483.91758041202;16630.75053874193;16657.583560411087;16663.25015374287;17077.146142692814;7323.12122545298;7495.512791668524;7502.287282708134;7563.546187228784;7567.129780075362;6819.522633415613;6923.4807389446;6932.722691092401;7021.754238601625;7238.891416628755;4971.154903666313;5106.66806657566;5123.129068058439;5127.66670166438;5137.845864624067;1336.1648969394128;1346.8451128120391;1349.8312710911136;1359.4154513559067;1371.91082579632;862.3316929379781;889.3241136735998;899.3794281945568;903.701778413122;910.8952470465849;8924.196822286025;9027.368084234173;9069.77325566866;9071.138241867013;9103.81792364149;980.1815484070738;982.3663736889666;990.1089019882164;999.6701088640731;1006.9798604027878;5290.4305886339225;5339.893202136013;5379.892402151935;5451.945480545144;5569.554435645138;19432.80567194338;19601.607967840562;20678.58642827165;20765.58468830645;20795.27216547444;19963.101660425316;20165.697514537293;20304.69542956857;20424;20506.692399614018;10809.35143891369;11049.668509944715;11232.55069797199;11328;11363.261388009752;8323.750287491384;8505.447145935494;8599.312055035707;8676.436031657922;9182.403143795633;17182.31270749156;17217;17731.202095905457;17838.464846054638;17995.82004179994;17711.911440442716;17763.46709598714;17905.820941790935;17952.371666991592;17959.281628734705;11631.534738610699;11993.100517461051;12002.939985300018;12014.459349329127;12062.276263424223;13141.802872957105;13330.133541319783;13423.530176443777;13540.72918541604;13890.652733681738;10431.582736690447;10588.841167382341;11005.449727513753;11201.831972520582;11378.31730096197;10893.836592450962;10906.454677266263;11120.221584489009;11248.88751112511;11254.718632034264;9735.61057557718;9834.262430317898;9838.852417213891;9846.950765246127;9849.113579777855;6976.093107896144;7079.787606371817;7247.565146091251;7273.309035641606;7406.1482929461645;7139.39412114564;7140.645444829665;7172.713091476283;7204.603746793977;7243.20324764286 14:51:02 INFO - PID 20598 | |4;prototype.html;474.3311930178445;478.8946431785008;505.35567151881355;508.819369123961;513.8021861583292;5980.7308671109795;6045.425684559971;6083.330833608299;6100.877982440348;6143;5903.970480147594;5993.340732519419;6036.667983260919;6111.541634377417;6139.877202455959;4900.6569540132205;4908.803647854082;4938.38270216223;4985.725785081819;4985.750712464381;4826.758662066883;4871.5615594596475;4888.97555512222;4918.532739389752;4949.579285760715;4857.587105096053;4857.829975950843;4878.170710979142;4900.289458028584;4966.553010229079;4830.516948305177;4928.162212423897;4944.38195225595;4950.55445009949;4961.355023846877;4459.799309031069;4460.308652158888;4463.375127482155;4476.37330773692;4485.170243504962;6029.6382217066675;6035.3059398169335;6042.637441753465;6098.451139397431;6119.2350956130485;5640.5487560995025;5685;5689.6586204827845;5734.684592347419;5753.482186603226;6450.806475805686;6472.061551075115;6475.5467117301805;6531.967340163269;6533.216014078341;4844;4851.490593487668;4864.659473836833;4871.512848715136;4895.216765317532;6870.244273129952;6870.656467176621;6884.277150899134;6911.516193866381;6954.061201737752;4957.876053098701;4958.380202474691;4978.153713868651;5000.774965126578;5034.395872495324;5053.725823379494;5064.518870707277;5070.797168113308;5082.542571168538;5099.490050994871;5702.429757024264;5720.2849643794525;5726.5418766499415;5737.3688894221605;5757.481826635623;6614.570052946543;6626.503012274099;6638.20341559016;6645.036469711865;6675.7997260082275;1674.4641714651439;1708.436216048701;1725.5513566472807;1762.8413442789954;1765.911704414774;1217.8843009914044;1218.530865616744;1231.8029115341503;1234.154604096197;1236.4065248680683;5654.5193658538665;5752.654840709571;5752.9712351437975;5774.133879917962;5785.30576330843;6723.361280678328;6733.225679046875;6741.449466622705;6754.832553096885;6796.898046529306;5817.621854579524;5826.359100498942;5829.213056237439;5830.7959221427045;5832.300123985149;3560.768550044239;3588.434269497322;3613.6567026132475;3613.7831730095754;3614.475900994341;6567.704453299613;6577.572457790324;6588.308227636125;6589.110470086573;6623.138991931114;6919.515633905578;6944.79165625022;6967.54710943787;6976.790696279119;6989.545679530815;6561.737530498822;6609.272979972199;6627.734890604418;6628.138342015507;6642.634655094016;6702.530822842355;6710.624322014073;6724.394804467622;6734.966325168343;6743.1908171019795;6635.1374321339845;6669.433098186514;6706.38451004099;6706.6646667665445;6735.360140786617;6465.935340646533;6504.902426463702;6516.6415847128865;6525.738970441129;6561.573497722633;4926.901461970812;4981.153203955264;4983.825566105169;5022.271770593316;5033.2701758245585;6498.870022599616;6609.933900660932;6763.391294783296;6797.66011699423;6831.59010459374;6266.185395898504;6422.967885160544;6441;6481.89807732696;6522.412982831568;6450.322716114741;6482.2869484357625;6495.447886929475;6518.608883467007;6531.575447595891;6239.625622462667;6346.238451385679;6401.839954001187;6412.487001039999;6445.935540644534;6467.385598368148;6483.481321494175;6489.5781774184525;6518.478521718346;6567.605943643397;6365.64988925595;6372.74509019634;6381.074744161978;6383.39357761012;6416 14:51:02 INFO - PID 20598 | |5;yui.html;897.6095398501657;901.4005686218663;914.8124634449938;917.5733284022928;935.284507351876;18632.627347453043;19580.804191958076;19740.210391584355;19762.70355944662;22277;21173;21971.121155153774;22052.558948821013;22168;22181.223657172002;1031.8245898197306;1056.889026652198;1062.3678911047914;1062.5377960587168;1066.7066556696932;971.7764914069733;1060.3213943076437;1060.581070477165;1064.2124827627538;1069.3797597393532;1124.7806677697852;1129.2772625519633;1129.9209055366086;1130.4065365683;1131.2816361610396;1117.681460783681;1123.0734643918759;1123.1744667669257;1124.600766727808;1127.9492422840951;818.0428898189133;818.6152508321079;820.9096999330069;820.9835803283901;821.34292565947;20049.8997505013;20326.390208293775;20335.694964575545;20343.08456119478;20896.164153433845;21901;22101.66847497289;22209.666854997187;22220.666689999664;22749.658755118686;16573.585660358465;16686.33254669812;16753.748693769605;16867.83132168675;17213.483595492155;3679.908002299937;3691.427828686558;3693.316736403774;3693.686036686885;3715.9442608360896;128119;128641;130163.34918325442;132625;132774.99999999904;16911;17176.484705458857;17296.740548891776;17316.913415433093;17499.12504374776;31321.8433907829;31968.520472192937;32259.51610725841;32365.35269294601;32386.514202286984;7788.57162856037;8015.719449819228;8638.222559969632;8786.07746186654;8901.955490222637;4247.5964783345535;4346.587074227943;4353.455818022747;4361.389405483234;4374.606285434263;5310.468953104736;5349.063913815145;5391.353037635509;5412.891742165135;5426.782928682808;1029.7477118106112;1065.0999905080196;1068.3376306689747;1069.9625513107003;1077.9137668986461;668.2715839734713;686.0772261308532;689.8551304226069;701.6176183979743;708.6775517139689;11649.650510484698;12182.451789669309;12295.938520307342;13017.284049377375;13442.126261792951;657.4543129202846;669.4075742967509;675.7938828657307;684.7569112964925;684.9965750171317;5922.230110085661;5967.015442452033;5987.221661184105;6167.537434692416;6259.499240060784;112546.43726781313;113816;114261;114342.42828785969;114776;95380;97743.51128244313;98381.50809245907;99650;100197;87523;88882.55558722165;89887;91044;92793.5360323194;12067.75864482723;13002.674933126747;13032.934835325763;13052.412641430969;13083.476660933457;38209.6179038206;41249.587504124574;41506;41640;42102.578974209864;73827.6308618475;73967.63016184885;74056.25943740494;74263;77457.61271193608;18822.153003114618;19210.8078919209;19422.2231110754;19485.90257048706;19930.20279188816;19222.423327300203;19755.901220493804;20021.09905054247;20036.09837557284;21364.786352136278;19082.52293692669;19376.70934936005;19540.90229548843;19636.90181549083;19700.605987879877;19569.510762231057;20077;20321.08555115053;20424.69362959527;20540;17676.91161544184;17857.642847143245;17942.102894854943;18065.81934180694;18742.625147497245;13967.161970281815;14049.859501404855;14279.57161285163;14608.488702895347;14669.633259168606;14830;15026.323815428113;15449.150296733787;15541.06753594788;15825.366985320457 14:51:02 INFO - PID 20598 | __end_tp_report 14:51:02 INFO - PID 20598 | __start_cc_report 14:51:02 INFO - PID 20598 | _x_x_mozilla_cycle_collect,376 14:51:02 INFO - PID 20598 | __end_cc_report 14:51:02 INFO - PID 20598 | __startTimestamp1502920262171__endTimestamp 14:51:02 INFO - PID 20598 | 14:51:02 INFO - PID 20598 | ------- Summary: start ------- 14:51:02 INFO - PID 20598 | Number of tests: 6 14:51:02 INFO - PID 20598 | 14:51:02 INFO - PID 20598 | [#0] dojo.html Cycles:165 Average:6105.73 Median:6348.30 stddev:710.73 (11.2%) stddev-sans-first:674.01 14:51:02 INFO - PID 20598 | Values: 3149.6 3165.2 3181.3 3187.9 3210.2 6094.3 6099.9 6160.1 6189.0 6238.1 6104.0 6163.5 6167.8 6176.1 6188.1 5564.3 5648.3 5653.1 5670.6 5689.4 5658.0 5661.9 5674.6 5678.5 5690.7 5713.3 5754.9 5782.8 5806.8 5860.8 5700.6 5713.6 5725.1 5797.6 5809.6 5450.5 5523.9 5582.0 5600.6 5634.4 6023.3 6096.7 6115.6 6127.9 6131.2 6552.2 6614.7 6641.8 6668.2 6685.6 6539.3 6645.1 6651.0 6728.0 6742.9 6047.6 6151.1 6235.2 6237.8 6243.9 6769.4 6826.1 6871.5 6880.8 6883.4 6366.8 6470.9 6520.3 6527.8 6619.1 6417.6 6447.5 6537.4 6641.2 6743.9 6531.5 6556.9 6595.3 6622.3 6678.0 6512.5 6625.2 6651.8 6665.9 6670.9 5360.1 5368.2 5441.0 5448.1 5481.7 4472.6 4524.9 4531.6 4539.7 4653.9 5738.9 5818.3 5821.3 5823.2 5823.7 6664.9 6715.6 6727.3 6732.4 6732.8 5777.6 5801.1 5859.8 5888.3 5889.2 5739.6 5817.4 5832.5 5903.2 5988.1 6363.9 6395.4 6399.1 6425.2 6561.8 6583.5 6649.3 6658.3 6662.6 6690.6 6409.4 6507.7 6533.3 6536.2 6544.7 6415.7 6433.3 6514.4 6522.4 6558.5 6545.9 6565.8 6607.0 6642.7 6731.1 6324.4 6344.9 6357.9 6366.1 6448.4 6448.7 6477.0 6487.0 6492.0 6492.3 6348.3 6404.2 6405.1 6420.6 6427.1 6407.4 6509.8 6549.6 6554.6 6567.8 6141.3 6259.8 6263.1 6270.1 6270.3 14:51:02 INFO - PID 20598 | 14:51:02 INFO - PID 20598 | [#1] ext.html Cycles:180 Average:39539.06 Median:3497.53 stddev:56912.39 (1627.2%) stddev-sans-first:56997.33 14:51:02 INFO - PID 20598 | Values: 701.4 761.4 781.8 797.6 1142.6 30617.8 31156.4 41316.6 41530.8 41880.6 42662.1 42796.4 42813.1 42893.8 42907.0 7409.5 7438.1 7569.3 7580.1 7605.3 7450.4 7548.6 7549.3 7549.7 7557.7 7553.5 7564.5 7607.7 7609.0 7612.5 7484.4 7526.9 7548.4 7550.0 7560.8 7438.7 7473.2 7477.2 7515.7 7523.1 37314.3 37549.0 37607.2 37731.0 37771.4 3453.9 3493.2 3495.8 3496.4 3498.7 31377.4 31378.8 31572.5 31723.5 31743.7 4926.6 4928.3 4939.3 5018.9 5031.0 195404.0 196552.0 196916.0 197148.0 198126.0 48445.5 48515.3 48516.5 48533.0 48657.8 51214.0 51216.0 51225.5 51310.0 51420.0 13488.3 13751.6 16375.5 16695.8 16727.2 13535.3 13665.6 13804.7 13808.9 13812.2 14664.0 14708.9 14718.7 14722.3 14877.4 5714.0 5733.4 5821.4 5854.6 5941.6 995.6 1010.6 1021.0 1022.6 1030.1 22974.5 23544.6 29355.9 29437.0 30133.7 1072.8 1077.8 1087.3 1095.6 1098.7 12498.6 12753.4 12768.0 12934.7 13029.7 235284.0 238967.0 240104.0 240394.0 240697.0 52067.5 52109.0 52184.5 52279.5 52426.7 1412.9 1455.6 1464.4 1470.3 1501.9 22530.9 28086.3 28148.4 28788.7 29184.1 51318.5 51689.7 51760.0 51770.2 51927.0 219019.0 220153.0 220760.0 220806.0 222402.0 36740.4 37356.3 37687.4 37804.1 37888.6 45577.1 46686.0 46860.5 47034.5 47234.8 33802.5 34002.5 34156.1 34257.3 34939.8 32993.0 33311.3 33743.5 33896.0 34030.0 36522.3 36846.4 36863.1 36912.8 37157.3 32622.8 32885.7 32900.2 33201.3 33399.0 23372.5 24282.0 24584.4 24997.8 25642.2 14:51:02 INFO - PID 20598 | 14:51:02 INFO - PID 20598 | [#2] jquery.html Cycles:180 Average:37693.50 Median:23919.00 stddev:88283.80 (369.1%) stddev-sans-first:88487.43 14:51:02 INFO - PID 20598 | Values: 556.2 557.7 569.6 572.9 578.8 21829.2 22784.0 22808.4 22880.0 23052.4 26889.6 27547.9 27619.6 27692.4 27726.2 6565.7 6698.6 6722.7 6738.6 6745.3 6041.2 6528.2 6543.3 6572.4 6595.2 6519.3 6560.0 6561.8 6566.4 6584.6 6472.2 6482.5 6493.1 6521.7 6558.2 6082.4 6093.8 6103.1 6114.1 6120.7 29657.6 29992.4 30204.8 30362.4 30418.4 1857.1 1913.4 1917.0 1917.4 1918.0 19296.4 19798.3 19978.8 20005.2 20023.4 2416.1 2471.6 2523.8 2528.3 2534.6 146397.0 147482.0 148000.3 148064.0 148258.0 13524.4 14835.6 14887.6 15212.2 15442.6 23856.0 23982.0 24027.9 24032.2 24062.0 10425.8 10535.5 10543.8 10555.9 10642.5 8211.7 8695.4 9546.6 9662.8 9708.1 9046.6 9304.0 9399.0 9412.0 9485.7 2673.6 2686.7 2752.0 2754.4 2764.5 947.7 966.2 977.9 979.2 989.2 19699.9 19955.7 20251.6 20526.9 20927.0 1043.8 1044.7 1048.9 1050.6 1058.6 11050.6 11503.8 13715.5 14036.2 14165.4 512957.0 518607.0 522582.0 525623.0 529094.0 127393.0 131573.0 131699.0 132442.0 133845.0 1279.5 1284.7 1316.6 1317.4 1326.8 22407.0 22591.9 22790.4 22866.0 22969.3 60205.7 61946.0 61963.7 62166.0 63394.4 81789.6 83810.6 83960.2 84398.0 85936.1 21052.7 21869.1 21964.5 22115.0 22181.2 24412.8 24565.6 24808.4 25049.2 25627.9 19539.7 19565.0 19614.0 19876.6 19895.0 16027.9 17372.4 17771.3 17842.8 18125.2 17543.6 17756.7 19914.4 20009.0 20076.7 20933.3 21283.6 21687.3 21727.7 21810.6 17558.6 18515.4 18908.0 19240.2 19259.7 14:51:02 INFO - PID 20598 | 14:51:02 INFO - PID 20598 | [#3] mootools.html Cycles:180 Average:9029.16 Median:2588.36 stddev:6243.73 (241.2%) stddev-sans-first:6234.29 14:51:02 INFO - PID 20598 | Values: 1308.2 1376.8 1399.1 1408.2 1411.0 14182.9 14408.4 14791.3 14802.3 14814.0 14097.8 14402.5 14405.4 14413.5 14440.1 2656.7 2694.9 2704.3 2705.4 2713.0 2573.5 2672.7 2723.7 2726.2 2728.0 2661.7 2679.4 2726.6 2729.8 2732.6 2617.5 2644.8 2656.9 2665.7 2668.1 2565.5 2576.5 2586.7 2588.1 2588.7 14150.4 14309.1 14360.9 14459.1 14477.5 7466.2 7776.3 7788.6 7794.8 7814.6 5034.4 5116.5 5197.4 5239.7 5287.5 1767.4 1767.6 1809.0 1829.4 1839.7 24078.6 24328.9 24403.0 24500.3 24565.3 6453.4 6503.9 6657.8 6689.6 6733.7 16483.9 16630.8 16657.6 16663.3 17077.1 7323.1 7495.5 7502.3 7563.5 7567.1 6819.5 6923.5 6932.7 7021.8 7238.9 4971.2 5106.7 5123.1 5127.7 5137.8 1336.2 1346.8 1349.8 1359.4 1371.9 862.3 889.3 899.4 903.7 910.9 8924.2 9027.4 9069.8 9071.1 9103.8 980.2 982.4 990.1 999.7 1007.0 5290.4 5339.9 5379.9 5451.9 5569.6 19432.8 19601.6 20678.6 20765.6 20795.3 19963.1 20165.7 20304.7 20424.0 20506.7 10809.4 11049.7 11232.6 11328.0 11363.3 8323.8 8505.4 8599.3 8676.4 9182.4 17182.3 17217.0 17731.2 17838.5 17995.8 17711.9 17763.5 17905.8 17952.4 17959.3 11631.5 11993.1 12002.9 12014.5 12062.3 13141.8 13330.1 13423.5 13540.7 13890.7 10431.6 10588.8 11005.4 11201.8 11378.3 10893.8 10906.5 11120.2 11248.9 11254.7 9735.6 9834.3 9838.9 9847.0 9849.1 6976.1 7079.8 7247.6 7273.3 7406.1 7139.4 7140.6 7172.7 7204.6 7243.2 14:51:02 INFO - PID 20598 | 14:51:02 INFO - PID 20598 | [#4] prototype.html Cycles:180 Average:5500.29 Median:6039.65 stddev:1550.76 (25.7%) stddev-sans-first:1508.53 14:51:02 INFO - PID 20598 | Values: 474.3 478.9 505.4 508.8 513.8 5980.7 6045.4 6083.3 6100.9 6143.0 5904.0 5993.3 6036.7 6111.5 6139.9 4900.7 4908.8 4938.4 4985.7 4985.8 4826.8 4871.6 4889.0 4918.5 4949.6 4857.6 4857.8 4878.2 4900.3 4966.6 4830.5 4928.2 4944.4 4950.6 4961.4 4459.8 4460.3 4463.4 4476.4 4485.2 6029.6 6035.3 6042.6 6098.5 6119.2 5640.5 5685.0 5689.7 5734.7 5753.5 6450.8 6472.1 6475.5 6532.0 6533.2 4844.0 4851.5 4864.7 4871.5 4895.2 6870.2 6870.7 6884.3 6911.5 6954.1 4957.9 4958.4 4978.2 5000.8 5034.4 5053.7 5064.5 5070.8 5082.5 5099.5 5702.4 5720.3 5726.5 5737.4 5757.5 6614.6 6626.5 6638.2 6645.0 6675.8 1674.5 1708.4 1725.6 1762.8 1765.9 1217.9 1218.5 1231.8 1234.2 1236.4 5654.5 5752.7 5753.0 5774.1 5785.3 6723.4 6733.2 6741.4 6754.8 6796.9 5817.6 5826.4 5829.2 5830.8 5832.3 3560.8 3588.4 3613.7 3613.8 3614.5 6567.7 6577.6 6588.3 6589.1 6623.1 6919.5 6944.8 6967.5 6976.8 6989.5 6561.7 6609.3 6627.7 6628.1 6642.6 6702.5 6710.6 6724.4 6735.0 6743.2 6635.1 6669.4 6706.4 6706.7 6735.4 6465.9 6504.9 6516.6 6525.7 6561.6 4926.9 4981.2 4983.8 5022.3 5033.3 6498.9 6609.9 6763.4 6797.7 6831.6 6266.2 6423.0 6441.0 6481.9 6522.4 6450.3 6482.3 6495.4 6518.6 6531.6 6239.6 6346.2 6401.8 6412.5 6445.9 6467.4 6483.5 6489.6 6518.5 6567.6 6365.6 6372.7 6381.1 6383.4 6416.0 14:51:02 INFO - PID 20598 | 14:51:02 INFO - PID 20598 | [#5] yui.html Cycles:180 Average:24655.85 Median:20199.04 stddev:33169.37 (164.2%) stddev-sans-first:33214.45 14:51:02 INFO - PID 20598 | Values: 897.6 901.4 914.8 917.6 935.3 18632.6 19580.8 19740.2 19762.7 22277.0 21173.0 21971.1 22052.6 22168.0 22181.2 1031.8 1056.9 1062.4 1062.5 1066.7 971.8 1060.3 1060.6 1064.2 1069.4 1124.8 1129.3 1129.9 1130.4 1131.3 1117.7 1123.1 1123.2 1124.6 1127.9 818.0 818.6 820.9 821.0 821.3 20049.9 20326.4 20335.7 20343.1 20896.2 21901.0 22101.7 22209.7 22220.7 22749.7 16573.6 16686.3 16753.7 16867.8 17213.5 3679.9 3691.4 3693.3 3693.7 3715.9 128119.0 128641.0 130163.3 132625.0 132775.0 16911.0 17176.5 17296.7 17316.9 17499.1 31321.8 31968.5 32259.5 32365.4 32386.5 7788.6 8015.7 8638.2 8786.1 8902.0 4247.6 4346.6 4353.5 4361.4 4374.6 5310.5 5349.1 5391.4 5412.9 5426.8 1029.7 1065.1 1068.3 1070.0 1077.9 668.3 686.1 689.9 701.6 708.7 11649.7 12182.5 12295.9 13017.3 13442.1 657.5 669.4 675.8 684.8 685.0 5922.2 5967.0 5987.2 6167.5 6259.5 112546.4 113816.0 114261.0 114342.4 114776.0 95380.0 97743.5 98381.5 99650.0 100197.0 87523.0 88882.6 89887.0 91044.0 92793.5 12067.8 13002.7 13032.9 13052.4 13083.5 38209.6 41249.6 41506.0 41640.0 42102.6 73827.6 73967.6 74056.3 74263.0 77457.6 18822.2 19210.8 19422.2 19485.9 19930.2 19222.4 19755.9 20021.1 20036.1 21364.8 19082.5 19376.7 19540.9 19636.9 19700.6 19569.5 20077.0 20321.1 20424.7 20540.0 17676.9 17857.6 17942.1 18065.8 18742.6 13967.2 14049.9 14279.6 14608.5 14669.6 14830.0 15026.3 15449.2 15541.1 15825.4 14:51:02 INFO - PID 20598 | -------- Summary: end -------- 14:51:02 INFO - PID 20598 | 14:51:02 INFO - TEST-INFO | 20598: exit 0 14:51:02 INFO - TEST-OK | dromaeo_css | took 1112515ms 14:51:02 INFO - TEST-START | kraken 14:51:02 INFO - Initialising browser for kraken test... 14:51:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55866/getInfo.html -profile /tmp/tmpNDKyFC/profile 14:51:02 INFO - TEST-INFO | started process 20966 (/builds/slave/test/build/application/firefox/firefox http://localhost:55866/getInfo.html) 14:51:08 INFO - TEST-INFO | 20966: exit 0 14:51:08 INFO - Browser initialized. 14:51:08 INFO - Running cycle 1/1 for kraken test... 14:51:08 INFO - TEST-INFO | started process 21200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNDKyFC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:09 INFO - PID 21200 | 14:51:09 INFO - PID 21200 | (/builds/slave/test/build/application/firefox/firefox:21254): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:51:09 INFO - PID 21200 | 14:51:20 INFO - PID 21200 | RSS: Main: 168312832 14:51:20 INFO - PID 21200 | 14:51:22 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55866/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:23 INFO - PID 21200 | RSS: Main: 174313472 14:51:23 INFO - PID 21200 | 14:51:26 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55866/tests/kraken/driver.html?testName=audio-dft) 14:51:27 INFO - PID 21200 | RSS: Main: 178565120 14:51:27 INFO - PID 21200 | 14:51:30 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55866/tests/kraken/driver.html?testName=audio-fft) 14:51:30 INFO - PID 21200 | RSS: Main: 172228608 14:51:30 INFO - PID 21200 | 14:51:32 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55866/tests/kraken/driver.html?testName=audio-oscillator) 14:51:33 INFO - PID 21200 | RSS: Main: 172728320 14:51:33 INFO - PID 21200 | 14:51:35 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:36 INFO - PID 21200 | RSS: Main: 172998656 14:51:36 INFO - PID 21200 | 14:51:39 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55866/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:40 INFO - PID 21200 | RSS: Main: 174080000 14:51:40 INFO - PID 21200 | 14:51:43 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55866/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:44 INFO - PID 21200 | RSS: Main: 173682688 14:51:44 INFO - PID 21200 | 14:51:47 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55866/tests/kraken/driver.html?testName=json-parse-financial) 14:51:47 INFO - PID 21200 | RSS: Main: 174776320 14:51:47 INFO - PID 21200 | 14:51:49 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:50 INFO - PID 21200 | RSS: Main: 174637056 14:51:50 INFO - PID 21200 | 14:51:52 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55866/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:52 INFO - PID 21200 | RSS: Main: 174698496 14:51:52 INFO - PID 21200 | 14:51:54 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:55 INFO - PID 21200 | RSS: Main: 174223360 14:51:55 INFO - PID 21200 | 14:51:58 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:51:58 INFO - PID 21200 | RSS: Main: 174923776 14:51:58 INFO - PID 21200 | 14:52:01 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:02 INFO - PID 21200 | RSS: Main: 175173632 14:52:02 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:55866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55866/tests/kraken/driver.html?testName=ai-astar) 14:52:04 INFO - PID 21200 | RSS: Main: 176680960 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | __start_tp_report 14:52:04 INFO - PID 21200 | _x_x_mozilla_page_load 14:52:04 INFO - PID 21200 | _x_x_mozilla_page_load_details 14:52:04 INFO - PID 21200 | |i|pagename|runs| 14:52:04 INFO - PID 21200 | |0;ai-astar;97;113;108;108;109;109;108;99;108;110 14:52:04 INFO - PID 21200 | |1;audio-beat-detection;143;119;149;173;123;144;162;119;173;119 14:52:04 INFO - PID 21200 | |2;audio-dft;165;162;167;166;165;163;171;166;172;167 14:52:04 INFO - PID 21200 | |3;audio-fft;76;74;75;183;83;75;77;90;97;76 14:52:04 INFO - PID 21200 | |4;audio-oscillator;79;79;129;78;78;79;132;87;79;127 14:52:04 INFO - PID 21200 | |5;imaging-gaussian-blur;113;116;114;117;116;122;116;114;114;113 14:52:04 INFO - PID 21200 | |6;imaging-darkroom;150;150;153;151;150;152;155;149;151;150 14:52:04 INFO - PID 21200 | |7;imaging-desaturate;95;93;94;94;95;99;99;94;93;93 14:52:04 INFO - PID 21200 | |8;json-parse-financial;55;54;53;55;55;57;55;54;63;54 14:52:04 INFO - PID 21200 | |9;json-stringify-tinderbox;54;54;55;54;55;55;54;59;55;60 14:52:04 INFO - PID 21200 | |10;stanford-crypto-aes;78;86;77;76;75;77;80;79;76;75 14:52:04 INFO - PID 21200 | |11;stanford-crypto-ccm;122;120;124;133;136;118;119;126;118;155 14:52:04 INFO - PID 21200 | |12;stanford-crypto-pbkdf2;182;181;175;189;175;180;187;180;176;191 14:52:04 INFO - PID 21200 | |13;stanford-crypto-sha256-iterative;75;76;68;67;67;74;70;69;66;71 14:52:04 INFO - PID 21200 | __end_tp_report 14:52:04 INFO - PID 21200 | __start_cc_report 14:52:04 INFO - PID 21200 | _x_x_mozilla_cycle_collect,931 14:52:04 INFO - PID 21200 | __end_cc_report 14:52:04 INFO - PID 21200 | __startTimestamp1502920324652__endTimestamp 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | ------- Summary: start ------- 14:52:04 INFO - PID 21200 | Number of tests: 14 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#0] ai-astar Cycles:10 Average:106.90 Median:109.50 stddev:4.95 (4.5%) stddev-sans-first:3.74 14:52:04 INFO - PID 21200 | Values: 97.0 113.0 108.0 108.0 109.0 109.0 108.0 99.0 108.0 110.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:146.50 stddev:21.91 (15.0%) stddev-sans-first:23.24 14:52:04 INFO - PID 21200 | Values: 143.0 119.0 149.0 173.0 123.0 144.0 162.0 119.0 173.0 119.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.50 stddev:3.13 (1.9%) stddev-sans-first:3.28 14:52:04 INFO - PID 21200 | Values: 165.0 162.0 167.0 166.0 165.0 163.0 171.0 166.0 172.0 167.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#3] audio-fft Cycles:10 Average:90.60 Median:76.50 stddev:33.35 (43.6%) stddev-sans-first:34.95 14:52:04 INFO - PID 21200 | Values: 76.0 74.0 75.0 183.0 83.0 75.0 77.0 90.0 97.0 76.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:24.07 (30.5%) stddev-sans-first:24.85 14:52:04 INFO - PID 21200 | Values: 79.0 79.0 129.0 78.0 78.0 79.0 132.0 87.0 79.0 127.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:116.00 stddev:2.68 (2.3%) stddev-sans-first:2.68 14:52:04 INFO - PID 21200 | Values: 113.0 116.0 114.0 117.0 116.0 122.0 116.0 114.0 114.0 113.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.79 (1.2%) stddev-sans-first:1.86 14:52:04 INFO - PID 21200 | Values: 150.0 150.0 153.0 151.0 150.0 152.0 155.0 149.0 151.0 150.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.50 stddev:2.28 (2.4%) stddev-sans-first:2.42 14:52:04 INFO - PID 21200 | Values: 95.0 93.0 94.0 94.0 95.0 99.0 99.0 94.0 93.0 93.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:2.84 (5.2%) stddev-sans-first:3.00 14:52:04 INFO - PID 21200 | Values: 55.0 54.0 53.0 55.0 55.0 57.0 55.0 54.0 63.0 54.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.00 stddev:2.17 (4.0%) stddev-sans-first:2.24 14:52:04 INFO - PID 21200 | Values: 54.0 54.0 55.0 54.0 55.0 55.0 54.0 59.0 55.0 60.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.50 stddev:3.28 (4.2%) stddev-sans-first:3.48 14:52:04 INFO - PID 21200 | Values: 78.0 86.0 77.0 76.0 75.0 77.0 80.0 79.0 76.0 75.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:125.00 stddev:11.60 (9.3%) stddev-sans-first:12.16 14:52:04 INFO - PID 21200 | Values: 122.0 120.0 124.0 133.0 136.0 118.0 119.0 126.0 118.0 155.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:181.50 stddev:5.74 (3.2%) stddev-sans-first:6.09 14:52:04 INFO - PID 21200 | Values: 182.0 181.0 175.0 189.0 175.0 180.0 187.0 180.0 176.0 191.0 14:52:04 INFO - PID 21200 | 14:52:04 INFO - PID 21200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:3.59 (5.1%) stddev-sans-first:3.38 14:52:04 INFO - PID 21200 | Values: 75.0 76.0 68.0 67.0 67.0 74.0 70.0 69.0 66.0 71.0 14:52:04 INFO - PID 21200 | -------- Summary: end -------- 14:52:04 INFO - PID 21200 | 14:52:05 INFO - PID 21200 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:52:05 INFO - TEST-INFO | 21200: exit 0 14:52:05 INFO - TEST-OK | kraken | took 62448ms 14:52:05 INFO - SUITE-END | took 1174s 14:52:05 INFO - Completed test suite (00:19:35) 14:52:05 INFO - javascript benchmark 14:52:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8672.710424272054, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.5748074010003, 3165.2245199926024, 3181.347823696142, 3187.8884239051636, 3210.1653570071776, 6094.2991555971075, 6099.878002439948, 6160.106784516248, 6189.0, 6238.0642903564485, 6103.969480152593, 6163.476104531109, 6167.81496555103, 6176.073588961658, 6188.071789231618, 5564.276644036269, 5648.293963254583, 5653.1237658162845, 5670.631408958425, 5689.431056894319, 5658.009848276535, 5661.8584535386735, 5674.631148975303, 5678.517326027272, 5690.7439165237665, 5713.285839270091, 5754.913676294859, 5782.768689252446, 5806.796762113327, 5860.824175274749, 5700.572457065695, 5713.5714821388565, 5725.055365864669, 5797.594168408213, 5809.593328467009, 5450.482204190595, 5523.889522209533, 5582.0, 5600.551955843523, 5634.380218176038, 6023.27720673522, 6096.664683442409, 6115.602485838451, 6127.938720612781, 6131.172291740602, 6552.213734351908, 6614.7023383947835, 6641.800745977628, 6668.233153187397, 6685.565438246498, 6539.28067912534, 6645.136132302818, 6650.9667451662435, 6727.966360168168, 6742.932570674328, 6047.606905551125, 6151.077338399231, 6235.158253635701, 6237.781677641261, 6243.906341404837, 6769.42459890905, 6826.078479405316, 6871.4502839773695, 6880.793576192722, 6883.449324054063, 6366.808995730135, 6470.870582588416, 6520.315366886409, 6527.836804079936, 6619.139511863427, 6417.647029413333, 6447.451966582799, 6537.411632953057, 6641.169853768279, 6743.898841517381, 6531.510136739764, 6556.868862622721, 6595.274519802818, 6622.2715501294815, 6677.998300255001, 6512.511561632802, 6625.204975402886, 6651.833704157435, 6665.866682666319, 6670.932650775852, 5360.115580929103, 5368.1679339702405, 5441.047816632074, 5448.073827449343, 5481.725913704299, 4472.642188624902, 4524.864254072383, 4531.592156705912, 4539.7049191802425, 4653.906921861611, 5738.942610573924, 5818.330891947396, 5821.330546987151, 5823.155642431909, 5823.650580965155, 6664.900026499607, 6715.630640314829, 6727.29363416844, 6732.427743641845, 6732.764353247613, 5777.595568310178, 5801.100829371454, 5859.765609375662, 5888.263967004124, 5889.1755154278435, 5739.598228124075, 5817.447342502455, 5832.504237139806, 5903.173555702205, 5988.131720900445, 6363.9045414318825, 6395.360463953567, 6399.072134540465, 6425.1968503937005, 6561.803145905535, 6583.506237032146, 6649.301823308483, 6658.334166583497, 6662.56693314933, 6690.632015239208, 6409.391107844747, 6507.6746162692625, 6533.314002029909, 6536.182977127859, 6544.6727663615675, 6415.679216039272, 6433.292337842927, 6514.446272066927, 6522.412982831568, 6558.540902136805, 6545.934540654723, 6565.80302590923, 6607.00894865774, 6642.734290628321, 6731.091302674076, 6324.367563243823, 6344.9048264277, 6357.904631430625, 6366.108744775827, 6448.355164483514, 6448.677566121582, 6477.028445733178, 6486.967565162144, 6492.0, 6492.253390859923, 6348.301686814354, 6404.1674582304, 6405.071264666504, 6420.6147631142285, 6427.132337134427, 6407.359264073555, 6509.772157974448, 6549.6070235786, 6554.57395269325, 6567.802965911031, 6141.263048434216, 6259.78090766821, 6263.123162757309, 6270.0908368287255, 6270.278917924497], "value": 6053.282276645446, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.4388489208632, 761.3642608421967, 781.8162731758035, 797.5972134072292, 1142.6343570057586, 30617.846910765442, 31156.376872462537, 41316.58683413165, 41530.792346038266, 41880.581194188046, 42662.14675706484, 42796.35805462913, 42813.14373712524, 42893.78553107238, 42907.0, 7409.5183813052245, 7438.070241219848, 7569.280918312779, 7580.090389153309, 7605.315521603055, 7450.441216908726, 7548.5848278344665, 7549.320561149495, 7549.7357592483995, 7557.735479258227, 7553.5090219135855, 7564.470487065908, 7607.733729319475, 7609.048868891388, 7612.543247405146, 7484.438667099962, 7526.9247307526775, 7548.433867459935, 7549.962250188769, 7560.810979725496, 7438.66526006331, 7473.177950425449, 7477.1775104738435, 7515.699372025112, 7523.09722833258, 37314.25371492582, 37549.0, 37607.24785504275, 37731.0, 37771.43342849832, 3453.861845526176, 3493.196564790087, 3495.7902525848276, 3496.370653282408, 3498.6851183393615, 31377.372452551048, 31378.843105784552, 31572.526412103838, 31723.52414713781, 31743.682563174305, 4926.5812405945535, 4928.28539861718, 4939.2838038484215, 5018.949810501885, 5031.0, 195404.0, 196552.0, 196916.0, 197148.0, 198125.99999999854, 48445.5155448441, 48515.272270915964, 48516.51483485191, 48533.0, 48657.756711216214, 51214.0, 51216.0, 51225.48774512282, 51310.0, 51420.0, 13488.258145802076, 13751.587452376445, 16375.508734737978, 16695.83304166967, 16727.16364181786, 13535.32323383827, 13665.590032299047, 13804.723905521832, 13808.928660700974, 13812.240326781923, 14664.0, 14708.852911470962, 14718.705625887636, 14722.263886805616, 14877.404903803943, 5714.0, 5733.426657334317, 5821.417858214145, 5854.565631420244, 5941.643501389844, 995.6017592962872, 1010.5503051142172, 1021.0, 1022.5807418958192, 1030.062642994871, 22974.540509189723, 23544.64683029756, 29355.85322073376, 29437.0, 30133.69866301353, 1072.7961687279392, 1077.8275475923972, 1087.2974385781527, 1095.5727266366123, 1098.7253186703324, 12498.562550310695, 12753.362331883369, 12768.0, 12934.741305173844, 13029.739405211843, 235284.0, 238967.0, 240104.0, 240394.0, 240697.0, 52067.47932520627, 52109.0, 52184.47815521796, 52279.47720522822, 52426.73786631119, 1412.901096923226, 1455.6142622205125, 1464.3849583174879, 1470.2575199524172, 1501.9474318398804, 22530.887345563166, 28086.2978425541, 28148.43703125967, 28788.712112878602, 29184.124476265744, 51318.48681513286, 51689.741551292005, 51760.0, 51770.22344664758, 51927.0, 219019.0, 220153.0, 220760.0, 220806.0, 222402.0, 36740.44889326609, 37356.25287494289, 37687.434688479145, 37804.05489862776, 37888.62111378961, 45577.088458231316, 46686.0, 46860.53139468562, 47034.52965470438, 47234.76382618065, 33802.49296260607, 34002.489962651074, 34156.14609634779, 34257.31485370328, 34939.82530087333, 32993.0, 33311.333773324885, 33743.4938475928, 33896.0, 34030.0, 36522.26955460929, 36846.44730328993, 36863.07842303964, 36912.81543592265, 37157.25685486329, 32622.836885816367, 32885.67114328826, 32900.177495561846, 33201.335973279914, 33399.0, 23372.532549349256, 24282.0, 24584.385390365384, 24997.750022499542, 25642.230733077293], "value": 17658.840849064025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.2046273828423, 557.6932687022137, 569.5984331046612, 572.9026065568853, 578.8205656246564, 21829.235976740798, 22784.0, 22808.42978925528, 22880.0, 23052.423689407773, 26889.596656050126, 27547.898084076664, 27619.585706214424, 27692.446151076965, 27726.168214953585, 6565.704543295563, 6698.564593301444, 6722.663866806664, 6738.595684258936, 6745.291744366845, 6041.214642096521, 6528.249251336109, 6543.280239173687, 6572.441342485894, 6595.241547222059, 6519.348065193466, 6559.967200163993, 6561.80314590563, 6566.409023187936, 6584.572002819801, 6472.158619379474, 6482.513811464159, 6493.123428337185, 6521.706523206467, 6558.180227471518, 6082.361352058058, 6093.817185484442, 6103.115048318014, 6114.082887566856, 6120.724567394478, 29657.555136672967, 29992.400151997055, 30204.8489757552, 30362.392752145053, 30418.391632167233, 1857.1457129720345, 1913.3972798568407, 1917.0, 1917.3960202536157, 1918.012223704793, 19296.4211073668, 19798.307059252857, 19978.80021199784, 20005.1997920083, 20023.399298021082, 2416.093964763214, 2471.6416119662726, 2523.772860442569, 2528.266802627236, 2534.569123249052, 146397.0, 147482.0, 148000.25999869933, 148064.0, 148258.0, 13524.391402386917, 14835.554933352018, 14887.553373398816, 15212.1633310169, 15442.613934651723, 23856.0, 23982.0, 24027.879860600933, 24032.158874439312, 24062.037518499415, 10425.810579778179, 10535.525026496296, 10543.789124217627, 10555.888822235584, 10642.521086551124, 8211.71259005932, 8695.391322607356, 9546.570404331822, 9662.75843103928, 9708.126268635715, 9046.638134474548, 9303.953480232556, 9399.0, 9412.0, 9485.715428537154, 2673.5989601559922, 2686.6775986881307, 2751.954257382182, 2754.4215714699735, 2764.543850264724, 947.6825263536655, 966.2221911361421, 977.9070988256104, 979.2068424576116, 989.2432289298692, 19699.901500492404, 19955.700664490043, 20251.59496810085, 20526.897365513374, 20927.0, 1043.7912417516375, 1044.6761503933806, 1048.8636477257908, 1050.5955207245113, 1058.5659879449388, 11050.557977680963, 11503.769924601462, 13715.519956801663, 14036.157830530201, 14165.362558684885, 512957.0, 518607.0, 522582.0, 525623.0, 529094.0, 127393.0, 131573.0, 131699.0, 132442.0, 133845.0, 1279.4626256972094, 1284.6659868434274, 1316.6115995781267, 1317.4071667749743, 1326.8341457317836, 22407.0, 22591.887040564692, 22790.430239244153, 22866.0, 22969.310920672408, 60205.69897150486, 61946.0, 61963.6901815488, 62166.0, 63394.36605633885, 81789.59105204436, 83810.58094709487, 83960.16039839524, 84398.0, 85936.14063859281, 21052.68420973656, 21869.12523499042, 21964.450888727908, 22115.0, 22181.223657171922, 24412.75587244105, 24565.63151552764, 24808.379790505383, 25049.248522544352, 25627.87186064058, 19539.70690439673, 19565.0, 19614.0, 19876.60246795085, 19895.0, 16027.919860400623, 17372.391966281626, 17771.289148433916, 17842.821571784636, 18125.184366703266, 17543.649127017645, 17756.733648995534, 19914.402567922985, 20009.0, 20076.69884951756, 20933.26733564318, 21283.574328513034, 21687.34937951864, 21727.674084888422, 21810.563788724456, 17558.561035974202, 18515.444536663923, 18908.0, 19240.23039078421, 19259.711104333164], "value": 12726.241767899324, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.2216081431548, 1376.7590671632468, 1399.125546533417, 1408.1902905829138, 1410.985890141099, 14182.858171418282, 14408.35162417691, 14791.334389952452, 14802.259887005646, 14814.0, 14097.78853317201, 14402.49591264306, 14405.423783048665, 14413.495527656534, 14440.133591984488, 2656.6944801347804, 2694.8652567371555, 2704.3374373278475, 2705.350715828197, 2713.036871910473, 2573.4853029394103, 2672.706002339741, 2723.6867760207633, 2726.1821453563953, 2727.972720272792, 2661.7471340222646, 2679.383741739401, 2726.5501192303245, 2729.7679697225662, 2732.603772453003, 2617.4765046990583, 2644.841309521435, 2656.893724251028, 2665.746754058361, 2668.132856821541, 2565.537084398979, 2576.4847030593955, 2586.6766654168227, 2588.0553597936805, 2588.6634737484005, 14150.433982640681, 14309.141451512942, 14360.928195359062, 14459.13245205291, 14477.493287734878, 7466.178720340758, 7776.261255180749, 7788.610569471561, 7794.805129871798, 7814.570198639072, 5034.395872495324, 5116.461916461916, 5197.350331208599, 5239.738013099368, 5287.524122828925, 1767.4167524716813, 1767.646470705864, 1808.9819101809076, 1829.3780114760912, 1839.7424360589528, 24078.63882041771, 24328.878355608107, 24403.0, 24500.264992050266, 24565.263042108767, 6453.386928241809, 6503.902441463382, 6657.833554161185, 6689.632070236184, 6733.730650773914, 16483.91758041202, 16630.75053874193, 16657.583560411087, 16663.25015374287, 17077.146142692814, 7323.12122545298, 7495.512791668524, 7502.287282708134, 7563.546187228784, 7567.129780075362, 6819.522633415613, 6923.4807389446, 6932.722691092401, 7021.754238601625, 7238.891416628755, 4971.154903666313, 5106.66806657566, 5123.129068058439, 5127.66670166438, 5137.845864624067, 1336.1648969394128, 1346.8451128120391, 1349.8312710911136, 1359.4154513559067, 1371.91082579632, 862.3316929379781, 889.3241136735998, 899.3794281945568, 903.701778413122, 910.8952470465849, 8924.196822286025, 9027.368084234173, 9069.77325566866, 9071.138241867013, 9103.81792364149, 980.1815484070738, 982.3663736889666, 990.1089019882164, 999.6701088640731, 1006.9798604027878, 5290.4305886339225, 5339.893202136013, 5379.892402151935, 5451.945480545144, 5569.554435645138, 19432.80567194338, 19601.607967840562, 20678.58642827165, 20765.58468830645, 20795.27216547444, 19963.101660425316, 20165.697514537293, 20304.69542956857, 20424.0, 20506.692399614018, 10809.35143891369, 11049.668509944715, 11232.55069797199, 11328.0, 11363.261388009752, 8323.750287491384, 8505.447145935494, 8599.312055035707, 8676.436031657922, 9182.403143795633, 17182.31270749156, 17217.0, 17731.202095905457, 17838.464846054638, 17995.82004179994, 17711.911440442716, 17763.46709598714, 17905.820941790935, 17952.371666991592, 17959.281628734705, 11631.534738610699, 11993.100517461051, 12002.939985300018, 12014.459349329127, 12062.276263424223, 13141.802872957105, 13330.133541319783, 13423.530176443777, 13540.72918541604, 13890.652733681738, 10431.582736690447, 10588.841167382341, 11005.449727513753, 11201.831972520582, 11378.31730096197, 10893.836592450962, 10906.454677266263, 11120.221584489009, 11248.88751112511, 11254.718632034264, 9735.61057557718, 9834.262430317898, 9838.852417213891, 9846.950765246127, 9849.113579777855, 6976.093107896144, 7079.787606371817, 7247.565146091251, 7273.309035641606, 7406.1482929461645, 7139.39412114564, 7140.645444829665, 7172.713091476283, 7204.603746793977, 7243.20324764286], "value": 6522.076094479431, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.3311930178445, 478.8946431785008, 505.35567151881355, 508.819369123961, 513.8021861583292, 5980.7308671109795, 6045.425684559971, 6083.330833608299, 6100.877982440348, 6143.0, 5903.970480147594, 5993.340732519419, 6036.667983260919, 6111.541634377417, 6139.877202455959, 4900.6569540132205, 4908.803647854082, 4938.38270216223, 4985.725785081819, 4985.750712464381, 4826.758662066883, 4871.5615594596475, 4888.97555512222, 4918.532739389752, 4949.579285760715, 4857.587105096053, 4857.829975950843, 4878.170710979142, 4900.289458028584, 4966.553010229079, 4830.516948305177, 4928.162212423897, 4944.38195225595, 4950.55445009949, 4961.355023846877, 4459.799309031069, 4460.308652158888, 4463.375127482155, 4476.37330773692, 4485.170243504962, 6029.6382217066675, 6035.3059398169335, 6042.637441753465, 6098.451139397431, 6119.2350956130485, 5640.5487560995025, 5685.0, 5689.6586204827845, 5734.684592347419, 5753.482186603226, 6450.806475805686, 6472.061551075115, 6475.5467117301805, 6531.967340163269, 6533.216014078341, 4844.0, 4851.490593487668, 4864.659473836833, 4871.512848715136, 4895.216765317532, 6870.244273129952, 6870.656467176621, 6884.277150899134, 6911.516193866381, 6954.061201737752, 4957.876053098701, 4958.380202474691, 4978.153713868651, 5000.774965126578, 5034.395872495324, 5053.725823379494, 5064.518870707277, 5070.797168113308, 5082.542571168538, 5099.490050994871, 5702.429757024264, 5720.2849643794525, 5726.5418766499415, 5737.3688894221605, 5757.481826635623, 6614.570052946543, 6626.503012274099, 6638.20341559016, 6645.036469711865, 6675.7997260082275, 1674.4641714651439, 1708.436216048701, 1725.5513566472807, 1762.8413442789954, 1765.911704414774, 1217.8843009914044, 1218.530865616744, 1231.8029115341503, 1234.154604096197, 1236.4065248680683, 5654.5193658538665, 5752.654840709571, 5752.9712351437975, 5774.133879917962, 5785.30576330843, 6723.361280678328, 6733.225679046875, 6741.449466622705, 6754.832553096885, 6796.898046529306, 5817.621854579524, 5826.359100498942, 5829.213056237439, 5830.7959221427045, 5832.300123985149, 3560.768550044239, 3588.434269497322, 3613.6567026132475, 3613.7831730095754, 3614.475900994341, 6567.704453299613, 6577.572457790324, 6588.308227636125, 6589.110470086573, 6623.138991931114, 6919.515633905578, 6944.79165625022, 6967.54710943787, 6976.790696279119, 6989.545679530815, 6561.737530498822, 6609.272979972199, 6627.734890604418, 6628.138342015507, 6642.634655094016, 6702.530822842355, 6710.624322014073, 6724.394804467622, 6734.966325168343, 6743.1908171019795, 6635.1374321339845, 6669.433098186514, 6706.38451004099, 6706.6646667665445, 6735.360140786617, 6465.935340646533, 6504.902426463702, 6516.6415847128865, 6525.738970441129, 6561.573497722633, 4926.901461970812, 4981.153203955264, 4983.825566105169, 5022.271770593316, 5033.2701758245585, 6498.870022599616, 6609.933900660932, 6763.391294783296, 6797.66011699423, 6831.59010459374, 6266.185395898504, 6422.967885160544, 6441.0, 6481.89807732696, 6522.412982831568, 6450.322716114741, 6482.2869484357625, 6495.447886929475, 6518.608883467007, 6531.575447595891, 6239.625622462667, 6346.238451385679, 6401.839954001187, 6412.487001039999, 6445.935540644534, 6467.385598368148, 6483.481321494175, 6489.5781774184525, 6518.478521718346, 6567.605943643397, 6365.64988925595, 6372.74509019634, 6381.074744161978, 6383.39357761012, 6416.0], "value": 5040.489939404154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.6095398501657, 901.4005686218663, 914.8124634449938, 917.5733284022928, 935.284507351876, 18632.627347453043, 19580.804191958076, 19740.210391584355, 19762.70355944662, 22277.0, 21173.0, 21971.121155153774, 22052.558948821013, 22168.0, 22181.223657172002, 1031.8245898197306, 1056.889026652198, 1062.3678911047914, 1062.5377960587168, 1066.7066556696932, 971.7764914069733, 1060.3213943076437, 1060.581070477165, 1064.2124827627538, 1069.3797597393532, 1124.7806677697852, 1129.2772625519633, 1129.9209055366086, 1130.4065365683, 1131.2816361610396, 1117.681460783681, 1123.0734643918759, 1123.1744667669257, 1124.600766727808, 1127.9492422840951, 818.0428898189133, 818.6152508321079, 820.9096999330069, 820.9835803283901, 821.34292565947, 20049.8997505013, 20326.390208293775, 20335.694964575545, 20343.08456119478, 20896.164153433845, 21901.0, 22101.66847497289, 22209.666854997187, 22220.666689999664, 22749.658755118686, 16573.585660358465, 16686.33254669812, 16753.748693769605, 16867.83132168675, 17213.483595492155, 3679.908002299937, 3691.427828686558, 3693.316736403774, 3693.686036686885, 3715.9442608360896, 128119.0, 128641.0, 130163.34918325442, 132625.0, 132774.99999999904, 16911.0, 17176.484705458857, 17296.740548891776, 17316.913415433093, 17499.12504374776, 31321.8433907829, 31968.520472192937, 32259.51610725841, 32365.35269294601, 32386.514202286984, 7788.57162856037, 8015.719449819228, 8638.222559969632, 8786.07746186654, 8901.955490222637, 4247.5964783345535, 4346.587074227943, 4353.455818022747, 4361.389405483234, 4374.606285434263, 5310.468953104736, 5349.063913815145, 5391.353037635509, 5412.891742165135, 5426.782928682808, 1029.7477118106112, 1065.0999905080196, 1068.3376306689747, 1069.9625513107003, 1077.9137668986461, 668.2715839734713, 686.0772261308532, 689.8551304226069, 701.6176183979743, 708.6775517139689, 11649.650510484698, 12182.451789669309, 12295.938520307342, 13017.284049377375, 13442.126261792951, 657.4543129202846, 669.4075742967509, 675.7938828657307, 684.7569112964925, 684.9965750171317, 5922.230110085661, 5967.015442452033, 5987.221661184105, 6167.537434692416, 6259.499240060784, 112546.43726781313, 113816.0, 114261.0, 114342.42828785969, 114776.0, 95380.0, 97743.51128244313, 98381.50809245907, 99650.0, 100197.0, 87523.0, 88882.55558722165, 89887.0, 91044.0, 92793.5360323194, 12067.75864482723, 13002.674933126747, 13032.934835325763, 13052.412641430969, 13083.476660933457, 38209.6179038206, 41249.587504124574, 41506.0, 41640.0, 42102.578974209864, 73827.6308618475, 73967.63016184885, 74056.25943740494, 74263.0, 77457.61271193608, 18822.153003114618, 19210.8078919209, 19422.2231110754, 19485.90257048706, 19930.20279188816, 19222.423327300203, 19755.901220493804, 20021.09905054247, 20036.09837557284, 21364.786352136278, 19082.52293692669, 19376.70934936005, 19540.90229548843, 19636.90181549083, 19700.605987879877, 19569.510762231057, 20077.0, 20321.08555115053, 20424.69362959527, 20540.0, 17676.91161544184, 17857.642847143245, 17942.102894854943, 18065.81934180694, 18742.625147497245, 13967.161970281815, 14049.859501404855, 14279.57161285163, 14608.488702895347, 14669.633259168606, 14830.0, 15026.323815428113, 15449.150296733787, 15541.06753594788, 15825.366985320457], "value": 9514.561461610247, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 113.0, 108.0, 108.0, 109.0, 109.0, 108.0, 99.0, 108.0, 110.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 149.0, 173.0, 123.0, 144.0, 162.0, 119.0, 173.0, 119.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 167.0, 166.0, 165.0, 163.0, 171.0, 166.0, 172.0, 167.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 183.0, 83.0, 75.0, 77.0, 90.0, 97.0, 76.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 129.0, 78.0, 78.0, 79.0, 132.0, 87.0, 79.0, 127.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 114.0, 117.0, 116.0, 122.0, 116.0, 114.0, 114.0, 113.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 153.0, 151.0, 150.0, 152.0, 155.0, 149.0, 151.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 94.0, 95.0, 99.0, 99.0, 94.0, 93.0, 93.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 55.0, 57.0, 55.0, 54.0, 63.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0, 59.0, 55.0, 60.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 86.0, 77.0, 76.0, 75.0, 77.0, 80.0, 79.0, 76.0, 75.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 124.0, 133.0, 136.0, 118.0, 119.0, 126.0, 118.0, 155.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 175.0, 189.0, 175.0, 180.0, 187.0, 180.0, 176.0, 191.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 68.0, 67.0, 67.0, 74.0, 70.0, 69.0, 66.0, 71.0], "value": 70.3, "unit": "score"}]}]} 14:52:05 INFO - Return code: 0 14:52:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:52:05 INFO - # TBPL SUCCESS # 14:52:05 INFO - Running post-action listener: _package_coverage_data 14:52:05 INFO - Running post-action listener: _resource_record_post_action 14:52:05 INFO - [mozharness: 2017-08-16 21:52:05.945339Z] Finished run-tests step (success) 14:52:05 INFO - Running post-run listener: _resource_record_post_run 14:52:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432541696; Read time: 12; Write time: 347608 14:52:06 INFO - TinderboxPrint: CPU usage
13.1% 14:52:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:52:06 INFO - TinderboxPrint: I/O write bytes / time
432,541,696 / 347,608 14:52:06 INFO - TinderboxPrint: CPU idle
8,266.1 (86.8%) 14:52:06 INFO - TinderboxPrint: CPU user
1,201.5 (12.6%) 14:52:06 INFO - TinderboxPrint: Swap in / out
0 / 0 14:52:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107241472; Read time: 0; Write time: 97836 14:52:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:52:06 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 325300224; Read time: 0; Write time: 249772 14:52:06 INFO - Running post-run listener: _upload_blobber_files 14:52:06 INFO - Blob upload gear active. 14:52:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:06 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 14:52:06 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'] 14:52:06 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 14:52:07 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:08 INFO - (blobuploader) - INFO - Done attempting. 14:52:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:52:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:15 INFO - (blobuploader) - INFO - Done attempting. 14:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:15 INFO - (blobuploader) - INFO - Done attempting. 14:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:52:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:16 INFO - (blobuploader) - INFO - Done attempting. 14:52:16 INFO - (blobuploader) - INFO - Iteration through files over. 14:52:16 INFO - Return code: 0 14:52:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:52:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:52:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdffbf30bc77fdd047a55e7a080f4c17ef7edda0058e5115b3463ff49783f980260b4b324135cfbd747578d3a6fff8a092bf7ff6c640844aa3e2efa2f6bfa53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad94aabfd45ba13a92ab5474a9cb6ed2f4458b4f9247b51abb6cacb8071064c09c9cc45c0f92af5efe7eea027e509d06dc3bd453457ed310031bca40527ba81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d148a191c0fd9b678cdd0a5200a3be3e15f736c888f0bab1eabad9e8299a9a2f90f71557b7a16dcb1ad64a66d645def9ccbea0414172d71b47b462e2b0e13b1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f99a8cc748c38da13ae33a8f467e087d4c6cb8769b23562a65c75e6b78261b6d3299d71fb4d9fa74e548188f2a56038ce97a6d6406519f29281e44347daf0dc"} 14:52:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:52:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:52:16 INFO - Contents: 14:52:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdffbf30bc77fdd047a55e7a080f4c17ef7edda0058e5115b3463ff49783f980260b4b324135cfbd747578d3a6fff8a092bf7ff6c640844aa3e2efa2f6bfa53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad94aabfd45ba13a92ab5474a9cb6ed2f4458b4f9247b51abb6cacb8071064c09c9cc45c0f92af5efe7eea027e509d06dc3bd453457ed310031bca40527ba81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d148a191c0fd9b678cdd0a5200a3be3e15f736c888f0bab1eabad9e8299a9a2f90f71557b7a16dcb1ad64a66d645def9ccbea0414172d71b47b462e2b0e13b1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f99a8cc748c38da13ae33a8f467e087d4c6cb8769b23562a65c75e6b78261b6d3299d71fb4d9fa74e548188f2a56038ce97a6d6406519f29281e44347daf0dc"} 14:52:16 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:16 INFO - Copying logs to upload dir... 14:52:16 INFO - mkdir: /builds/slave/test/build/upload/logs 14:52:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.938813 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-16 14:52:16.218680) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 14:52:16.223721) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdffbf30bc77fdd047a55e7a080f4c17ef7edda0058e5115b3463ff49783f980260b4b324135cfbd747578d3a6fff8a092bf7ff6c640844aa3e2efa2f6bfa53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad94aabfd45ba13a92ab5474a9cb6ed2f4458b4f9247b51abb6cacb8071064c09c9cc45c0f92af5efe7eea027e509d06dc3bd453457ed310031bca40527ba81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d148a191c0fd9b678cdd0a5200a3be3e15f736c888f0bab1eabad9e8299a9a2f90f71557b7a16dcb1ad64a66d645def9ccbea0414172d71b47b462e2b0e13b1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f99a8cc748c38da13ae33a8f467e087d4c6cb8769b23562a65c75e6b78261b6d3299d71fb4d9fa74e548188f2a56038ce97a6d6406519f29281e44347daf0dc"} build_url:https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/ZbYi7e4SShuLRJRdD3myxg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdffbf30bc77fdd047a55e7a080f4c17ef7edda0058e5115b3463ff49783f980260b4b324135cfbd747578d3a6fff8a092bf7ff6c640844aa3e2efa2f6bfa53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad94aabfd45ba13a92ab5474a9cb6ed2f4458b4f9247b51abb6cacb8071064c09c9cc45c0f92af5efe7eea027e509d06dc3bd453457ed310031bca40527ba81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d148a191c0fd9b678cdd0a5200a3be3e15f736c888f0bab1eabad9e8299a9a2f90f71557b7a16dcb1ad64a66d645def9ccbea0414172d71b47b462e2b0e13b1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f99a8cc748c38da13ae33a8f467e087d4c6cb8769b23562a65c75e6b78261b6d3299d71fb4d9fa74e548188f2a56038ce97a6d6406519f29281e44347daf0dc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 14:52:16.260044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 14:52:16.263567) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1502919079.19196-1179562296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 14:52:16.345932) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 14:52:16.346390) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 14:52:16.346806) ========= ========= Total master_lag: 0.07 =========