builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-074 starttime: 1502669522.67 results: success (0) revision: e594b178728bc6a51fc81bffcb1d6f0a7071cd33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:02.666500) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:02.666953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:02.667245) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:02.715290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:02.715631) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-13 17:12:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-08-13 17:12:03 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:02.913258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:02.916569) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017396 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:02.984458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-13 17:12:02.984789) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e594b178728bc6a51fc81bffcb1d6f0a7071cd33 --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 e594b178728bc6a51fc81bffcb1d6f0a7071cd33 --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=23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-13 17:12:04,087 truncating revision to first 12 chars 2017-08-13 17:12:04,087 Setting DEBUG logging. 2017-08-13 17:12:04,087 attempt 1/10 2017-08-13 17:12:04,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e594b178728b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-13 17:12:05,252 unpacking tar archive at: mozilla-central-e594b178728b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.483205 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-13 17:12:04.500846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:04.501161) ========= script_repo_revision: e594b178728bc6a51fc81bffcb1d6f0a7071cd33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:04.501572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:04.501842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 17:12:04.537311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-13 17:12:04.537603) ========= /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=23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:12:05 INFO - MultiFileLogger online at 20170813 17:12:05 in /builds/slave/test 17:12:05 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 17:12:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:12:05 INFO - {'append_to_log': False, 17:12:05 INFO - 'base_work_dir': '/builds/slave/test', 17:12:05 INFO - 'blob_upload_branch': 'Firefox', 17:12:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:12:05 INFO - 'branch': 'Firefox', 17:12:05 INFO - 'buildbot_json_path': 'buildprops.json', 17:12:05 INFO - 'code_coverage': False, 17:12:05 INFO - 'config_files': ('talos/linux_config.py',), 17:12:05 INFO - 'default_actions': ('clobber', 17:12:05 INFO - 'read-buildbot-config', 17:12:05 INFO - 'download-and-extract', 17:12:05 INFO - 'populate-webroot', 17:12:05 INFO - 'create-virtualenv', 17:12:05 INFO - 'install', 17:12:05 INFO - 'setup-mitmproxy', 17:12:05 INFO - 'run-tests'), 17:12:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:12:05 INFO - 'disable_ccov_upload': False, 17:12:05 INFO - 'download_minidump_stackwalk': True, 17:12:05 INFO - 'download_symbols': 'ondemand', 17:12:05 INFO - 'enable_stylo': False, 17:12:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:12:05 INFO - 'tooltool.py': '/tools/tooltool.py', 17:12:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:12:05 INFO - '/tools/misc-python/virtualenv.py')}, 17:12:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:12:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:12:05 INFO - 'gecko_profile': False, 17:12:05 INFO - 'gecko_profile_interval': 0, 17:12:05 INFO - 'installer_path': 'installer.exe', 17:12:05 INFO - 'log_level': 'info', 17:12:05 INFO - 'log_name': 'talos', 17:12:05 INFO - 'log_to_console': True, 17:12:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:12:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:12:05 INFO - 'opt_config_files': (), 17:12:05 INFO - 'pip_index': False, 17:12:05 INFO - 'suite': 'dromaeojs-e10s', 17:12:05 INFO - 'system_bits': '32', 17:12:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:12:05 INFO - 'title': 'talos-linux64-ix-074', 17:12:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:12:05 INFO - 'use_talos_json': True, 17:12:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:12:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:12:05 INFO - 'work_dir': 'build'} 17:12:05 INFO - [mozharness: 2017-08-14 00:12:05.733514Z] Running clobber step. 17:12:05 INFO - Running pre-action listener: _resource_record_pre_action 17:12:05 INFO - Running main action method: clobber 17:12:05 INFO - rmtree: /builds/slave/test/build 17:12:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:12:06 INFO - Running post-action listener: _resource_record_post_action 17:12:06 INFO - [mozharness: 2017-08-14 00:12:06.754829Z] Finished clobber step (success) 17:12:06 INFO - [mozharness: 2017-08-14 00:12:06.754933Z] Running read-buildbot-config step. 17:12:06 INFO - Running pre-action listener: _resource_record_pre_action 17:12:06 INFO - Running main action method: read_buildbot_config 17:12:06 INFO - Using buildbot properties: 17:12:06 INFO - { 17:12:06 INFO - "project": "", 17:12:06 INFO - "product": "firefox", 17:12:06 INFO - "who": "archaeopteryx@coole-files.de", 17:12:06 INFO - "installer_path": "public/build/target.tar.bz2", 17:12:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:12:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:12:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:12:06 INFO - "stage_platform": "linux64-stylo", 17:12:06 INFO - "basedir": "/builds/slave/test", 17:12:06 INFO - "buildnumber": 28, 17:12:06 INFO - "platform": "ubuntu64_hw_stylo", 17:12:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:12:06 INFO - "slavebuilddir": "test", 17:12:06 INFO - "taskId": "ITiNEdUuSzu1DsNt2x0YAQ", 17:12:06 INFO - "branch": "mozilla-central", 17:12:06 INFO - "script_repo_revision": "production", 17:12:06 INFO - "revision": "e594b178728bc6a51fc81bffcb1d6f0a7071cd33", 17:12:06 INFO - "slavename": "talos-linux64-ix-074", 17:12:06 INFO - "repo_path": "mozilla-central" 17:12:06 INFO - } 17:12:06 INFO - Finding installer, test and symbols from parent task. 17:12:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ITiNEdUuSzu1DsNt2x0YAQ'}, attempt #1 17:12:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ITiNEdUuSzu1DsNt2x0YAQ'}, attempt #1 17:12:07 INFO - Task dependencies: Cpe3HXCkQHyHzCn410T5Mw 17:12:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw'}, attempt #1 17:12:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.tar.bz2 17:12:08 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.test_packages.json 17:12:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.crashreporter-symbols.zip 17:12:08 INFO - Running post-action listener: _resource_record_post_action 17:12:08 INFO - [mozharness: 2017-08-14 00:12:08.254167Z] Finished read-buildbot-config step (success) 17:12:08 INFO - [mozharness: 2017-08-14 00:12:08.254388Z] Running download-and-extract step. 17:12:08 INFO - Running pre-action listener: _resource_record_pre_action 17:12:08 INFO - Running main action method: download_and_extract 17:12:08 INFO - mkdir: /builds/slave/test/build/tests 17:12:08 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')]} 17:12:08 INFO - trying https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.test_packages.json 17:12:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:12:08 INFO - Downloaded 989 bytes. 17:12:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:12:08 INFO - Using the following test package requirements: 17:12:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:12:08 INFO - u'common': [u'target.common.tests.zip'], 17:12:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:12:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:12:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:12:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:12:08 INFO - u'mozbase': [u'target.common.tests.zip'], 17:12:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:12:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:12:08 INFO - u'web-platform': [u'target.common.tests.zip', 17:12:08 INFO - u'target.web-platform.tests.tar.gz'], 17:12:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:12:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:12:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.common.tests.zip 17:12:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:12:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.common.tests.zip into memory 17:12:10 INFO - Content-Length response header: 54034790 17:12:10 INFO - Bytes received: 54034790 17:12:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:12:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.common.tests.zip 17:12:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:12:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.common.tests.zip into memory 17:12:22 INFO - Content-Length response header: 54034790 17:12:22 INFO - Bytes received: 54034790 17:12:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.talos.tests.zip 17:12:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:12:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.talos.tests.zip into memory 17:12:34 INFO - Content-Length response header: 14496050 17:12:34 INFO - Bytes received: 14496050 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:34 INFO - trying https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.tar.bz2 17:12:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:12:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:12:35 INFO - Downloaded 61731308 bytes. 17:12:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.tar.bz2 17:12:35 INFO - mkdir: /builds/slave/test/properties 17:12:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:35 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:35 INFO - Contents: 17:12:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.tar.bz2 17:12:35 INFO - Running post-action listener: _resource_record_post_action 17:12:35 INFO - Running post-action listener: set_extra_try_arguments 17:12:35 INFO - [mozharness: 2017-08-14 00:12:35.931487Z] Finished download-and-extract step (success) 17:12:35 INFO - [mozharness: 2017-08-14 00:12:35.931585Z] Running populate-webroot step. 17:12:35 INFO - Running pre-action listener: _resource_record_pre_action 17:12:35 INFO - Running main action method: populate_webroot 17:12:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:12:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:12:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:12:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:12:35 INFO - 'tests': ['damp', 'tps']}, 17:12:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:12:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:12:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:12:35 INFO - 'other-e10s': {'tests': ['a11yr', 17:12:35 INFO - 'ts_paint', 17:12:35 INFO - 'tpaint', 17:12:35 INFO - 'sessionrestore', 17:12:35 INFO - 'sessionrestore_many_windows', 17:12:35 INFO - 'sessionrestore_no_auto_restore', 17:12:35 INFO - 'tabpaint']}, 17:12:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:12:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:12:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:12:35 INFO - 'tsvgr_opacity', 17:12:35 INFO - 'tart', 17:12:35 INFO - 'tscrollx', 17:12:35 INFO - 'tsvg_static']}, 17:12:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:12:35 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:12:35 INFO - 'talos_options': ['--mitmproxy', 17:12:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:12:35 INFO - '--firstNonBlankPaint'], 17:12:35 INFO - 'tests': ['tp6_google', 17:12:35 INFO - 'tp6_youtube', 17:12:35 INFO - 'tp6_amazon', 17:12:35 INFO - 'tp6_facebook']}, 17:12:35 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:12:35 INFO - 'talos_options': ['--stylo', 17:12:35 INFO - '--mitmproxy', 17:12:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:12:35 INFO - '--firstNonBlankPaint'], 17:12:35 INFO - 'tests': ['tp6_google', 17:12:35 INFO - 'tp6_youtube', 17:12:35 INFO - 'tp6_amazon', 17:12:35 INFO - 'tp6_facebook']}, 17:12:35 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:12:35 INFO - 'talos_options': ['--stylo', 17:12:35 INFO - '--stylo-threads=1', 17:12:35 INFO - '--mitmproxy', 17:12:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:12:35 INFO - '--firstNonBlankPaint'], 17:12:35 INFO - 'tests': ['tp6_google', 17:12:35 INFO - 'tp6_youtube', 17:12:35 INFO - 'tp6_amazon', 17:12:35 INFO - 'tp6_facebook']}, 17:12:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:12:35 INFO - 'talos_options': ['--xperf_path', 17:12:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:35 INFO - 'tests': ['tp5n']}}} 17:12:35 INFO - Running post-action listener: _resource_record_post_action 17:12:35 INFO - [mozharness: 2017-08-14 00:12:35.939975Z] Finished populate-webroot step (success) 17:12:35 INFO - [mozharness: 2017-08-14 00:12:35.940065Z] Running create-virtualenv step. 17:12:35 INFO - Running pre-action listener: _resource_record_pre_action 17:12:35 INFO - Running main action method: create_virtualenv 17:12:35 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:35 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 17:12:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:12:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:36 INFO - Using real prefix '/usr' 17:12:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:36 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:38 INFO - Installing pip.................done. 17:12:38 INFO - Return code: 0 17:12:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:12:38 INFO - Reading from file tmpfile_stdout 17:12:38 INFO - Output received: 17:12:38 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) 17:12:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:38 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')]} 17:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:38 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')]} 17:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:38 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 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:38 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 17:12:38 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 17:12:38 INFO - Using env: {'DISPLAY': ':0', 17:12:38 INFO - 'HOME': '/home/cltbld', 17:12:38 INFO - 'LANG': 'en_US.UTF-8', 17:12:38 INFO - 'LANGUAGE': 'en_US:en', 17:12:38 INFO - 'LOGNAME': 'cltbld', 17:12:38 INFO - 'MAIL': '/var/mail/cltbld', 17:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:38 INFO - 'MOZ_NO_REMOTE': '1', 17:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:38 INFO - 'NO_EM_RESTART': '1', 17:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:38 INFO - 'PWD': '/builds/slave/test', 17:12:38 INFO - 'SHELL': '/bin/bash', 17:12:38 INFO - 'SHLVL': '1', 17:12:38 INFO - 'TERM': 'linux', 17:12:38 INFO - 'TMOUT': '86400', 17:12:38 INFO - 'USER': 'cltbld', 17:12:38 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:38 INFO - '_': '/tools/buildbot/bin/python'} 17:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:38 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 17:12:38 INFO - Cleaning up... 17:12:38 INFO - Return code: 0 17:12:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:12:38 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')]} 17:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:38 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')]} 17:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:38 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 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:38 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 17:12:38 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 17:12:38 INFO - Using env: {'DISPLAY': ':0', 17:12:38 INFO - 'HOME': '/home/cltbld', 17:12:38 INFO - 'LANG': 'en_US.UTF-8', 17:12:38 INFO - 'LANGUAGE': 'en_US:en', 17:12:38 INFO - 'LOGNAME': 'cltbld', 17:12:38 INFO - 'MAIL': '/var/mail/cltbld', 17:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:38 INFO - 'MOZ_NO_REMOTE': '1', 17:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:38 INFO - 'NO_EM_RESTART': '1', 17:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:38 INFO - 'PWD': '/builds/slave/test', 17:12:38 INFO - 'SHELL': '/bin/bash', 17:12:38 INFO - 'SHLVL': '1', 17:12:38 INFO - 'TERM': 'linux', 17:12:38 INFO - 'TMOUT': '86400', 17:12:38 INFO - 'USER': 'cltbld', 17:12:38 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:38 INFO - '_': '/tools/buildbot/bin/python'} 17:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:39 INFO - Downloading/unpacking psutil>=3.1.1 17:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:40 INFO - Installing collected packages: psutil 17:12:40 INFO - Running setup.py install for psutil 17:12:40 INFO - building 'psutil._psutil_linux' extension 17:12:40 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 17:12:40 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 17:12:40 INFO - building 'psutil._psutil_posix' extension 17:12:40 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 17:12:40 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 17:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:40 INFO - Successfully installed psutil 17:12:40 INFO - Cleaning up... 17:12:40 INFO - Return code: 0 17:12:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:12:40 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')]} 17:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:40 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')]} 17:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:40 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 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:40 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 17:12:40 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 17:12:40 INFO - Using env: {'DISPLAY': ':0', 17:12:40 INFO - 'HOME': '/home/cltbld', 17:12:40 INFO - 'LANG': 'en_US.UTF-8', 17:12:40 INFO - 'LANGUAGE': 'en_US:en', 17:12:40 INFO - 'LOGNAME': 'cltbld', 17:12:40 INFO - 'MAIL': '/var/mail/cltbld', 17:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:40 INFO - 'MOZ_NO_REMOTE': '1', 17:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:40 INFO - 'NO_EM_RESTART': '1', 17:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:40 INFO - 'PWD': '/builds/slave/test', 17:12:40 INFO - 'SHELL': '/bin/bash', 17:12:40 INFO - 'SHLVL': '1', 17:12:40 INFO - 'TERM': 'linux', 17:12:40 INFO - 'TMOUT': '86400', 17:12:40 INFO - 'USER': 'cltbld', 17:12:40 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:40 INFO - '_': '/tools/buildbot/bin/python'} 17:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:12:41 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 17:12:41 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 17:12:41 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 17:12:41 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 17:12:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:12:42 INFO - Installing collected packages: mozsystemmonitor 17:12:42 INFO - Running setup.py install for mozsystemmonitor 17:12:42 INFO - Successfully installed mozsystemmonitor 17:12:42 INFO - Cleaning up... 17:12:42 INFO - Return code: 0 17:12:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:12:42 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')]} 17:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:42 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')]} 17:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:42 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 17:12:42 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 17:12:42 INFO - Using env: {'DISPLAY': ':0', 17:12:42 INFO - 'HOME': '/home/cltbld', 17:12:42 INFO - 'LANG': 'en_US.UTF-8', 17:12:42 INFO - 'LANGUAGE': 'en_US:en', 17:12:42 INFO - 'LOGNAME': 'cltbld', 17:12:42 INFO - 'MAIL': '/var/mail/cltbld', 17:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:42 INFO - 'MOZ_NO_REMOTE': '1', 17:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:42 INFO - 'NO_EM_RESTART': '1', 17:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:42 INFO - 'PWD': '/builds/slave/test', 17:12:42 INFO - 'SHELL': '/bin/bash', 17:12:42 INFO - 'SHLVL': '1', 17:12:42 INFO - 'TERM': 'linux', 17:12:42 INFO - 'TMOUT': '86400', 17:12:42 INFO - 'USER': 'cltbld', 17:12:42 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:42 INFO - '_': '/tools/buildbot/bin/python'} 17:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:42 INFO - Downloading/unpacking jsonschema==2.5.1 17:12:42 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 17:12:42 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 17:12:42 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 17:12:42 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 17:12:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:12:43 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 17:12:43 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 17:12:43 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 17:12:43 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 17:12:44 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:44 INFO - warning: no files found matching '*.txt' 17:12:44 INFO - no previously-included directories found matching 'build' 17:12:44 INFO - no previously-included directories found matching 'dist' 17:12:44 INFO - no previously-included directories found matching '.git*' 17:12:44 INFO - Installing collected packages: jsonschema, functools32 17:12:44 INFO - Running setup.py install for functools32 17:12:44 INFO - warning: no files found matching '*.txt' 17:12:44 INFO - no previously-included directories found matching 'build' 17:12:44 INFO - no previously-included directories found matching 'dist' 17:12:44 INFO - no previously-included directories found matching '.git*' 17:12:44 INFO - Successfully installed jsonschema functools32 17:12:44 INFO - Cleaning up... 17:12:44 INFO - Return code: 0 17:12:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:44 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 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:44 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 17:12:44 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 17:12:44 INFO - Using env: {'DISPLAY': ':0', 17:12:44 INFO - 'HOME': '/home/cltbld', 17:12:44 INFO - 'LANG': 'en_US.UTF-8', 17:12:44 INFO - 'LANGUAGE': 'en_US:en', 17:12:44 INFO - 'LOGNAME': 'cltbld', 17:12:44 INFO - 'MAIL': '/var/mail/cltbld', 17:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:44 INFO - 'MOZ_NO_REMOTE': '1', 17:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:44 INFO - 'NO_EM_RESTART': '1', 17:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:44 INFO - 'PWD': '/builds/slave/test', 17:12:44 INFO - 'SHELL': '/bin/bash', 17:12:44 INFO - 'SHLVL': '1', 17:12:44 INFO - 'TERM': 'linux', 17:12:44 INFO - 'TMOUT': '86400', 17:12:44 INFO - 'USER': 'cltbld', 17:12:44 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:44 INFO - '_': '/tools/buildbot/bin/python'} 17:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:12:44 INFO - Cleaning up... 17:12:44 INFO - Return code: 0 17:12:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:44 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 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:44 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 17:12:44 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 17:12:44 INFO - Using env: {'DISPLAY': ':0', 17:12:44 INFO - 'HOME': '/home/cltbld', 17:12:44 INFO - 'LANG': 'en_US.UTF-8', 17:12:44 INFO - 'LANGUAGE': 'en_US:en', 17:12:44 INFO - 'LOGNAME': 'cltbld', 17:12:44 INFO - 'MAIL': '/var/mail/cltbld', 17:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:44 INFO - 'MOZ_NO_REMOTE': '1', 17:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:44 INFO - 'NO_EM_RESTART': '1', 17:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:44 INFO - 'PWD': '/builds/slave/test', 17:12:44 INFO - 'SHELL': '/bin/bash', 17:12:44 INFO - 'SHLVL': '1', 17:12:44 INFO - 'TERM': 'linux', 17:12:44 INFO - 'TMOUT': '86400', 17:12:44 INFO - 'USER': 'cltbld', 17:12:44 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:44 INFO - '_': '/tools/buildbot/bin/python'} 17:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:44 INFO - Downloading/unpacking blobuploader==1.2.4 17:12:44 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 17:12:44 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 17:12:44 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 17:12:44 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 17:12:45 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12:45 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 17:12:45 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 17:12:45 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 17:12:45 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 17:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:12:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12:46 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 17:12:46 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 17:12:46 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 17:12:46 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 17:12:46 INFO - Downloading docopt-0.6.1.tar.gz 17:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:46 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:46 INFO - Running setup.py install for blobuploader 17:12:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:12:46 INFO - Running setup.py install for requests 17:12:46 INFO - Running setup.py install for docopt 17:12:46 INFO - Successfully installed blobuploader requests docopt 17:12:46 INFO - Cleaning up... 17:12:47 INFO - Return code: 0 17:12:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:47 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 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:47 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 17:12:47 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 17:12:47 INFO - Using env: {'DISPLAY': ':0', 17:12:47 INFO - 'HOME': '/home/cltbld', 17:12:47 INFO - 'LANG': 'en_US.UTF-8', 17:12:47 INFO - 'LANGUAGE': 'en_US:en', 17:12:47 INFO - 'LOGNAME': 'cltbld', 17:12:47 INFO - 'MAIL': '/var/mail/cltbld', 17:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:47 INFO - 'MOZ_NO_REMOTE': '1', 17:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:47 INFO - 'NO_EM_RESTART': '1', 17:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:47 INFO - 'PWD': '/builds/slave/test', 17:12:47 INFO - 'SHELL': '/bin/bash', 17:12:47 INFO - 'SHLVL': '1', 17:12:47 INFO - 'TERM': 'linux', 17:12:47 INFO - 'TMOUT': '86400', 17:12:47 INFO - 'USER': 'cltbld', 17:12:47 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:47 INFO - '_': '/tools/buildbot/bin/python'} 17:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:47 INFO - Running setup.py (path:/tmp/pip-CZNkdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:47 INFO - Running setup.py (path:/tmp/pip-FgDnaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:47 INFO - Running setup.py (path:/tmp/pip-5AcHc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:47 INFO - Running setup.py (path:/tmp/pip-hN3I7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:47 INFO - Running setup.py (path:/tmp/pip-Vwe50E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:47 INFO - Running setup.py (path:/tmp/pip-i5y1AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:47 INFO - Running setup.py (path:/tmp/pip-ifKDDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:47 INFO - Running setup.py (path:/tmp/pip-3RXLoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:47 INFO - Running setup.py (path:/tmp/pip-8e4INx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:47 INFO - Running setup.py (path:/tmp/pip-lekFYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:47 INFO - Running setup.py (path:/tmp/pip-ie57PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:48 INFO - Running setup.py (path:/tmp/pip-gZrLgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:48 INFO - Running setup.py (path:/tmp/pip-2W_yZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:48 INFO - Running setup.py (path:/tmp/pip-3WacAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:48 INFO - Running setup.py (path:/tmp/pip-rPFvlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:48 INFO - Running setup.py (path:/tmp/pip-cp3LO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:48 INFO - Running setup.py (path:/tmp/pip-WySA71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:48 INFO - Running setup.py install for manifestparser 17:12:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for mozcrash 17:12:48 INFO - Running setup.py install for mozdebug 17:12:48 INFO - Running setup.py install for mozdevice 17:12:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for mozfile 17:12:48 INFO - Running setup.py install for mozhttpd 17:12:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Running setup.py install for mozinfo 17:12:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Running setup.py install for mozInstall 17:12:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Running setup.py install for mozleak 17:12:49 INFO - Running setup.py install for mozlog 17:12:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Running setup.py install for moznetwork 17:12:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Running setup.py install for mozprocess 17:12:49 INFO - Running setup.py install for mozprofile 17:12:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Running setup.py install for mozrunner 17:12:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Running setup.py install for mozscreenshot 17:12:49 INFO - Running setup.py install for moztest 17:12:50 INFO - Running setup.py install for mozversion 17:12:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:12:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:12:50 INFO - Cleaning up... 17:12:50 INFO - Return code: 0 17:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12: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')]} 17:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:50 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 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:50 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 17:12:50 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 17:12:50 INFO - Using env: {'DISPLAY': ':0', 17:12:50 INFO - 'HOME': '/home/cltbld', 17:12:50 INFO - 'LANG': 'en_US.UTF-8', 17:12:50 INFO - 'LANGUAGE': 'en_US:en', 17:12:50 INFO - 'LOGNAME': 'cltbld', 17:12:50 INFO - 'MAIL': '/var/mail/cltbld', 17:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:50 INFO - 'MOZ_NO_REMOTE': '1', 17:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:50 INFO - 'NO_EM_RESTART': '1', 17:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:50 INFO - 'PWD': '/builds/slave/test', 17:12:50 INFO - 'SHELL': '/bin/bash', 17:12:50 INFO - 'SHLVL': '1', 17:12:50 INFO - 'TERM': 'linux', 17:12:50 INFO - 'TMOUT': '86400', 17:12:50 INFO - 'USER': 'cltbld', 17:12:50 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:50 INFO - '_': '/tools/buildbot/bin/python'} 17:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:50 INFO - Running setup.py (path:/tmp/pip-JZS7g7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:50 INFO - Running setup.py (path:/tmp/pip-5AdqHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:50 INFO - Running setup.py (path:/tmp/pip-Su5mXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:50 INFO - Running setup.py (path:/tmp/pip-kRGU55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:50 INFO - Running setup.py (path:/tmp/pip-nZdURb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:50 INFO - Running setup.py (path:/tmp/pip-3Qq6r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:50 INFO - Running setup.py (path:/tmp/pip-9d9zHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:50 INFO - Running setup.py (path:/tmp/pip-pOmiAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:51 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)) 17:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:51 INFO - Running setup.py (path:/tmp/pip-BBB41e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:51 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)) 17:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:51 INFO - Running setup.py (path:/tmp/pip-tEB8Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:51 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)) 17:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:51 INFO - Running setup.py (path:/tmp/pip-sGs9bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:51 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)) 17:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:51 INFO - Running setup.py (path:/tmp/pip-NIxY8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:51 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)) 17:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:51 INFO - Running setup.py (path:/tmp/pip-dSkIl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:51 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)) 17:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:51 INFO - Running setup.py (path:/tmp/pip-3KMLFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:51 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)) 17:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:51 INFO - Running setup.py (path:/tmp/pip-wEhTl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:51 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)) 17:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:51 INFO - Running setup.py (path:/tmp/pip-RdM3rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:51 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)) 17:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:51 INFO - Running setup.py (path:/tmp/pip-tXUv27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:51 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)) 17:12:51 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)) 17:12:51 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)) 17:12:51 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)) 17:12:51 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)) 17:12:51 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)) 17:12:51 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)) 17:12:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:12:51 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 17:12:51 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 17:12:51 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 17:12:51 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 17:12:52 INFO - Downloading blessings-1.6.tar.gz 17:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:52 INFO - Installing collected packages: blessings 17:12:52 INFO - Running setup.py install for blessings 17:12:52 INFO - Successfully installed blessings 17:12:52 INFO - Cleaning up... 17:12:53 INFO - Return code: 0 17:12:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:53 INFO - Reading from file tmpfile_stdout 17:12:53 INFO - Current package versions: 17:12:53 INFO - argparse == 1.2.1 17:12:53 INFO - blessings == 1.6 17:12:53 INFO - blobuploader == 1.2.4 17:12:53 INFO - docopt == 0.6.1 17:12:53 INFO - functools32 == 3.2.3-2 17:12:53 INFO - jsonschema == 2.5.1 17:12:53 INFO - manifestparser == 1.1 17:12:53 INFO - mozInstall == 1.13 17:12:53 INFO - mozcrash == 1.0 17:12:53 INFO - mozdebug == 0.1 17:12:53 INFO - mozdevice == 0.51 17:12:53 INFO - mozfile == 1.2 17:12:53 INFO - mozhttpd == 0.7 17:12:53 INFO - mozinfo == 0.10 17:12:53 INFO - mozleak == 0.1 17:12:53 INFO - mozlog == 3.5 17:12:53 INFO - moznetwork == 0.27 17:12:53 INFO - mozprocess == 0.25 17:12:53 INFO - mozprofile == 0.28 17:12:53 INFO - mozrunner == 6.13 17:12:53 INFO - mozscreenshot == 0.1 17:12:53 INFO - mozsystemmonitor == 0.3 17:12:53 INFO - moztest == 0.8 17:12:53 INFO - mozversion == 1.4 17:12:53 INFO - psutil == 3.1.1 17:12:53 INFO - requests == 1.2.3 17:12:53 INFO - wsgiref == 0.1.2 17:12:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:53 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 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:53 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 17:12:53 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 17:12:53 INFO - Using env: {'DISPLAY': ':0', 17:12:53 INFO - 'HOME': '/home/cltbld', 17:12:53 INFO - 'LANG': 'en_US.UTF-8', 17:12:53 INFO - 'LANGUAGE': 'en_US:en', 17:12:53 INFO - 'LOGNAME': 'cltbld', 17:12:53 INFO - 'MAIL': '/var/mail/cltbld', 17:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:53 INFO - 'MOZ_NO_REMOTE': '1', 17:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:53 INFO - 'NO_EM_RESTART': '1', 17:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:53 INFO - 'PWD': '/builds/slave/test', 17:12:53 INFO - 'SHELL': '/bin/bash', 17:12:53 INFO - 'SHLVL': '1', 17:12:53 INFO - 'TERM': 'linux', 17:12:53 INFO - 'TMOUT': '86400', 17:12:53 INFO - 'USER': 'cltbld', 17:12:53 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:53 INFO - '_': '/tools/buildbot/bin/python'} 17:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:12:53 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 17:12:53 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 17:12:53 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 17:12:53 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 17:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:12:54 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)) 17:12:54 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)) 17:12:54 INFO - Installing collected packages: simplejson 17:12:54 INFO - Running setup.py install for simplejson 17:12:54 INFO - building 'simplejson._speedups' extension 17:12:54 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 17:12:55 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 17:12:55 INFO - Successfully installed simplejson 17:12:55 INFO - Cleaning up... 17:12:55 INFO - Return code: 0 17:12:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1873a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', '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 17:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:12:55 INFO - Using env: {'DISPLAY': ':0', 17:12:55 INFO - 'HOME': '/home/cltbld', 17:12:55 INFO - 'LANG': 'en_US.UTF-8', 17:12:55 INFO - 'LANGUAGE': 'en_US:en', 17:12:55 INFO - 'LOGNAME': 'cltbld', 17:12:55 INFO - 'MAIL': '/var/mail/cltbld', 17:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:55 INFO - 'MOZ_NO_REMOTE': '1', 17:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:55 INFO - 'NO_EM_RESTART': '1', 17:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:55 INFO - 'PWD': '/builds/slave/test', 17:12:55 INFO - 'SHELL': '/bin/bash', 17:12:55 INFO - 'SHLVL': '1', 17:12:55 INFO - 'TERM': 'linux', 17:12:55 INFO - 'TMOUT': '86400', 17:12:55 INFO - 'USER': 'cltbld', 17:12:55 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:55 INFO - '_': '/tools/buildbot/bin/python'} 17:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:12:55 INFO - Cleaning up... 17:12:55 INFO - Return code: 0 17:12:55 INFO - Running post-action listener: _resource_record_post_action 17:12:55 INFO - Running post-action listener: _start_resource_monitoring 17:12:55 INFO - Starting resource monitoring. 17:12:55 INFO - [mozharness: 2017-08-14 00:12:55.941044Z] Finished create-virtualenv step (success) 17:12:55 INFO - [mozharness: 2017-08-14 00:12:55.941604Z] Running install step. 17:12:55 INFO - Running pre-action listener: _resource_record_pre_action 17:12:55 INFO - Running main action method: install 17:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:56 INFO - Reading from file tmpfile_stdout 17:12:56 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:56 INFO - Reading from file tmpfile_stdout 17:12:56 INFO - Output received: 17:12:56 INFO - Usage: mozinstall [options] installer 17:12:56 INFO - Options: 17:12:56 INFO - -h, --help show this help message and exit 17:12:56 INFO - -d DEST, --destination=DEST 17:12:56 INFO - Directory to install application into. [default: 17:12:56 INFO - "/builds/slave/test"] 17:12:56 INFO - --app=APP Application being installed. [default: firefox] 17:12:56 INFO - mkdir: /builds/slave/test/build/application 17:12:56 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'] 17:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:13:14 INFO - Reading from file tmpfile_stdout 17:13:14 INFO - Output received: 17:13:14 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:14 INFO - Running post-action listener: _resource_record_post_action 17:13:14 INFO - [mozharness: 2017-08-14 00:13:14.196486Z] Finished install step (success) 17:13:14 INFO - [mozharness: 2017-08-14 00:13:14.196774Z] Running setup-mitmproxy step. 17:13:14 INFO - Running pre-action listener: _resource_record_pre_action 17:13:14 INFO - Running main action method: setup_mitmproxy 17:13:14 INFO - Skipping: mitmproxy is not required 17:13:14 INFO - Running post-action listener: _resource_record_post_action 17:13:14 INFO - [mozharness: 2017-08-14 00:13:14.197969Z] Finished setup-mitmproxy step (success) 17:13:14 INFO - [mozharness: 2017-08-14 00:13:14.198191Z] Running run-tests step. 17:13:14 INFO - Running pre-action listener: _resource_record_pre_action 17:13:14 INFO - Running pre-action listener: _set_gcov_prefix 17:13:14 INFO - Running main action method: run_tests 17:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:14 INFO - Python 2.7.3 17:13:14 INFO - Return code: 0 17:13:14 INFO - grabbing minidump binary from tooltool 17:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:14 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 0x1a17f00>, '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 0x1a12ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a13050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:14 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 17:13:14 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 17:13:14 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 17:13:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:14 INFO - Return code: 0 17:13:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:14 INFO - ENV: RUST_BACKTRACE is now full 17:13:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:14 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/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 17:13:14 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/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --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 17:13:14 INFO - Using env: {'DISPLAY': ':0', 17:13:14 INFO - 'HOME': '/home/cltbld', 17:13:14 INFO - 'LANG': 'en_US.UTF-8', 17:13:14 INFO - 'LANGUAGE': 'en_US:en', 17:13:14 INFO - 'LOGNAME': 'cltbld', 17:13:14 INFO - 'MAIL': '/var/mail/cltbld', 17:13:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:14 INFO - 'MOZ_NO_REMOTE': '1', 17:13:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:14 INFO - 'NO_EM_RESTART': '1', 17:13:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:14 INFO - 'PWD': '/builds/slave/test', 17:13:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:14 INFO - 'RUST_BACKTRACE': 'full', 17:13:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:13:14 INFO - 'SHELL': '/bin/bash', 17:13:14 INFO - 'SHLVL': '1', 17:13:14 INFO - 'STYLO_FORCE_ENABLED': '1', 17:13:14 INFO - 'TERM': 'linux', 17:13:14 INFO - 'TMOUT': '86400', 17:13:14 INFO - 'USER': 'cltbld', 17:13:14 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347', 17:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:14 INFO - '_': '/tools/buildbot/bin/python'} 17:13:14 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/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 17:13:14 INFO - mozversion application_buildid: 20170813232840 17:13:14 INFO - mozversion application_changeset: e594b178728bc6a51fc81bffcb1d6f0a7071cd33 17:13:14 INFO - mozversion application_display_name: Nightly 17:13:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:14 INFO - mozversion application_name: Firefox 17:13:14 INFO - mozversion application_remotingname: firefox 17:13:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:13:14 INFO - mozversion application_vendor: Mozilla 17:13:14 INFO - mozversion application_version: 57.0a1 17:13:14 INFO - mozversion platform_buildid: 20170813232840 17:13:14 INFO - mozversion platform_changeset: e594b178728bc6a51fc81bffcb1d6f0a7071cd33 17:13:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:13:14 INFO - mozversion platform_version: 57.0a1 17:13:14 INFO - using testdate: 1502669594 17:13:14 INFO - actual date: 1502669594 17:13:14 INFO - starting webserver on 'localhost:60939' 17:13:14 INFO - SUITE-START | Running 2 tests 17:13:14 INFO - TEST-START | dromaeo_css 17:13:14 INFO - Initialising browser for dromaeo_css test... 17:13:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60939/getInfo.html -profile /tmp/tmpdsDMln/profile 17:13:14 INFO - TEST-INFO | started process 32255 (/builds/slave/test/build/application/firefox/firefox http://localhost:60939/getInfo.html) 17:13:21 INFO - TEST-INFO | 32255: exit 0 17:13:21 INFO - Browser initialized. 17:13:21 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:21 INFO - TEST-INFO | started process 32490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdsDMln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:22 INFO - PID 32490 | 17:13:22 INFO - PID 32490 | (/builds/slave/test/build/application/firefox/firefox:32544): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:13:22 INFO - PID 32490 | 17:13:32 INFO - PID 32490 | RSS: Main: 168140800 17:13:32 INFO - PID 32490 | 17:16:32 INFO - PID 32490 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60939/tests/dromaeo/cssquery-ext.html) 17:16:33 INFO - PID 32490 | RSS: Main: 175263744 17:16:33 INFO - PID 32490 | 17:19:35 INFO - PID 32490 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-ext.html (next: http://localhost:60939/tests/dromaeo/cssquery-jquery.html) 17:19:35 INFO - PID 32490 | RSS: Main: 170848256 17:19:35 INFO - PID 32490 | 17:22:37 INFO - PID 32490 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60939/tests/dromaeo/cssquery-mootools.html) 17:22:38 INFO - PID 32490 | RSS: Main: 174669824 17:22:38 INFO - PID 32490 | 17:25:40 INFO - PID 32490 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60939/tests/dromaeo/cssquery-prototype.html) 17:25:40 INFO - PID 32490 | RSS: Main: 173006848 17:25:40 INFO - PID 32490 | 17:28:44 INFO - PID 32490 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60939/tests/dromaeo/cssquery-yui.html) 17:28:45 INFO - PID 32490 | RSS: Main: 175804416 17:28:45 INFO - PID 32490 | 17:31:47 INFO - PID 32490 | Cycle 1(1): loaded http://localhost:60939/tests/dromaeo/cssquery-yui.html (next: http://localhost:60939/tests/dromaeo/cssquery-dojo.html) 17:31:47 INFO - PID 32490 | RSS: Main: 177205248 17:31:47 INFO - PID 32490 | 17:31:47 INFO - PID 32490 | __start_tp_report 17:31:47 INFO - PID 32490 | _x_x_mozilla_page_load 17:31:47 INFO - PID 32490 | _x_x_mozilla_page_load_details 17:31:47 INFO - PID 32490 | |i|pagename|runs| 17:31:47 INFO - PID 32490 | |0;dojo.html;3152.196189971557;3163.035274241356;3193.21766167289;3205.134613654312;3207.711305982461;6169.321374648785;6244.157038799766;6269.310375858652;6281.183446151999;6318.147050148229;5996.940030599703;6097.603655762372;6100.23747031621;6109.969450152743;6117.5717699761035;5547.861303467415;5552.333719953611;5659.1511273309125;5718.59969802114;5828.883422331551;5783.103618939072;5783.103618939072;5793.102069179263;5797.623154494965;5832.912506312408;5473.0969390050595;5622;5715.885682286352;5774.595778295521;5845.620034697752;5689.943100568983;5706.172604972256;5746.25298711169;5763.711814409263;5763.913541296842;5463.262459567987;5624.493795558378;5669.461401166924;5682.943170568283;5702.486776190163;6007.789727359522;6041.24484439445;6043.758249670008;6069.453749162552;6081.847953801146;6580.605163690194;6617.272100068989;6634.038064480672;6641.203055633307;6660.9000864987065;6603.471722262256;6603.570767900119;6639.302873198293;6692.163479565054;6732.730690772412;5973.820785376446;5978.40215978403;6032.8793424132145;6152.600080994721;6248.031555108965;6765.594064356154;6780;6782.050512928194;6787.321267873173;6793.830154246183;6389.297177310492;6452.193475815523;6465.4827613790785;6469.256035555972;6469.773557925544;6570.441512471493;6581.012848072827;6627;6699.564528305645;6714.227863795726;6649.700763465656;6709.6980635871505;6719.630420326929;6737.663116844138;6743.089682892747;6635.10426092481;6654.83362915931;6696.799096027127;6769.695363708645;6784;5273.736313184326;5307.230451584499;5308.787648494094;5312.468753124734;5402.783888644489;4664.230401983635;4668.089722504079;4687.742174180453;4707.458642256184;4734.029523947583;5721.456461636138;5800.8259752207505;5803.912941305884;5812.738426770806;5822.184894114827;6705.832354191087;6746.325367463214;6817.659117044128;6830.112085428962;6833.6241506716615;5546.833594992157;5590.2453168821685;5712.914306285409;5737.971310143423;5781.942180578225;5854.356020837789;5881.3530511643685;5884.117382392676;5886.529077673776;5926.140709597084;6398.744050237939;6553.246376666744;6570.737170513222;6574.704138313788;6575.473962083021;6683.6324002180345;6690.163729533809;6788.76239331621;6789.355011273921;6791.422729067887;6313.337099604659;6326.177596912372;6399.520035997412;6488.124103246001;6567.146270984741;6511.3163117871945;6540.117084193573;6555.639439830855;6586.308437613981;6599.53803233769;6656.7670131545165;6686.465082793462;6750.966245168743;6760.425363844129;6775.830604234933;6473.320301368477;6488.740450381932;6562.934370656232;6563.638999855054;6575.408213260829;6301.369863013662;6384.17005789263;6394.680265986589;6467.741290348334;6567.934320656732;6324.462420694293;6348.047792831112;6353.047042943595;6449.774257900951;6452.22573291208;6574.4740420765265;6575.473962083118;6597.736090556324;6619.66901654925;6680.933190668031;6111.266648002268;6239.875202495834;6312.4634406076;6350.301466838737;6366.713497892699 17:31:47 INFO - PID 32490 | |1;ext.html;835.841190173867;875.0855356152821;896.9955150224248;1152.9077673786103;1180.4392913366146;38448;41931;41954.58045419545;41960.58039419605;42074.36888446672;42364.57635423645;42464.36303455443;42840.78579607105;42864.57135428645;42889;7635.65639546219;7643.197464266255;7646.426518011143;7740.148583655793;7794.688212471494;7643.541387516739;7688.538687678729;7692;7716.459847810655;7719.228077192292;5828.125781132842;5973.581849270553;7651.928729977808;7877.6848926042885;7883.211678832128;7794.142644309121;7868.213178682143;7904.920950790476;7906.565138917357;7907.2488113629115;7656.157822639505;7711.691532338699;7715.652795624211;7722.42081843864;7730.729424470116;38211.23577528434;38528.22943541114;38592.614073859186;38612.80693596542;38616;3580.2660454606744;3617.6382361763876;3622.1669016126175;3625.0212442640604;3630.909227269339;30571.694283057106;30917.536236956465;30937.226569335722;30955.071347859375;30973.535396969062;5070.974645126787;5112.565431938253;5124.538791508745;5129.307543481619;5133.845984620468;183825;183835.08082459637;183848;184153;184418;46973.29540056902;46983.29525057127;47084.293735593994;47118.52881471141;47232.7638361806;48741.26888096681;49141;49142.26286605704;49157;49295;15567.143807090719;15591.61020974462;15650.37398504047;15662.451814186448;15688.921555392379;13013.934930325477;13021.609351719464;13022.674433139058;13030.348482575833;13040.347982601023;11840.940795295968;13534.120282181626;13847.723045539033;13851.238181899891;14025.509107181404;4586.931196032062;5946.316173640001;5982.521398288127;6001.129836173817;6135.785247516315;977.6871401151564;991.4497453913148;1002.8595996560488;1005.7535903703639;1010.0808264479435;23827.285181444586;29162.854185728935;29445.55831662527;29810;30091.699083009327;1060.533365319257;1063.6117816996896;1068.6847380022912;1070.4433694478828;1081.4214395298634;12751.872481275068;16102.436414725662;16266.674666506604;16382.180890955404;16574.917125414297;239083;240676;243613;243662;243966;58012;58134.96527621513;58246;58551.70724146437;58774;1423.9003269771017;1470.919099449519;1478.1279045363287;1481.4444583281054;1490.0389248934594;27247.455050898476;27683.723162768114;27957.580636290066;28070.57894131549;28219.858900705363;38918;38971.6102838968;39010.2197956045;39028.21943561056;39031.2193756129;201772;202562;202630;202886;203552;35141.29717405689;35279.29441411209;35501.467477988364;35579.644203558666;35812;43611.345829811944;44413.55586444094;44942.77528612336;45031;45088.323675144245;31823.840880796375;32222.19444513906;32708.182295441853;32999.67000329966;33008.83495582507;32303.51544726878;32491;32864.67135328616;32926.83536582302;33146;35191.47212791759;35334;35549.46675799813;35552.28895422129;35643;30618.693813062477;31259.687403126587;31395.37209255848;31630.051098467084;31741.36517269688;23180.652290215996;23530.41173970596;24948.501029979663;25525.87237063803;25794.226173214833 17:31:47 INFO - PID 32490 | |2;jquery.html;568.7867049856304;579.5740131003713;580.5616759346692;583.2213994317585;589.1869220475744;16660.58348541287;22646.547069058608;23556.88221558894;23557.175498857523;23756.406089847762;19579;19907.502312442197;24508;25263.494730105387;25550.488990220183;6389.20134983126;6481.384268494509;6572.014197870334;6578.24350199726;6578.967105164467;5937.346891841894;6453.16108905844;6501.219853617573;6624.403803657669;6641.767538136166;6344.936550634504;6394.552381333308;6395.264544577363;6400;6403.327650596691;6400.487960963112;6406.679666016704;6421.7110230039525;6437.356264373572;6437.452816510602;5944.167816505693;5958;5975.163477113208;5982.670953097578;5985.850353741148;27376.315592110157;28090.719092809013;28517.429651407063;28520.714792852013;28571.285717857012;1967.085305333027;1997.9300724474574;1998.0309549868302;2000.3298894870236;2003.008510787155;19156.329528466576;19714.42284617227;19717.507062323413;19775.110120044632;19802.405927822187;2096.9790302096935;2123.3417640531484;2163.8377121715776;2169.945751356213;2370.952580948371;136124.31937840246;138664.30667846696;138803;139328.30335848356;139351;14527.201003944672;14872.62818429548;15041.623959401102;15109.773353399489;15468.303926323342;22858.42853928665;22859.657105143437;22877;22924.426889327566;22948.770512294996;10069.59721611142;10133.442660653734;10145.492725363702;10148.543315550818;10179.54192061359;9315.953420232856;9332.58003389849;9346.11211934865;9407.717768466957;9434.386764860263;8838.248748856291;8982.730518084469;9108.544572771334;9295.58169882357;9566.51270669617;2575.53640344736;2588.7415201992617;2698.2849544870624;2739.8082134250412;2824.533951897955;904.1500989070253;911.3939230411835;929.4098247612815;969.2294625772528;970.1511177719495;18582.81417185838;19016.904915475334;19316.517087072934;19414.029298535017;19482;946.2619157057507;950.8732152399291;1024.8273659841184;1040.2510192661273;1041.890601486833;10946.726331841608;10967.890321096846;11155.107591392669;11229.66311010671;11252.58721727628;472635;482006;487620;489530;515546;119368;119423;120712;121690.39154804347;122233;1266.4554241676167;1270.5426046623209;1290.9870901291056;1291.438224372401;1292.713749818936;17047;17310.82689173092;17451.127443627513;17741;17770.644587108443;53012.73493632507;54640.453595463536;55487.72256138694;56919.715401424386;57236.71381643232;70913;71006;71300;71403.64298178475;73028.26971730427;14325.85674143287;14612.561623151323;14845.109293442429;14910.776338354717;14920.850791492381;23726.169584064475;23907.402314942265;24024.519509610058;24057.759422406252;24064.398390040387;18624.161912714233;18714.438566843015;18739.71890421672;18849.24603015864;19046.809531904502;16918.492445226664;17414.0422276776;17499.56251093733;17593.82406175922;18012.90993545024;18175.81824181741;19310;19573.804261957197;19625.411237662895;19759.703604446233;14747.115173089649;14977.400903963719;15000.099993999958;15037.323320450387;15053.473128440452;18287.634247314712;18590;18837.90581047141;18953.43139705811;18955 17:31:47 INFO - PID 32490 | |3;mootools.html;1379.6481897116234;1445.1184777285853;1447.3631602095077;1461.8245810502735;1462.553921054078;13860.930695346522;14347.21090340031;14381.137131772088;14401.495947641835;14409.92795036026;15041.247937603132;15251.161186134757;15303.846961530382;15315.540533784004;15315.770263446057;2667.7865770738294;2718.4019515706514;2718.7417195366406;2721.306066952924;2724.1691284158323;2633.5522961096563;2675.933101672464;2699.082312013915;2717.55160398535;2721.2788611018095;2635.1040646180295;2661.760441560259;2669.319323572486;2709.403931135147;2720.64631597892;2653.270350653576;2664.5736682130864;2671.3188137025127;2674.598810178469;2674.6924103728124;2615.5422801009745;2620.0305886821807;2629.0535407253565;2633.9604905926426;2634.9604755928676;13849.376778045013;14077.507287244896;14123.505677301246;14124.858751412457;14127.505537306144;7428.702851885918;7639.618019099078;7641.3504852087635;7641.579713115776;7681.692732290701;5085.440601533828;5197.66215196011;5204.661696989683;5309.7610607522365;5321.654092484015;1935.380678182982;1942.5046613113707;1946.6496030714466;1950.6781381072105;1976.713376560405;23924.52150956971;24051.158209462585;24105;24113.638295425582;24114.517709645883;6380.234371875405;6466.515011374166;6488.124103246096;6656.334366563305;6685.264620891698;15866.286017129258;15912.204389780465;15941.44204952821;15960;15966.76049859253;7406.777796666109;7520.962395187989;7530.096388433423;7531.887021694679;7534.321911027924;5758.539316854642;6965.616891071039;7043.506954513237;7119.644017799193;7150.821229469201;5057.494250574913;5173.5343819055715;5197.246399272084;5218.086834803894;5261.500157485033;1459.8248210214629;1462.4515806572535;1472.580314610331;1473.3204147272118;1480.0389483933832;886.1625763653286;899.869518919766;900.4057322167338;913.2739472119681;919.3151102428733;7517.661705223278;7548.849023019508;7551.244875512405;7566.772996809995;7590.696372145163;720.4632548751109;723.9746608868664;726.7492715013312;729.5221629832469;729.9708011679579;4447.435993318887;4592.104539614743;5088.491150884956;5140;5156.8968620627375;19254;20275.695864562043;20286.39140825748;20304.289349872684;20433.284835030703;19087.141078651493;19519;19960.60078798416;19984;20037.899810501145;10691.465426728633;10754.085902698202;10931.890681093246;10954.616588419367;10981.560737570408;7709.1708072208385;7740.496867703581;7876.330511906552;7898.170692077479;7950.52296862167;17057.658846823244;17309.134543273038;17390.565235868697;17617.383391581232;17828.19773110187;17572.297108115534;17636.911815440842;17875.123112073044;17922.641547169245;17941.73087403664;11221;11389.715257118638;11448.828267575826;11449.370284634426;11463.484143213409;13367.197968121944;13419.932900335436;13522.594322170351;13530.93234533821;13532.797008045085;10711.464426778473;10760.946195268974;10783.352998820095;10954.56181752721;11002.394868282321;10908.836367454653;10913.781724365626;10945;10992.120630349713;11244.887551124712;9083.863742044006;9135.26917846584;9140.360174787702;9142.63429462814;9164.725058248263;7133.251008644018;7156.427485801228;7171.1394632644415;7188.28117188277;7231.023811785552;6998.545094568837;7063;7086.681099350439;7097.574145551283;7108.3602475777425 17:31:47 INFO - PID 32490 | |4;prototype.html;496.10453132096563;498.90956890628263;528.2415612914117;529.045073642076;534.2280404815044;6283.308836028039;6294.6223226606435;6311.495080393569;6341.143945567347;6344.746210151594;5961.0760332148475;6165.445109940116;6192.938070619292;6219.346968568303;6239.15771370866;4964.652474326798;5019.774110165043;5033.521815427529;5045.217991211368;5082.526067440456;4993.425756038047;5002.849914502571;5006.148954677696;5019;5050.595952323805;4770.713757174581;4925.605951523869;4952.603791696655;4979.477154898737;5044.142495775727;4916.385451818523;4924.187509061001;4932.53140951609;4982.651214414975;5025.447200807908;4482.753448560328;4490.977545112253;4509.458864936196;4517.096580683843;4528.615067719248;6141.324454310023;6151.5386346024225;6165.167702360169;6190.907136392958;6229.875402491924;5629.749539097996;5682.602217844753;5774.335951365605;5789.623674461147;5791.102379131242;6473.352664733536;6479.403930818394;6563.081168636347;6593.3736295051895;6615.966920165417;4816.229403295491;4855.878603034952;4883.316335713003;4894;4923.90152196954;6798.456123510107;6804.76183333581;6963.825904352431;6973.128358955181;7025.578465292047;4991.151504244287;5011.4236862761245;5020.297158397827;5022.573081288058;5051.636058264322;5119.769610367543;5122.667026643257;5147.794088236504;5148.56237219833;5151.330327057533;5656.264685590847;5721.22763426932;5725.77096916127;5757.309122905278;5764.394738552475;6578.848701477223;6581.243157036906;6608.306127856602;6615.569987950767;6725.361090696376;1696.5993119735683;1727.5940154063785;1736.2273788164146;1758.34062226665;1798.6762382770964;1209.3227792436087;1212.5271144253747;1236.7781928077409;1237.9504819807287;1250.5748045664336;5644.488202749819;5673.347565030074;5688.317401911797;5755.712214389264;5760.8271751847515;6551.65865408645;6640.269570347258;6669;6757.290484499155;6810.114685091005;5691;5692.345380281321;5732.627379220337;5754.482096611325;5759.884802303931;3601.94597081044;3602;3608.783472991576;3629.7822130672243;3631.418972964313;6489.805305840738;6520.673966301666;6584.604923704593;6594.505412094112;6693.297203793629;6881.587104773729;6907.205671347759;6930.306969303029;6978.337057979484;7032.753853615099;6479.254885688112;6481.351864813481;6612.900806487906;6626.138601981712;6633.900491492632;6760.763373281911;6785.389314961677;6794.558353706993;6795.422389096982;6819.795406137824;6644.933550664625;6645.468362530889;6751.93248067513;6755.527113102035;6808.38724514796;6492.220933488012;6515.446187074152;6516.979736281768;6584.637844918576;6618.338166183536;4989.376327959005;4996.450390456974;5024.271480635361;5032.899342013213;5049.192129259301;6777.423918966943;6812.318768123148;6847.726090956306;6874.9656251718425;6884.862302754017;6579.144711187515;6583.835404114935;6588.8023359299295;6635.369639884203;6636.800895973129;6555.869342463814;6571.3757193066585;6605.768798092044;6614.404703576702;6690.665466726547;6016.285358672757;6263.498920086291;6317.39984701471;6332.841678958063;6499.28507864144;6542.313057128933;6567.605943643397;6591.670416479253;6604.174478190226;6643.202815662152;6317.715702793477;6342.365763423621;6361.650109244036;6365.172527571386;6434.967825160844 17:31:47 INFO - PID 32490 | |5;yui.html;901.1709227510686;922.1424075609682;924.2236521322088;932.95801688924;939.135994884706;17154.485365439024;17797.822021779793;17821.64356712868;17870.91064544677;22476.775232247674;21014.789852101476;22017.66973495395;22041.669374959347;22089.889550552263;22192.223272185478;1021.1371391174446;1050.915926725864;1058.1006144776954;1058.1164727452585;1059.3061544688242;1015.7968406318729;1047.586203449637;1064.074255397805;1065.211743309953;1071.4000159910436;1095.6548687163558;1096.3038470571164;1096.7696783675437;1097.3306283167262;1098.9450527473634;1083.864516935383;1084.3331351218944;1089.264746296251;1089.2974031749516;1090.4111779638986;802.7952872017598;803.0122948773042;803.2248879830933;803.317180396664;803.6624617660597;19831.206751729915;19992;20051.1979520819;20089.397318080482;20363;21692.132314707393;21822.345329640135;22264.443388915246;22316.776832231633;22356.664650030263;16600;16753.664926701396;16795.32818687251;17094.658106837916;18025.369112081145;3570.3037907608027;3578.58846232684;3578.8389522471552;3599.226166374242;3604.4953706481115;126645;127944;128579;128740;131797;17528.649427011387;17647.11764411774;17720.468385948185;18069.186886590134;18097.18562664683;30955;31066.68933310638;31356;31569.21076973094;31672;7218.494705370574;7587.658555365022;8655.307575393954;8850.20348168668;8973.237274831581;4197.223513649923;4480.327950807405;4484.327350897326;4484.327350897392;4516.458025036951;5269.367675878919;5381.327334083239;5417.079096553595;5418.431064738224;5448.346198456132;1078.078243102152;1086.6957251969461;1096.9177311701494;1097.6706987903597;1101.24014430043;608.2518502242267;613.349849159892;624.581530374641;634.014108061968;638.3361304243534;10704.839427408595;11601.941990289995;12326.50693972231;12463.314517701432;12706.9364653178;617;635.1425575473166;649.7693318871827;664;669.9497537684693;5299.761510731949;5599.440055994368;5645.858853528694;5728.971355143198;5780.393058728773;109000.4549977245;109836;109929.45035274772;110755;114850;96682;96978;98916;100044.49977750065;100258;86869;87922.68115978266;89146;90280.5485972566;91633;9530.285228608021;9562.856557151508;9729.513524323615;9765.169960553432;9850.113489785954;36466.27067458689;36602.45096323504;36925.26149477049;39012.219755604165;39051;48968.2654760186;49291;67438.66280668565;70876;75582;14031.368588413341;17066.829331706525;17201.56996075058;17354.566135846704;17363.2186551608;16230.431934882223;19759.901200493907;20012.699809502577;20865;20934.47663808417;16666.16669166561;16938.576535586708;17086.829131708524;17126;17357.826421735623;15890.205489725698;15937.760933586238;16010.35958561691;16020.038797672178;16023.118728470046;16696.83303166953;16720.74918876242;17361.218745156246;17476.30094796245;17532.298708052047;11745.17783755129;12095.516179352728;12371.69070773202;12423.440945157308;12429.937850310691;13346.399412026289;13427.530036448677;13516.797248041485;13623.591292261248;13960.092593981359 17:31:47 INFO - PID 32490 | __end_tp_report 17:31:47 INFO - PID 32490 | __start_cc_report 17:31:47 INFO - PID 32490 | _x_x_mozilla_cycle_collect,385 17:31:47 INFO - PID 32490 | __end_cc_report 17:31:47 INFO - PID 32490 | __startTimestamp1502670707277__endTimestamp 17:31:47 INFO - PID 32490 | 17:31:47 INFO - PID 32490 | ------- Summary: start ------- 17:31:47 INFO - PID 32490 | Number of tests: 6 17:31:47 INFO - PID 32490 | 17:31:47 INFO - PID 32490 | [#0] dojo.html Cycles:165 Average:6124.14 Median:6348.05 stddev:720.15 (11.3%) stddev-sans-first:683.58 17:31:47 INFO - PID 32490 | Values: 3152.2 3163.0 3193.2 3205.1 3207.7 6169.3 6244.2 6269.3 6281.2 6318.1 5996.9 6097.6 6100.2 6110.0 6117.6 5547.9 5552.3 5659.2 5718.6 5828.9 5783.1 5783.1 5793.1 5797.6 5832.9 5473.1 5622.0 5715.9 5774.6 5845.6 5689.9 5706.2 5746.3 5763.7 5763.9 5463.3 5624.5 5669.5 5682.9 5702.5 6007.8 6041.2 6043.8 6069.5 6081.8 6580.6 6617.3 6634.0 6641.2 6660.9 6603.5 6603.6 6639.3 6692.2 6732.7 5973.8 5978.4 6032.9 6152.6 6248.0 6765.6 6780.0 6782.1 6787.3 6793.8 6389.3 6452.2 6465.5 6469.3 6469.8 6570.4 6581.0 6627.0 6699.6 6714.2 6649.7 6709.7 6719.6 6737.7 6743.1 6635.1 6654.8 6696.8 6769.7 6784.0 5273.7 5307.2 5308.8 5312.5 5402.8 4664.2 4668.1 4687.7 4707.5 4734.0 5721.5 5800.8 5803.9 5812.7 5822.2 6705.8 6746.3 6817.7 6830.1 6833.6 5546.8 5590.2 5712.9 5738.0 5781.9 5854.4 5881.4 5884.1 5886.5 5926.1 6398.7 6553.2 6570.7 6574.7 6575.5 6683.6 6690.2 6788.8 6789.4 6791.4 6313.3 6326.2 6399.5 6488.1 6567.1 6511.3 6540.1 6555.6 6586.3 6599.5 6656.8 6686.5 6751.0 6760.4 6775.8 6473.3 6488.7 6562.9 6563.6 6575.4 6301.4 6384.2 6394.7 6467.7 6567.9 6324.5 6348.0 6353.0 6449.8 6452.2 6574.5 6575.5 6597.7 6619.7 6680.9 6111.3 6239.9 6312.5 6350.3 6366.7 17:31:47 INFO - PID 32490 | 17:31:47 INFO - PID 32490 | [#1] ext.html Cycles:180 Average:38430.44 Median:35550.88 stddev:54664.57 (153.8%) stddev-sans-first:54745.03 17:31:47 INFO - PID 32490 | Values: 835.8 875.1 897.0 1152.9 1180.4 38448.0 41931.0 41954.6 41960.6 42074.4 42364.6 42464.4 42840.8 42864.6 42889.0 7635.7 7643.2 7646.4 7740.1 7794.7 7643.5 7688.5 7692.0 7716.5 7719.2 5828.1 5973.6 7651.9 7877.7 7883.2 7794.1 7868.2 7904.9 7906.6 7907.2 7656.2 7711.7 7715.7 7722.4 7730.7 38211.2 38528.2 38592.6 38612.8 38616.0 3580.3 3617.6 3622.2 3625.0 3630.9 30571.7 30917.5 30937.2 30955.1 30973.5 5071.0 5112.6 5124.5 5129.3 5133.8 183825.0 183835.1 183848.0 184153.0 184418.0 46973.3 46983.3 47084.3 47118.5 47232.8 48741.3 49141.0 49142.3 49157.0 49295.0 15567.1 15591.6 15650.4 15662.5 15688.9 13013.9 13021.6 13022.7 13030.3 13040.3 11840.9 13534.1 13847.7 13851.2 14025.5 4586.9 5946.3 5982.5 6001.1 6135.8 977.7 991.4 1002.9 1005.8 1010.1 23827.3 29162.9 29445.6 29810.0 30091.7 1060.5 1063.6 1068.7 1070.4 1081.4 12751.9 16102.4 16266.7 16382.2 16574.9 239083.0 240676.0 243613.0 243662.0 243966.0 58012.0 58135.0 58246.0 58551.7 58774.0 1423.9 1470.9 1478.1 1481.4 1490.0 27247.5 27683.7 27957.6 28070.6 28219.9 38918.0 38971.6 39010.2 39028.2 39031.2 201772.0 202562.0 202630.0 202886.0 203552.0 35141.3 35279.3 35501.5 35579.6 35812.0 43611.3 44413.6 44942.8 45031.0 45088.3 31823.8 32222.2 32708.2 32999.7 33008.8 32303.5 32491.0 32864.7 32926.8 33146.0 35191.5 35334.0 35549.5 35552.3 35643.0 30618.7 31259.7 31395.4 31630.1 31741.4 23180.7 23530.4 24948.5 25525.9 25794.2 17:31:47 INFO - PID 32490 | 17:31:47 INFO - PID 32490 | [#2] jquery.html Cycles:180 Average:34807.48 Median:22752.49 stddev:82683.05 (363.4%) stddev-sans-first:82875.03 17:31:47 INFO - PID 32490 | Values: 568.8 579.6 580.6 583.2 589.2 16660.6 22646.5 23556.9 23557.2 23756.4 19579.0 19907.5 24508.0 25263.5 25550.5 6389.2 6481.4 6572.0 6578.2 6579.0 5937.3 6453.2 6501.2 6624.4 6641.8 6344.9 6394.6 6395.3 6400.0 6403.3 6400.5 6406.7 6421.7 6437.4 6437.5 5944.2 5958.0 5975.2 5982.7 5985.9 27376.3 28090.7 28517.4 28520.7 28571.3 1967.1 1997.9 1998.0 2000.3 2003.0 19156.3 19714.4 19717.5 19775.1 19802.4 2097.0 2123.3 2163.8 2169.9 2371.0 136124.3 138664.3 138803.0 139328.3 139351.0 14527.2 14872.6 15041.6 15109.8 15468.3 22858.4 22859.7 22877.0 22924.4 22948.8 10069.6 10133.4 10145.5 10148.5 10179.5 9316.0 9332.6 9346.1 9407.7 9434.4 8838.2 8982.7 9108.5 9295.6 9566.5 2575.5 2588.7 2698.3 2739.8 2824.5 904.2 911.4 929.4 969.2 970.2 18582.8 19016.9 19316.5 19414.0 19482.0 946.3 950.9 1024.8 1040.3 1041.9 10946.7 10967.9 11155.1 11229.7 11252.6 472635.0 482006.0 487620.0 489530.0 515546.0 119368.0 119423.0 120712.0 121690.4 122233.0 1266.5 1270.5 1291.0 1291.4 1292.7 17047.0 17310.8 17451.1 17741.0 17770.6 53012.7 54640.5 55487.7 56919.7 57236.7 70913.0 71006.0 71300.0 71403.6 73028.3 14325.9 14612.6 14845.1 14910.8 14920.9 23726.2 23907.4 24024.5 24057.8 24064.4 18624.2 18714.4 18739.7 18849.2 19046.8 16918.5 17414.0 17499.6 17593.8 18012.9 18175.8 19310.0 19573.8 19625.4 19759.7 14747.1 14977.4 15000.1 15037.3 15053.5 18287.6 18590.0 18837.9 18953.4 18955.0 17:31:47 INFO - PID 32490 | 17:31:47 INFO - PID 32490 | [#3] mootools.html Cycles:180 Average:8849.69 Median:2635.03 stddev:6163.37 (233.9%) stddev-sans-first:6155.10 17:31:47 INFO - PID 32490 | Values: 1379.6 1445.1 1447.4 1461.8 1462.6 13860.9 14347.2 14381.1 14401.5 14409.9 15041.2 15251.2 15303.8 15315.5 15315.8 2667.8 2718.4 2718.7 2721.3 2724.2 2633.6 2675.9 2699.1 2717.6 2721.3 2635.1 2661.8 2669.3 2709.4 2720.6 2653.3 2664.6 2671.3 2674.6 2674.7 2615.5 2620.0 2629.1 2634.0 2635.0 13849.4 14077.5 14123.5 14124.9 14127.5 7428.7 7639.6 7641.4 7641.6 7681.7 5085.4 5197.7 5204.7 5309.8 5321.7 1935.4 1942.5 1946.6 1950.7 1976.7 23924.5 24051.2 24105.0 24113.6 24114.5 6380.2 6466.5 6488.1 6656.3 6685.3 15866.3 15912.2 15941.4 15960.0 15966.8 7406.8 7521.0 7530.1 7531.9 7534.3 5758.5 6965.6 7043.5 7119.6 7150.8 5057.5 5173.5 5197.2 5218.1 5261.5 1459.8 1462.5 1472.6 1473.3 1480.0 886.2 899.9 900.4 913.3 919.3 7517.7 7548.8 7551.2 7566.8 7590.7 720.5 724.0 726.7 729.5 730.0 4447.4 4592.1 5088.5 5140.0 5156.9 19254.0 20275.7 20286.4 20304.3 20433.3 19087.1 19519.0 19960.6 19984.0 20037.9 10691.5 10754.1 10931.9 10954.6 10981.6 7709.2 7740.5 7876.3 7898.2 7950.5 17057.7 17309.1 17390.6 17617.4 17828.2 17572.3 17636.9 17875.1 17922.6 17941.7 11221.0 11389.7 11448.8 11449.4 11463.5 13367.2 13419.9 13522.6 13530.9 13532.8 10711.5 10760.9 10783.4 10954.6 11002.4 10908.8 10913.8 10945.0 10992.1 11244.9 9083.9 9135.3 9140.4 9142.6 9164.7 7133.3 7156.4 7171.1 7188.3 7231.0 6998.5 7063.0 7086.7 7097.6 7108.4 17:31:47 INFO - PID 32490 | 17:31:47 INFO - PID 32490 | [#4] prototype.html Cycles:180 Average:5537.11 Median:6178.18 stddev:1556.88 (25.2%) stddev-sans-first:1514.57 17:31:47 INFO - PID 32490 | Values: 496.1 498.9 528.2 529.0 534.2 6283.3 6294.6 6311.5 6341.1 6344.7 5961.1 6165.4 6192.9 6219.3 6239.2 4964.7 5019.8 5033.5 5045.2 5082.5 4993.4 5002.8 5006.1 5019.0 5050.6 4770.7 4925.6 4952.6 4979.5 5044.1 4916.4 4924.2 4932.5 4982.7 5025.4 4482.8 4491.0 4509.5 4517.1 4528.6 6141.3 6151.5 6165.2 6190.9 6229.9 5629.7 5682.6 5774.3 5789.6 5791.1 6473.4 6479.4 6563.1 6593.4 6616.0 4816.2 4855.9 4883.3 4894.0 4923.9 6798.5 6804.8 6963.8 6973.1 7025.6 4991.2 5011.4 5020.3 5022.6 5051.6 5119.8 5122.7 5147.8 5148.6 5151.3 5656.3 5721.2 5725.8 5757.3 5764.4 6578.8 6581.2 6608.3 6615.6 6725.4 1696.6 1727.6 1736.2 1758.3 1798.7 1209.3 1212.5 1236.8 1238.0 1250.6 5644.5 5673.3 5688.3 5755.7 5760.8 6551.7 6640.3 6669.0 6757.3 6810.1 5691.0 5692.3 5732.6 5754.5 5759.9 3601.9 3602.0 3608.8 3629.8 3631.4 6489.8 6520.7 6584.6 6594.5 6693.3 6881.6 6907.2 6930.3 6978.3 7032.8 6479.3 6481.4 6612.9 6626.1 6633.9 6760.8 6785.4 6794.6 6795.4 6819.8 6644.9 6645.5 6751.9 6755.5 6808.4 6492.2 6515.4 6517.0 6584.6 6618.3 4989.4 4996.5 5024.3 5032.9 5049.2 6777.4 6812.3 6847.7 6875.0 6884.9 6579.1 6583.8 6588.8 6635.4 6636.8 6555.9 6571.4 6605.8 6614.4 6690.7 6016.3 6263.5 6317.4 6332.8 6499.3 6542.3 6567.6 6591.7 6604.2 6643.2 6317.7 6342.4 6361.7 6365.2 6435.0 17:31:47 INFO - PID 32490 | 17:31:47 INFO - PID 32490 | [#5] yui.html Cycles:180 Average:23490.69 Median:20031.95 stddev:32440.09 (161.9%) stddev-sans-first:32486.75 17:31:47 INFO - PID 32490 | Values: 901.2 922.1 924.2 933.0 939.1 17154.5 17797.8 17821.6 17870.9 22476.8 21014.8 22017.7 22041.7 22089.9 22192.2 1021.1 1050.9 1058.1 1058.1 1059.3 1015.8 1047.6 1064.1 1065.2 1071.4 1095.7 1096.3 1096.8 1097.3 1098.9 1083.9 1084.3 1089.3 1089.3 1090.4 802.8 803.0 803.2 803.3 803.7 19831.2 19992.0 20051.2 20089.4 20363.0 21692.1 21822.3 22264.4 22316.8 22356.7 16600.0 16753.7 16795.3 17094.7 18025.4 3570.3 3578.6 3578.8 3599.2 3604.5 126645.0 127944.0 128579.0 128740.0 131797.0 17528.6 17647.1 17720.5 18069.2 18097.2 30955.0 31066.7 31356.0 31569.2 31672.0 7218.5 7587.7 8655.3 8850.2 8973.2 4197.2 4480.3 4484.3 4484.3 4516.5 5269.4 5381.3 5417.1 5418.4 5448.3 1078.1 1086.7 1096.9 1097.7 1101.2 608.3 613.3 624.6 634.0 638.3 10704.8 11601.9 12326.5 12463.3 12706.9 617.0 635.1 649.8 664.0 669.9 5299.8 5599.4 5645.9 5729.0 5780.4 109000.5 109836.0 109929.5 110755.0 114850.0 96682.0 96978.0 98916.0 100044.5 100258.0 86869.0 87922.7 89146.0 90280.5 91633.0 9530.3 9562.9 9729.5 9765.2 9850.1 36466.3 36602.5 36925.3 39012.2 39051.0 48968.3 49291.0 67438.7 70876.0 75582.0 14031.4 17066.8 17201.6 17354.6 17363.2 16230.4 19759.9 20012.7 20865.0 20934.5 16666.2 16938.6 17086.8 17126.0 17357.8 15890.2 15937.8 16010.4 16020.0 16023.1 16696.8 16720.7 17361.2 17476.3 17532.3 11745.2 12095.5 12371.7 12423.4 12429.9 13346.4 13427.5 13516.8 13623.6 13960.1 17:31:47 INFO - PID 32490 | -------- Summary: end -------- 17:31:47 INFO - PID 32490 | 17:31:47 INFO - TEST-INFO | 32490: exit 0 17:31:47 INFO - TEST-OK | dromaeo_css | took 1113359ms 17:31:47 INFO - TEST-START | kraken 17:31:47 INFO - Initialising browser for kraken test... 17:31:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60939/getInfo.html -profile /tmp/tmpZSIVW9/profile 17:31:47 INFO - TEST-INFO | started process 403 (/builds/slave/test/build/application/firefox/firefox http://localhost:60939/getInfo.html) 17:31:54 INFO - TEST-INFO | 403: exit 0 17:31:54 INFO - Browser initialized. 17:31:54 INFO - Running cycle 1/1 for kraken test... 17:31:54 INFO - TEST-INFO | started process 642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZSIVW9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:55 INFO - PID 642 | 17:31:55 INFO - PID 642 | (/builds/slave/test/build/application/firefox/firefox:696): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:31:55 INFO - PID 642 | 17:32:05 INFO - PID 642 | RSS: Main: 167563264 17:32:05 INFO - PID 642 | 17:32:08 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60939/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:09 INFO - PID 642 | RSS: Main: 173867008 17:32:09 INFO - PID 642 | 17:32:12 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60939/tests/kraken/driver.html?testName=audio-dft) 17:32:12 INFO - PID 642 | RSS: Main: 173940736 17:32:12 INFO - PID 642 | 17:32:15 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60939/tests/kraken/driver.html?testName=audio-fft) 17:32:16 INFO - PID 642 | RSS: Main: 168951808 17:32:16 INFO - PID 642 | 17:32:18 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60939/tests/kraken/driver.html?testName=audio-oscillator) 17:32:19 INFO - PID 642 | RSS: Main: 169713664 17:32:19 INFO - PID 642 | 17:32:21 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:22 INFO - PID 642 | RSS: Main: 169680896 17:32:22 INFO - PID 642 | 17:32:25 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60939/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:26 INFO - PID 642 | RSS: Main: 172552192 17:32:26 INFO - PID 642 | 17:32:29 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60939/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:30 INFO - PID 642 | RSS: Main: 172277760 17:32:30 INFO - PID 642 | 17:32:33 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60939/tests/kraken/driver.html?testName=json-parse-financial) 17:32:33 INFO - PID 642 | RSS: Main: 173649920 17:32:33 INFO - PID 642 | 17:32:35 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:35 INFO - PID 642 | RSS: Main: 173314048 17:32:35 INFO - PID 642 | 17:32:37 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:38 INFO - PID 642 | RSS: Main: 173772800 17:32:38 INFO - PID 642 | 17:32:40 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:41 INFO - PID 642 | RSS: Main: 173576192 17:32:41 INFO - PID 642 | 17:32:44 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:44 INFO - PID 642 | RSS: Main: 173969408 17:32:44 INFO - PID 642 | 17:32:47 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:48 INFO - PID 642 | RSS: Main: 173903872 17:32:48 INFO - PID 642 | 17:32:50 INFO - PID 642 | Cycle 1(1): loaded http://localhost:60939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60939/tests/kraken/driver.html?testName=ai-astar) 17:32:50 INFO - PID 642 | RSS: Main: 175542272 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | __start_tp_report 17:32:50 INFO - PID 642 | _x_x_mozilla_page_load 17:32:50 INFO - PID 642 | _x_x_mozilla_page_load_details 17:32:50 INFO - PID 642 | |i|pagename|runs| 17:32:50 INFO - PID 642 | |0;ai-astar;107;119;103;110;108;109;113;106;113;109 17:32:50 INFO - PID 642 | |1;audio-beat-detection;150;120;156;182;131;144;148;122;165;120 17:32:50 INFO - PID 642 | |2;audio-dft;165;170;162;165;165;165;170;166;164;169 17:32:50 INFO - PID 642 | |3;audio-fft;76;76;76;184;76;77;77;74;158;80 17:32:50 INFO - PID 642 | |4;audio-oscillator;79;79;140;79;78;79;130;80;87;138 17:32:50 INFO - PID 642 | |5;imaging-gaussian-blur;113;113;114;118;117;116;113;116;121;118 17:32:50 INFO - PID 642 | |6;imaging-darkroom;150;149;150;150;150;151;158;152;150;151 17:32:50 INFO - PID 642 | |7;imaging-desaturate;95;93;93;101;95;94;93;94;100;95 17:32:50 INFO - PID 642 | |8;json-parse-financial;57;56;53;59;59;55;58;65;54;56 17:32:50 INFO - PID 642 | |9;json-stringify-tinderbox;55;61;54;54;55;54;54;54;55;55 17:32:50 INFO - PID 642 | |10;stanford-crypto-aes;77;79;77;77;81;79;81;77;79;78 17:32:50 INFO - PID 642 | |11;stanford-crypto-ccm;138;134;125;126;137;124;125;141;139;173 17:32:50 INFO - PID 642 | |12;stanford-crypto-pbkdf2;175;181;192;201;185;179;177;188;178;184 17:32:50 INFO - PID 642 | |13;stanford-crypto-sha256-iterative;78;70;71;70;69;68;68;74;68;69 17:32:50 INFO - PID 642 | __end_tp_report 17:32:50 INFO - PID 642 | __start_cc_report 17:32:50 INFO - PID 642 | _x_x_mozilla_cycle_collect,974 17:32:50 INFO - PID 642 | __end_cc_report 17:32:50 INFO - PID 642 | __startTimestamp1502670770684__endTimestamp 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | ------- Summary: start ------- 17:32:50 INFO - PID 642 | Number of tests: 14 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#0] ai-astar Cycles:10 Average:109.70 Median:109.50 stddev:4.45 (4.1%) stddev-sans-first:4.61 17:32:50 INFO - PID 642 | Values: 107.0 119.0 103.0 110.0 108.0 109.0 113.0 106.0 113.0 109.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:149.00 stddev:20.78 (13.9%) stddev-sans-first:21.92 17:32:50 INFO - PID 642 | Values: 150.0 120.0 156.0 182.0 131.0 144.0 148.0 122.0 165.0 120.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.50 stddev:2.69 (1.6%) stddev-sans-first:2.82 17:32:50 INFO - PID 642 | Values: 165.0 170.0 162.0 165.0 165.0 165.0 170.0 166.0 164.0 169.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:40.34 (53.1%) stddev-sans-first:42.17 17:32:50 INFO - PID 642 | Values: 76.0 76.0 76.0 184.0 76.0 77.0 77.0 74.0 158.0 80.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:79.00 stddev:27.21 (34.4%) stddev-sans-first:28.08 17:32:50 INFO - PID 642 | Values: 79.0 79.0 140.0 79.0 78.0 79.0 130.0 80.0 87.0 138.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.50 stddev:2.69 (2.3%) stddev-sans-first:2.64 17:32:50 INFO - PID 642 | Values: 113.0 113.0 114.0 118.0 117.0 116.0 113.0 116.0 121.0 118.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:150.50 stddev:2.56 (1.7%) stddev-sans-first:2.68 17:32:50 INFO - PID 642 | Values: 150.0 149.0 150.0 150.0 150.0 151.0 158.0 152.0 150.0 151.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.00 stddev:2.87 (3.1%) stddev-sans-first:3.04 17:32:50 INFO - PID 642 | Values: 95.0 93.0 93.0 101.0 95.0 94.0 93.0 94.0 100.0 95.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:3.39 (5.9%) stddev-sans-first:3.60 17:32:50 INFO - PID 642 | Values: 57.0 56.0 53.0 59.0 59.0 55.0 58.0 65.0 54.0 56.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:2.13 (3.9%) stddev-sans-first:2.26 17:32:50 INFO - PID 642 | Values: 55.0 61.0 54.0 54.0 55.0 54.0 54.0 54.0 55.0 55.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:79.00 stddev:1.58 (2.0%) stddev-sans-first:1.58 17:32:50 INFO - PID 642 | Values: 77.0 79.0 77.0 77.0 81.0 79.0 81.0 77.0 79.0 78.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:137.50 stddev:14.52 (10.6%) stddev-sans-first:15.39 17:32:50 INFO - PID 642 | Values: 138.0 134.0 125.0 126.0 137.0 124.0 125.0 141.0 139.0 173.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.00 Median:184.50 stddev:7.96 (4.3%) stddev-sans-first:7.75 17:32:50 INFO - PID 642 | Values: 175.0 181.0 192.0 201.0 185.0 179.0 177.0 188.0 178.0 184.0 17:32:50 INFO - PID 642 | 17:32:50 INFO - PID 642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:3.21 (4.6%) stddev-sans-first:1.94 17:32:50 INFO - PID 642 | Values: 78.0 70.0 71.0 70.0 69.0 68.0 68.0 74.0 68.0 69.0 17:32:50 INFO - PID 642 | -------- Summary: end -------- 17:32:50 INFO - PID 642 | 17:32:51 INFO - PID 642 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:32:51 INFO - TEST-INFO | 642: exit 0 17:32:51 INFO - TEST-OK | kraken | took 63463ms 17:32:51 INFO - SUITE-END | took 1176s 17:32:51 INFO - Completed test suite (00:19:37) 17:32:51 INFO - javascript benchmark 17:32:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8480.687097958169, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.196189971557, 3163.035274241356, 3193.21766167289, 3205.134613654312, 3207.711305982461, 6169.321374648785, 6244.157038799766, 6269.310375858652, 6281.183446151999, 6318.147050148229, 5996.940030599703, 6097.603655762372, 6100.23747031621, 6109.969450152743, 6117.5717699761035, 5547.861303467415, 5552.333719953611, 5659.1511273309125, 5718.59969802114, 5828.883422331551, 5783.103618939072, 5783.103618939072, 5793.102069179263, 5797.623154494965, 5832.912506312408, 5473.0969390050595, 5622.0, 5715.885682286352, 5774.595778295521, 5845.620034697752, 5689.943100568983, 5706.172604972256, 5746.25298711169, 5763.711814409263, 5763.913541296842, 5463.262459567987, 5624.493795558378, 5669.461401166924, 5682.943170568283, 5702.486776190163, 6007.789727359522, 6041.24484439445, 6043.758249670008, 6069.453749162552, 6081.847953801146, 6580.605163690194, 6617.272100068989, 6634.038064480672, 6641.203055633307, 6660.9000864987065, 6603.471722262256, 6603.570767900119, 6639.302873198293, 6692.163479565054, 6732.730690772412, 5973.820785376446, 5978.40215978403, 6032.8793424132145, 6152.600080994721, 6248.031555108965, 6765.594064356154, 6780.0, 6782.050512928194, 6787.321267873173, 6793.830154246183, 6389.297177310492, 6452.193475815523, 6465.4827613790785, 6469.256035555972, 6469.773557925544, 6570.441512471493, 6581.012848072827, 6627.0, 6699.564528305645, 6714.227863795726, 6649.700763465656, 6709.6980635871505, 6719.630420326929, 6737.663116844138, 6743.089682892747, 6635.10426092481, 6654.83362915931, 6696.799096027127, 6769.695363708645, 6784.0, 5273.736313184326, 5307.230451584499, 5308.787648494094, 5312.468753124734, 5402.783888644489, 4664.230401983635, 4668.089722504079, 4687.742174180453, 4707.458642256184, 4734.029523947583, 5721.456461636138, 5800.8259752207505, 5803.912941305884, 5812.738426770806, 5822.184894114827, 6705.832354191087, 6746.325367463214, 6817.659117044128, 6830.112085428962, 6833.6241506716615, 5546.833594992157, 5590.2453168821685, 5712.914306285409, 5737.971310143423, 5781.942180578225, 5854.356020837789, 5881.3530511643685, 5884.117382392676, 5886.529077673776, 5926.140709597084, 6398.744050237939, 6553.246376666744, 6570.737170513222, 6574.704138313788, 6575.473962083021, 6683.6324002180345, 6690.163729533809, 6788.76239331621, 6789.355011273921, 6791.422729067887, 6313.337099604659, 6326.177596912372, 6399.520035997412, 6488.124103246001, 6567.146270984741, 6511.3163117871945, 6540.117084193573, 6555.639439830855, 6586.308437613981, 6599.53803233769, 6656.7670131545165, 6686.465082793462, 6750.966245168743, 6760.425363844129, 6775.830604234933, 6473.320301368477, 6488.740450381932, 6562.934370656232, 6563.638999855054, 6575.408213260829, 6301.369863013662, 6384.17005789263, 6394.680265986589, 6467.741290348334, 6567.934320656732, 6324.462420694293, 6348.047792831112, 6353.047042943595, 6449.774257900951, 6452.22573291208, 6574.4740420765265, 6575.473962083118, 6597.736090556324, 6619.66901654925, 6680.933190668031, 6111.266648002268, 6239.875202495834, 6312.4634406076, 6350.301466838737, 6366.713497892699], "value": 6071.008441466617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.841190173867, 875.0855356152821, 896.9955150224248, 1152.9077673786103, 1180.4392913366146, 38448.0, 41931.0, 41954.58045419545, 41960.58039419605, 42074.36888446672, 42364.57635423645, 42464.36303455443, 42840.78579607105, 42864.57135428645, 42889.0, 7635.65639546219, 7643.197464266255, 7646.426518011143, 7740.148583655793, 7794.688212471494, 7643.541387516739, 7688.538687678729, 7692.0, 7716.459847810655, 7719.228077192292, 5828.125781132842, 5973.581849270553, 7651.928729977808, 7877.6848926042885, 7883.211678832128, 7794.142644309121, 7868.213178682143, 7904.920950790476, 7906.565138917357, 7907.2488113629115, 7656.157822639505, 7711.691532338699, 7715.652795624211, 7722.42081843864, 7730.729424470116, 38211.23577528434, 38528.22943541114, 38592.614073859186, 38612.80693596542, 38616.0, 3580.2660454606744, 3617.6382361763876, 3622.1669016126175, 3625.0212442640604, 3630.909227269339, 30571.694283057106, 30917.536236956465, 30937.226569335722, 30955.071347859375, 30973.535396969062, 5070.974645126787, 5112.565431938253, 5124.538791508745, 5129.307543481619, 5133.845984620468, 183825.0, 183835.08082459637, 183848.0, 184153.0, 184418.0, 46973.29540056902, 46983.29525057127, 47084.293735593994, 47118.52881471141, 47232.7638361806, 48741.26888096681, 49141.0, 49142.26286605704, 49157.0, 49295.0, 15567.143807090719, 15591.61020974462, 15650.37398504047, 15662.451814186448, 15688.921555392379, 13013.934930325477, 13021.609351719464, 13022.674433139058, 13030.348482575833, 13040.347982601023, 11840.940795295968, 13534.120282181626, 13847.723045539033, 13851.238181899891, 14025.509107181404, 4586.931196032062, 5946.316173640001, 5982.521398288127, 6001.129836173817, 6135.785247516315, 977.6871401151564, 991.4497453913148, 1002.8595996560488, 1005.7535903703639, 1010.0808264479435, 23827.285181444586, 29162.854185728935, 29445.55831662527, 29810.0, 30091.699083009327, 1060.533365319257, 1063.6117816996896, 1068.6847380022912, 1070.4433694478828, 1081.4214395298634, 12751.872481275068, 16102.436414725662, 16266.674666506604, 16382.180890955404, 16574.917125414297, 239083.0, 240676.0, 243613.0, 243662.0, 243966.0, 58012.0, 58134.96527621513, 58246.0, 58551.70724146437, 58774.0, 1423.9003269771017, 1470.919099449519, 1478.1279045363287, 1481.4444583281054, 1490.0389248934594, 27247.455050898476, 27683.723162768114, 27957.580636290066, 28070.57894131549, 28219.858900705363, 38918.0, 38971.6102838968, 39010.2197956045, 39028.21943561056, 39031.2193756129, 201772.0, 202562.0, 202630.0, 202886.0, 203552.0, 35141.29717405689, 35279.29441411209, 35501.467477988364, 35579.644203558666, 35812.0, 43611.345829811944, 44413.55586444094, 44942.77528612336, 45031.0, 45088.323675144245, 31823.840880796375, 32222.19444513906, 32708.182295441853, 32999.67000329966, 33008.83495582507, 32303.51544726878, 32491.0, 32864.67135328616, 32926.83536582302, 33146.0, 35191.47212791759, 35334.0, 35549.46675799813, 35552.28895422129, 35643.0, 30618.693813062477, 31259.687403126587, 31395.37209255848, 31630.051098467084, 31741.36517269688, 23180.652290215996, 23530.41173970596, 24948.501029979663, 25525.87237063803, 25794.226173214833], "value": 17567.82475220173, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7867049856304, 579.5740131003713, 580.5616759346692, 583.2213994317585, 589.1869220475744, 16660.58348541287, 22646.547069058608, 23556.88221558894, 23557.175498857523, 23756.406089847762, 19579.0, 19907.502312442197, 24508.0, 25263.494730105387, 25550.488990220183, 6389.20134983126, 6481.384268494509, 6572.014197870334, 6578.24350199726, 6578.967105164467, 5937.346891841894, 6453.16108905844, 6501.219853617573, 6624.403803657669, 6641.767538136166, 6344.936550634504, 6394.552381333308, 6395.264544577363, 6400.0, 6403.327650596691, 6400.487960963112, 6406.679666016704, 6421.7110230039525, 6437.356264373572, 6437.452816510602, 5944.167816505693, 5958.0, 5975.163477113208, 5982.670953097578, 5985.850353741148, 27376.315592110157, 28090.719092809013, 28517.429651407063, 28520.714792852013, 28571.285717857012, 1967.085305333027, 1997.9300724474574, 1998.0309549868302, 2000.3298894870236, 2003.008510787155, 19156.329528466576, 19714.42284617227, 19717.507062323413, 19775.110120044632, 19802.405927822187, 2096.9790302096935, 2123.3417640531484, 2163.8377121715776, 2169.945751356213, 2370.952580948371, 136124.31937840246, 138664.30667846696, 138803.0, 139328.30335848356, 139351.0, 14527.201003944672, 14872.62818429548, 15041.623959401102, 15109.773353399489, 15468.303926323342, 22858.42853928665, 22859.657105143437, 22877.0, 22924.426889327566, 22948.770512294996, 10069.59721611142, 10133.442660653734, 10145.492725363702, 10148.543315550818, 10179.54192061359, 9315.953420232856, 9332.58003389849, 9346.11211934865, 9407.717768466957, 9434.386764860263, 8838.248748856291, 8982.730518084469, 9108.544572771334, 9295.58169882357, 9566.51270669617, 2575.53640344736, 2588.7415201992617, 2698.2849544870624, 2739.8082134250412, 2824.533951897955, 904.1500989070253, 911.3939230411835, 929.4098247612815, 969.2294625772528, 970.1511177719495, 18582.81417185838, 19016.904915475334, 19316.517087072934, 19414.029298535017, 19482.0, 946.2619157057507, 950.8732152399291, 1024.8273659841184, 1040.2510192661273, 1041.890601486833, 10946.726331841608, 10967.890321096846, 11155.107591392669, 11229.66311010671, 11252.58721727628, 472635.0, 482006.0, 487620.0, 489530.0, 515546.0, 119368.0, 119423.0, 120712.0, 121690.39154804347, 122233.0, 1266.4554241676167, 1270.5426046623209, 1290.9870901291056, 1291.438224372401, 1292.713749818936, 17047.0, 17310.82689173092, 17451.127443627513, 17741.0, 17770.644587108443, 53012.73493632507, 54640.453595463536, 55487.72256138694, 56919.715401424386, 57236.71381643232, 70913.0, 71006.0, 71300.0, 71403.64298178475, 73028.26971730427, 14325.85674143287, 14612.561623151323, 14845.109293442429, 14910.776338354717, 14920.850791492381, 23726.169584064475, 23907.402314942265, 24024.519509610058, 24057.759422406252, 24064.398390040387, 18624.161912714233, 18714.438566843015, 18739.71890421672, 18849.24603015864, 19046.809531904502, 16918.492445226664, 17414.0422276776, 17499.56251093733, 17593.82406175922, 18012.90993545024, 18175.81824181741, 19310.0, 19573.804261957197, 19625.411237662895, 19759.703604446233, 14747.115173089649, 14977.400903963719, 15000.099993999958, 15037.323320450387, 15053.473128440452, 18287.634247314712, 18590.0, 18837.90581047141, 18953.43139705811, 18955.0], "value": 11905.14825445606, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.6481897116234, 1445.1184777285853, 1447.3631602095077, 1461.8245810502735, 1462.553921054078, 13860.930695346522, 14347.21090340031, 14381.137131772088, 14401.495947641835, 14409.92795036026, 15041.247937603132, 15251.161186134757, 15303.846961530382, 15315.540533784004, 15315.770263446057, 2667.7865770738294, 2718.4019515706514, 2718.7417195366406, 2721.306066952924, 2724.1691284158323, 2633.5522961096563, 2675.933101672464, 2699.082312013915, 2717.55160398535, 2721.2788611018095, 2635.1040646180295, 2661.760441560259, 2669.319323572486, 2709.403931135147, 2720.64631597892, 2653.270350653576, 2664.5736682130864, 2671.3188137025127, 2674.598810178469, 2674.6924103728124, 2615.5422801009745, 2620.0305886821807, 2629.0535407253565, 2633.9604905926426, 2634.9604755928676, 13849.376778045013, 14077.507287244896, 14123.505677301246, 14124.858751412457, 14127.505537306144, 7428.702851885918, 7639.618019099078, 7641.3504852087635, 7641.579713115776, 7681.692732290701, 5085.440601533828, 5197.66215196011, 5204.661696989683, 5309.7610607522365, 5321.654092484015, 1935.380678182982, 1942.5046613113707, 1946.6496030714466, 1950.6781381072105, 1976.713376560405, 23924.52150956971, 24051.158209462585, 24105.0, 24113.638295425582, 24114.517709645883, 6380.234371875405, 6466.515011374166, 6488.124103246096, 6656.334366563305, 6685.264620891698, 15866.286017129258, 15912.204389780465, 15941.44204952821, 15960.0, 15966.76049859253, 7406.777796666109, 7520.962395187989, 7530.096388433423, 7531.887021694679, 7534.321911027924, 5758.539316854642, 6965.616891071039, 7043.506954513237, 7119.644017799193, 7150.821229469201, 5057.494250574913, 5173.5343819055715, 5197.246399272084, 5218.086834803894, 5261.500157485033, 1459.8248210214629, 1462.4515806572535, 1472.580314610331, 1473.3204147272118, 1480.0389483933832, 886.1625763653286, 899.869518919766, 900.4057322167338, 913.2739472119681, 919.3151102428733, 7517.661705223278, 7548.849023019508, 7551.244875512405, 7566.772996809995, 7590.696372145163, 720.4632548751109, 723.9746608868664, 726.7492715013312, 729.5221629832469, 729.9708011679579, 4447.435993318887, 4592.104539614743, 5088.491150884956, 5140.0, 5156.8968620627375, 19254.0, 20275.695864562043, 20286.39140825748, 20304.289349872684, 20433.284835030703, 19087.141078651493, 19519.0, 19960.60078798416, 19984.0, 20037.899810501145, 10691.465426728633, 10754.085902698202, 10931.890681093246, 10954.616588419367, 10981.560737570408, 7709.1708072208385, 7740.496867703581, 7876.330511906552, 7898.170692077479, 7950.52296862167, 17057.658846823244, 17309.134543273038, 17390.565235868697, 17617.383391581232, 17828.19773110187, 17572.297108115534, 17636.911815440842, 17875.123112073044, 17922.641547169245, 17941.73087403664, 11221.0, 11389.715257118638, 11448.828267575826, 11449.370284634426, 11463.484143213409, 13367.197968121944, 13419.932900335436, 13522.594322170351, 13530.93234533821, 13532.797008045085, 10711.464426778473, 10760.946195268974, 10783.352998820095, 10954.56181752721, 11002.394868282321, 10908.836367454653, 10913.781724365626, 10945.0, 10992.120630349713, 11244.887551124712, 9083.863742044006, 9135.26917846584, 9140.360174787702, 9142.63429462814, 9164.725058248263, 7133.251008644018, 7156.427485801228, 7171.1394632644415, 7188.28117188277, 7231.023811785552, 6998.545094568837, 7063.0, 7086.681099350439, 7097.574145551283, 7108.3602475777425], "value": 6387.839670134282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.10453132096563, 498.90956890628263, 528.2415612914117, 529.045073642076, 534.2280404815044, 6283.308836028039, 6294.6223226606435, 6311.495080393569, 6341.143945567347, 6344.746210151594, 5961.0760332148475, 6165.445109940116, 6192.938070619292, 6219.346968568303, 6239.15771370866, 4964.652474326798, 5019.774110165043, 5033.521815427529, 5045.217991211368, 5082.526067440456, 4993.425756038047, 5002.849914502571, 5006.148954677696, 5019.0, 5050.595952323805, 4770.713757174581, 4925.605951523869, 4952.603791696655, 4979.477154898737, 5044.142495775727, 4916.385451818523, 4924.187509061001, 4932.53140951609, 4982.651214414975, 5025.447200807908, 4482.753448560328, 4490.977545112253, 4509.458864936196, 4517.096580683843, 4528.615067719248, 6141.324454310023, 6151.5386346024225, 6165.167702360169, 6190.907136392958, 6229.875402491924, 5629.749539097996, 5682.602217844753, 5774.335951365605, 5789.623674461147, 5791.102379131242, 6473.352664733536, 6479.403930818394, 6563.081168636347, 6593.3736295051895, 6615.966920165417, 4816.229403295491, 4855.878603034952, 4883.316335713003, 4894.0, 4923.90152196954, 6798.456123510107, 6804.76183333581, 6963.825904352431, 6973.128358955181, 7025.578465292047, 4991.151504244287, 5011.4236862761245, 5020.297158397827, 5022.573081288058, 5051.636058264322, 5119.769610367543, 5122.667026643257, 5147.794088236504, 5148.56237219833, 5151.330327057533, 5656.264685590847, 5721.22763426932, 5725.77096916127, 5757.309122905278, 5764.394738552475, 6578.848701477223, 6581.243157036906, 6608.306127856602, 6615.569987950767, 6725.361090696376, 1696.5993119735683, 1727.5940154063785, 1736.2273788164146, 1758.34062226665, 1798.6762382770964, 1209.3227792436087, 1212.5271144253747, 1236.7781928077409, 1237.9504819807287, 1250.5748045664336, 5644.488202749819, 5673.347565030074, 5688.317401911797, 5755.712214389264, 5760.8271751847515, 6551.65865408645, 6640.269570347258, 6669.0, 6757.290484499155, 6810.114685091005, 5691.0, 5692.345380281321, 5732.627379220337, 5754.482096611325, 5759.884802303931, 3601.94597081044, 3602.0, 3608.783472991576, 3629.7822130672243, 3631.418972964313, 6489.805305840738, 6520.673966301666, 6584.604923704593, 6594.505412094112, 6693.297203793629, 6881.587104773729, 6907.205671347759, 6930.306969303029, 6978.337057979484, 7032.753853615099, 6479.254885688112, 6481.351864813481, 6612.900806487906, 6626.138601981712, 6633.900491492632, 6760.763373281911, 6785.389314961677, 6794.558353706993, 6795.422389096982, 6819.795406137824, 6644.933550664625, 6645.468362530889, 6751.93248067513, 6755.527113102035, 6808.38724514796, 6492.220933488012, 6515.446187074152, 6516.979736281768, 6584.637844918576, 6618.338166183536, 4989.376327959005, 4996.450390456974, 5024.271480635361, 5032.899342013213, 5049.192129259301, 6777.423918966943, 6812.318768123148, 6847.726090956306, 6874.9656251718425, 6884.862302754017, 6579.144711187515, 6583.835404114935, 6588.8023359299295, 6635.369639884203, 6636.800895973129, 6555.869342463814, 6571.3757193066585, 6605.768798092044, 6614.404703576702, 6690.665466726547, 6016.285358672757, 6263.498920086291, 6317.39984701471, 6332.841678958063, 6499.28507864144, 6542.313057128933, 6567.605943643397, 6591.670416479253, 6604.174478190226, 6643.202815662152, 6317.715702793477, 6342.365763423621, 6361.650109244036, 6365.172527571386, 6434.967825160844], "value": 5079.090716786117, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.1709227510686, 922.1424075609682, 924.2236521322088, 932.95801688924, 939.135994884706, 17154.485365439024, 17797.822021779793, 17821.64356712868, 17870.91064544677, 22476.775232247674, 21014.789852101476, 22017.66973495395, 22041.669374959347, 22089.889550552263, 22192.223272185478, 1021.1371391174446, 1050.915926725864, 1058.1006144776954, 1058.1164727452585, 1059.3061544688242, 1015.7968406318729, 1047.586203449637, 1064.074255397805, 1065.211743309953, 1071.4000159910436, 1095.6548687163558, 1096.3038470571164, 1096.7696783675437, 1097.3306283167262, 1098.9450527473634, 1083.864516935383, 1084.3331351218944, 1089.264746296251, 1089.2974031749516, 1090.4111779638986, 802.7952872017598, 803.0122948773042, 803.2248879830933, 803.317180396664, 803.6624617660597, 19831.206751729915, 19992.0, 20051.1979520819, 20089.397318080482, 20363.0, 21692.132314707393, 21822.345329640135, 22264.443388915246, 22316.776832231633, 22356.664650030263, 16600.0, 16753.664926701396, 16795.32818687251, 17094.658106837916, 18025.369112081145, 3570.3037907608027, 3578.58846232684, 3578.8389522471552, 3599.226166374242, 3604.4953706481115, 126645.0, 127944.0, 128579.0, 128740.0, 131797.0, 17528.649427011387, 17647.11764411774, 17720.468385948185, 18069.186886590134, 18097.18562664683, 30955.0, 31066.68933310638, 31356.0, 31569.21076973094, 31672.0, 7218.494705370574, 7587.658555365022, 8655.307575393954, 8850.20348168668, 8973.237274831581, 4197.223513649923, 4480.327950807405, 4484.327350897326, 4484.327350897392, 4516.458025036951, 5269.367675878919, 5381.327334083239, 5417.079096553595, 5418.431064738224, 5448.346198456132, 1078.078243102152, 1086.6957251969461, 1096.9177311701494, 1097.6706987903597, 1101.24014430043, 608.2518502242267, 613.349849159892, 624.581530374641, 634.014108061968, 638.3361304243534, 10704.839427408595, 11601.941990289995, 12326.50693972231, 12463.314517701432, 12706.9364653178, 617.0, 635.1425575473166, 649.7693318871827, 664.0, 669.9497537684693, 5299.761510731949, 5599.440055994368, 5645.858853528694, 5728.971355143198, 5780.393058728773, 109000.4549977245, 109836.0, 109929.45035274772, 110755.0, 114850.0, 96682.0, 96978.0, 98916.0, 100044.49977750065, 100258.0, 86869.0, 87922.68115978266, 89146.0, 90280.5485972566, 91633.0, 9530.285228608021, 9562.856557151508, 9729.513524323615, 9765.169960553432, 9850.113489785954, 36466.27067458689, 36602.45096323504, 36925.26149477049, 39012.219755604165, 39051.0, 48968.2654760186, 49291.0, 67438.66280668565, 70876.0, 75582.0, 14031.368588413341, 17066.829331706525, 17201.56996075058, 17354.566135846704, 17363.2186551608, 16230.431934882223, 19759.901200493907, 20012.699809502577, 20865.0, 20934.47663808417, 16666.16669166561, 16938.576535586708, 17086.829131708524, 17126.0, 17357.826421735623, 15890.205489725698, 15937.760933586238, 16010.35958561691, 16020.038797672178, 16023.118728470046, 16696.83303166953, 16720.74918876242, 17361.218745156246, 17476.30094796245, 17532.298708052047, 11745.17783755129, 12095.516179352728, 12371.69070773202, 12423.440945157308, 12429.937850310691, 13346.399412026289, 13427.530036448677, 13516.797248041485, 13623.591292261248, 13960.092593981359], "value": 9030.370503988634, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 103.0, 110.0, 108.0, 109.0, 113.0, 106.0, 113.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 156.0, 182.0, 131.0, 144.0, 148.0, 122.0, 165.0, 120.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 162.0, 165.0, 165.0, 165.0, 170.0, 166.0, 164.0, 169.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 184.0, 76.0, 77.0, 77.0, 74.0, 158.0, 80.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 140.0, 79.0, 78.0, 79.0, 130.0, 80.0, 87.0, 138.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 118.0, 117.0, 116.0, 113.0, 116.0, 121.0, 118.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 150.0, 150.0, 151.0, 158.0, 152.0, 150.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 93.0, 101.0, 95.0, 94.0, 93.0, 94.0, 100.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 53.0, 59.0, 59.0, 55.0, 58.0, 65.0, 54.0, 56.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 77.0, 77.0, 81.0, 79.0, 81.0, 77.0, 79.0, 78.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 125.0, 126.0, 137.0, 124.0, 125.0, 141.0, 139.0, 173.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 181.0, 192.0, 201.0, 185.0, 179.0, 177.0, 188.0, 178.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 70.0, 71.0, 70.0, 69.0, 68.0, 68.0, 74.0, 68.0, 69.0], "value": 70.5, "unit": "score"}]}]} 17:32:51 INFO - Return code: 0 17:32:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:32:51 INFO - # TBPL SUCCESS # 17:32:51 INFO - Running post-action listener: _package_coverage_data 17:32:51 INFO - Running post-action listener: _resource_record_post_action 17:32:51 INFO - [mozharness: 2017-08-14 00:32:51.986729Z] Finished run-tests step (success) 17:32:51 INFO - Running post-run listener: _resource_record_post_run 17:32:52 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 428863488; Read time: 12; Write time: 277656 17:32:52 INFO - TinderboxPrint: CPU usage
13.1% 17:32:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:32:52 INFO - TinderboxPrint: I/O write bytes / time
428,863,488 / 277,656 17:32:52 INFO - TinderboxPrint: CPU idle
8,275.0 (86.8%) 17:32:52 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 17:32:52 INFO - TinderboxPrint: Swap in / out
0 / 0 17:32:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106446848; Read time: 0; Write time: 88532 17:32:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:32:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 321802240; Read time: 0; Write time: 189120 17:32:52 INFO - Running post-run listener: _upload_blobber_files 17:32:52 INFO - Blob upload gear active. 17:32:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:52 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 17:32:52 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'] 17:32:52 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 17:32:53 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:32:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:00 INFO - (blobuploader) - INFO - Done attempting. 17:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:00 INFO - (blobuploader) - INFO - Done attempting. 17:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:01 INFO - (blobuploader) - INFO - Done attempting. 17:33:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:33:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:02 INFO - (blobuploader) - INFO - Done attempting. 17:33:02 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:02 INFO - Return code: 0 17:33:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:33:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9877ace3fe14a4ab0e2eb45ac7e03a628dc37de0a90a2777e2f307ab527a6f684b2fbed9a069de3af3d2ce05ff4ceb38f9d8e1099a57cedc02bf45adeddcaf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/474eb1ddb94fc791972cf19ff56517e7c398e04a997a5f6c11210fee4890a88ea085d437ce9a12c213bea6436a18a45d2cebeb23d251ecf68a7de86ed445b6fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5db7f1b5d162bd8170a17ff51d4a2366cd2f24dddff4f4b0c4b93e3fbc2803be8437c36794aea87739429ca601938ce4763744aac30feff6a1105d5bb6c8e03a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3800fa6f662c87c3ff7d04a90a0a7aa51ab5f368068cb6feefd79cba55b4987676c9e7eaf4b2e8010fcfbe7eaa509bae5b32e4ec6dc4cb0d821e49ef107ed3a8"} 17:33:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:33:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:33:02 INFO - Contents: 17:33:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9877ace3fe14a4ab0e2eb45ac7e03a628dc37de0a90a2777e2f307ab527a6f684b2fbed9a069de3af3d2ce05ff4ceb38f9d8e1099a57cedc02bf45adeddcaf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/474eb1ddb94fc791972cf19ff56517e7c398e04a997a5f6c11210fee4890a88ea085d437ce9a12c213bea6436a18a45d2cebeb23d251ecf68a7de86ed445b6fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5db7f1b5d162bd8170a17ff51d4a2366cd2f24dddff4f4b0c4b93e3fbc2803be8437c36794aea87739429ca601938ce4763744aac30feff6a1105d5bb6c8e03a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3800fa6f662c87c3ff7d04a90a0a7aa51ab5f368068cb6feefd79cba55b4987676c9e7eaf4b2e8010fcfbe7eaa509bae5b32e4ec6dc4cb0d821e49ef107ed3a8"} 17:33:02 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:02 INFO - Copying logs to upload dir... 17:33:02 INFO - mkdir: /builds/slave/test/build/upload/logs 17:33:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.919787 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-13 17:33:01.470678) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 17:33:01.477767) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347 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/e9877ace3fe14a4ab0e2eb45ac7e03a628dc37de0a90a2777e2f307ab527a6f684b2fbed9a069de3af3d2ce05ff4ceb38f9d8e1099a57cedc02bf45adeddcaf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/474eb1ddb94fc791972cf19ff56517e7c398e04a997a5f6c11210fee4890a88ea085d437ce9a12c213bea6436a18a45d2cebeb23d251ecf68a7de86ed445b6fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5db7f1b5d162bd8170a17ff51d4a2366cd2f24dddff4f4b0c4b93e3fbc2803be8437c36794aea87739429ca601938ce4763744aac30feff6a1105d5bb6c8e03a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3800fa6f662c87c3ff7d04a90a0a7aa51ab5f368068cb6feefd79cba55b4987676c9e7eaf4b2e8010fcfbe7eaa509bae5b32e4ec6dc4cb0d821e49ef107ed3a8"} build_url:https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/Cpe3HXCkQHyHzCn410T5Mw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9877ace3fe14a4ab0e2eb45ac7e03a628dc37de0a90a2777e2f307ab527a6f684b2fbed9a069de3af3d2ce05ff4ceb38f9d8e1099a57cedc02bf45adeddcaf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/474eb1ddb94fc791972cf19ff56517e7c398e04a997a5f6c11210fee4890a88ea085d437ce9a12c213bea6436a18a45d2cebeb23d251ecf68a7de86ed445b6fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5db7f1b5d162bd8170a17ff51d4a2366cd2f24dddff4f4b0c4b93e3fbc2803be8437c36794aea87739429ca601938ce4763744aac30feff6a1105d5bb6c8e03a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3800fa6f662c87c3ff7d04a90a0a7aa51ab5f368068cb6feefd79cba55b4987676c9e7eaf4b2e8010fcfbe7eaa509bae5b32e4ec6dc4cb0d821e49ef107ed3a8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 17:33:01.505801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:33:01.506178) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1502657264.993797-1353038347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:33:01.589452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 17:33:01.589870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 17:33:01.590202) ========= ========= Total master_lag: 0.21 =========