builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1502483505.17 results: success (0) revision: e7dc8329e2d478087314605e8184627489eef636 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:45.172818) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:45.173668) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:45.174241) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:45.192832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:45.193393) ========= 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=930c87414c89fc706ee2024c000001c6-1502483504.745194-765263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-11 13:31:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-08-11 13:31:45 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:45.320111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:45.320620) ========= 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=930c87414c89fc706ee2024c000001c6-1502483504.745194-765263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015937 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:45.371015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:45.371407) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e7dc8329e2d478087314605e8184627489eef636 --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 e7dc8329e2d478087314605e8184627489eef636 --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=930c87414c89fc706ee2024c000001c6-1502483504.745194-765263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-11 13:31:45,513 truncating revision to first 12 chars 2017-08-11 13:31:45,513 Setting DEBUG logging. 2017-08-11 13:31:45,513 attempt 1/10 2017-08-11 13:31:45,513 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e7dc8329e2d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-11 13:31:45,833 unpacking tar archive at: mozilla-central-e7dc8329e2d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.729676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:46.121753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:46.122134) ========= script_repo_revision: e7dc8329e2d478087314605e8184627489eef636 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:46.124844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:46.125187) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 13:31:46.142431) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-11 13:31:46.142893) ========= /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=930c87414c89fc706ee2024c000001c6-1502483504.745194-765263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:31:46 INFO - MultiFileLogger online at 20170811 13:31:46 in /builds/slave/test 13:31:46 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 13:31:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:31:46 INFO - {'append_to_log': False, 13:31:46 INFO - 'base_work_dir': '/builds/slave/test', 13:31:46 INFO - 'blob_upload_branch': 'Firefox', 13:31:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:31:46 INFO - 'branch': 'Firefox', 13:31:46 INFO - 'buildbot_json_path': 'buildprops.json', 13:31:46 INFO - 'code_coverage': False, 13:31:46 INFO - 'config_files': ('talos/linux_config.py',), 13:31:46 INFO - 'default_actions': ('clobber', 13:31:46 INFO - 'read-buildbot-config', 13:31:46 INFO - 'download-and-extract', 13:31:46 INFO - 'populate-webroot', 13:31:46 INFO - 'create-virtualenv', 13:31:46 INFO - 'install', 13:31:46 INFO - 'setup-mitmproxy', 13:31:46 INFO - 'run-tests'), 13:31:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:31:46 INFO - 'disable_ccov_upload': False, 13:31:46 INFO - 'download_minidump_stackwalk': True, 13:31:46 INFO - 'download_symbols': 'ondemand', 13:31:46 INFO - 'enable_stylo': False, 13:31:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:31:46 INFO - 'tooltool.py': '/tools/tooltool.py', 13:31:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:31:46 INFO - '/tools/misc-python/virtualenv.py')}, 13:31:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:31:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:31:46 INFO - 'gecko_profile': False, 13:31:46 INFO - 'gecko_profile_interval': 0, 13:31:46 INFO - 'installer_path': 'installer.exe', 13:31:46 INFO - 'log_level': 'info', 13:31:46 INFO - 'log_name': 'talos', 13:31:46 INFO - 'log_to_console': True, 13:31:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:31:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:31:46 INFO - 'opt_config_files': (), 13:31:46 INFO - 'pip_index': False, 13:31:46 INFO - 'suite': 'dromaeojs-e10s', 13:31:46 INFO - 'system_bits': '32', 13:31:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:31:46 INFO - 'title': 'talos-linux64-ix-022', 13:31:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:31:46 INFO - 'use_talos_json': True, 13:31:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:31:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:31:46 INFO - 'work_dir': 'build'} 13:31:46 INFO - [mozharness: 2017-08-11 20:31:46.393562Z] Running clobber step. 13:31:46 INFO - Running pre-action listener: _resource_record_pre_action 13:31:46 INFO - Running main action method: clobber 13:31:46 INFO - rmtree: /builds/slave/test/build 13:31:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:31:47 INFO - Running post-action listener: _resource_record_post_action 13:31:47 INFO - [mozharness: 2017-08-11 20:31:47.574689Z] Finished clobber step (success) 13:31:47 INFO - [mozharness: 2017-08-11 20:31:47.574791Z] Running read-buildbot-config step. 13:31:47 INFO - Running pre-action listener: _resource_record_pre_action 13:31:47 INFO - Running main action method: read_buildbot_config 13:31:47 INFO - Using buildbot properties: 13:31:47 INFO - { 13:31:47 INFO - "project": "", 13:31:47 INFO - "product": "firefox", 13:31:47 INFO - "who": "kwierso@gmail.com", 13:31:47 INFO - "installer_path": "public/build/target.tar.bz2", 13:31:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 13:31:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:31:47 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 13:31:47 INFO - "stage_platform": "linux64-stylo", 13:31:47 INFO - "basedir": "/builds/slave/test", 13:31:47 INFO - "buildnumber": 268, 13:31:47 INFO - "platform": "ubuntu64_hw_stylo", 13:31:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:31:47 INFO - "slavebuilddir": "test", 13:31:47 INFO - "taskId": "ZmCgl8qaTbe378kmnWS4qw", 13:31:47 INFO - "branch": "mozilla-central", 13:31:47 INFO - "script_repo_revision": "production", 13:31:47 INFO - "revision": "e7dc8329e2d478087314605e8184627489eef636", 13:31:47 INFO - "slavename": "talos-linux64-ix-022", 13:31:47 INFO - "repo_path": "mozilla-central" 13:31:47 INFO - } 13:31:47 INFO - Finding installer, test and symbols from parent task. 13:31:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZmCgl8qaTbe378kmnWS4qw'}, attempt #1 13:31:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZmCgl8qaTbe378kmnWS4qw'}, attempt #1 13:31:48 INFO - Task dependencies: RpnxFEWaSluJ4sP8X5FZcg 13:31:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg'}, attempt #1 13:31:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 13:31:48 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.test_packages.json 13:31:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.crashreporter-symbols.zip 13:31:48 INFO - Running post-action listener: _resource_record_post_action 13:31:48 INFO - [mozharness: 2017-08-11 20:31:48.935821Z] Finished read-buildbot-config step (success) 13:31:48 INFO - [mozharness: 2017-08-11 20:31:48.936041Z] Running download-and-extract step. 13:31:48 INFO - Running pre-action listener: _resource_record_pre_action 13:31:48 INFO - Running main action method: download_and_extract 13:31:48 INFO - mkdir: /builds/slave/test/build/tests 13:31:48 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')]} 13:31:48 INFO - trying https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.test_packages.json 13:31:48 INFO - Downloading https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:31:49 INFO - Downloaded 989 bytes. 13:31:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:31:49 INFO - Using the following test package requirements: 13:31:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:31:49 INFO - u'common': [u'target.common.tests.zip'], 13:31:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:31:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:31:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:31:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:31:49 INFO - u'mozbase': [u'target.common.tests.zip'], 13:31:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:31:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:31:49 INFO - u'web-platform': [u'target.common.tests.zip', 13:31:49 INFO - u'target.web-platform.tests.tar.gz'], 13:31:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:31:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:31:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip 13:31:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:31:49 INFO - Fetch https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip into memory 13:31:50 INFO - Content-Length response header: 54036652 13:31:50 INFO - Bytes received: 54036652 13:32:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:32:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip 13:32:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:32:01 INFO - Fetch https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip into memory 13:32:02 INFO - Content-Length response header: 54036652 13:32:02 INFO - Bytes received: 54036652 13:32:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.talos.tests.zip 13:32:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:32:16 INFO - Fetch https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.talos.tests.zip into memory 13:32:16 INFO - Content-Length response header: 14496050 13:32:16 INFO - Bytes received: 14496050 13:32:17 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')]} 13:32:17 INFO - trying https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 13:32:17 INFO - Downloading https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:32:18 INFO - Downloaded 61924881 bytes. 13:32:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 13:32:18 INFO - mkdir: /builds/slave/test/properties 13:32:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:32:18 INFO - Writing to file /builds/slave/test/properties/build_url 13:32:18 INFO - Contents: 13:32:18 INFO - build_url:https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 13:32:18 INFO - Running post-action listener: _resource_record_post_action 13:32:18 INFO - Running post-action listener: set_extra_try_arguments 13:32:18 INFO - [mozharness: 2017-08-11 20:32:18.392341Z] Finished download-and-extract step (success) 13:32:18 INFO - [mozharness: 2017-08-11 20:32:18.392439Z] Running populate-webroot step. 13:32:18 INFO - Running pre-action listener: _resource_record_pre_action 13:32:18 INFO - Running main action method: populate_webroot 13:32:18 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:32:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:32:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:32:18 INFO - 'tests': ['damp', 'tps']}, 13:32:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:32:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:32:18 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:32:18 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:32:18 INFO - 'other-e10s': {'tests': ['a11yr', 13:32:18 INFO - 'ts_paint', 13:32:18 INFO - 'tpaint', 13:32:18 INFO - 'sessionrestore', 13:32:18 INFO - 'sessionrestore_many_windows', 13:32:18 INFO - 'sessionrestore_no_auto_restore', 13:32:18 INFO - 'tabpaint']}, 13:32:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:32:18 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:32:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:32:18 INFO - 'tsvgr_opacity', 13:32:18 INFO - 'tart', 13:32:18 INFO - 'tscrollx', 13:32:18 INFO - 'tsvg_static']}, 13:32:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:32:18 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:32:18 INFO - 'talos_options': ['--mitmproxy', 13:32:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:32:18 INFO - '--firstNonBlankPaint'], 13:32:18 INFO - 'tests': ['tp6_google', 13:32:18 INFO - 'tp6_youtube', 13:32:18 INFO - 'tp6_amazon', 13:32:18 INFO - 'tp6_facebook']}, 13:32:18 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:32:18 INFO - 'talos_options': ['--stylo', 13:32:18 INFO - '--mitmproxy', 13:32:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:32:18 INFO - '--firstNonBlankPaint'], 13:32:18 INFO - 'tests': ['tp6_google', 13:32:18 INFO - 'tp6_youtube', 13:32:18 INFO - 'tp6_amazon', 13:32:18 INFO - 'tp6_facebook']}, 13:32:18 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:32:18 INFO - 'talos_options': ['--stylo', 13:32:18 INFO - '--stylo-threads=1', 13:32:18 INFO - '--mitmproxy', 13:32:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:32:18 INFO - '--firstNonBlankPaint'], 13:32:18 INFO - 'tests': ['tp6_google', 13:32:18 INFO - 'tp6_youtube', 13:32:18 INFO - 'tp6_amazon', 13:32:18 INFO - 'tp6_facebook']}, 13:32:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:32:18 INFO - 'talos_options': ['--xperf_path', 13:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:18 INFO - 'tests': ['tp5n']}}} 13:32:18 INFO - Running post-action listener: _resource_record_post_action 13:32:18 INFO - [mozharness: 2017-08-11 20:32:18.400891Z] Finished populate-webroot step (success) 13:32:18 INFO - [mozharness: 2017-08-11 20:32:18.400982Z] Running create-virtualenv step. 13:32:18 INFO - Running pre-action listener: _resource_record_pre_action 13:32:18 INFO - Running main action method: create_virtualenv 13:32:18 INFO - Creating virtualenv /builds/slave/test/build/venv 13:32:18 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 13:32:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:32:18 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:32:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:32:18 INFO - Using real prefix '/usr' 13:32:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:32:18 INFO - Installing distribute.............................................................................................................................................................................................done. 13:32:20 INFO - Installing pip.................done. 13:32:20 INFO - Return code: 0 13:32:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:32:21 INFO - Reading from file tmpfile_stdout 13:32:21 INFO - Output received: 13:32:21 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) 13:32:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:32:21 INFO - Using env: {'DISPLAY': ':0', 13:32:21 INFO - 'HOME': '/home/cltbld', 13:32:21 INFO - 'LANG': 'en_US.UTF-8', 13:32:21 INFO - 'LANGUAGE': 'en_US:en', 13:32:21 INFO - 'LOGNAME': 'cltbld', 13:32:21 INFO - 'MAIL': '/var/mail/cltbld', 13:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:21 INFO - 'MOZ_NO_REMOTE': '1', 13:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:21 INFO - 'NO_EM_RESTART': '1', 13:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:21 INFO - 'PWD': '/builds/slave/test', 13:32:21 INFO - 'SHELL': '/bin/bash', 13:32:21 INFO - 'SHLVL': '1', 13:32:21 INFO - 'TERM': 'linux', 13:32:21 INFO - 'TMOUT': '86400', 13:32:21 INFO - 'USER': 'cltbld', 13:32:21 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:21 INFO - '_': '/tools/buildbot/bin/python'} 13:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:21 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 13:32:21 INFO - Cleaning up... 13:32:21 INFO - Return code: 0 13:32:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:32:21 INFO - Using env: {'DISPLAY': ':0', 13:32:21 INFO - 'HOME': '/home/cltbld', 13:32:21 INFO - 'LANG': 'en_US.UTF-8', 13:32:21 INFO - 'LANGUAGE': 'en_US:en', 13:32:21 INFO - 'LOGNAME': 'cltbld', 13:32:21 INFO - 'MAIL': '/var/mail/cltbld', 13:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:21 INFO - 'MOZ_NO_REMOTE': '1', 13:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:21 INFO - 'NO_EM_RESTART': '1', 13:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:21 INFO - 'PWD': '/builds/slave/test', 13:32:21 INFO - 'SHELL': '/bin/bash', 13:32:21 INFO - 'SHLVL': '1', 13:32:21 INFO - 'TERM': 'linux', 13:32:21 INFO - 'TMOUT': '86400', 13:32:21 INFO - 'USER': 'cltbld', 13:32:21 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:21 INFO - '_': '/tools/buildbot/bin/python'} 13:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:21 INFO - Downloading/unpacking psutil>=3.1.1 13:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:22 INFO - Installing collected packages: psutil 13:32:22 INFO - Running setup.py install for psutil 13:32:22 INFO - building 'psutil._psutil_linux' extension 13:32:22 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 13:32:23 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 13:32:23 INFO - building 'psutil._psutil_posix' extension 13:32:23 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 13:32:23 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 13:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:23 INFO - Successfully installed psutil 13:32:23 INFO - Cleaning up... 13:32:23 INFO - Return code: 0 13:32:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:32:23 INFO - Using env: {'DISPLAY': ':0', 13:32:23 INFO - 'HOME': '/home/cltbld', 13:32:23 INFO - 'LANG': 'en_US.UTF-8', 13:32:23 INFO - 'LANGUAGE': 'en_US:en', 13:32:23 INFO - 'LOGNAME': 'cltbld', 13:32:23 INFO - 'MAIL': '/var/mail/cltbld', 13:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:23 INFO - 'MOZ_NO_REMOTE': '1', 13:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:23 INFO - 'NO_EM_RESTART': '1', 13:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:23 INFO - 'PWD': '/builds/slave/test', 13:32:23 INFO - 'SHELL': '/bin/bash', 13:32:23 INFO - 'SHLVL': '1', 13:32:23 INFO - 'TERM': 'linux', 13:32:23 INFO - 'TMOUT': '86400', 13:32:23 INFO - 'USER': 'cltbld', 13:32:23 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:23 INFO - '_': '/tools/buildbot/bin/python'} 13:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:32:24 INFO - Installing collected packages: mozsystemmonitor 13:32:24 INFO - Running setup.py install for mozsystemmonitor 13:32:24 INFO - Successfully installed mozsystemmonitor 13:32:24 INFO - Cleaning up... 13:32:24 INFO - Return code: 0 13:32:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:24 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 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:24 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 13:32:24 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 13:32:24 INFO - Using env: {'DISPLAY': ':0', 13:32:24 INFO - 'HOME': '/home/cltbld', 13:32:24 INFO - 'LANG': 'en_US.UTF-8', 13:32:24 INFO - 'LANGUAGE': 'en_US:en', 13:32:24 INFO - 'LOGNAME': 'cltbld', 13:32:24 INFO - 'MAIL': '/var/mail/cltbld', 13:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:24 INFO - 'MOZ_NO_REMOTE': '1', 13:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:24 INFO - 'NO_EM_RESTART': '1', 13:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:24 INFO - 'PWD': '/builds/slave/test', 13:32:24 INFO - 'SHELL': '/bin/bash', 13:32:24 INFO - 'SHLVL': '1', 13:32:24 INFO - 'TERM': 'linux', 13:32:24 INFO - 'TMOUT': '86400', 13:32:24 INFO - 'USER': 'cltbld', 13:32:24 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:24 INFO - '_': '/tools/buildbot/bin/python'} 13:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:25 INFO - Downloading/unpacking jsonschema==2.5.1 13:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:32:26 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 13:32:26 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 13:32:26 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 13:32:26 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 13:32:26 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:26 INFO - warning: no files found matching '*.txt' 13:32:26 INFO - no previously-included directories found matching 'build' 13:32:26 INFO - no previously-included directories found matching 'dist' 13:32:26 INFO - no previously-included directories found matching '.git*' 13:32:26 INFO - Installing collected packages: jsonschema, functools32 13:32:26 INFO - Running setup.py install for functools32 13:32:26 INFO - warning: no files found matching '*.txt' 13:32:26 INFO - no previously-included directories found matching 'build' 13:32:26 INFO - no previously-included directories found matching 'dist' 13:32:26 INFO - no previously-included directories found matching '.git*' 13:32:26 INFO - Successfully installed jsonschema functools32 13:32:26 INFO - Cleaning up... 13:32:26 INFO - Return code: 0 13:32:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:26 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 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:26 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 13:32:26 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 13:32:26 INFO - Using env: {'DISPLAY': ':0', 13:32:26 INFO - 'HOME': '/home/cltbld', 13:32:26 INFO - 'LANG': 'en_US.UTF-8', 13:32:26 INFO - 'LANGUAGE': 'en_US:en', 13:32:26 INFO - 'LOGNAME': 'cltbld', 13:32:26 INFO - 'MAIL': '/var/mail/cltbld', 13:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:26 INFO - 'MOZ_NO_REMOTE': '1', 13:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:26 INFO - 'NO_EM_RESTART': '1', 13:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:26 INFO - 'PWD': '/builds/slave/test', 13:32:26 INFO - 'SHELL': '/bin/bash', 13:32:26 INFO - 'SHLVL': '1', 13:32:26 INFO - 'TERM': 'linux', 13:32:26 INFO - 'TMOUT': '86400', 13:32:26 INFO - 'USER': 'cltbld', 13:32:26 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:26 INFO - '_': '/tools/buildbot/bin/python'} 13:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:32:26 INFO - Cleaning up... 13:32:26 INFO - Return code: 0 13:32:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:26 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 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:26 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 13:32:26 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 13:32:26 INFO - Using env: {'DISPLAY': ':0', 13:32:26 INFO - 'HOME': '/home/cltbld', 13:32:26 INFO - 'LANG': 'en_US.UTF-8', 13:32:26 INFO - 'LANGUAGE': 'en_US:en', 13:32:26 INFO - 'LOGNAME': 'cltbld', 13:32:26 INFO - 'MAIL': '/var/mail/cltbld', 13:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:26 INFO - 'MOZ_NO_REMOTE': '1', 13:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:26 INFO - 'NO_EM_RESTART': '1', 13:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:26 INFO - 'PWD': '/builds/slave/test', 13:32:26 INFO - 'SHELL': '/bin/bash', 13:32:26 INFO - 'SHLVL': '1', 13:32:26 INFO - 'TERM': 'linux', 13:32:26 INFO - 'TMOUT': '86400', 13:32:26 INFO - 'USER': 'cltbld', 13:32:26 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:26 INFO - '_': '/tools/buildbot/bin/python'} 13:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:26 INFO - Downloading/unpacking blobuploader==1.2.4 13:32:26 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 13:32:26 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 13:32:26 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 13:32:26 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 13:32:28 INFO - Downloading blobuploader-1.2.4.tar.gz 13:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:32:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:32:28 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 13:32:28 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 13:32:28 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 13:32:28 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 13:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:32:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:32:28 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 13:32:28 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 13:32:28 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 13:32:28 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 13:32:28 INFO - Downloading docopt-0.6.1.tar.gz 13:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:32:28 INFO - Installing collected packages: blobuploader, requests, docopt 13:32:28 INFO - Running setup.py install for blobuploader 13:32:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:32:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:32:28 INFO - Running setup.py install for requests 13:32:29 INFO - Running setup.py install for docopt 13:32:29 INFO - Successfully installed blobuploader requests docopt 13:32:29 INFO - Cleaning up... 13:32:29 INFO - Return code: 0 13:32:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:29 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 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:29 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 13:32:29 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 13:32:29 INFO - Using env: {'DISPLAY': ':0', 13:32:29 INFO - 'HOME': '/home/cltbld', 13:32:29 INFO - 'LANG': 'en_US.UTF-8', 13:32:29 INFO - 'LANGUAGE': 'en_US:en', 13:32:29 INFO - 'LOGNAME': 'cltbld', 13:32:29 INFO - 'MAIL': '/var/mail/cltbld', 13:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:29 INFO - 'MOZ_NO_REMOTE': '1', 13:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:29 INFO - 'NO_EM_RESTART': '1', 13:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:29 INFO - 'PWD': '/builds/slave/test', 13:32:29 INFO - 'SHELL': '/bin/bash', 13:32:29 INFO - 'SHLVL': '1', 13:32:29 INFO - 'TERM': 'linux', 13:32:29 INFO - 'TMOUT': '86400', 13:32:29 INFO - 'USER': 'cltbld', 13:32:29 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:29 INFO - '_': '/tools/buildbot/bin/python'} 13:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:29 INFO - Running setup.py (path:/tmp/pip-3kYO1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:29 INFO - Running setup.py (path:/tmp/pip-R_o5uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:29 INFO - Running setup.py (path:/tmp/pip-5XpZ6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:29 INFO - Running setup.py (path:/tmp/pip-ZJgFph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:29 INFO - Running setup.py (path:/tmp/pip-nNbST3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:29 INFO - Running setup.py (path:/tmp/pip-SbveH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:29 INFO - Running setup.py (path:/tmp/pip-DHt78B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:29 INFO - Running setup.py (path:/tmp/pip-GHjzWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:30 INFO - Running setup.py (path:/tmp/pip-OkN8_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:30 INFO - Running setup.py (path:/tmp/pip-2eTTp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:30 INFO - Running setup.py (path:/tmp/pip-M7Oe95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:30 INFO - Running setup.py (path:/tmp/pip-xI_ldV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:30 INFO - Running setup.py (path:/tmp/pip-6acSr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:30 INFO - Running setup.py (path:/tmp/pip-wsqgf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:30 INFO - Running setup.py (path:/tmp/pip-XQwqxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:30 INFO - Running setup.py (path:/tmp/pip-vWlAW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:30 INFO - Running setup.py (path:/tmp/pip-im1h3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:32:30 INFO - Running setup.py install for manifestparser 13:32:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:32:30 INFO - Running setup.py install for mozcrash 13:32:30 INFO - Running setup.py install for mozdebug 13:32:30 INFO - Running setup.py install for mozdevice 13:32:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Running setup.py install for mozfile 13:32:31 INFO - Running setup.py install for mozhttpd 13:32:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Running setup.py install for mozinfo 13:32:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Running setup.py install for mozInstall 13:32:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Running setup.py install for mozleak 13:32:31 INFO - Running setup.py install for mozlog 13:32:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Running setup.py install for moznetwork 13:32:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Running setup.py install for mozprocess 13:32:31 INFO - Running setup.py install for mozprofile 13:32:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:31 INFO - Running setup.py install for mozrunner 13:32:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:32 INFO - Running setup.py install for mozscreenshot 13:32:32 INFO - Running setup.py install for moztest 13:32:32 INFO - Running setup.py install for mozversion 13:32:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:32 INFO - Cleaning up... 13:32:32 INFO - Return code: 0 13:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:32 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 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:32 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 13:32:32 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 13:32:32 INFO - Using env: {'DISPLAY': ':0', 13:32:32 INFO - 'HOME': '/home/cltbld', 13:32:32 INFO - 'LANG': 'en_US.UTF-8', 13:32:32 INFO - 'LANGUAGE': 'en_US:en', 13:32:32 INFO - 'LOGNAME': 'cltbld', 13:32:32 INFO - 'MAIL': '/var/mail/cltbld', 13:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:32 INFO - 'MOZ_NO_REMOTE': '1', 13:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:32 INFO - 'NO_EM_RESTART': '1', 13:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:32 INFO - 'PWD': '/builds/slave/test', 13:32:32 INFO - 'SHELL': '/bin/bash', 13:32:32 INFO - 'SHLVL': '1', 13:32:32 INFO - 'TERM': 'linux', 13:32:32 INFO - 'TMOUT': '86400', 13:32:32 INFO - 'USER': 'cltbld', 13:32:32 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:32 INFO - '_': '/tools/buildbot/bin/python'} 13:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:32 INFO - Running setup.py (path:/tmp/pip-79R8hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:32 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)) 13:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:32 INFO - Running setup.py (path:/tmp/pip-eOLNZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:32 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)) 13:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:32 INFO - Running setup.py (path:/tmp/pip-C8ZGUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:32 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)) 13:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:32 INFO - Running setup.py (path:/tmp/pip-FhVfBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:32 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)) 13:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:32 INFO - Running setup.py (path:/tmp/pip-mQA7zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:33 INFO - Running setup.py (path:/tmp/pip-16l04N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:33 INFO - Running setup.py (path:/tmp/pip-d0JJ1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:33 INFO - Running setup.py (path:/tmp/pip-4IyXhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:33 INFO - Running setup.py (path:/tmp/pip-7ODgk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:33 INFO - Running setup.py (path:/tmp/pip-tdtY4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:33 INFO - Running setup.py (path:/tmp/pip-HUUE23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:33 INFO - Running setup.py (path:/tmp/pip-vqzDs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:33 INFO - Running setup.py (path:/tmp/pip-Q7f8uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:33 INFO - Running setup.py (path:/tmp/pip-HjoDT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:33 INFO - Running setup.py (path:/tmp/pip-fA05wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:33 INFO - Running setup.py (path:/tmp/pip-JuQ1nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:33 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)) 13:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:33 INFO - Running setup.py (path:/tmp/pip-2O89Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:33 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)) 13:32:33 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)) 13:32:33 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)) 13:32:33 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)) 13:32:33 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)) 13:32:33 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)) 13:32:33 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)) 13:32:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:33 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 13:32:33 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 13:32:33 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 13:32:33 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 13:32:34 INFO - Downloading blessings-1.6.tar.gz 13:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:35 INFO - Installing collected packages: blessings 13:32:35 INFO - Running setup.py install for blessings 13:32:35 INFO - Successfully installed blessings 13:32:35 INFO - Cleaning up... 13:32:35 INFO - Return code: 0 13:32:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:35 INFO - Reading from file tmpfile_stdout 13:32:35 INFO - Current package versions: 13:32:35 INFO - argparse == 1.2.1 13:32:35 INFO - blessings == 1.6 13:32:35 INFO - blobuploader == 1.2.4 13:32:35 INFO - docopt == 0.6.1 13:32:35 INFO - functools32 == 3.2.3-2 13:32:35 INFO - jsonschema == 2.5.1 13:32:35 INFO - manifestparser == 1.1 13:32:35 INFO - mozInstall == 1.13 13:32:35 INFO - mozcrash == 1.0 13:32:35 INFO - mozdebug == 0.1 13:32:35 INFO - mozdevice == 0.51 13:32:35 INFO - mozfile == 1.2 13:32:35 INFO - mozhttpd == 0.7 13:32:35 INFO - mozinfo == 0.10 13:32:35 INFO - mozleak == 0.1 13:32:35 INFO - mozlog == 3.5 13:32:35 INFO - moznetwork == 0.27 13:32:35 INFO - mozprocess == 0.25 13:32:35 INFO - mozprofile == 0.28 13:32:35 INFO - mozrunner == 6.13 13:32:35 INFO - mozscreenshot == 0.1 13:32:35 INFO - mozsystemmonitor == 0.3 13:32:35 INFO - moztest == 0.8 13:32:35 INFO - mozversion == 1.4 13:32:35 INFO - psutil == 3.1.1 13:32:35 INFO - requests == 1.2.3 13:32:35 INFO - wsgiref == 0.1.2 13:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:35 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')]} 13:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:35 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')]} 13:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:35 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 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:35 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 13:32:35 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 13:32:35 INFO - Using env: {'DISPLAY': ':0', 13:32:35 INFO - 'HOME': '/home/cltbld', 13:32:35 INFO - 'LANG': 'en_US.UTF-8', 13:32:35 INFO - 'LANGUAGE': 'en_US:en', 13:32:35 INFO - 'LOGNAME': 'cltbld', 13:32:35 INFO - 'MAIL': '/var/mail/cltbld', 13:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:35 INFO - 'MOZ_NO_REMOTE': '1', 13:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:35 INFO - 'NO_EM_RESTART': '1', 13:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:35 INFO - 'PWD': '/builds/slave/test', 13:32:35 INFO - 'SHELL': '/bin/bash', 13:32:35 INFO - 'SHLVL': '1', 13:32:35 INFO - 'TERM': 'linux', 13:32:35 INFO - 'TMOUT': '86400', 13:32:35 INFO - 'USER': 'cltbld', 13:32:35 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:35 INFO - '_': '/tools/buildbot/bin/python'} 13:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:35 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)) 13:32:35 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)) 13:32:35 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)) 13:32:35 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)) 13:32:35 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)) 13:32:35 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)) 13:32:35 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)) 13:32:35 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)) 13:32:35 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)) 13:32:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:32:35 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 13:32:35 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 13:32:35 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 13:32:35 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 13:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:32:36 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)) 13:32:36 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)) 13:32:36 INFO - Installing collected packages: simplejson 13:32:36 INFO - Running setup.py install for simplejson 13:32:36 INFO - building 'simplejson._speedups' extension 13:32:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 13:32:37 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 13:32:37 INFO - Successfully installed simplejson 13:32:37 INFO - Cleaning up... 13:32:37 INFO - Return code: 0 13:32:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:37 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')]} 13:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:37 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')]} 13:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:37 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 0x12c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, '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': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', '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 13:32:37 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 13:32:37 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 13:32:37 INFO - Using env: {'DISPLAY': ':0', 13:32:37 INFO - 'HOME': '/home/cltbld', 13:32:37 INFO - 'LANG': 'en_US.UTF-8', 13:32:37 INFO - 'LANGUAGE': 'en_US:en', 13:32:37 INFO - 'LOGNAME': 'cltbld', 13:32:37 INFO - 'MAIL': '/var/mail/cltbld', 13:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:37 INFO - 'MOZ_NO_REMOTE': '1', 13:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:37 INFO - 'NO_EM_RESTART': '1', 13:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:37 INFO - 'PWD': '/builds/slave/test', 13:32:37 INFO - 'SHELL': '/bin/bash', 13:32:37 INFO - 'SHLVL': '1', 13:32:37 INFO - 'TERM': 'linux', 13:32:37 INFO - 'TMOUT': '86400', 13:32:37 INFO - 'USER': 'cltbld', 13:32:37 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:37 INFO - '_': '/tools/buildbot/bin/python'} 13:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:32:38 INFO - Cleaning up... 13:32:38 INFO - Return code: 0 13:32:38 INFO - Running post-action listener: _resource_record_post_action 13:32:38 INFO - Running post-action listener: _start_resource_monitoring 13:32:38 INFO - Starting resource monitoring. 13:32:38 INFO - [mozharness: 2017-08-11 20:32:38.142016Z] Finished create-virtualenv step (success) 13:32:38 INFO - [mozharness: 2017-08-11 20:32:38.142484Z] Running install step. 13:32:38 INFO - Running pre-action listener: _resource_record_pre_action 13:32:38 INFO - Running main action method: install 13:32:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:38 INFO - Reading from file tmpfile_stdout 13:32:38 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:38 INFO - Reading from file tmpfile_stdout 13:32:38 INFO - Output received: 13:32:38 INFO - Usage: mozinstall [options] installer 13:32:38 INFO - Options: 13:32:38 INFO - -h, --help show this help message and exit 13:32:38 INFO - -d DEST, --destination=DEST 13:32:38 INFO - Directory to install application into. [default: 13:32:38 INFO - "/builds/slave/test"] 13:32:38 INFO - --app=APP Application being installed. [default: firefox] 13:32:38 INFO - mkdir: /builds/slave/test/build/application 13:32:38 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'] 13:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:32:57 INFO - Reading from file tmpfile_stdout 13:32:57 INFO - Output received: 13:32:57 INFO - /builds/slave/test/build/application/firefox/firefox 13:32:57 INFO - Running post-action listener: _resource_record_post_action 13:32:57 INFO - [mozharness: 2017-08-11 20:32:57.302851Z] Finished install step (success) 13:32:57 INFO - [mozharness: 2017-08-11 20:32:57.303132Z] Running setup-mitmproxy step. 13:32:57 INFO - Running pre-action listener: _resource_record_pre_action 13:32:57 INFO - Running main action method: setup_mitmproxy 13:32:57 INFO - Skipping: mitmproxy is not required 13:32:57 INFO - Running post-action listener: _resource_record_post_action 13:32:57 INFO - [mozharness: 2017-08-11 20:32:57.304371Z] Finished setup-mitmproxy step (success) 13:32:57 INFO - [mozharness: 2017-08-11 20:32:57.304606Z] Running run-tests step. 13:32:57 INFO - Running pre-action listener: _resource_record_pre_action 13:32:57 INFO - Running pre-action listener: _set_gcov_prefix 13:32:57 INFO - Running main action method: run_tests 13:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:32:57 INFO - Python 2.7.3 13:32:57 INFO - Return code: 0 13:32:57 INFO - grabbing minidump binary from tooltool 13:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:57 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 0x1631f00>, '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 0x162cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162d050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:32:57 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 13:32:57 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 13:32:57 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 13:32:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:32:57 INFO - Return code: 0 13:32:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:32:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:32:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:32:57 INFO - ENV: RUST_BACKTRACE is now full 13:32:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:32:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:32:57 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/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:32:57 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/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 13:32:57 INFO - Using env: {'DISPLAY': ':0', 13:32:57 INFO - 'HOME': '/home/cltbld', 13:32:57 INFO - 'LANG': 'en_US.UTF-8', 13:32:57 INFO - 'LANGUAGE': 'en_US:en', 13:32:57 INFO - 'LOGNAME': 'cltbld', 13:32:57 INFO - 'MAIL': '/var/mail/cltbld', 13:32:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:32:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:57 INFO - 'MOZ_NO_REMOTE': '1', 13:32:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:57 INFO - 'NO_EM_RESTART': '1', 13:32:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:57 INFO - 'PWD': '/builds/slave/test', 13:32:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:32:57 INFO - 'RUST_BACKTRACE': 'full', 13:32:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:32:57 INFO - 'SHELL': '/bin/bash', 13:32:57 INFO - 'SHLVL': '1', 13:32:57 INFO - 'STYLO_FORCE_ENABLED': '1', 13:32:57 INFO - 'TERM': 'linux', 13:32:57 INFO - 'TMOUT': '86400', 13:32:57 INFO - 'USER': 'cltbld', 13:32:57 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502483504.745194-765263', 13:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:57 INFO - '_': '/tools/buildbot/bin/python'} 13:32:57 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/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:32:57 INFO - mozversion application_buildid: 20170811194712 13:32:57 INFO - mozversion application_changeset: e7dc8329e2d478087314605e8184627489eef636 13:32:57 INFO - mozversion application_display_name: Nightly 13:32:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:32:57 INFO - mozversion application_name: Firefox 13:32:57 INFO - mozversion application_remotingname: firefox 13:32:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:32:57 INFO - mozversion application_vendor: Mozilla 13:32:57 INFO - mozversion application_version: 57.0a1 13:32:57 INFO - mozversion platform_buildid: 20170811194712 13:32:57 INFO - mozversion platform_changeset: e7dc8329e2d478087314605e8184627489eef636 13:32:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:32:57 INFO - mozversion platform_version: 57.0a1 13:32:57 INFO - using testdate: 1502483577 13:32:57 INFO - actual date: 1502483577 13:32:57 INFO - starting webserver on 'localhost:50403' 13:32:57 INFO - SUITE-START | Running 2 tests 13:32:57 INFO - TEST-START | dromaeo_css 13:32:57 INFO - Initialising browser for dromaeo_css test... 13:32:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50403/getInfo.html -profile /tmp/tmpBIPFz2/profile 13:32:57 INFO - TEST-INFO | started process 26059 (/builds/slave/test/build/application/firefox/firefox http://localhost:50403/getInfo.html) 13:33:04 INFO - TEST-INFO | 26059: exit 0 13:33:04 INFO - Browser initialized. 13:33:04 INFO - Running cycle 1/1 for dromaeo_css test... 13:33:04 INFO - TEST-INFO | started process 26295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBIPFz2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:05 INFO - PID 26295 | 13:33:05 INFO - PID 26295 | (/builds/slave/test/build/application/firefox/firefox:26349): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:33:05 INFO - PID 26295 | 13:33:15 INFO - PID 26295 | RSS: Main: 167800832 13:33:15 INFO - PID 26295 | 13:36:15 INFO - PID 26295 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50403/tests/dromaeo/cssquery-ext.html) 13:36:16 INFO - PID 26295 | RSS: Main: 175132672 13:36:16 INFO - PID 26295 | 13:39:18 INFO - PID 26295 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-ext.html (next: http://localhost:50403/tests/dromaeo/cssquery-jquery.html) 13:39:18 INFO - PID 26295 | RSS: Main: 172269568 13:39:18 INFO - PID 26295 | 13:42:20 INFO - PID 26295 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50403/tests/dromaeo/cssquery-mootools.html) 13:42:21 INFO - PID 26295 | RSS: Main: 174358528 13:42:21 INFO - PID 26295 | 13:45:22 INFO - PID 26295 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50403/tests/dromaeo/cssquery-prototype.html) 13:45:23 INFO - PID 26295 | RSS: Main: 173023232 13:45:23 INFO - PID 26295 | 13:48:27 INFO - PID 26295 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50403/tests/dromaeo/cssquery-yui.html) 13:48:28 INFO - PID 26295 | RSS: Main: 176427008 13:48:28 INFO - PID 26295 | 13:51:29 INFO - PID 26295 | Cycle 1(1): loaded http://localhost:50403/tests/dromaeo/cssquery-yui.html (next: http://localhost:50403/tests/dromaeo/cssquery-dojo.html) 13:51:30 INFO - PID 26295 | RSS: Main: 176836608 13:51:30 INFO - PID 26295 | 13:51:30 INFO - PID 26295 | __start_tp_report 13:51:30 INFO - PID 26295 | _x_x_mozilla_page_load 13:51:30 INFO - PID 26295 | _x_x_mozilla_page_load_details 13:51:30 INFO - PID 26295 | |i|pagename|runs| 13:51:30 INFO - PID 26295 | |0;dojo.html;3152.5113607390863;3192.9361412771736;3196.5524826524306;3200.7919485233456;3224.403485355208;6261.3425590313045;6287;6341.239051313849;6358.841028974278;6372.553921225516;6165.907511387333;6251.874962500748;6257;6257.37426257374;6258.655773932432;5732.541396688265;5737.196792449061;5742.4831765141125;5749.971250143743;5842.123681447774;5778.7977420790285;5792.391798861101;5831.591788574801;5880.647161170344;5912.379200183983;5602.691851948182;5690.7439165237665;5742.626729262605;5765.769369225226;5853;5683.403242659544;5719.056355701305;5755.223044888929;5778.8266352009505;5802.854928626776;5626.578006649518;5669.886602267931;5766.538676905838;5782.479576838105;5782.710864456761;5971.552133589955;6109.20580324555;6161.7535298588;6225.595336303126;6256.843578910563;6561.967190164019;6626.867462650768;6634.93365066348;6652.467802575782;6655.334466553354;6688.3646053624825;6693.431058360045;6702.564333318319;6710.396064354183;6726.058351830748;6182.845428864314;6185.16500272462;6185.16500272462;6186.474149697281;6193.1329613854095;6822.727090916407;6842.110525631736;6902.965485172542;6916.827079323057;6947.270536593686;6543.967280163664;6622.437092847065;6637.1703537057865;6644.966775166094;6655.866882662416;6623.933760662332;6649.867002659919;6657.034729964128;6744.966275168593;6751.527393082437;6552.148220731275;6605.207375115017;6627.734890604322;6654.534182607268;6708.396244338033;6592.604443733391;6620;6634.0712300278;6656.733730650816;6657.600543967377;4725.1730947084125;5407;5410.215518749759;5413.404525502192;5533.446655334435;4555.088982203506;4666.136764698542;4667.393238878924;4671.7430541320555;4686.484486706459;5752.3097228332035;5780.479756821906;5791.623544469596;5833.154192642043;5833.649981001068;6547.5416720830035;6742.0224067509935;6801.4558835293055;6819.7272109116075;6825.897611535831;5680.460356266148;5799.3620701722775;5867.325257595346;5870.911936320958;5874.1776151338845;5897.557683173779;5907.2911250650195;5930.614510056833;5932.377100404482;5940.495057920125;6534.019897015486;6555.934440655627;6602.14172157626;6613.966930165318;6629.105070815474;6703.296153903965;6728.360805723449;6729.528932974645;6776.847935850818;6807.3873351398615;6335.714892829926;6500.317466666121;6501.44737697301;6506.707198176188;6614.4708423325055;6587.835304117435;6593.769218077345;6609.570377925419;6617.338266173537;6663.700133493908;6664.900026499509;6757.3242675732035;6796.626185559841;6811.761588344384;6820.249772524919;6562.475001999924;6629.900551491635;6635.8009259722285;6638.004299355135;6643.435307998681;6539.509536784665;6543.443807276435;6553.541252112306;6632.767853125118;6642.76750313756;6327.303996560283;6414.10202571631;6418.743250269937;6494.545381823227;6499.122618446449;6579.769708060195;6619.768308109193;6657.73369065232;6670.466362690876;6679.365460281266;6247.125402443752;6282.560220784501;6346.587471814318;6362.04569314588;6386.616802991835 13:51:30 INFO - PID 26295 | |1;ext.html;828.7058094376496;872.2760109109438;894.3471265975837;898.2679116520036;1188.150472412225;31909.52135717963;42514.57485425145;42926.14147717052;43118.13763724727;43710.781446092726;43157.136857262834;43195.568044319545;43484.78257608708;43595;43918;7332.853342933165;7731.033620797414;7849.5682737449415;7882.172371900954;7960.800979975518;7744.148143704188;7823.5305881647;7846.72536461224;7853.921460785376;7857.449978501507;7815;7870.881936770925;7881;7882.211778822129;7884.172161923001;7811.882821757678;7847.489913155655;7849.097353804328;7853.8036549086155;7855.803604909923;7719.65261563231;7785.182555831613;7788.0654321481215;7788.143304236586;7811.921880781177;39616.405753913714;39832;39893.80053099745;39948.80025599853;39991.8000409999;3494.4758286257265;3531.8057506837113;3537.663921927413;3542.929141417157;3552.5914519830035;32141.51787723186;32183.83908080468;32266.516002259985;32269.677303227138;32307.19232019195;5004.149294619923;5035.597152227813;5082.059818933509;5083.593312534988;5088.92366614501;190120;190797;191241;191815;192223;50092.749536252086;50362.74818625883;50380.244296335586;50515.7474212634;50581.49418505768;52816;52846.47153528492;52876.47123528716;52883.471165287854;52939.73530132325;16414.753778693328;16710.498685039467;16767.329306827833;16778.244978975974;16788.244528996223;12213.633590992284;12330.136890417763;12338.444769985372;13777.655558611115;13996.790048149285;14942.178180200193;14990.250487475801;15002.549923502313;15055.849441505445;15211.163386013875;5822.359540450547;5840.649561026352;5851.736671849777;5926.348101708809;6011.879762404727;978.7602037500858;982.3467394182788;1002.1631937332409;1006.2754816532085;1025.4462590201208;22580.20969266068;23384.064637414314;29944.700552994625;30208.09375718732;30377;1081.8377243413552;1092.4210168610648;1095.1457862866976;1101.867775866885;1102.9117670586334;12133.575324863587;12299.262044277371;12334.321612311409;12363.443645035995;12392.380380980914;227974;231200;231737;232047;232299;54425;54558;54582.45417545853;54640;54688.726556366964;1455.9490417835325;1459.0594509302603;1477.128494188434;1478.1500637133477;1483.8738707209793;22384.664230036236;22574.66138007964;22621;22627.773722262566;22808.543829123657;37257.6274237265;37394.813025934694;37449.43825842669;37451.250974980896;37467;203047;204496;204717;204989.90020199213;205001;31020.22449438692;31581;31646.683533164374;34213.31573368568;34345.82827085849;43989.78005109954;44196;44318.77840610905;44381;45007;32524;32978.83510582432;33273.500897486076;33577.328453431284;33746;32690.50964235586;32868.83565582253;32973.67026329706;33247.50128748119;33276.66723332833;35476.64523354734;36016.27967440584;36049.098772530895;36052.27895442129;36334.8183259082;31362;31817.681823182396;32084.839575801972;32106.83946580252;32316.676833232308;23530.647040294753;23742.287731368087;23835.761642384048;23980.160694375612;23992.40018999539 13:51:30 INFO - PID 26295 | |2;jquery.html;578.965262084275;579.3627010288683;579.5827004556718;583.2563481561009;583.5477504933679;22293.331200064003;23081.884590577043;23134.421639459022;23253.651195232083;23420.76579234207;24923.75076249237;25802.999999999953;27053.86473067632;27098.45803083937;27181;6650.334966503359;6787.966060169717;6791.117154769898;6800.285969973156;6813.250542440328;6238.251409830827;6603.339666033382;6690.59856408617;6700.966495167518;6732.2257940336995;6473.708683109271;6488.967555162218;6491.837704057389;6504.121943537609;6506;6404.975203967366;6446.838829029289;6453.2256129264315;6502.902456463157;6506.4469520090615;6023.939760602381;6028.156058151862;6033.1553582498045;6040.305364883051;6051.606645568068;29290.560641590393;29588.55617165744;30251.09246722602;30308.242293942607;31154.532682009787;1946.4549926020736;2002.029015927274;2002.8197462228325;2003.07858385143;2003.789602091774;19881.30415435467;20589.794102059088;20607.484812879648;20611.587768244703;20627.79372206274;2429.392651837041;2468.8148388870904;2523.659305993686;2540;2540.3776074861594;132937;138672.99999999898;138775.30612346975;138792.30603847018;139124;14647.267636618126;15377.769333460006;15417.691646167013;15429.614259643598;15711.68576628461;23703.288901332988;23771.762282376956;23777.52444951126;23779.524409512058;23816;10229.693109206586;10256.948715256376;10269.640562580274;10360.119389851796;10415.479226038668;9481.24150067993;9497.5726092326;9500.524973751422;9512.334136610509;9579.90420095804;8905.332100092519;9322.30082743797;9384.202342800801;9428.15146636806;9526.666566670134;2592.974070259273;2594.8962041518507;2634.3150780796745;2721.6597925259343;2724.82288651237;939.389396892012;970.1414248390225;978.5694294510392;988.3279370028449;989.6882482018285;19499.31752388688;20066;20199.29302474436;20448.079836407396;24013.7598624015;1022.5245260953692;1058.9841152382721;1066.8773091094624;1071.373246650718;1076.3380520979697;11064.889351106547;11311.434428278717;11454.828177577343;11560.901714337124;11594.420278986017;530525;532038;532558;537087;539683;116485.41757291328;124736;125593;125951;126077.36961315134;1266.8416447944007;1277.3804704718204;1312.5143696832233;1313.0283590143226;1319.907606467538;20432.28487003007;20587;20590.82275317369;20674.069666864725;20973.58052838965;57085.71457142688;57731;58429.70785146047;59469.70265148646;60718.696406519455;75310.24689753032;75570;75659.62170189334;75917;76488.23511764812;14692.779608306098;14797.92601036988;14876;14961.177135257665;14992.925035374754;21501.139954402275;21753.347399578037;21881.234156804436;22011.11955521761;22014;18237.635247295246;18566.721499177795;18574.907125464288;18590.81409185891;18615.255389784255;16410.179491025163;17026.574335641708;17496.91251543734;17930.103494824947;18135.27458901682;19669.21323147058;20054.799452005293;20249.493762656053;20287.28994485186;20487.28294509685;14744.852551474776;15227.695446091238;15234.466793662612;15255.160966146968;15282.465113720966;18821.341253056624;19244.03779811032;19307.4207773767;19456.319028833925;19485.610287794447 13:51:30 INFO - PID 26295 | |3;mootools.html;1344.6235054184829;1387.6114687887389;1392.7284179584985;1397.1058522545566;1405.7048019915817;13762.105463144888;14223.857761422383;14335;14359.35382907769;14364.425422983068;14288.857111428908;14547.272636368165;14548.563543093698;14551.345189466472;14558.490452834152;2684.543627583311;2716.619673245747;2729.2221716810714;2731.6721993360825;2731.986340068297;2555.667763190792;2622.265765585639;2644.0217119665654;2702.3784529558116;2707.56678931371;2697.2043247242013;2734.9589756153673;2735.9179224623294;2740.5341092014305;2741.7806575474015;2628.4217472156097;2657.2825337158956;2682.369643133862;2683.785297176241;2695.4743824954044;2568.5761849294845;2568.8715564221716;2660.7472290132405;2667.773239274664;2672.3452754075183;13731.656708582266;13825.723485530232;13851.307434628228;13872.722545549133;13910.374033168531;7405.8889116663295;7732.072151341875;7750.14748377678;7760.805979850493;7768.922310776933;4874.46380898101;5001.749562609348;5080.923786143211;5126.897462050775;5200.8179713710215;1850.3616252392903;1917.769867615895;1924.7305377247196;1958.921643134273;1961.1370996761523;23160.65259021116;23820.64269035966;23826.523469530686;23837.523249535087;23843.88078059616;6848.9657551711925;6896.517243792886;7114;7128.607926563985;7147.785566433015;15807.920960395124;15870;15902.443414480438;15913.443029493912;15947.760783588255;7625.504342217738;7870.173631768696;7913.920860791433;7921.32668723165;7924;6942.444604431634;7000.194977577542;7055.753048643272;7082.220955694869;7161.67772450241;4989.775460104304;5176.7411629418375;5189.065968125774;5200.531952124327;5211.478852114758;1399.8530154333853;1416.9291535423188;1506.1716056169064;1516.4919751883242;1521.9467318643794;868.8218915122385;893.718478679227;906.6781292641149;907.2787134228304;909.1045320359441;8420.8315833683;8573.699920502753;8588.184122508352;8616.698415555426;8650.221480066824;993.3940296419179;998.7053819123377;1017.8320577104695;1020.2756043209256;1026.5935668134703;4602.608778253819;4833.540813622701;5314.703447725606;5330.8933821324135;5344.599155063386;19086.904565477085;20016.69974950377;20028.89985550092;20064;20094.39716808498;18463.723044154347;19586.804131958783;19671.016449177485;19765.703514447294;19873.403797886087;9886.357386769838;9957.402555846673;10038.297319187734;10053.59785608582;10111.696649100539;7925.841483170189;8225.71210007647;8244.216799404046;8260.132686068117;8383.496990180609;16392.426265081143;16408.425705100264;16462;16735.1632418381;16835.579110522336;17332.826671733626;17337.913310433367;17421.738673919648;17494.300227990738;17558.38545650896;10376.584936602452;10459.738506537398;10516;10588.470576470992;10589.629362972259;11713.648590542298;12496.687582810502;12819.038572107316;12830.358482076046;12838.935805320914;9096.863547046933;9842.163416109712;10199.031092046243;10255.487225638539;10419.94790026045;10032.046955539212;10222.53998570081;10258.384496930208;10303.124234439856;10433.32183408076;9148.954255228682;9211.618257261196;9214.677486287948;9222.170004699608;9230.769230769285;7226.313500217471;7249.710011599477;7254.202037775735;7304.452166087458;7332.5600463970195;7015.298470152944;7069.187043490065;7135.286471352823;7288.526245794006;7319.853602927805 13:51:30 INFO - PID 26295 | |4;prototype.html;493.1081343428459;494.27782162588784;517.2086707337775;521.288441277656;523.296166655848;6275.4038366355235;6279.843003924904;6326.240851097869;6359.745610175599;6395.825419357418;6080.787172448965;6202.379762023796;6216.564840461169;6287.2140982377205;6303.779367722131;5192.117340052181;5217.634765566412;5257.631965762398;5260.289860868772;5281.2342210379475;5208.140656791625;5237.109691352479;5259.737013149346;5264.446988138489;5282.947170528284;5009.273655319977;5211.635185537014;5212.400573934008;5212.582993360541;5225.111731005719;5166.560842328407;5176.21420609889;5180.1452760294505;5212.739363031833;5241;4817.662763606549;4834.685745426536;4840.201366774478;4887.486813884562;4896.95103048972;6061.302950160743;6090.725917333731;6100.816975490742;6127.78552750656;6163.938360616381;6041.184440100574;6065.211522502046;6068.484178844804;6069.696515174268;6089.177960975256;6660.733570657168;6661.93338066618;6664.300248473889;6665.833354166185;6681.231658359302;5303.7348132593215;5312.751503396698;5313.362396512404;5326.082610260303;5333.733313334318;6917.861642767167;6982.406495447893;7028.929710702879;7029.5430796998035;7043.577385356895;5493.258410114663;5518.944810551843;5523.7790488380815;5540.390557038722;5545.611807173459;5571.4121475379325;5572.832815015556;5573.749181286852;5582.609217354828;5605.943940560543;5983.730732117066;6014.7594096236535;6023.48800351975;6036.305824830113;6047.3045599755715;6702.19573651165;6705.832354191087;6722.781482110891;6756.864862702719;6762.932370676329;1878.8121187881377;1895.1187697720627;1923.3172223860329;1924;1939.2824654877786;1305.419088505606;1372.9244891531062;1378.3659516622265;1401.0752903083915;1425.4868247430916;5674.971625141848;5678.176664383641;5756.395578464285;5768.567357448208;5805.88388232233;6567.8358041048405;6605.57063790852;6661.9000714989315;6689.264180940093;6747.291534388916;5674.744636491368;5686.516646085129;5722;5758.280214973129;5788.652680839163;3559.430491121408;3568.197155640012;3577.4454959481322;3586.497890295361;3607.458881167846;6439.871202576016;6495.382938620824;6523.967380163069;6545.574537655038;6589.924173885211;6906.482013848981;6908.378245957888;6950.582965022014;6971.17667344716;7017.684204210823;6519.771807986603;6533.738650453929;6536.477081833442;6578.967105164444;6599.901001484982;6721.193456785217;6757.594544327356;6794.4904132189295;6804.421624161803;6828.795136145924;6683.498737594603;6713.878046708304;6723.7646682365885;6737.898931515933;6755.0205220241805;6468.663352733919;6551.6069035858;6598.208215014229;6638.468922486286;6642.667866606747;4993.400791904995;5067.138586440387;5077.746112694276;5099.974500127476;5107.259447380184;6735;6748.561343512656;6751.88593882004;6777.322267773183;6832.419244364285;6532.379423954717;6544.055175171096;6558.967205164135;6560.44236239925;6622.503312251504;6458.773942911976;6501.382368674968;6582.341765823571;6585.078089067439;6607.735690572324;6184.8763024738355;6401.199850018747;6512;6516.543841931019;6590.9670451647435;6212.378762123933;6462.127612772216;6507.609543427409;6564.5076619254705;6644.800655980328;6231.844203894939;6384.265809431975;6384.648844313421;6392.360763923756;6407 13:51:30 INFO - PID 26295 | |5;yui.html;904.9321300902429;916.1708653668429;933.472587987787;937.4515908193706;939.746268507503;19092;20080.397588072345;20090.095945682442;20113.59772804545;20470.2835400761;21865.344039678836;22775.31674049777;22842.543149137007;22926.65610015851;22940.655890161663;1020.846872969055;1063.7181146996052;1064;1065.589747947042;1066.3122286125445;966.7293157915794;1039.8492218628294;1064.6486659402378;1067.5996501312009;1068.1775033224412;1112.9054030407426;1113.1595645287796;1113.4877956140185;1113.9108871290277;1115.0912006714502;1102.063246240693;1107.1696227829127;1109.500724673892;1112.0158659586243;1114.186643750059;808.6563210635456;809.0372456776417;813.9267465928036;815.9510429374257;815.995920020396;18532.814671853244;18851;19055.142518586697;19122.139503722366;19199.904000480048;21916.89041554782;22239.110435582556;22299.44251393712;22749.43126421853;22761.77238227613;16371.099589522571;16450.506484805475;16729.581760455963;16741.91629041859;16894.83105168945;3601.4237721964623;3612.0608641753333;3626.8730594429067;3635.8909232723063;3644.125409901631;113440;115971;116393;118178.40910795477;118575.4071229647;17108.48674539766;17225.3971111013;17318.913405432893;17401.390951316895;17449.912750436168;31683.683163168072;31782.523262151088;32499.675003249664;32503.51244731331;32557.18607034843;9013.684521041732;9091.363604547618;9097.90902090984;9156.084391560791;9166.954165229265;4126.195391898611;4224.239636865394;4226.1758957003085;4226.5139508956245;4227.492700875914;5203.60972927032;5743.827685169452;5899.410058994152;5922.615030023035;5932.822015339547;1011.3123076308034;1025.3847691385108;1037.071820720451;1047.92064173901;1049.905508504223;634.6414275934083;642.980710578674;645.7901182115831;651.9641419721866;656.471540409965;11300.265482743594;11624.593139240085;11989.220700654603;12518.81221781674;12540.686482838002;539.9055165346049;545.9099248623933;551.8482417335265;560.4619565217437;563.2199403825649;5712.971435142797;5834.27071616048;5838.328592211865;6052.757889684452;6069.119977603223;118216;119273;119301;119564.40217798855;121405.39297303457;105152;105265;108168;109177.45411272893;109926;85733.28533429296;86143.56928215318;87316.56341718377;87867.56066219756;89864;10824.945875270574;11843.28940263587;12036.578719744766;12054.337011464102;12847;38467.42298865463;40367.596324036385;41206.587934120274;41638.58361416347;42226.788866055475;72728;74472.62763686146;75811;77253.61373193098;77734.22265777495;18890.94694378819;19569.119389627216;19678.311259105863;19744.30894918671;19992;21739.673904891755;22903.770962290164;22954.42613934665;23312.417189570395;23350.53298933978;18115.72826407631;18509.53726156857;19060.046997649784;19260.614787703886;19271.51821204481;17479.82520174833;17526.036068016383;17572.2092505835;20090.497737556678;20187.39437816868;17517.737233941247;17586.472405827844;17933.551661208574;18386;18646.254149834396;12815.679608009874;13499.055066145276;14177.645558860699;14220.288985550887;14613.342399592257;13576.253306068262;13588.93205533966;13974.510892119133;13981.370838312503;14259.500917467838 13:51:30 INFO - PID 26295 | __end_tp_report 13:51:30 INFO - PID 26295 | __start_cc_report 13:51:30 INFO - PID 26295 | _x_x_mozilla_cycle_collect,377 13:51:30 INFO - PID 26295 | __end_cc_report 13:51:30 INFO - PID 26295 | __startTimestamp1502484690058__endTimestamp 13:51:30 INFO - PID 26295 | 13:51:30 INFO - PID 26295 | ------- Summary: start ------- 13:51:30 INFO - PID 26295 | Number of tests: 6 13:51:30 INFO - PID 26295 | 13:51:30 INFO - PID 26295 | [#0] dojo.html Cycles:165 Average:6173.45 Median:6414.10 stddev:728.25 (11.4%) stddev-sans-first:690.85 13:51:30 INFO - PID 26295 | Values: 3152.5 3192.9 3196.6 3200.8 3224.4 6261.3 6287.0 6341.2 6358.8 6372.6 6165.9 6251.9 6257.0 6257.4 6258.7 5732.5 5737.2 5742.5 5750.0 5842.1 5778.8 5792.4 5831.6 5880.6 5912.4 5602.7 5690.7 5742.6 5765.8 5853.0 5683.4 5719.1 5755.2 5778.8 5802.9 5626.6 5669.9 5766.5 5782.5 5782.7 5971.6 6109.2 6161.8 6225.6 6256.8 6562.0 6626.9 6634.9 6652.5 6655.3 6688.4 6693.4 6702.6 6710.4 6726.1 6182.8 6185.2 6185.2 6186.5 6193.1 6822.7 6842.1 6903.0 6916.8 6947.3 6544.0 6622.4 6637.2 6645.0 6655.9 6623.9 6649.9 6657.0 6745.0 6751.5 6552.1 6605.2 6627.7 6654.5 6708.4 6592.6 6620.0 6634.1 6656.7 6657.6 4725.2 5407.0 5410.2 5413.4 5533.4 4555.1 4666.1 4667.4 4671.7 4686.5 5752.3 5780.5 5791.6 5833.2 5833.6 6547.5 6742.0 6801.5 6819.7 6825.9 5680.5 5799.4 5867.3 5870.9 5874.2 5897.6 5907.3 5930.6 5932.4 5940.5 6534.0 6555.9 6602.1 6614.0 6629.1 6703.3 6728.4 6729.5 6776.8 6807.4 6335.7 6500.3 6501.4 6506.7 6614.5 6587.8 6593.8 6609.6 6617.3 6663.7 6664.9 6757.3 6796.6 6811.8 6820.2 6562.5 6629.9 6635.8 6638.0 6643.4 6539.5 6543.4 6553.5 6632.8 6642.8 6327.3 6414.1 6418.7 6494.5 6499.1 6579.8 6619.8 6657.7 6670.5 6679.4 6247.1 6282.6 6346.6 6362.0 6386.6 13:51:30 INFO - PID 26295 | 13:51:30 INFO - PID 26295 | [#1] ext.html Cycles:180 Average:38283.55 Median:3513.14 stddev:54285.36 (1545.2%) stddev-sans-first:54364.79 13:51:30 INFO - PID 26295 | Values: 828.7 872.3 894.3 898.3 1188.2 31909.5 42514.6 42926.1 43118.1 43710.8 43157.1 43195.6 43484.8 43595.0 43918.0 7332.9 7731.0 7849.6 7882.2 7960.8 7744.1 7823.5 7846.7 7853.9 7857.4 7815.0 7870.9 7881.0 7882.2 7884.2 7811.9 7847.5 7849.1 7853.8 7855.8 7719.7 7785.2 7788.1 7788.1 7811.9 39616.4 39832.0 39893.8 39948.8 39991.8 3494.5 3531.8 3537.7 3542.9 3552.6 32141.5 32183.8 32266.5 32269.7 32307.2 5004.1 5035.6 5082.1 5083.6 5088.9 190120.0 190797.0 191241.0 191815.0 192223.0 50092.7 50362.7 50380.2 50515.7 50581.5 52816.0 52846.5 52876.5 52883.5 52939.7 16414.8 16710.5 16767.3 16778.2 16788.2 12213.6 12330.1 12338.4 13777.7 13996.8 14942.2 14990.3 15002.5 15055.8 15211.2 5822.4 5840.6 5851.7 5926.3 6011.9 978.8 982.3 1002.2 1006.3 1025.4 22580.2 23384.1 29944.7 30208.1 30377.0 1081.8 1092.4 1095.1 1101.9 1102.9 12133.6 12299.3 12334.3 12363.4 12392.4 227974.0 231200.0 231737.0 232047.0 232299.0 54425.0 54558.0 54582.5 54640.0 54688.7 1455.9 1459.1 1477.1 1478.2 1483.9 22384.7 22574.7 22621.0 22627.8 22808.5 37257.6 37394.8 37449.4 37451.3 37467.0 203047.0 204496.0 204717.0 204989.9 205001.0 31020.2 31581.0 31646.7 34213.3 34345.8 43989.8 44196.0 44318.8 44381.0 45007.0 32524.0 32978.8 33273.5 33577.3 33746.0 32690.5 32868.8 32973.7 33247.5 33276.7 35476.6 36016.3 36049.1 36052.3 36334.8 31362.0 31817.7 32084.8 32106.8 32316.7 23530.6 23742.3 23835.8 23980.2 23992.4 13:51:30 INFO - PID 26295 | 13:51:30 INFO - PID 26295 | [#2] jquery.html Cycles:180 Average:36722.59 Median:23108.15 stddev:89647.99 (387.9%) stddev-sans-first:89858.41 13:51:30 INFO - PID 26295 | Values: 579.0 579.4 579.6 583.3 583.5 22293.3 23081.9 23134.4 23253.7 23420.8 24923.8 25803.0 27053.9 27098.5 27181.0 6650.3 6788.0 6791.1 6800.3 6813.3 6238.3 6603.3 6690.6 6701.0 6732.2 6473.7 6489.0 6491.8 6504.1 6506.0 6405.0 6446.8 6453.2 6502.9 6506.4 6023.9 6028.2 6033.2 6040.3 6051.6 29290.6 29588.6 30251.1 30308.2 31154.5 1946.5 2002.0 2002.8 2003.1 2003.8 19881.3 20589.8 20607.5 20611.6 20627.8 2429.4 2468.8 2523.7 2540.0 2540.4 132937.0 138673.0 138775.3 138792.3 139124.0 14647.3 15377.8 15417.7 15429.6 15711.7 23703.3 23771.8 23777.5 23779.5 23816.0 10229.7 10256.9 10269.6 10360.1 10415.5 9481.2 9497.6 9500.5 9512.3 9579.9 8905.3 9322.3 9384.2 9428.2 9526.7 2593.0 2594.9 2634.3 2721.7 2724.8 939.4 970.1 978.6 988.3 989.7 19499.3 20066.0 20199.3 20448.1 24013.8 1022.5 1059.0 1066.9 1071.4 1076.3 11064.9 11311.4 11454.8 11560.9 11594.4 530525.0 532038.0 532558.0 537087.0 539683.0 116485.4 124736.0 125593.0 125951.0 126077.4 1266.8 1277.4 1312.5 1313.0 1319.9 20432.3 20587.0 20590.8 20674.1 20973.6 57085.7 57731.0 58429.7 59469.7 60718.7 75310.2 75570.0 75659.6 75917.0 76488.2 14692.8 14797.9 14876.0 14961.2 14992.9 21501.1 21753.3 21881.2 22011.1 22014.0 18237.6 18566.7 18574.9 18590.8 18615.3 16410.2 17026.6 17496.9 17930.1 18135.3 19669.2 20054.8 20249.5 20287.3 20487.3 14744.9 15227.7 15234.5 15255.2 15282.5 18821.3 19244.0 19307.4 19456.3 19485.6 13:51:30 INFO - PID 26295 | 13:51:30 INFO - PID 26295 | [#3] mootools.html Cycles:180 Average:8726.00 Median:2659.01 stddev:5966.95 (224.4%) stddev-sans-first:5957.91 13:51:30 INFO - PID 26295 | Values: 1344.6 1387.6 1392.7 1397.1 1405.7 13762.1 14223.9 14335.0 14359.4 14364.4 14288.9 14547.3 14548.6 14551.3 14558.5 2684.5 2716.6 2729.2 2731.7 2732.0 2555.7 2622.3 2644.0 2702.4 2707.6 2697.2 2735.0 2735.9 2740.5 2741.8 2628.4 2657.3 2682.4 2683.8 2695.5 2568.6 2568.9 2660.7 2667.8 2672.3 13731.7 13825.7 13851.3 13872.7 13910.4 7405.9 7732.1 7750.1 7760.8 7768.9 4874.5 5001.7 5080.9 5126.9 5200.8 1850.4 1917.8 1924.7 1958.9 1961.1 23160.7 23820.6 23826.5 23837.5 23843.9 6849.0 6896.5 7114.0 7128.6 7147.8 15807.9 15870.0 15902.4 15913.4 15947.8 7625.5 7870.2 7913.9 7921.3 7924.0 6942.4 7000.2 7055.8 7082.2 7161.7 4989.8 5176.7 5189.1 5200.5 5211.5 1399.9 1416.9 1506.2 1516.5 1521.9 868.8 893.7 906.7 907.3 909.1 8420.8 8573.7 8588.2 8616.7 8650.2 993.4 998.7 1017.8 1020.3 1026.6 4602.6 4833.5 5314.7 5330.9 5344.6 19086.9 20016.7 20028.9 20064.0 20094.4 18463.7 19586.8 19671.0 19765.7 19873.4 9886.4 9957.4 10038.3 10053.6 10111.7 7925.8 8225.7 8244.2 8260.1 8383.5 16392.4 16408.4 16462.0 16735.2 16835.6 17332.8 17337.9 17421.7 17494.3 17558.4 10376.6 10459.7 10516.0 10588.5 10589.6 11713.6 12496.7 12819.0 12830.4 12838.9 9096.9 9842.2 10199.0 10255.5 10419.9 10032.0 10222.5 10258.4 10303.1 10433.3 9149.0 9211.6 9214.7 9222.2 9230.8 7226.3 7249.7 7254.2 7304.5 7332.6 7015.3 7069.2 7135.3 7288.5 7319.9 13:51:30 INFO - PID 26295 | 13:51:30 INFO - PID 26295 | [#4] prototype.html Cycles:180 Average:5642.00 Median:6174.41 stddev:1518.17 (24.6%) stddev-sans-first:1472.42 13:51:30 INFO - PID 26295 | Values: 493.1 494.3 517.2 521.3 523.3 6275.4 6279.8 6326.2 6359.7 6395.8 6080.8 6202.4 6216.6 6287.2 6303.8 5192.1 5217.6 5257.6 5260.3 5281.2 5208.1 5237.1 5259.7 5264.4 5282.9 5009.3 5211.6 5212.4 5212.6 5225.1 5166.6 5176.2 5180.1 5212.7 5241.0 4817.7 4834.7 4840.2 4887.5 4897.0 6061.3 6090.7 6100.8 6127.8 6163.9 6041.2 6065.2 6068.5 6069.7 6089.2 6660.7 6661.9 6664.3 6665.8 6681.2 5303.7 5312.8 5313.4 5326.1 5333.7 6917.9 6982.4 7028.9 7029.5 7043.6 5493.3 5518.9 5523.8 5540.4 5545.6 5571.4 5572.8 5573.7 5582.6 5605.9 5983.7 6014.8 6023.5 6036.3 6047.3 6702.2 6705.8 6722.8 6756.9 6762.9 1878.8 1895.1 1923.3 1924.0 1939.3 1305.4 1372.9 1378.4 1401.1 1425.5 5675.0 5678.2 5756.4 5768.6 5805.9 6567.8 6605.6 6661.9 6689.3 6747.3 5674.7 5686.5 5722.0 5758.3 5788.7 3559.4 3568.2 3577.4 3586.5 3607.5 6439.9 6495.4 6524.0 6545.6 6589.9 6906.5 6908.4 6950.6 6971.2 7017.7 6519.8 6533.7 6536.5 6579.0 6599.9 6721.2 6757.6 6794.5 6804.4 6828.8 6683.5 6713.9 6723.8 6737.9 6755.0 6468.7 6551.6 6598.2 6638.5 6642.7 4993.4 5067.1 5077.7 5100.0 5107.3 6735.0 6748.6 6751.9 6777.3 6832.4 6532.4 6544.1 6559.0 6560.4 6622.5 6458.8 6501.4 6582.3 6585.1 6607.7 6184.9 6401.2 6512.0 6516.5 6591.0 6212.4 6462.1 6507.6 6564.5 6644.8 6231.8 6384.3 6384.6 6392.4 6407.0 13:51:30 INFO - PID 26295 | 13:51:30 INFO - PID 26295 | [#5] yui.html Cycles:180 Average:24552.19 Median:19711.31 stddev:32981.41 (167.3%) stddev-sans-first:33026.13 13:51:30 INFO - PID 26295 | Values: 904.9 916.2 933.5 937.5 939.7 19092.0 20080.4 20090.1 20113.6 20470.3 21865.3 22775.3 22842.5 22926.7 22940.7 1020.8 1063.7 1064.0 1065.6 1066.3 966.7 1039.8 1064.6 1067.6 1068.2 1112.9 1113.2 1113.5 1113.9 1115.1 1102.1 1107.2 1109.5 1112.0 1114.2 808.7 809.0 813.9 816.0 816.0 18532.8 18851.0 19055.1 19122.1 19199.9 21916.9 22239.1 22299.4 22749.4 22761.8 16371.1 16450.5 16729.6 16741.9 16894.8 3601.4 3612.1 3626.9 3635.9 3644.1 113440.0 115971.0 116393.0 118178.4 118575.4 17108.5 17225.4 17318.9 17401.4 17449.9 31683.7 31782.5 32499.7 32503.5 32557.2 9013.7 9091.4 9097.9 9156.1 9167.0 4126.2 4224.2 4226.2 4226.5 4227.5 5203.6 5743.8 5899.4 5922.6 5932.8 1011.3 1025.4 1037.1 1047.9 1049.9 634.6 643.0 645.8 652.0 656.5 11300.3 11624.6 11989.2 12518.8 12540.7 539.9 545.9 551.8 560.5 563.2 5713.0 5834.3 5838.3 6052.8 6069.1 118216.0 119273.0 119301.0 119564.4 121405.4 105152.0 105265.0 108168.0 109177.5 109926.0 85733.3 86143.6 87316.6 87867.6 89864.0 10824.9 11843.3 12036.6 12054.3 12847.0 38467.4 40367.6 41206.6 41638.6 42226.8 72728.0 74472.6 75811.0 77253.6 77734.2 18890.9 19569.1 19678.3 19744.3 19992.0 21739.7 22903.8 22954.4 23312.4 23350.5 18115.7 18509.5 19060.0 19260.6 19271.5 17479.8 17526.0 17572.2 20090.5 20187.4 17517.7 17586.5 17933.6 18386.0 18646.3 12815.7 13499.1 14177.6 14220.3 14613.3 13576.3 13588.9 13974.5 13981.4 14259.5 13:51:30 INFO - PID 26295 | -------- Summary: end -------- 13:51:30 INFO - PID 26295 | 13:51:30 INFO - TEST-INFO | 26295: exit 0 13:51:30 INFO - TEST-OK | dromaeo_css | took 1113100ms 13:51:30 INFO - TEST-START | kraken 13:51:30 INFO - Initialising browser for kraken test... 13:51:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50403/getInfo.html -profile /tmp/tmpnKmXhn/profile 13:51:30 INFO - TEST-INFO | started process 26677 (/builds/slave/test/build/application/firefox/firefox http://localhost:50403/getInfo.html) 13:51:36 INFO - TEST-INFO | 26677: exit 0 13:51:36 INFO - Browser initialized. 13:51:36 INFO - Running cycle 1/1 for kraken test... 13:51:36 INFO - TEST-INFO | started process 26912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnKmXhn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:37 INFO - PID 26912 | 13:51:37 INFO - PID 26912 | (/builds/slave/test/build/application/firefox/firefox:26967): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:51:37 INFO - PID 26912 | 13:51:48 INFO - PID 26912 | RSS: Main: 167866368 13:51:48 INFO - PID 26912 | 13:51:50 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50403/tests/kraken/driver.html?testName=audio-beat-detection) 13:51:51 INFO - PID 26912 | RSS: Main: 174350336 13:51:51 INFO - PID 26912 | 13:51:54 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50403/tests/kraken/driver.html?testName=audio-dft) 13:51:55 INFO - PID 26912 | RSS: Main: 177991680 13:51:55 INFO - PID 26912 | 13:51:58 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50403/tests/kraken/driver.html?testName=audio-fft) 13:51:58 INFO - PID 26912 | RSS: Main: 172208128 13:51:58 INFO - PID 26912 | 13:52:01 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50403/tests/kraken/driver.html?testName=audio-oscillator) 13:52:01 INFO - PID 26912 | RSS: Main: 172920832 13:52:01 INFO - PID 26912 | 13:52:03 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:52:04 INFO - PID 26912 | RSS: Main: 172781568 13:52:04 INFO - PID 26912 | 13:52:07 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50403/tests/kraken/driver.html?testName=imaging-darkroom) 13:52:08 INFO - PID 26912 | RSS: Main: 173785088 13:52:08 INFO - PID 26912 | 13:52:11 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50403/tests/kraken/driver.html?testName=imaging-desaturate) 13:52:12 INFO - PID 26912 | RSS: Main: 173432832 13:52:12 INFO - PID 26912 | 13:52:15 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50403/tests/kraken/driver.html?testName=json-parse-financial) 13:52:16 INFO - PID 26912 | RSS: Main: 174268416 13:52:16 INFO - PID 26912 | 13:52:17 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:52:18 INFO - PID 26912 | RSS: Main: 174194688 13:52:18 INFO - PID 26912 | 13:52:20 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:52:20 INFO - PID 26912 | RSS: Main: 174505984 13:52:20 INFO - PID 26912 | 13:52:23 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:52:23 INFO - PID 26912 | RSS: Main: 174002176 13:52:23 INFO - PID 26912 | 13:52:26 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:52:27 INFO - PID 26912 | RSS: Main: 174952448 13:52:27 INFO - PID 26912 | 13:52:30 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:30 INFO - PID 26912 | RSS: Main: 174882816 13:52:30 INFO - PID 26912 | 13:52:32 INFO - PID 26912 | Cycle 1(1): loaded http://localhost:50403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50403/tests/kraken/driver.html?testName=ai-astar) 13:52:32 INFO - PID 26912 | RSS: Main: 176267264 13:52:32 INFO - PID 26912 | 13:52:32 INFO - PID 26912 | __start_tp_report 13:52:32 INFO - PID 26912 | _x_x_mozilla_page_load 13:52:32 INFO - PID 26912 | _x_x_mozilla_page_load_details 13:52:32 INFO - PID 26912 | |i|pagename|runs| 13:52:32 INFO - PID 26912 | |0;ai-astar;99;106;107;108;117;113;108;99;109;107 13:52:32 INFO - PID 26912 | |1;audio-beat-detection;154;120;143;175;116;148;147;121;177;126 13:52:32 INFO - PID 26912 | |2;audio-dft;163;165;164;168;163;167;175;163;164;166 13:52:32 INFO - PID 26912 | |3;audio-fft;75;75;74;189;77;84;75;76;154;77 13:52:32 INFO - PID 26912 | |4;audio-oscillator;79;78;128;85;81;79;137;79;79;133 13:52:32 INFO - PID 26912 | |5;imaging-gaussian-blur;114;115;115;115;114;114;115;115;114;115 13:52:32 INFO - PID 26912 | |6;imaging-darkroom;149;151;158;150;150;149;151;150;152;151 13:52:32 INFO - PID 26912 | |7;imaging-desaturate;94;94;94;94;94;93;95;93;93;94 13:52:32 INFO - PID 26912 | |8;json-parse-financial;56;56;57;56;55;64;61;58;61;59 13:52:32 INFO - PID 26912 | |9;json-stringify-tinderbox;55;53;54;54;53;54;59;60;55;56 13:52:32 INFO - PID 26912 | |10;stanford-crypto-aes;78;94;81;78;81;77;82;78;77;80 13:52:32 INFO - PID 26912 | |11;stanford-crypto-ccm;124;131;126;128;132;136;120;127;127;166 13:52:32 INFO - PID 26912 | |12;stanford-crypto-pbkdf2;180;186;176;173;175;178;178;174;179;176 13:52:32 INFO - PID 26912 | |13;stanford-crypto-sha256-iterative;68;70;66;68;68;72;70;72;78;67 13:52:32 INFO - PID 26912 | __end_tp_report 13:52:32 INFO - PID 26912 | __start_cc_report 13:52:32 INFO - PID 26912 | _x_x_mozilla_cycle_collect,957 13:52:32 INFO - PID 26912 | __end_cc_report 13:52:32 INFO - PID 26912 | __startTimestamp1502484752982__endTimestamp 13:52:32 INFO - PID 26912 | 13:52:32 INFO - PID 26912 | ------- Summary: start ------- 13:52:32 INFO - PID 26912 | Number of tests: 14 13:52:32 INFO - PID 26912 | 13:52:32 INFO - PID 26912 | [#0] ai-astar Cycles:10 Average:107.30 Median:111.00 stddev:5.48 (4.9%) stddev-sans-first:4.92 13:52:32 INFO - PID 26912 | Values: 99.0 106.0 107.0 108.0 117.0 113.0 108.0 99.0 109.0 107.0 13:52:32 INFO - PID 26912 | 13:52:32 INFO - PID 26912 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:147.50 stddev:22.04 (14.9%) stddev-sans-first:23.00 13:52:32 INFO - PID 26912 | Values: 154.0 120.0 143.0 175.0 116.0 148.0 147.0 121.0 177.0 126.0 13:52:32 INFO - PID 26912 | 13:52:32 INFO - PID 26912 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.68 (2.2%) stddev-sans-first:3.76 13:52:32 INFO - PID 26912 | Values: 163.0 165.0 164.0 168.0 163.0 167.0 175.0 163.0 164.0 166.0 13:52:32 INFO - PID 26912 | 13:52:32 INFO - PID 26912 | [#3] audio-fft Cycles:10 Average:95.60 Median:75.50 stddev:40.94 (54.2%) stddev-sans-first:42.74 13:52:32 INFO - PID 26912 | Values: 75.0 75.0 74.0 189.0 77.0 84.0 75.0 76.0 154.0 77.0 13:52:32 INFO - PID 26912 | 13:52:32 INFO - PID 26912 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:79.00 stddev:25.60 (32.4%) stddev-sans-first:26.42 13:52:32 INFO - PID 26912 | Values: 79.0 78.0 128.0 85.0 81.0 79.0 137.0 79.0 79.0 133.0 13:52:32 INFO - PID 26912 | 13:52:32 INFO - PID 26912 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:52:32 INFO - PID 26912 | Values: 114.0 115.0 115.0 115.0 114.0 114.0 115.0 115.0 114.0 115.0 13:52:32 INFO - PID 26912 | 13:52:33 INFO - PID 26912 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:2.60 (1.7%) stddev-sans-first:2.65 13:52:33 INFO - PID 26912 | Values: 149.0 151.0 158.0 150.0 150.0 149.0 151.0 150.0 152.0 151.0 13:52:33 INFO - PID 26912 | 13:52:33 INFO - PID 26912 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 13:52:33 INFO - PID 26912 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 95.0 93.0 93.0 94.0 13:52:33 INFO - PID 26912 | 13:52:33 INFO - PID 26912 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.50 stddev:2.91 (5.0%) stddev-sans-first:2.96 13:52:33 INFO - PID 26912 | Values: 56.0 56.0 57.0 56.0 55.0 64.0 61.0 58.0 61.0 59.0 13:52:33 INFO - PID 26912 | 13:52:33 INFO - PID 26912 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:2.41 (4.4%) stddev-sans-first:2.55 13:52:33 INFO - PID 26912 | Values: 55.0 53.0 54.0 54.0 53.0 54.0 59.0 60.0 55.0 56.0 13:52:33 INFO - PID 26912 | 13:52:33 INFO - PID 26912 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:5.04 (6.3%) stddev-sans-first:5.25 13:52:33 INFO - PID 26912 | Values: 78.0 94.0 81.0 78.0 81.0 77.0 82.0 78.0 77.0 80.0 13:52:33 INFO - PID 26912 | 13:52:33 INFO - PID 26912 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:129.50 stddev:12.83 (9.9%) stddev-sans-first:13.31 13:52:33 INFO - PID 26912 | Values: 124.0 131.0 126.0 128.0 132.0 136.0 120.0 127.0 127.0 166.0 13:52:33 INFO - PID 26912 | 13:52:33 INFO - PID 26912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:178.00 stddev:3.72 (2.1%) stddev-sans-first:3.83 13:52:33 INFO - PID 26912 | Values: 180.0 186.0 176.0 173.0 175.0 178.0 178.0 174.0 179.0 176.0 13:52:33 INFO - PID 26912 | 13:52:33 INFO - PID 26912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:3.48 (5.0%) stddev-sans-first:3.62 13:52:33 INFO - PID 26912 | Values: 68.0 70.0 66.0 68.0 68.0 72.0 70.0 72.0 78.0 67.0 13:52:33 INFO - PID 26912 | -------- Summary: end -------- 13:52:33 INFO - PID 26912 | 13:52:33 INFO - PID 26912 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:52:33 INFO - TEST-INFO | 26912: exit 0 13:52:33 INFO - TEST-OK | kraken | took 62878ms 13:52:33 INFO - SUITE-END | took 1175s 13:52:34 INFO - Completed test suite (00:19:36) 13:52:34 INFO - javascript benchmark 13:52:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8624.256711751106, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.5113607390863, 3192.9361412771736, 3196.5524826524306, 3200.7919485233456, 3224.403485355208, 6261.3425590313045, 6287.0, 6341.239051313849, 6358.841028974278, 6372.553921225516, 6165.907511387333, 6251.874962500748, 6257.0, 6257.37426257374, 6258.655773932432, 5732.541396688265, 5737.196792449061, 5742.4831765141125, 5749.971250143743, 5842.123681447774, 5778.7977420790285, 5792.391798861101, 5831.591788574801, 5880.647161170344, 5912.379200183983, 5602.691851948182, 5690.7439165237665, 5742.626729262605, 5765.769369225226, 5853.0, 5683.403242659544, 5719.056355701305, 5755.223044888929, 5778.8266352009505, 5802.854928626776, 5626.578006649518, 5669.886602267931, 5766.538676905838, 5782.479576838105, 5782.710864456761, 5971.552133589955, 6109.20580324555, 6161.7535298588, 6225.595336303126, 6256.843578910563, 6561.967190164019, 6626.867462650768, 6634.93365066348, 6652.467802575782, 6655.334466553354, 6688.3646053624825, 6693.431058360045, 6702.564333318319, 6710.396064354183, 6726.058351830748, 6182.845428864314, 6185.16500272462, 6185.16500272462, 6186.474149697281, 6193.1329613854095, 6822.727090916407, 6842.110525631736, 6902.965485172542, 6916.827079323057, 6947.270536593686, 6543.967280163664, 6622.437092847065, 6637.1703537057865, 6644.966775166094, 6655.866882662416, 6623.933760662332, 6649.867002659919, 6657.034729964128, 6744.966275168593, 6751.527393082437, 6552.148220731275, 6605.207375115017, 6627.734890604322, 6654.534182607268, 6708.396244338033, 6592.604443733391, 6620.0, 6634.0712300278, 6656.733730650816, 6657.600543967377, 4725.1730947084125, 5407.0, 5410.215518749759, 5413.404525502192, 5533.446655334435, 4555.088982203506, 4666.136764698542, 4667.393238878924, 4671.7430541320555, 4686.484486706459, 5752.3097228332035, 5780.479756821906, 5791.623544469596, 5833.154192642043, 5833.649981001068, 6547.5416720830035, 6742.0224067509935, 6801.4558835293055, 6819.7272109116075, 6825.897611535831, 5680.460356266148, 5799.3620701722775, 5867.325257595346, 5870.911936320958, 5874.1776151338845, 5897.557683173779, 5907.2911250650195, 5930.614510056833, 5932.377100404482, 5940.495057920125, 6534.019897015486, 6555.934440655627, 6602.14172157626, 6613.966930165318, 6629.105070815474, 6703.296153903965, 6728.360805723449, 6729.528932974645, 6776.847935850818, 6807.3873351398615, 6335.714892829926, 6500.317466666121, 6501.44737697301, 6506.707198176188, 6614.4708423325055, 6587.835304117435, 6593.769218077345, 6609.570377925419, 6617.338266173537, 6663.700133493908, 6664.900026499509, 6757.3242675732035, 6796.626185559841, 6811.761588344384, 6820.249772524919, 6562.475001999924, 6629.900551491635, 6635.8009259722285, 6638.004299355135, 6643.435307998681, 6539.509536784665, 6543.443807276435, 6553.541252112306, 6632.767853125118, 6642.76750313756, 6327.303996560283, 6414.10202571631, 6418.743250269937, 6494.545381823227, 6499.122618446449, 6579.769708060195, 6619.768308109193, 6657.73369065232, 6670.466362690876, 6679.365460281266, 6247.125402443752, 6282.560220784501, 6346.587471814318, 6362.04569314588, 6386.616802991835], "value": 6119.245152575755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.7058094376496, 872.2760109109438, 894.3471265975837, 898.2679116520036, 1188.150472412225, 31909.52135717963, 42514.57485425145, 42926.14147717052, 43118.13763724727, 43710.781446092726, 43157.136857262834, 43195.568044319545, 43484.78257608708, 43595.0, 43918.0, 7332.853342933165, 7731.033620797414, 7849.5682737449415, 7882.172371900954, 7960.800979975518, 7744.148143704188, 7823.5305881647, 7846.72536461224, 7853.921460785376, 7857.449978501507, 7815.0, 7870.881936770925, 7881.0, 7882.211778822129, 7884.172161923001, 7811.882821757678, 7847.489913155655, 7849.097353804328, 7853.8036549086155, 7855.803604909923, 7719.65261563231, 7785.182555831613, 7788.0654321481215, 7788.143304236586, 7811.921880781177, 39616.405753913714, 39832.0, 39893.80053099745, 39948.80025599853, 39991.8000409999, 3494.4758286257265, 3531.8057506837113, 3537.663921927413, 3542.929141417157, 3552.5914519830035, 32141.51787723186, 32183.83908080468, 32266.516002259985, 32269.677303227138, 32307.19232019195, 5004.149294619923, 5035.597152227813, 5082.059818933509, 5083.593312534988, 5088.92366614501, 190120.0, 190797.0, 191241.0, 191815.0, 192223.0, 50092.749536252086, 50362.74818625883, 50380.244296335586, 50515.7474212634, 50581.49418505768, 52816.0, 52846.47153528492, 52876.47123528716, 52883.471165287854, 52939.73530132325, 16414.753778693328, 16710.498685039467, 16767.329306827833, 16778.244978975974, 16788.244528996223, 12213.633590992284, 12330.136890417763, 12338.444769985372, 13777.655558611115, 13996.790048149285, 14942.178180200193, 14990.250487475801, 15002.549923502313, 15055.849441505445, 15211.163386013875, 5822.359540450547, 5840.649561026352, 5851.736671849777, 5926.348101708809, 6011.879762404727, 978.7602037500858, 982.3467394182788, 1002.1631937332409, 1006.2754816532085, 1025.4462590201208, 22580.20969266068, 23384.064637414314, 29944.700552994625, 30208.09375718732, 30377.0, 1081.8377243413552, 1092.4210168610648, 1095.1457862866976, 1101.867775866885, 1102.9117670586334, 12133.575324863587, 12299.262044277371, 12334.321612311409, 12363.443645035995, 12392.380380980914, 227974.0, 231200.0, 231737.0, 232047.0, 232299.0, 54425.0, 54558.0, 54582.45417545853, 54640.0, 54688.726556366964, 1455.9490417835325, 1459.0594509302603, 1477.128494188434, 1478.1500637133477, 1483.8738707209793, 22384.664230036236, 22574.66138007964, 22621.0, 22627.773722262566, 22808.543829123657, 37257.6274237265, 37394.813025934694, 37449.43825842669, 37451.250974980896, 37467.0, 203047.0, 204496.0, 204717.0, 204989.90020199213, 205001.0, 31020.22449438692, 31581.0, 31646.683533164374, 34213.31573368568, 34345.82827085849, 43989.78005109954, 44196.0, 44318.77840610905, 44381.0, 45007.0, 32524.0, 32978.83510582432, 33273.500897486076, 33577.328453431284, 33746.0, 32690.50964235586, 32868.83565582253, 32973.67026329706, 33247.50128748119, 33276.66723332833, 35476.64523354734, 36016.27967440584, 36049.098772530895, 36052.27895442129, 36334.8183259082, 31362.0, 31817.681823182396, 32084.839575801972, 32106.83946580252, 32316.676833232308, 23530.647040294753, 23742.287731368087, 23835.761642384048, 23980.160694375612, 23992.40018999539], "value": 17494.26368817276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.965262084275, 579.3627010288683, 579.5827004556718, 583.2563481561009, 583.5477504933679, 22293.331200064003, 23081.884590577043, 23134.421639459022, 23253.651195232083, 23420.76579234207, 24923.75076249237, 25802.999999999953, 27053.86473067632, 27098.45803083937, 27181.0, 6650.334966503359, 6787.966060169717, 6791.117154769898, 6800.285969973156, 6813.250542440328, 6238.251409830827, 6603.339666033382, 6690.59856408617, 6700.966495167518, 6732.2257940336995, 6473.708683109271, 6488.967555162218, 6491.837704057389, 6504.121943537609, 6506.0, 6404.975203967366, 6446.838829029289, 6453.2256129264315, 6502.902456463157, 6506.4469520090615, 6023.939760602381, 6028.156058151862, 6033.1553582498045, 6040.305364883051, 6051.606645568068, 29290.560641590393, 29588.55617165744, 30251.09246722602, 30308.242293942607, 31154.532682009787, 1946.4549926020736, 2002.029015927274, 2002.8197462228325, 2003.07858385143, 2003.789602091774, 19881.30415435467, 20589.794102059088, 20607.484812879648, 20611.587768244703, 20627.79372206274, 2429.392651837041, 2468.8148388870904, 2523.659305993686, 2540.0, 2540.3776074861594, 132937.0, 138672.99999999898, 138775.30612346975, 138792.30603847018, 139124.0, 14647.267636618126, 15377.769333460006, 15417.691646167013, 15429.614259643598, 15711.68576628461, 23703.288901332988, 23771.762282376956, 23777.52444951126, 23779.524409512058, 23816.0, 10229.693109206586, 10256.948715256376, 10269.640562580274, 10360.119389851796, 10415.479226038668, 9481.24150067993, 9497.5726092326, 9500.524973751422, 9512.334136610509, 9579.90420095804, 8905.332100092519, 9322.30082743797, 9384.202342800801, 9428.15146636806, 9526.666566670134, 2592.974070259273, 2594.8962041518507, 2634.3150780796745, 2721.6597925259343, 2724.82288651237, 939.389396892012, 970.1414248390225, 978.5694294510392, 988.3279370028449, 989.6882482018285, 19499.31752388688, 20066.0, 20199.29302474436, 20448.079836407396, 24013.7598624015, 1022.5245260953692, 1058.9841152382721, 1066.8773091094624, 1071.373246650718, 1076.3380520979697, 11064.889351106547, 11311.434428278717, 11454.828177577343, 11560.901714337124, 11594.420278986017, 530525.0, 532038.0, 532558.0, 537087.0, 539683.0, 116485.41757291328, 124736.0, 125593.0, 125951.0, 126077.36961315134, 1266.8416447944007, 1277.3804704718204, 1312.5143696832233, 1313.0283590143226, 1319.907606467538, 20432.28487003007, 20587.0, 20590.82275317369, 20674.069666864725, 20973.58052838965, 57085.71457142688, 57731.0, 58429.70785146047, 59469.70265148646, 60718.696406519455, 75310.24689753032, 75570.0, 75659.62170189334, 75917.0, 76488.23511764812, 14692.779608306098, 14797.92601036988, 14876.0, 14961.177135257665, 14992.925035374754, 21501.139954402275, 21753.347399578037, 21881.234156804436, 22011.11955521761, 22014.0, 18237.635247295246, 18566.721499177795, 18574.907125464288, 18590.81409185891, 18615.255389784255, 16410.179491025163, 17026.574335641708, 17496.91251543734, 17930.103494824947, 18135.27458901682, 19669.21323147058, 20054.799452005293, 20249.493762656053, 20287.28994485186, 20487.28294509685, 14744.852551474776, 15227.695446091238, 15234.466793662612, 15255.160966146968, 15282.465113720966, 18821.341253056624, 19244.03779811032, 19307.4207773767, 19456.319028833925, 19485.610287794447], "value": 12310.271972824408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.6235054184829, 1387.6114687887389, 1392.7284179584985, 1397.1058522545566, 1405.7048019915817, 13762.105463144888, 14223.857761422383, 14335.0, 14359.35382907769, 14364.425422983068, 14288.857111428908, 14547.272636368165, 14548.563543093698, 14551.345189466472, 14558.490452834152, 2684.543627583311, 2716.619673245747, 2729.2221716810714, 2731.6721993360825, 2731.986340068297, 2555.667763190792, 2622.265765585639, 2644.0217119665654, 2702.3784529558116, 2707.56678931371, 2697.2043247242013, 2734.9589756153673, 2735.9179224623294, 2740.5341092014305, 2741.7806575474015, 2628.4217472156097, 2657.2825337158956, 2682.369643133862, 2683.785297176241, 2695.4743824954044, 2568.5761849294845, 2568.8715564221716, 2660.7472290132405, 2667.773239274664, 2672.3452754075183, 13731.656708582266, 13825.723485530232, 13851.307434628228, 13872.722545549133, 13910.374033168531, 7405.8889116663295, 7732.072151341875, 7750.14748377678, 7760.805979850493, 7768.922310776933, 4874.46380898101, 5001.749562609348, 5080.923786143211, 5126.897462050775, 5200.8179713710215, 1850.3616252392903, 1917.769867615895, 1924.7305377247196, 1958.921643134273, 1961.1370996761523, 23160.65259021116, 23820.64269035966, 23826.523469530686, 23837.523249535087, 23843.88078059616, 6848.9657551711925, 6896.517243792886, 7114.0, 7128.607926563985, 7147.785566433015, 15807.920960395124, 15870.0, 15902.443414480438, 15913.443029493912, 15947.760783588255, 7625.504342217738, 7870.173631768696, 7913.920860791433, 7921.32668723165, 7924.0, 6942.444604431634, 7000.194977577542, 7055.753048643272, 7082.220955694869, 7161.67772450241, 4989.775460104304, 5176.7411629418375, 5189.065968125774, 5200.531952124327, 5211.478852114758, 1399.8530154333853, 1416.9291535423188, 1506.1716056169064, 1516.4919751883242, 1521.9467318643794, 868.8218915122385, 893.718478679227, 906.6781292641149, 907.2787134228304, 909.1045320359441, 8420.8315833683, 8573.699920502753, 8588.184122508352, 8616.698415555426, 8650.221480066824, 993.3940296419179, 998.7053819123377, 1017.8320577104695, 1020.2756043209256, 1026.5935668134703, 4602.608778253819, 4833.540813622701, 5314.703447725606, 5330.8933821324135, 5344.599155063386, 19086.904565477085, 20016.69974950377, 20028.89985550092, 20064.0, 20094.39716808498, 18463.723044154347, 19586.804131958783, 19671.016449177485, 19765.703514447294, 19873.403797886087, 9886.357386769838, 9957.402555846673, 10038.297319187734, 10053.59785608582, 10111.696649100539, 7925.841483170189, 8225.71210007647, 8244.216799404046, 8260.132686068117, 8383.496990180609, 16392.426265081143, 16408.425705100264, 16462.0, 16735.1632418381, 16835.579110522336, 17332.826671733626, 17337.913310433367, 17421.738673919648, 17494.300227990738, 17558.38545650896, 10376.584936602452, 10459.738506537398, 10516.0, 10588.470576470992, 10589.629362972259, 11713.648590542298, 12496.687582810502, 12819.038572107316, 12830.358482076046, 12838.935805320914, 9096.863547046933, 9842.163416109712, 10199.031092046243, 10255.487225638539, 10419.94790026045, 10032.046955539212, 10222.53998570081, 10258.384496930208, 10303.124234439856, 10433.32183408076, 9148.954255228682, 9211.618257261196, 9214.677486287948, 9222.170004699608, 9230.769230769285, 7226.313500217471, 7249.710011599477, 7254.202037775735, 7304.452166087458, 7332.5600463970195, 7015.298470152944, 7069.187043490065, 7135.286471352823, 7288.526245794006, 7319.853602927805], "value": 6401.263606503344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.1081343428459, 494.27782162588784, 517.2086707337775, 521.288441277656, 523.296166655848, 6275.4038366355235, 6279.843003924904, 6326.240851097869, 6359.745610175599, 6395.825419357418, 6080.787172448965, 6202.379762023796, 6216.564840461169, 6287.2140982377205, 6303.779367722131, 5192.117340052181, 5217.634765566412, 5257.631965762398, 5260.289860868772, 5281.2342210379475, 5208.140656791625, 5237.109691352479, 5259.737013149346, 5264.446988138489, 5282.947170528284, 5009.273655319977, 5211.635185537014, 5212.400573934008, 5212.582993360541, 5225.111731005719, 5166.560842328407, 5176.21420609889, 5180.1452760294505, 5212.739363031833, 5241.0, 4817.662763606549, 4834.685745426536, 4840.201366774478, 4887.486813884562, 4896.95103048972, 6061.302950160743, 6090.725917333731, 6100.816975490742, 6127.78552750656, 6163.938360616381, 6041.184440100574, 6065.211522502046, 6068.484178844804, 6069.696515174268, 6089.177960975256, 6660.733570657168, 6661.93338066618, 6664.300248473889, 6665.833354166185, 6681.231658359302, 5303.7348132593215, 5312.751503396698, 5313.362396512404, 5326.082610260303, 5333.733313334318, 6917.861642767167, 6982.406495447893, 7028.929710702879, 7029.5430796998035, 7043.577385356895, 5493.258410114663, 5518.944810551843, 5523.7790488380815, 5540.390557038722, 5545.611807173459, 5571.4121475379325, 5572.832815015556, 5573.749181286852, 5582.609217354828, 5605.943940560543, 5983.730732117066, 6014.7594096236535, 6023.48800351975, 6036.305824830113, 6047.3045599755715, 6702.19573651165, 6705.832354191087, 6722.781482110891, 6756.864862702719, 6762.932370676329, 1878.8121187881377, 1895.1187697720627, 1923.3172223860329, 1924.0, 1939.2824654877786, 1305.419088505606, 1372.9244891531062, 1378.3659516622265, 1401.0752903083915, 1425.4868247430916, 5674.971625141848, 5678.176664383641, 5756.395578464285, 5768.567357448208, 5805.88388232233, 6567.8358041048405, 6605.57063790852, 6661.9000714989315, 6689.264180940093, 6747.291534388916, 5674.744636491368, 5686.516646085129, 5722.0, 5758.280214973129, 5788.652680839163, 3559.430491121408, 3568.197155640012, 3577.4454959481322, 3586.497890295361, 3607.458881167846, 6439.871202576016, 6495.382938620824, 6523.967380163069, 6545.574537655038, 6589.924173885211, 6906.482013848981, 6908.378245957888, 6950.582965022014, 6971.17667344716, 7017.684204210823, 6519.771807986603, 6533.738650453929, 6536.477081833442, 6578.967105164444, 6599.901001484982, 6721.193456785217, 6757.594544327356, 6794.4904132189295, 6804.421624161803, 6828.795136145924, 6683.498737594603, 6713.878046708304, 6723.7646682365885, 6737.898931515933, 6755.0205220241805, 6468.663352733919, 6551.6069035858, 6598.208215014229, 6638.468922486286, 6642.667866606747, 4993.400791904995, 5067.138586440387, 5077.746112694276, 5099.974500127476, 5107.259447380184, 6735.0, 6748.561343512656, 6751.88593882004, 6777.322267773183, 6832.419244364285, 6532.379423954717, 6544.055175171096, 6558.967205164135, 6560.44236239925, 6622.503312251504, 6458.773942911976, 6501.382368674968, 6582.341765823571, 6585.078089067439, 6607.735690572324, 6184.8763024738355, 6401.199850018747, 6512.0, 6516.543841931019, 6590.9670451647435, 6212.378762123933, 6462.127612772216, 6507.609543427409, 6564.5076619254705, 6644.800655980328, 6231.844203894939, 6384.265809431975, 6384.648844313421, 6392.360763923756, 6407.0], "value": 5199.647678917181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.9321300902429, 916.1708653668429, 933.472587987787, 937.4515908193706, 939.746268507503, 19092.0, 20080.397588072345, 20090.095945682442, 20113.59772804545, 20470.2835400761, 21865.344039678836, 22775.31674049777, 22842.543149137007, 22926.65610015851, 22940.655890161663, 1020.846872969055, 1063.7181146996052, 1064.0, 1065.589747947042, 1066.3122286125445, 966.7293157915794, 1039.8492218628294, 1064.6486659402378, 1067.5996501312009, 1068.1775033224412, 1112.9054030407426, 1113.1595645287796, 1113.4877956140185, 1113.9108871290277, 1115.0912006714502, 1102.063246240693, 1107.1696227829127, 1109.500724673892, 1112.0158659586243, 1114.186643750059, 808.6563210635456, 809.0372456776417, 813.9267465928036, 815.9510429374257, 815.995920020396, 18532.814671853244, 18851.0, 19055.142518586697, 19122.139503722366, 19199.904000480048, 21916.89041554782, 22239.110435582556, 22299.44251393712, 22749.43126421853, 22761.77238227613, 16371.099589522571, 16450.506484805475, 16729.581760455963, 16741.91629041859, 16894.83105168945, 3601.4237721964623, 3612.0608641753333, 3626.8730594429067, 3635.8909232723063, 3644.125409901631, 113440.0, 115971.0, 116393.0, 118178.40910795477, 118575.4071229647, 17108.48674539766, 17225.3971111013, 17318.913405432893, 17401.390951316895, 17449.912750436168, 31683.683163168072, 31782.523262151088, 32499.675003249664, 32503.51244731331, 32557.18607034843, 9013.684521041732, 9091.363604547618, 9097.90902090984, 9156.084391560791, 9166.954165229265, 4126.195391898611, 4224.239636865394, 4226.1758957003085, 4226.5139508956245, 4227.492700875914, 5203.60972927032, 5743.827685169452, 5899.410058994152, 5922.615030023035, 5932.822015339547, 1011.3123076308034, 1025.3847691385108, 1037.071820720451, 1047.92064173901, 1049.905508504223, 634.6414275934083, 642.980710578674, 645.7901182115831, 651.9641419721866, 656.471540409965, 11300.265482743594, 11624.593139240085, 11989.220700654603, 12518.81221781674, 12540.686482838002, 539.9055165346049, 545.9099248623933, 551.8482417335265, 560.4619565217437, 563.2199403825649, 5712.971435142797, 5834.27071616048, 5838.328592211865, 6052.757889684452, 6069.119977603223, 118216.0, 119273.0, 119301.0, 119564.40217798855, 121405.39297303457, 105152.0, 105265.0, 108168.0, 109177.45411272893, 109926.0, 85733.28533429296, 86143.56928215318, 87316.56341718377, 87867.56066219756, 89864.0, 10824.945875270574, 11843.28940263587, 12036.578719744766, 12054.337011464102, 12847.0, 38467.42298865463, 40367.596324036385, 41206.587934120274, 41638.58361416347, 42226.788866055475, 72728.0, 74472.62763686146, 75811.0, 77253.61373193098, 77734.22265777495, 18890.94694378819, 19569.119389627216, 19678.311259105863, 19744.30894918671, 19992.0, 21739.673904891755, 22903.770962290164, 22954.42613934665, 23312.417189570395, 23350.53298933978, 18115.72826407631, 18509.53726156857, 19060.046997649784, 19260.614787703886, 19271.51821204481, 17479.82520174833, 17526.036068016383, 17572.2092505835, 20090.497737556678, 20187.39437816868, 17517.737233941247, 17586.472405827844, 17933.551661208574, 18386.0, 18646.254149834396, 12815.679608009874, 13499.055066145276, 14177.645558860699, 14220.288985550887, 14613.342399592257, 13576.253306068262, 13588.93205533966, 13974.510892119133, 13981.370838312503, 14259.500917467838], "value": 9379.996129929104, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 106.0, 107.0, 108.0, 117.0, 113.0, 108.0, 99.0, 109.0, 107.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 143.0, 175.0, 116.0, 148.0, 147.0, 121.0, 177.0, 126.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 168.0, 163.0, 167.0, 175.0, 163.0, 164.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 189.0, 77.0, 84.0, 75.0, 76.0, 154.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 128.0, 85.0, 81.0, 79.0, 137.0, 79.0, 79.0, 133.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 158.0, 150.0, 150.0, 149.0, 151.0, 150.0, 152.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 93.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 55.0, 64.0, 61.0, 58.0, 61.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 53.0, 54.0, 59.0, 60.0, 55.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 94.0, 81.0, 78.0, 81.0, 77.0, 82.0, 78.0, 77.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 126.0, 128.0, 132.0, 136.0, 120.0, 127.0, 127.0, 166.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 186.0, 176.0, 173.0, 175.0, 178.0, 178.0, 174.0, 179.0, 176.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 66.0, 68.0, 68.0, 72.0, 70.0, 72.0, 78.0, 67.0], "value": 69.9, "unit": "score"}]}]} 13:52:34 INFO - Return code: 0 13:52:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:52:34 INFO - # TBPL SUCCESS # 13:52:34 INFO - Running post-action listener: _package_coverage_data 13:52:34 INFO - Running post-action listener: _resource_record_post_action 13:52:34 INFO - [mozharness: 2017-08-11 20:52:34.289087Z] Finished run-tests step (success) 13:52:34 INFO - Running post-run listener: _resource_record_post_run 13:52:34 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 440008704; Read time: 116; Write time: 333928 13:52:34 INFO - TinderboxPrint: CPU usage
13.1% 13:52:34 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 116 13:52:34 INFO - TinderboxPrint: I/O write bytes / time
440,008,704 / 333,928 13:52:34 INFO - TinderboxPrint: CPU idle
8,280.1 (86.8%) 13:52:34 INFO - TinderboxPrint: CPU user
1,203.9 (12.6%) 13:52:34 INFO - TinderboxPrint: Swap in / out
0 / 0 13:52:34 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 115781632; Read time: 0; Write time: 95228 13:52:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:52:34 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 322768896; Read time: 104; Write time: 238636 13:52:34 INFO - Running post-run listener: _upload_blobber_files 13:52:34 INFO - Blob upload gear active. 13:52:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:52:34 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 13:52:34 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'] 13:52:34 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 13:52:35 INFO - (blobuploader) - INFO - Open directory for files ... 13:52:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:52:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:52:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:36 INFO - (blobuploader) - INFO - Done attempting. 13:52:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:52:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:43 INFO - (blobuploader) - INFO - Done attempting. 13:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:44 INFO - (blobuploader) - INFO - Done attempting. 13:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:52:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:45 INFO - (blobuploader) - INFO - Done attempting. 13:52:45 INFO - (blobuploader) - INFO - Iteration through files over. 13:52:45 INFO - Return code: 0 13:52:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:52:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:52:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85411befacb2439ff5f02614f61528b5f7bc4d7b89d1c7cf6fbeb3f76b1145f4f9d3cee3a5420325a114fdcd47c4d1df5c76524491137d9b71f38613a2cedbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb1efded7bd50cf1a9c05a736ff6662f52a5b66f81b00da4adcad2b39e00234797be6aa5fbd4a99f091fee1beef2b96dad29b1161b96c94603c88579d183fa95", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c682a2221ad3b578b38d75c9cde38512d29ba120299641c907d3013a4a1f2395bb4717ef4ff9a78349b25f651064fefeb6a06fc3d9a566e27c7de272a1c6a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a61e009f5798dd5a1d4253dab179cfb7d5ab64f36381e18ea0b9516a6fb5c46142a957e3126479c5d08b05411d1947360923665dc24ea1a38e3c9c19f55edb8c"} 13:52:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:52:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:52:45 INFO - Contents: 13:52:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85411befacb2439ff5f02614f61528b5f7bc4d7b89d1c7cf6fbeb3f76b1145f4f9d3cee3a5420325a114fdcd47c4d1df5c76524491137d9b71f38613a2cedbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb1efded7bd50cf1a9c05a736ff6662f52a5b66f81b00da4adcad2b39e00234797be6aa5fbd4a99f091fee1beef2b96dad29b1161b96c94603c88579d183fa95", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c682a2221ad3b578b38d75c9cde38512d29ba120299641c907d3013a4a1f2395bb4717ef4ff9a78349b25f651064fefeb6a06fc3d9a566e27c7de272a1c6a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a61e009f5798dd5a1d4253dab179cfb7d5ab64f36381e18ea0b9516a6fb5c46142a957e3126479c5d08b05411d1947360923665dc24ea1a38e3c9c19f55edb8c"} 13:52:45 INFO - Running post-run listener: copy_logs_to_upload_dir 13:52:45 INFO - Copying logs to upload dir... 13:52:45 INFO - mkdir: /builds/slave/test/build/upload/logs 13:52:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.859098 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-11 13:52:45.021190) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 13:52:45.024996) ========= 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=930c87414c89fc706ee2024c000001c6-1502483504.745194-765263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85411befacb2439ff5f02614f61528b5f7bc4d7b89d1c7cf6fbeb3f76b1145f4f9d3cee3a5420325a114fdcd47c4d1df5c76524491137d9b71f38613a2cedbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb1efded7bd50cf1a9c05a736ff6662f52a5b66f81b00da4adcad2b39e00234797be6aa5fbd4a99f091fee1beef2b96dad29b1161b96c94603c88579d183fa95", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c682a2221ad3b578b38d75c9cde38512d29ba120299641c907d3013a4a1f2395bb4717ef4ff9a78349b25f651064fefeb6a06fc3d9a566e27c7de272a1c6a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a61e009f5798dd5a1d4253dab179cfb7d5ab64f36381e18ea0b9516a6fb5c46142a957e3126479c5d08b05411d1947360923665dc24ea1a38e3c9c19f55edb8c"} build_url:https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85411befacb2439ff5f02614f61528b5f7bc4d7b89d1c7cf6fbeb3f76b1145f4f9d3cee3a5420325a114fdcd47c4d1df5c76524491137d9b71f38613a2cedbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb1efded7bd50cf1a9c05a736ff6662f52a5b66f81b00da4adcad2b39e00234797be6aa5fbd4a99f091fee1beef2b96dad29b1161b96c94603c88579d183fa95", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c682a2221ad3b578b38d75c9cde38512d29ba120299641c907d3013a4a1f2395bb4717ef4ff9a78349b25f651064fefeb6a06fc3d9a566e27c7de272a1c6a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a61e009f5798dd5a1d4253dab179cfb7d5ab64f36381e18ea0b9516a6fb5c46142a957e3126479c5d08b05411d1947360923665dc24ea1a38e3c9c19f55edb8c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 13:52:45.049562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:52:45.049879) ========= 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=930c87414c89fc706ee2024c000001c6-1502483504.745194-765263 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004355 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:52:45.135119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 13:52:45.135791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 13:52:45.136350) ========= ========= Total master_lag: 0.19 =========