builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1501607219.23 results: success (0) revision: 291cf1dea1f174982e72d5bcc26886fdf210584a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 10:06:59.232028) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 10:06:59.232423) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 10:06:59.232693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 10:06:59.248024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 10:06:59.248307) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-01 10:06:59-- 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% 42.6M=0s 2017-08-01 10:06:59 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130548 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 10:06:59.391980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 10:06:59.395301) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020604 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 10:06:59.444497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 10:06:59.444797) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 291cf1dea1f174982e72d5bcc26886fdf210584a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/cedar --rev 291cf1dea1f174982e72d5bcc26886fdf210584a --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=2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-01 10:06:59,729 truncating revision to first 12 chars 2017-08-01 10:06:59,729 Setting DEBUG logging. 2017-08-01 10:06:59,729 attempt 1/10 2017-08-01 10:06:59,729 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/291cf1dea1f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-01 10:07:00,187 unpacking tar archive at: cedar-291cf1dea1f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.760806 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 10:07:00.220770) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 10:07:00.221085) ========= script_repo_revision: 291cf1dea1f174982e72d5bcc26886fdf210584a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 10:07:00.224476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 10:07:00.224738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 10:07:00.233863) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-01 10:07:00.234284) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:00 INFO - MultiFileLogger online at 20170801 10:07:00 in /builds/slave/test 10:07:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 10:07:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:00 INFO - {'append_to_log': False, 10:07:00 INFO - 'base_work_dir': '/builds/slave/test', 10:07:00 INFO - 'blob_upload_branch': 'Cedar', 10:07:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:00 INFO - 'branch': 'Cedar', 10:07:00 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:00 INFO - 'code_coverage': False, 10:07:00 INFO - 'config_files': ('talos/linux_config.py',), 10:07:00 INFO - 'default_actions': ('clobber', 10:07:00 INFO - 'read-buildbot-config', 10:07:00 INFO - 'download-and-extract', 10:07:00 INFO - 'populate-webroot', 10:07:00 INFO - 'create-virtualenv', 10:07:00 INFO - 'install', 10:07:00 INFO - 'setup-mitmproxy', 10:07:00 INFO - 'run-tests'), 10:07:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:00 INFO - 'disable_ccov_upload': False, 10:07:00 INFO - 'download_minidump_stackwalk': True, 10:07:00 INFO - 'download_symbols': 'ondemand', 10:07:00 INFO - 'enable_stylo': False, 10:07:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:00 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:00 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:00 INFO - 'gecko_profile': False, 10:07:00 INFO - 'gecko_profile_interval': 0, 10:07:00 INFO - 'installer_path': 'installer.exe', 10:07:00 INFO - 'log_level': 'info', 10:07:00 INFO - 'log_name': 'talos', 10:07:00 INFO - 'log_to_console': True, 10:07:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:00 INFO - 'opt_config_files': (), 10:07:00 INFO - 'pip_index': False, 10:07:00 INFO - 'suite': 'dromaeojs-e10s', 10:07:00 INFO - 'system_bits': '32', 10:07:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:00 INFO - 'title': 'talos-linux64-ix-012', 10:07:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:00 INFO - 'use_talos_json': True, 10:07:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:00 INFO - 'work_dir': 'build'} 10:07:00 INFO - [mozharness: 2017-08-01 17:07:00.622737Z] Running clobber step. 10:07:00 INFO - Running pre-action listener: _resource_record_pre_action 10:07:00 INFO - Running main action method: clobber 10:07:00 INFO - rmtree: /builds/slave/test/build 10:07:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:02 INFO - Running post-action listener: _resource_record_post_action 10:07:02 INFO - [mozharness: 2017-08-01 17:07:02.323506Z] Finished clobber step (success) 10:07:02 INFO - [mozharness: 2017-08-01 17:07:02.323607Z] Running read-buildbot-config step. 10:07:02 INFO - Running pre-action listener: _resource_record_pre_action 10:07:02 INFO - Running main action method: read_buildbot_config 10:07:02 INFO - Using buildbot properties: 10:07:02 INFO - { 10:07:02 INFO - "project": "", 10:07:02 INFO - "product": "firefox", 10:07:02 INFO - "who": "mconley@mozilla.com", 10:07:02 INFO - "installer_path": "public/build/target.tar.bz2", 10:07:02 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 10:07:02 INFO - "repository": "https://hg.mozilla.org/projects/cedar", 10:07:02 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 10:07:02 INFO - "stage_platform": "linux64", 10:07:02 INFO - "basedir": "/builds/slave/test", 10:07:02 INFO - "buildnumber": 2, 10:07:02 INFO - "platform": "ubuntu64_hw", 10:07:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:07:02 INFO - "slavebuilddir": "test", 10:07:02 INFO - "taskId": "HgYgoPi6ToikpfzteWwLIw", 10:07:02 INFO - "branch": "cedar", 10:07:02 INFO - "script_repo_revision": "default", 10:07:02 INFO - "revision": "291cf1dea1f174982e72d5bcc26886fdf210584a", 10:07:02 INFO - "slavename": "talos-linux64-ix-012", 10:07:02 INFO - "repo_path": "projects/cedar" 10:07:02 INFO - } 10:07:02 INFO - Finding installer, test and symbols from parent task. 10:07:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HgYgoPi6ToikpfzteWwLIw'}, attempt #1 10:07:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HgYgoPi6ToikpfzteWwLIw'}, attempt #1 10:07:03 INFO - Task dependencies: SoyM-Uw2TWqOFF86MmQaog 10:07:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog'}, attempt #1 10:07:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.tar.bz2 10:07:03 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.test_packages.json 10:07:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.crashreporter-symbols.zip 10:07:03 INFO - Running post-action listener: _resource_record_post_action 10:07:03 INFO - [mozharness: 2017-08-01 17:07:03.780713Z] Finished read-buildbot-config step (success) 10:07:03 INFO - [mozharness: 2017-08-01 17:07:03.780936Z] Running download-and-extract step. 10:07:03 INFO - Running pre-action listener: _resource_record_pre_action 10:07:03 INFO - Running main action method: download_and_extract 10:07:03 INFO - mkdir: /builds/slave/test/build/tests 10:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:03 INFO - trying https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.test_packages.json 10:07:03 INFO - Downloading https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:07:04 INFO - Downloaded 989 bytes. 10:07:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:07:04 INFO - Using the following test package requirements: 10:07:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:07:04 INFO - u'common': [u'target.common.tests.zip'], 10:07:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:07:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:07:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:07:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:07:04 INFO - u'mozbase': [u'target.common.tests.zip'], 10:07:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:07:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:07:04 INFO - u'web-platform': [u'target.common.tests.zip', 10:07:04 INFO - u'target.web-platform.tests.tar.gz'], 10:07:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:07:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:07:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.common.tests.zip 10:07:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:07:04 INFO - Fetch https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.common.tests.zip into memory 10:07:05 INFO - Content-Length response header: 72397318 10:07:05 INFO - Bytes received: 72397318 10:07:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:07:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.common.tests.zip 10:07:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:07:16 INFO - Fetch https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.common.tests.zip into memory 10:07:17 INFO - Content-Length response header: 72397318 10:07:17 INFO - Bytes received: 72397318 10:07:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.talos.tests.zip 10:07:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:07:29 INFO - Fetch https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.talos.tests.zip into memory 10:07:31 INFO - Content-Length response header: 14496467 10:07:31 INFO - Bytes received: 14496467 10:07: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')]} 10:07:32 INFO - trying https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.tar.bz2 10:07:32 INFO - Downloading https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:07:33 INFO - Downloaded 62284503 bytes. 10:07:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.tar.bz2 10:07:33 INFO - mkdir: /builds/slave/test/properties 10:07:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:33 INFO - Contents: 10:07:33 INFO - build_url:https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.tar.bz2 10:07:33 INFO - Running post-action listener: _resource_record_post_action 10:07:33 INFO - Running post-action listener: set_extra_try_arguments 10:07:33 INFO - [mozharness: 2017-08-01 17:07:33.337055Z] Finished download-and-extract step (success) 10:07:33 INFO - [mozharness: 2017-08-01 17:07:33.337153Z] Running populate-webroot step. 10:07:33 INFO - Running pre-action listener: _resource_record_pre_action 10:07:33 INFO - Running main action method: populate_webroot 10:07:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:07:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:07:33 INFO - 'tests': ['damp', 'tps']}, 10:07:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:07:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:07:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:07:33 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:33 INFO - 'ts_paint', 10:07:33 INFO - 'tpaint', 10:07:33 INFO - 'sessionrestore', 10:07:33 INFO - 'sessionrestore_many_windows', 10:07:33 INFO - 'sessionrestore_no_auto_restore', 10:07:33 INFO - 'tabpaint']}, 10:07:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:07:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:07:33 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:07:33 INFO - 'talos_options': ['--mitmproxy', 10:07:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:07:33 INFO - '--firstNonBlankPaint'], 10:07:33 INFO - 'tests': ['quantum_pageload_google', 10:07:33 INFO - 'quantum_pageload_youtube', 10:07:33 INFO - 'quantum_pageload_amazon', 10:07:33 INFO - 'quantum_pageload_facebook']}, 10:07:33 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:07:33 INFO - 'talos_options': ['--stylo', 10:07:33 INFO - '--mitmproxy', 10:07:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:07:33 INFO - '--firstNonBlankPaint'], 10:07:33 INFO - 'tests': ['quantum_pageload_google', 10:07:33 INFO - 'quantum_pageload_youtube', 10:07:33 INFO - 'quantum_pageload_amazon', 10:07:33 INFO - 'quantum_pageload_facebook']}, 10:07:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:33 INFO - 'tsvgr_opacity', 10:07:33 INFO - 'tart', 10:07:33 INFO - 'tscrollx', 10:07:33 INFO - 'cart', 10:07:33 INFO - 'tsvg_static']}, 10:07:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:07:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:07:33 INFO - 'talos_options': ['--stylo', 10:07:33 INFO - '--stylo-threads=1', 10:07:33 INFO - '--mitmproxy', 10:07:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:07:33 INFO - '--firstNonBlankPaint'], 10:07:33 INFO - 'tests': ['tp6_google', 10:07:33 INFO - 'tp6_youtube', 10:07:33 INFO - 'tp6_amazon', 10:07:33 INFO - 'tp6_facebook']}, 10:07:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:07:33 INFO - 'talos_options': ['--xperf_path', 10:07:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:33 INFO - 'tests': ['tp5n']}}} 10:07:33 INFO - Running post-action listener: _resource_record_post_action 10:07:33 INFO - [mozharness: 2017-08-01 17:07:33.345835Z] Finished populate-webroot step (success) 10:07:33 INFO - [mozharness: 2017-08-01 17:07:33.345926Z] Running create-virtualenv step. 10:07:33 INFO - Running pre-action listener: _resource_record_pre_action 10:07:33 INFO - Running main action method: create_virtualenv 10:07:33 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:33 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 10:07:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:07:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:33 INFO - Using real prefix '/usr' 10:07:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:35 INFO - Installing pip.................done. 10:07:35 INFO - Return code: 0 10:07:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:07:36 INFO - Reading from file tmpfile_stdout 10:07:36 INFO - Output received: 10:07:36 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) 10:07:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:07:36 INFO - Using env: {'DISPLAY': ':0', 10:07:36 INFO - 'HOME': '/home/cltbld', 10:07:36 INFO - 'LANG': 'en_US.UTF-8', 10:07:36 INFO - 'LANGUAGE': 'en_US:en', 10:07:36 INFO - 'LOGNAME': 'cltbld', 10:07:36 INFO - 'MAIL': '/var/mail/cltbld', 10:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:36 INFO - 'MOZ_NO_REMOTE': '1', 10:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:36 INFO - 'NO_EM_RESTART': '1', 10:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:36 INFO - 'PWD': '/builds/slave/test', 10:07:36 INFO - 'SHELL': '/bin/bash', 10:07:36 INFO - 'SHLVL': '1', 10:07:36 INFO - 'TERM': 'linux', 10:07:36 INFO - 'TMOUT': '86400', 10:07:36 INFO - 'USER': 'cltbld', 10:07:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:36 INFO - '_': '/tools/buildbot/bin/python'} 10:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:36 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 10:07:36 INFO - Cleaning up... 10:07:36 INFO - Return code: 0 10:07:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:07:36 INFO - Using env: {'DISPLAY': ':0', 10:07:36 INFO - 'HOME': '/home/cltbld', 10:07:36 INFO - 'LANG': 'en_US.UTF-8', 10:07:36 INFO - 'LANGUAGE': 'en_US:en', 10:07:36 INFO - 'LOGNAME': 'cltbld', 10:07:36 INFO - 'MAIL': '/var/mail/cltbld', 10:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:36 INFO - 'MOZ_NO_REMOTE': '1', 10:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:36 INFO - 'NO_EM_RESTART': '1', 10:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:36 INFO - 'PWD': '/builds/slave/test', 10:07:36 INFO - 'SHELL': '/bin/bash', 10:07:36 INFO - 'SHLVL': '1', 10:07:36 INFO - 'TERM': 'linux', 10:07:36 INFO - 'TMOUT': '86400', 10:07:36 INFO - 'USER': 'cltbld', 10:07:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:36 INFO - '_': '/tools/buildbot/bin/python'} 10:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:36 INFO - Downloading/unpacking psutil>=3.1.1 10:07:36 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 10:07:36 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 10:07:36 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 10:07:36 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 10:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:37 INFO - Installing collected packages: psutil 10:07:37 INFO - Running setup.py install for psutil 10:07:37 INFO - building 'psutil._psutil_linux' extension 10:07:37 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 10:07:38 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 10:07:38 INFO - building 'psutil._psutil_posix' extension 10:07:38 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 10:07:38 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 10:07:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:38 INFO - Successfully installed psutil 10:07:38 INFO - Cleaning up... 10:07:38 INFO - Return code: 0 10:07:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:07:38 INFO - Using env: {'DISPLAY': ':0', 10:07:38 INFO - 'HOME': '/home/cltbld', 10:07:38 INFO - 'LANG': 'en_US.UTF-8', 10:07:38 INFO - 'LANGUAGE': 'en_US:en', 10:07:38 INFO - 'LOGNAME': 'cltbld', 10:07:38 INFO - 'MAIL': '/var/mail/cltbld', 10:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:38 INFO - 'MOZ_NO_REMOTE': '1', 10:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:38 INFO - 'NO_EM_RESTART': '1', 10:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:38 INFO - 'PWD': '/builds/slave/test', 10:07:38 INFO - 'SHELL': '/bin/bash', 10:07:38 INFO - 'SHLVL': '1', 10:07:38 INFO - 'TERM': 'linux', 10:07:38 INFO - 'TMOUT': '86400', 10:07:38 INFO - 'USER': 'cltbld', 10:07:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:38 INFO - '_': '/tools/buildbot/bin/python'} 10:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:07:38 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 10:07:38 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 10:07:38 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 10:07:38 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 10:07:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:07:39 INFO - Installing collected packages: mozsystemmonitor 10:07:39 INFO - Running setup.py install for mozsystemmonitor 10:07:39 INFO - Successfully installed mozsystemmonitor 10:07:39 INFO - Cleaning up... 10:07:39 INFO - Return code: 0 10:07:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:07:39 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')]} 10:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:39 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')]} 10:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:39 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 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:39 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 10:07:39 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 10:07:39 INFO - Using env: {'DISPLAY': ':0', 10:07:39 INFO - 'HOME': '/home/cltbld', 10:07:39 INFO - 'LANG': 'en_US.UTF-8', 10:07:39 INFO - 'LANGUAGE': 'en_US:en', 10:07:39 INFO - 'LOGNAME': 'cltbld', 10:07:39 INFO - 'MAIL': '/var/mail/cltbld', 10:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:39 INFO - 'MOZ_NO_REMOTE': '1', 10:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:39 INFO - 'NO_EM_RESTART': '1', 10:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:39 INFO - 'PWD': '/builds/slave/test', 10:07:39 INFO - 'SHELL': '/bin/bash', 10:07:39 INFO - 'SHLVL': '1', 10:07:39 INFO - 'TERM': 'linux', 10:07:39 INFO - 'TMOUT': '86400', 10:07:39 INFO - 'USER': 'cltbld', 10:07:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:39 INFO - '_': '/tools/buildbot/bin/python'} 10:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:39 INFO - Downloading/unpacking jsonschema==2.5.1 10:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:41 INFO - warning: no files found matching '*.txt' 10:07:41 INFO - no previously-included directories found matching 'build' 10:07:41 INFO - no previously-included directories found matching 'dist' 10:07:41 INFO - no previously-included directories found matching '.git*' 10:07:41 INFO - Installing collected packages: jsonschema, functools32 10:07:41 INFO - Running setup.py install for functools32 10:07:41 INFO - warning: no files found matching '*.txt' 10:07:41 INFO - no previously-included directories found matching 'build' 10:07:41 INFO - no previously-included directories found matching 'dist' 10:07:41 INFO - no previously-included directories found matching '.git*' 10:07:41 INFO - Successfully installed jsonschema functools32 10:07:41 INFO - Cleaning up... 10:07:41 INFO - Return code: 0 10:07:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:07:41 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')]} 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:41 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')]} 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:41 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 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:41 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 10:07:41 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 10:07:41 INFO - Using env: {'DISPLAY': ':0', 10:07:41 INFO - 'HOME': '/home/cltbld', 10:07:41 INFO - 'LANG': 'en_US.UTF-8', 10:07:41 INFO - 'LANGUAGE': 'en_US:en', 10:07:41 INFO - 'LOGNAME': 'cltbld', 10:07:41 INFO - 'MAIL': '/var/mail/cltbld', 10:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:41 INFO - 'MOZ_NO_REMOTE': '1', 10:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:41 INFO - 'NO_EM_RESTART': '1', 10:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:41 INFO - 'PWD': '/builds/slave/test', 10:07:41 INFO - 'SHELL': '/bin/bash', 10:07:41 INFO - 'SHLVL': '1', 10:07:41 INFO - 'TERM': 'linux', 10:07:41 INFO - 'TMOUT': '86400', 10:07:41 INFO - 'USER': 'cltbld', 10:07:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:41 INFO - '_': '/tools/buildbot/bin/python'} 10:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:07:41 INFO - Cleaning up... 10:07:41 INFO - Return code: 0 10:07:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07:41 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')]} 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:41 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')]} 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:41 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 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:41 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 10:07:41 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 10:07:41 INFO - Using env: {'DISPLAY': ':0', 10:07:41 INFO - 'HOME': '/home/cltbld', 10:07:41 INFO - 'LANG': 'en_US.UTF-8', 10:07:41 INFO - 'LANGUAGE': 'en_US:en', 10:07:41 INFO - 'LOGNAME': 'cltbld', 10:07:41 INFO - 'MAIL': '/var/mail/cltbld', 10:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:41 INFO - 'MOZ_NO_REMOTE': '1', 10:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:41 INFO - 'NO_EM_RESTART': '1', 10:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:41 INFO - 'PWD': '/builds/slave/test', 10:07:41 INFO - 'SHELL': '/bin/bash', 10:07:41 INFO - 'SHLVL': '1', 10:07:41 INFO - 'TERM': 'linux', 10:07:41 INFO - 'TMOUT': '86400', 10:07:41 INFO - 'USER': 'cltbld', 10:07:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:41 INFO - '_': '/tools/buildbot/bin/python'} 10:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:42 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:43 INFO - Downloading docopt-0.6.1.tar.gz 10:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:43 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:43 INFO - Running setup.py install for blobuploader 10:07:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:43 INFO - Running setup.py install for requests 10:07:43 INFO - Running setup.py install for docopt 10:07:44 INFO - Successfully installed blobuploader requests docopt 10:07:44 INFO - Cleaning up... 10:07:44 INFO - Return code: 0 10:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:44 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 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:44 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 10:07:44 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 10:07:44 INFO - Using env: {'DISPLAY': ':0', 10:07:44 INFO - 'HOME': '/home/cltbld', 10:07:44 INFO - 'LANG': 'en_US.UTF-8', 10:07:44 INFO - 'LANGUAGE': 'en_US:en', 10:07:44 INFO - 'LOGNAME': 'cltbld', 10:07:44 INFO - 'MAIL': '/var/mail/cltbld', 10:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:44 INFO - 'MOZ_NO_REMOTE': '1', 10:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:44 INFO - 'NO_EM_RESTART': '1', 10:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:44 INFO - 'PWD': '/builds/slave/test', 10:07:44 INFO - 'SHELL': '/bin/bash', 10:07:44 INFO - 'SHLVL': '1', 10:07:44 INFO - 'TERM': 'linux', 10:07:44 INFO - 'TMOUT': '86400', 10:07:44 INFO - 'USER': 'cltbld', 10:07:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:44 INFO - '_': '/tools/buildbot/bin/python'} 10:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:44 INFO - Running setup.py (path:/tmp/pip-OzoBjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:44 INFO - Running setup.py (path:/tmp/pip-S2aqpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:44 INFO - Running setup.py (path:/tmp/pip-LFNuQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:44 INFO - Running setup.py (path:/tmp/pip-7fJb1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:44 INFO - Running setup.py (path:/tmp/pip-n11Fk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:44 INFO - Running setup.py (path:/tmp/pip-Ra7Uet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:44 INFO - Running setup.py (path:/tmp/pip-L8nAeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:44 INFO - Running setup.py (path:/tmp/pip-gZDH3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:44 INFO - Running setup.py (path:/tmp/pip-3eZWEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:44 INFO - Running setup.py (path:/tmp/pip-4u5HGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:45 INFO - Running setup.py (path:/tmp/pip-baHsFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:45 INFO - Running setup.py (path:/tmp/pip-6sW2Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:45 INFO - Running setup.py (path:/tmp/pip-lbrNLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:45 INFO - Running setup.py (path:/tmp/pip-hhqvM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:45 INFO - Running setup.py (path:/tmp/pip-Snt2TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:45 INFO - Running setup.py (path:/tmp/pip-SiQzL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:45 INFO - Running setup.py (path:/tmp/pip-jLicqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:45 INFO - Running setup.py install for manifestparser 10:07:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:07:45 INFO - Running setup.py install for mozcrash 10:07:45 INFO - Running setup.py install for mozdebug 10:07:45 INFO - Running setup.py install for mozdevice 10:07:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:07:45 INFO - Running setup.py install for mozfile 10:07:46 INFO - Running setup.py install for mozhttpd 10:07:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Running setup.py install for mozinfo 10:07:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Running setup.py install for mozInstall 10:07:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Running setup.py install for mozleak 10:07:46 INFO - Running setup.py install for mozlog 10:07:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Running setup.py install for moznetwork 10:07:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Running setup.py install for mozprocess 10:07:46 INFO - Running setup.py install for mozprofile 10:07:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:07:46 INFO - Running setup.py install for mozrunner 10:07:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Running setup.py install for mozscreenshot 10:07:47 INFO - Running setup.py install for moztest 10:07:47 INFO - Running setup.py install for mozversion 10:07:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:07:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:47 INFO - Cleaning up... 10:07:47 INFO - Return code: 0 10:07:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:47 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 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:47 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 10:07:47 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 10:07:47 INFO - Using env: {'DISPLAY': ':0', 10:07:47 INFO - 'HOME': '/home/cltbld', 10:07:47 INFO - 'LANG': 'en_US.UTF-8', 10:07:47 INFO - 'LANGUAGE': 'en_US:en', 10:07:47 INFO - 'LOGNAME': 'cltbld', 10:07:47 INFO - 'MAIL': '/var/mail/cltbld', 10:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:47 INFO - 'MOZ_NO_REMOTE': '1', 10:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:47 INFO - 'NO_EM_RESTART': '1', 10:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:47 INFO - 'PWD': '/builds/slave/test', 10:07:47 INFO - 'SHELL': '/bin/bash', 10:07:47 INFO - 'SHLVL': '1', 10:07:47 INFO - 'TERM': 'linux', 10:07:47 INFO - 'TMOUT': '86400', 10:07:47 INFO - 'USER': 'cltbld', 10:07:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:47 INFO - '_': '/tools/buildbot/bin/python'} 10:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:47 INFO - Running setup.py (path:/tmp/pip-Khpjmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:47 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)) 10:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:47 INFO - Running setup.py (path:/tmp/pip-P8Q7WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:47 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)) 10:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:47 INFO - Running setup.py (path:/tmp/pip-rpDlAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:47 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)) 10:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:47 INFO - Running setup.py (path:/tmp/pip-ucVMcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:47 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)) 10:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:47 INFO - Running setup.py (path:/tmp/pip-MmpMDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:47 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)) 10:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:47 INFO - Running setup.py (path:/tmp/pip-1ON71A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:47 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)) 10:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:47 INFO - Running setup.py (path:/tmp/pip-XY8nhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:48 INFO - Running setup.py (path:/tmp/pip-Cr_tYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:48 INFO - Running setup.py (path:/tmp/pip-dDExNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:48 INFO - Running setup.py (path:/tmp/pip-z6e_nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:48 INFO - Running setup.py (path:/tmp/pip-DFG0OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:48 INFO - Running setup.py (path:/tmp/pip-PKCZJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:48 INFO - Running setup.py (path:/tmp/pip-gr7u9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:48 INFO - Running setup.py (path:/tmp/pip-bLJMfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:48 INFO - Running setup.py (path:/tmp/pip-j81M2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:48 INFO - Running setup.py (path:/tmp/pip-ozITC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:48 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)) 10:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:48 INFO - Running setup.py (path:/tmp/pip-Db8D24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:48 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)) 10:07:48 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)) 10:07:48 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)) 10:07:48 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)) 10:07:48 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)) 10:07:48 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)) 10:07:48 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)) 10:07:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:48 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 10:07:48 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 10:07:48 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 10:07:48 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 10:07:49 INFO - Downloading blessings-1.6.tar.gz 10:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:49 INFO - Installing collected packages: blessings 10:07:49 INFO - Running setup.py install for blessings 10:07:50 INFO - Successfully installed blessings 10:07:50 INFO - Cleaning up... 10:07:50 INFO - Return code: 0 10:07:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:50 INFO - Reading from file tmpfile_stdout 10:07:50 INFO - Current package versions: 10:07:50 INFO - argparse == 1.2.1 10:07:50 INFO - blessings == 1.6 10:07:50 INFO - blobuploader == 1.2.4 10:07:50 INFO - docopt == 0.6.1 10:07:50 INFO - functools32 == 3.2.3-2 10:07:50 INFO - jsonschema == 2.5.1 10:07:50 INFO - manifestparser == 1.1 10:07:50 INFO - mozInstall == 1.13 10:07:50 INFO - mozcrash == 1.0 10:07:50 INFO - mozdebug == 0.1 10:07:50 INFO - mozdevice == 0.51 10:07:50 INFO - mozfile == 1.2 10:07:50 INFO - mozhttpd == 0.7 10:07:50 INFO - mozinfo == 0.10 10:07:50 INFO - mozleak == 0.1 10:07:50 INFO - mozlog == 3.5 10:07:50 INFO - moznetwork == 0.27 10:07:50 INFO - mozprocess == 0.25 10:07:50 INFO - mozprofile == 0.28 10:07:50 INFO - mozrunner == 6.13 10:07:50 INFO - mozscreenshot == 0.1 10:07:50 INFO - mozsystemmonitor == 0.3 10:07:50 INFO - moztest == 0.8 10:07:50 INFO - mozversion == 1.4 10:07:50 INFO - psutil == 3.1.1 10:07:50 INFO - requests == 1.2.3 10:07:50 INFO - wsgiref == 0.1.2 10:07:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:50 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 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:50 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 10:07:50 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 10:07:50 INFO - Using env: {'DISPLAY': ':0', 10:07:50 INFO - 'HOME': '/home/cltbld', 10:07:50 INFO - 'LANG': 'en_US.UTF-8', 10:07:50 INFO - 'LANGUAGE': 'en_US:en', 10:07:50 INFO - 'LOGNAME': 'cltbld', 10:07:50 INFO - 'MAIL': '/var/mail/cltbld', 10:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:50 INFO - 'MOZ_NO_REMOTE': '1', 10:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:50 INFO - 'NO_EM_RESTART': '1', 10:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:50 INFO - 'PWD': '/builds/slave/test', 10:07:50 INFO - 'SHELL': '/bin/bash', 10:07:50 INFO - 'SHLVL': '1', 10:07:50 INFO - 'TERM': 'linux', 10:07:50 INFO - 'TMOUT': '86400', 10:07:50 INFO - 'USER': 'cltbld', 10:07:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:50 INFO - '_': '/tools/buildbot/bin/python'} 10:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:50 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)) 10:07:50 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)) 10:07:50 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)) 10:07:50 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)) 10:07:50 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)) 10:07:50 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)) 10:07:50 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)) 10:07:50 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)) 10:07:50 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)) 10:07:50 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:07:50 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 10:07:50 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 10:07:50 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 10:07:50 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 10:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:07:51 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)) 10:07:51 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)) 10:07:51 INFO - Installing collected packages: simplejson 10:07:51 INFO - Running setup.py install for simplejson 10:07:51 INFO - building 'simplejson._speedups' extension 10:07:51 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 10:07:52 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 10:07:52 INFO - Successfully installed simplejson 10:07:52 INFO - Cleaning up... 10:07:52 INFO - Return code: 0 10:07:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07:52 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')]} 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:52 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')]} 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:52 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 0x176e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1addd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', '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 10:07:52 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 10:07:52 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 10:07:52 INFO - Using env: {'DISPLAY': ':0', 10:07:52 INFO - 'HOME': '/home/cltbld', 10:07:52 INFO - 'LANG': 'en_US.UTF-8', 10:07:52 INFO - 'LANGUAGE': 'en_US:en', 10:07:52 INFO - 'LOGNAME': 'cltbld', 10:07:52 INFO - 'MAIL': '/var/mail/cltbld', 10:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:52 INFO - 'MOZ_NO_REMOTE': '1', 10:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:52 INFO - 'NO_EM_RESTART': '1', 10:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:52 INFO - 'PWD': '/builds/slave/test', 10:07:52 INFO - 'SHELL': '/bin/bash', 10:07:52 INFO - 'SHLVL': '1', 10:07:52 INFO - 'TERM': 'linux', 10:07:52 INFO - 'TMOUT': '86400', 10:07:52 INFO - 'USER': 'cltbld', 10:07:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:52 INFO - '_': '/tools/buildbot/bin/python'} 10:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:07:52 INFO - Cleaning up... 10:07:52 INFO - Return code: 0 10:07:52 INFO - Running post-action listener: _resource_record_post_action 10:07:52 INFO - Running post-action listener: _start_resource_monitoring 10:07:53 INFO - Starting resource monitoring. 10:07:53 INFO - [mozharness: 2017-08-01 17:07:53.010369Z] Finished create-virtualenv step (success) 10:07:53 INFO - [mozharness: 2017-08-01 17:07:53.010885Z] Running install step. 10:07:53 INFO - Running pre-action listener: _resource_record_pre_action 10:07:53 INFO - Running main action method: install 10:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:53 INFO - Reading from file tmpfile_stdout 10:07:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:07:53 INFO - Reading from file tmpfile_stdout 10:07:53 INFO - Output received: 10:07:53 INFO - Usage: mozinstall [options] installer 10:07:53 INFO - Options: 10:07:53 INFO - -h, --help show this help message and exit 10:07:53 INFO - -d DEST, --destination=DEST 10:07:53 INFO - Directory to install application into. [default: 10:07:53 INFO - "/builds/slave/test"] 10:07:53 INFO - --app=APP Application being installed. [default: firefox] 10:07:53 INFO - mkdir: /builds/slave/test/build/application 10:07:53 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'] 10:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:08:11 INFO - Reading from file tmpfile_stdout 10:08:11 INFO - Output received: 10:08:11 INFO - /builds/slave/test/build/application/firefox/firefox 10:08:11 INFO - Running post-action listener: _resource_record_post_action 10:08:11 INFO - [mozharness: 2017-08-01 17:08:11.394385Z] Finished install step (success) 10:08:11 INFO - [mozharness: 2017-08-01 17:08:11.394656Z] Running setup-mitmproxy step. 10:08:11 INFO - Running pre-action listener: _resource_record_pre_action 10:08:11 INFO - Running main action method: setup_mitmproxy 10:08:11 INFO - Skipping: mitmproxy is not required 10:08:11 INFO - Running post-action listener: _resource_record_post_action 10:08:11 INFO - [mozharness: 2017-08-01 17:08:11.395794Z] Finished setup-mitmproxy step (success) 10:08:11 INFO - [mozharness: 2017-08-01 17:08:11.396014Z] Running run-tests step. 10:08:11 INFO - Running pre-action listener: _resource_record_pre_action 10:08:11 INFO - Running pre-action listener: _set_gcov_prefix 10:08:11 INFO - Running main action method: run_tests 10:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:08:11 INFO - Python 2.7.3 10:08:11 INFO - Return code: 0 10:08:11 INFO - grabbing minidump binary from tooltool 10:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:11 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 0x1adaeb0>, '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 0x1adbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adc240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:08:11 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 10:08:11 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 10:08:11 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 10:08:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:11 INFO - Return code: 0 10:08:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:08:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:08:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:08:11 INFO - ENV: RUST_BACKTRACE is now 1 10:08:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:08:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 10:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 10:08:11 INFO - Using env: {'DISPLAY': ':0', 10:08:11 INFO - 'HOME': '/home/cltbld', 10:08:11 INFO - 'LANG': 'en_US.UTF-8', 10:08:11 INFO - 'LANGUAGE': 'en_US:en', 10:08:11 INFO - 'LOGNAME': 'cltbld', 10:08:11 INFO - 'MAIL': '/var/mail/cltbld', 10:08:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:08:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:11 INFO - 'MOZ_NO_REMOTE': '1', 10:08:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:11 INFO - 'NO_EM_RESTART': '1', 10:08:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:11 INFO - 'PWD': '/builds/slave/test', 10:08:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:08:11 INFO - 'RUST_BACKTRACE': '1', 10:08:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:08:11 INFO - 'SHELL': '/bin/bash', 10:08:11 INFO - 'SHLVL': '1', 10:08:11 INFO - 'TERM': 'linux', 10:08:11 INFO - 'TMOUT': '86400', 10:08:11 INFO - 'USER': 'cltbld', 10:08:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536', 10:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:11 INFO - '_': '/tools/buildbot/bin/python'} 10:08:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 10:08:11 INFO - mozversion application_buildid: 20170801152040 10:08:11 INFO - mozversion application_changeset: 291cf1dea1f174982e72d5bcc26886fdf210584a 10:08:11 INFO - mozversion application_display_name: Nightly 10:08:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:11 INFO - mozversion application_name: Firefox 10:08:11 INFO - mozversion application_remotingname: firefox 10:08:11 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 10:08:11 INFO - mozversion application_vendor: Mozilla 10:08:11 INFO - mozversion application_version: 56.0a1 10:08:11 INFO - mozversion platform_buildid: 20170801152040 10:08:11 INFO - mozversion platform_changeset: 291cf1dea1f174982e72d5bcc26886fdf210584a 10:08:11 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 10:08:11 INFO - mozversion platform_version: 56.0a1 10:08:11 INFO - using testdate: 1501607291 10:08:11 INFO - actual date: 1501607291 10:08:11 INFO - starting webserver on 'localhost:44203' 10:08:11 INFO - SUITE-START | Running 2 tests 10:08:11 INFO - TEST-START | dromaeo_css 10:08:11 INFO - Initialising browser for dromaeo_css test... 10:08:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44203/getInfo.html -profile /tmp/tmp5pOWBB/profile 10:08:11 INFO - TEST-INFO | started process 11561 (/builds/slave/test/build/application/firefox/firefox http://localhost:44203/getInfo.html) 10:08:16 INFO - TEST-INFO | 11561: exit 0 10:08:17 INFO - Browser initialized. 10:08:17 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:17 INFO - TEST-INFO | started process 11772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5pOWBB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:18 INFO - PID 11772 | 10:08:18 INFO - PID 11772 | (/builds/slave/test/build/application/firefox/firefox:11820): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:08:18 INFO - PID 11772 | 10:08:28 INFO - PID 11772 | RSS: Main: 171425792 10:08:28 INFO - PID 11772 | 10:11:28 INFO - PID 11772 | Cycle 1(1): loaded http://localhost:44203/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44203/tests/dromaeo/cssquery-ext.html) 10:11:29 INFO - PID 11772 | RSS: Main: 173830144 10:11:29 INFO - PID 11772 | 10:14:31 INFO - PID 11772 | Cycle 1(1): loaded http://localhost:44203/tests/dromaeo/cssquery-ext.html (next: http://localhost:44203/tests/dromaeo/cssquery-jquery.html) 10:14:31 INFO - PID 11772 | RSS: Main: 171397120 10:14:31 INFO - PID 11772 | 10:17:33 INFO - PID 11772 | Cycle 1(1): loaded http://localhost:44203/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44203/tests/dromaeo/cssquery-mootools.html) 10:17:34 INFO - PID 11772 | RSS: Main: 173670400 10:17:34 INFO - PID 11772 | 10:20:36 INFO - PID 11772 | Cycle 1(1): loaded http://localhost:44203/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44203/tests/dromaeo/cssquery-prototype.html) 10:20:36 INFO - PID 11772 | RSS: Main: 172040192 10:20:36 INFO - PID 11772 | 10:23:40 INFO - PID 11772 | Cycle 1(1): loaded http://localhost:44203/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44203/tests/dromaeo/cssquery-yui.html) 10:23:41 INFO - PID 11772 | RSS: Main: 175067136 10:23:41 INFO - PID 11772 | 10:26:42 INFO - PID 11772 | Cycle 1(1): loaded http://localhost:44203/tests/dromaeo/cssquery-yui.html (next: http://localhost:44203/tests/dromaeo/cssquery-dojo.html) 10:26:43 INFO - PID 11772 | RSS: Main: 175460352 10:26:43 INFO - PID 11772 | 10:26:43 INFO - PID 11772 | __start_tp_report 10:26:43 INFO - PID 11772 | _x_x_mozilla_page_load 10:26:43 INFO - PID 11772 | _x_x_mozilla_page_load_details 10:26:43 INFO - PID 11772 | |i|pagename|runs| 10:26:43 INFO - PID 11772 | |0;dojo.html;3116.688331166885;3150.1652062203507;3151.0074326587123;3169.4611915974288;3187.920301992451;6104.847378815532;6212.720427580758;6273.529485288599;6275.152854364659;6289.339619339972;5914.822555323347;6030.246219222598;6041.184440100585;6060;6069.271687397508;5628.240187574666;5663.886722265553;5677.744501497443;5697;5697.515711164556;5591.832245032635;5622.859428514279;5682.26130603021;5692.857678558048;5705.48650621444;5599.160125981095;5642;5682.573806964494;5701.743421546041;5705;5417.349918009864;5489.835304940858;5597.832065038056;5607.943920560783;5638.774449022034;5600.719964001783;5631.8592035199445;5638.126090455986;5658.207850900877;5678.9432105678825;6115.052166914135;6139.38606139387;6205.968970155121;6217.844553886144;6220.1913751212505;6470.708818103197;6535.607863528204;6564.40920317169;6572.342765723437;6707.597544147318;6603.240627327823;6615.338466153395;6620.37106474889;6668.533202675814;6781.423578995791;6261.092141639482;6263.937360626335;6277.05844123376;6280.5289603279025;6308.905366419507;6741.325867413219;6838.863222735517;6919.273476284918;6928.1339832520935;6936.237013928464;6574.6055236685;6588.8352791180605;6650.3349665034075;6681.799546013627;6698.39714425704;6484.870302593922;6565.901511477332;6575.605463672195;6576.243731970789;6585.045168450548;6524.608523488511;6541.378569036029;6575.408213260829;6631.668416579152;6647.169103862017;6628.5691430056895;6648.83377915556;6651.334866513407;6652.368025037614;6677.898146805723;5365.946340536622;5365.973170134124;5392.676439413648;5402.324709411324;5434.728263586805;4522.208613492626;4597.218472859622;4636.026434448736;4638.327442520816;4670.906581868344;5753.33836608787;5764.308283006066;5766.596338256281;5768.163616275617;5775.335836378787;6608.834779130464;6609.4712423007;6660.067590537328;6672.432843208285;6674.432673222734;5618.101103823368;5747.85630359236;5754.683492407874;5765.913511297334;5846.386129456431;5757.309122905278;5810.82567522975;5841.853953651193;5844.211031510777;5854.4730974212525;6393.073004414334;6412.422881940648;6495.253045899687;6500.902486462707;6506.577072490368;6490.7079181436;6596.934030659632;6605.636689982097;6616.636085015371;6783.559068660521;6148.047052706837;6171.938280617136;6189.133521306931;6197;6207.317195108625;6184.288806787277;6241.188645476059;6251.78118765841;6275.02737075754;6279.403456671609;6305.4009869062365;6714.0600315954825;6788.694508747019;6818.079559259437;6818.795436136924;6444.806655800334;6464.870702586016;6520.413162815369;6553.574017688835;6555.868882622225;6462.224533055875;6465.1595292611655;6549.050387693853;6559.770408035887;6578.572392794453;6162.322144564005;6274.780382686584;6299.559030867796;6423.132877061536;6465.806025819233;6577.276499584946;6583.934160658332;6613.2394774601535;6641.203055633355;6643.435307998874;6151.753929842756;6264.780732674517;6336.936630633819;6416.358364163733;6447.097406363019 10:26:43 INFO - PID 11772 | |1;ext.html;772.5248971882294;835.2566216067698;864.5417928497894;1117.3798541809297;1153.6885041038915;29809.701902980963;39673.40489892651;40293.39559906604;40460.59539404605;40514.59485405149;40785.38821917673;41005;41286;41359.58640413595;41369;7411.925880741178;7474.103107627092;7608.163102058769;7623;7648.120466146381;7356.74251401201;7519.7368092116785;7559.206283340252;7559.773206803778;7560.2439756024505;7448.255174482562;7500;7504.137024242227;7516.774496765079;7529.247075292455;7493.437992150583;7533;7533.35966442853;7533.4349923755935;7543.622818859035;7451.366633836131;7496.400287977003;7513.060867391576;7528.360089392409;7556.055493063367;36601.08497287562;36760.81619591912;36844.81577592122;36864;36914.261714765555;3451.9827400863087;3489.110276879405;3497.2131270464197;3498.475228715713;3501.719862411001;30580.54129188064;30790.230244244074;30807.537886931714;30813.69186308153;30955.845220773754;4609.354690343354;4788.114198873185;4788.401449818773;4805.279208118775;4813.78337974792;189861.050694747;189939;191142;191145;191565;48181.27728084011;48331.27503087457;48467.5153248463;48507;48571.75714121407;50421.49578504241;50481;50667.23999140016;50726.239106413435;50868.491315087114;12337.259764414164;14812;15006.624834379229;15043.924780376028;15113.924430377778;10000.899991000142;12075.154739168349;12242.81635775464;12245.08161887862;12247.142700010914;14470;14501.12993220389;14508.492202772852;14510.492132775302;14704.30900446441;5667;5841.474267315962;5900.20347253124;5981.431763982415;6063.151158837766;975.4439969217619;987.5753426026733;998.8601595776597;1016.364772017489;1016.4917541229386;22802.543949120925;22888.198913038297;23000.4249893754;23400.64899026516;23482.500661246842;1071.12703146935;1083.9620613278655;1091.7652704668535;1104.376027544435;1111.572044762772;11811.704707382212;12017;12104.576339828063;12188.695282617828;12288.2012669178;211162;212111;212350;212574;213380;51481.742591286806;51578.22632660513;51833.481665182866;51890.22164667533;51947.480525195024;1434.1968497641353;1467.8899082568637;1475.4172102019643;1477.9556613301834;1488.404638144729;22302.21942232014;22705.432364191027;22809;22903.19838805634;22936;37311;37443.43834842425;37461.62538374581;37475.625243747214;37479.31343089622;185958;186055.0697246505;186170;186686;187019;33134.171645708084;34736.652633474354;35604.46593301155;35727.82136089303;35751.10622234465;43149;44744.105117898114;44944.55055449404;45125.54874451213;45545.31682024706;29757;31258;31491.212719681276;31639.20901977377;32282.35435291234;31270.53094203543;32131.51802723008;32148.83925580357;32259.67740322567;32386.514202287457;36516.634833651326;36620.26759464743;36716.63283367132;36732.632673672924;36865.63134368622;29560;31580.368392632477;31767;32311.51532726964;32345.676543234265;22178;24188;24235.515289693754;24276.66478343708;24481.265562033168 10:26:43 INFO - PID 11772 | |2;jquery.html;574.2016560452605;582.208196852281;582.8338923406827;585.7422733997041;600.9248843894513;21817.345479635616;22595.096196152153;22709.318720438372;22732;23551.882240588817;26060.34849128773;26623.733762662367;26650.73349266507;26662.466750664975;26670.733292667068;6464.353564643533;6658.234303055138;6658.4673226141795;6659.5671281366795;6673.065770792093;5890.793822216223;6201.751929922798;6457.128287681174;6498;6517.217933847921;6439.22729272488;6447.129637498924;6451.967740161293;6452.3225061368585;6453.386928241809;6442.6134431934;6463.095166676669;6486.643234622094;6487.967560162169;6493.220813502387;6014.1580178775;6022.367651396584;6045.365236650133;6047.939520604826;6049.818505444844;26350.341241468926;29001.56497652537;29253.268668283465;29640.851795740884;30264.697353026408;1870.7474490943684;1919.8368138708227;1920.039980009995;1922.2791453205048;1922.7019811929033;17689.29242830285;18762.24951001958;18907.62184756311;18945.43163705091;18972.241110355568;2373.335466069503;2384.880755962195;2420.1408499982604;2439.2682195341504;2444.0590372706456;120838.39580802128;123944;125044;125296.37351813182;125322;14156.36296366666;15054.849451505565;15111.31999060045;15277.770833437507;15422.845771542365;23261.53476930452;23417.882910585337;23457.765422345557;23492.295231143093;23511;9715.368501047551;9942.204623630092;10128.848067278997;10132.594696212216;10236.692899213036;7533.962330188314;9000.18998290144;9096.81806363869;9121.635134594675;9285.860712089325;7697.923020769833;9041.77395565116;9075.81848363029;9206.17144457002;9262.212711919428;2721.251655794633;2737.7262273772462;2745.6018877263086;2782.721727827201;2842.332051967786;906.7551761024487;936.1481052242563;940.7695114696943;973.6446197137993;975.858500517421;19081.713774293396;19386.80613193878;20529.589408211752;23092.7690723094;24886.875565622056;1016.5933626549439;1028.84052971788;1030.2324768047852;1046.5813674530098;1059.4173204737363;11167.664970050912;11312.208145429906;11686.94156529212;11691.883081169079;11760.823587646191;496993;497584;497846;499945;505557;120295.39852300682;122261.38869305774;123905;124802;126292;1199.5801469485784;1216.7444836584416;1248.5380409248637;1254.3038613569556;1264.2288204195434;19763.308284209983;20079.29722459707;21243;22014.779852201915;22439.5512089754;61086.38913610807;61294.38705612887;61851.07223391563;62890.371096290284;63284.683576581825;69631.6518417425;70277.64861175661;70743.29256707572;70963;72349.27650723635;14550.4907328243;14770.187639679922;14796.926015369854;14859.628509287355;14862.33119509603;22488.100475980777;22488.550228995657;22515.43711407228;22672.659910101032;22937.65593516132;18007.729884052012;18075;18342.532597392445;18403.90798046001;18436.07819609041;15396.923015384851;15838.60403489922;15863.920680396986;15959.281832317341;16721.581960451087;18165;18187.727184091986;18527.907360463112;19422;19530.31643892457;14433;14461.927690361481;14603.488877889224;14606.342714578082;14612;17064.744028839825;17918.372856949944;17940.372086976895;18019.459416217534;18048.90975545114 10:26:43 INFO - PID 11772 | |3;mootools.html;1337.5251785616106;1398.6013986013988;1419.4393214680194;1426.2227086237997;1426.586289975907;13449.26029068401;14098.083624564422;14099.929500352497;14104.224267665288;14129.152250864956;11675.883241167587;12131.211471254363;12132.81800772987;13645.113067650596;14086.154830710164;2649.218480548243;2711.7288271172824;2713.796465265103;2713.91858244253;2715.1311580294314;2616.738326167387;2661.0420248710548;2690.3946612012337;2695.8247713898536;2696.5281075811754;2501.9124330648433;2622.8426294422397;2624.370151163726;2628.986855065722;2631.5657916443765;2638.9076382326525;2662.7071022187642;2675.2108128102063;2692.488427198836;2693.4747724193694;2536.5307418127704;2544.274881658718;2549.056848965876;2549.1842610364693;2550.923472295834;13633.659158521017;13854.376553055137;13855.653608659763;13856.376463059187;13905.443782248698;7548.547087174732;7857.6856925722905;7859.960700196462;7863.252990965849;7863.764087077397;4170.72890262132;5216.113260745682;5236.607254455931;5349.7057661828585;5356.758945847408;1698.898066116037;1715.408184176457;1721.2340508473735;1784.5627821183764;1786.2319202742815;22659.32022039325;22874.199403020983;22924.19765308206;22930.19744308941;22938.770612293996;6563.343665633494;6568.86862262752;6608.603483790988;6773.187217533928;6808;15138.924305378623;15670.294836732146;15682.68634627301;15854.762178567331;15886.841131588537;7414.925850741532;7575.734849280359;7627.161012288644;7632.542047477169;7638.159802421729;6971.442284617218;6982.61595612236;7004.089468369079;7252.274772522811;7270.382017528464;5056.82301119459;5241.899201167721;5249.842504724865;5275.630705850554;5319.46805319465;1507.7889095526634;1522.9923850380678;1524.336913442656;1525.8169019717704;1537.6155961009747;811.363079982223;830.6345208108413;832.1512057701111;853.7481442974338;863.5725315968635;6472.255690595548;6649.567778094409;6737.124173857367;6755.594664320157;6776.322367763184;685.143570536829;711.8042538302009;712.4905692429937;737.5095561451682;742.1242933338713;4382;4750.311204875274;4778.593819525309;5187.974060129675;5208.531232189045;18778.154983025797;19240.134193961305;19261.940593267223;19290.61418771645;19416.4175074748;18731.438056858315;18747.81252187488;19517.414477565697;19579.804201958083;19601.509962250773;10643.935606439449;10775.299605525615;10903.563857445613;10949.288296260718;10962.068224200873;7363.668634911549;7706.383489320729;7773.1060927994;7828.804279893048;7967;16813.91593042027;16862;17004.404845830337;17088.91455542714;17857.642847143245;16472.505824825275;17286;17467.30130794754;17818;17950.91024544869;11347.48936297852;11842.76314473723;11870.109741769229;11871.76256474883;11904.285742855456;12919.806202907152;12941.935290323489;13011.414486347947;13085.542006029744;13090.214587124803;10297.9485102574;10649.89350106489;10794.838077429002;10883;10956.068734157687;9945.154661853823;10363.740906477398;10587.947060264958;10641.308314959502;10692.572297108029;8724.476531408136;8888.86666700013;8892.688755893512;8899.688510902088;8947.194752472049;6626.91252255538;6723.327667233238;6736.427403670743;6741.157355330583;6864.656767161522;6327.3988971047675;6331.195609251341;6466.51501137426;6513.7068831903625;6537.05212744159 10:26:43 INFO - PID 11772 | |4;prototype.html;489.7526748991759;495.4475759528125;516.6796586116608;519.8908229271852;531.4711861697612;6058.575899687024;6214.689265536722;6251.499880009594;6315.336889626592;6333.240011198651;6029.427204415584;6069.57512974092;6101.267847858252;6117.204763380754;6189.566730328879;4908.631852611068;4914.5085491450745;4945.28293397458;4961.479044700309;4962.528559786832;4820.542048505386;4846.715620360607;4851.611871050325;4885.804567817283;4942.431620363668;4878.292647566101;4885.340479035338;4912.533309335608;4923.77842997066;4930.654854160211;4841.845378806433;4849.739067842351;4902.779374928136;4916.680415772963;4954.653174277802;4356.542563030868;4419.867403977853;4434.334849772527;4466.8436604719;4475.641948644101;6058.394160583906;6117.388261173892;6123.571350005502;6129.662868542228;6145.201123853871;5682.374938756733;5696.8006119785605;5705.857353566194;5711.514521265656;5730.312362516524;6458.903116453257;6477;6481.74073037078;6529.347065293433;6573.145491086176;4789.161896668069;4842;4854.757262136879;4881.975590122062;4888.682235654706;6892.551984121016;6917.723291068301;6925.480588955798;6962.930370696329;7021.543599666056;4910.337104490919;4918.975405122951;4932.802687892516;4961.355023846877;4962.875928101754;4960.280759289883;4991.575716064175;5034.798608055637;5048.62135339851;5058.620603454682;5651.350094739076;5666.914996275059;5668.688222147739;5687.8862422752145;5710.8001219957105;6462.192225971754;6585.649941761927;6609.735610575619;6615.636140012345;6642.468602511787;1643.6712657468315;1661.7341225403877;1695.7541156532234;1696.245170898938;1761.4539492757285;1184.1474138620179;1196.5034510678145;1218.9634310970685;1222.5293262094158;1224.400043978462;5679.858003549944;5694.971525142348;5708.571857110734;5713.400092990176;5808.535317174616;6427.55007149495;6677.29888361715;6736.7642132525125;6737.393634572912;6741.730330786713;5675.858103547362;5741.7655204131315;5756.481916627524;5767.5674324425;5783.739731712083;3516.6460912548855;3600.595767650618;3609.1338078860886;3632.4914511968345;3656.323580137683;6534.346565343428;6555.541112122201;6617.305182955816;6671.966640166768;6675.165604299463;6935.895961560581;6958.617276049765;6970.233274339818;6994.61529615876;6997.510174287751;6340.175777149033;6370.85324641569;6468.870622587522;6496.285408604956;6518.348165183538;6758.357955994173;6771.356721111487;6814.080099186546;6840;6861.2109607393795;6717.56335838169;6760.391564759196;6772.356626120511;6775.49183811226;6781.6270105144695;6459.192600924885;6480.740770369321;6525.412712855866;6615.536912416084;6617;4887.413510378778;4915.95084049155;4932.630052745986;4946.307516947558;4995.600351971906;6481.675916204265;6681.899771503334;6726.596404215763;6751.324867513209;6776.593404395752;6347.587406818542;6364.268109167505;6367.61794292344;6480.546361754632;6509.880712130582;6401.391867772554;6446.484281257582;6509.218893732783;6510.902336464862;6521.804345869631;6250.531210159347;6436.935630643821;6437.098806167234;6477.740890364333;6512.381323774234;6379.170707807955;6519.869602607826;6528.575642583217;6643.847595252967;6667.799966001027;6306.810795676137;6380.553361264667;6395.712192951235;6449.258335291502;6463.806085817433 10:26:43 INFO - PID 11772 | |5;yui.html;910.1490106750189;915.1031988651122;932.6735642525122;939.0656296984502;949.7578117580016;17750.289988400466;18721.812781872177;18743.43769686908;18749.71875421868;18765.7185142223;18359.357422490215;19825.900870495665;19945.601087978233;20007.1997120115;20074;1031.6079889641926;1049.3284298049255;1056.3820165203326;1057.7778666480049;1059.3643813711749;973.5083782689767;1040.4225654761603;1047.3820445936897;1054.894510548943;1062.7077553672725;1109.7003808971613;1112.3159257056893;1112.9944350278279;1114.320264638574;1114.9331040137577;1103.4923934989833;1103.9724006899812;1107.9002889739922;1109.7447587054983;1110.1784679337272;811.3914564076942;814.1288820961573;814.2305521282391;815.2866242038217;817.3624572833199;18413.815861841344;18918.148683309286;19279.710804337945;19482.610347793106;19534.90232548828;19129.904350478297;19326.903365483224;19379;19756.012199390116;19910.20359185631;14008.579742607739;15010.47463338778;15157.166355850424;15187;15247.923760381238;3488.773229740059;3519.6304388039143;3533.6466353364717;3564.3940530109685;3564.9108772280642;117150.41424792906;121107;124839;127806;128844.3557782205;15586.220688965506;16158.949668271525;16505.17474126289;16507;16512.917435412986;29007.85496072506;29352;29627.259318517208;29628.555571666442;29657.703422965493;8304.792380190544;8414.453060551044;8428.115047920002;8449.57752112392;8504.829903401896;4225;4374.671899607479;4374.759388233678;4382.298832186835;4383.1452866691325;4783.760811959388;5062.949370506321;5377.946220537823;5935.52515798735;5941.762329506858;1082.99458502707;1118.4910865556153;1147.4836323654388;1148.093006524836;1149.2931846914087;614.7940439952577;623.6975067092457;655.5411212151417;655.5968079631087;669.7254125808395;10936.45317734126;11316;11740.471678774476;11764.647060588197;11887.88112118885;655.8884989551788;685.5098604497708;686.9278725733826;693.1578132568953;702.4801646781447;5159.432462429129;5504.80733174337;5526.861828454241;5583.581231407661;5742.368339482654;90669.54665226763;94254.52872735729;98586.5070674642;99237.50381248047;100451;87009.56495217483;87216.56391718001;89832;89872;90177.54911225534;79013.20986790059;80874;81788.18211817925;83260.75108873371;84132;11059.889401105886;11333.433328333715;11861;12090;12659.98720102408;34370.48444273288;35128;35134.64865351314;36896;37191.6280837199;62202.37797622147;63044;65113.674431627536;67484.66257668876;70001.29998700152;17804.732929006335;18389.172487238375;18487.260509579468;18506.722399164293;18507;20008.699869501677;20152.59694806125;20262.59474810525;20360.490987724832;21224.469388265417;17076.74384884203;17624.206910688794;17980.730289045936;18109.728354074963;18388.172532235814;17608.647827043133;17624.55938601545;17644.73532897033;17652.82347176563;17855.37506187277;17266.740998885278;17862.106894655477;18094.909525452287;18423.53941151482;18638.440846774618;12790.68023299425;13176.47294108225;13206.735865282833;13217.933910330386;13385.799213011618;12845.550405735754;13061.477540898257;13634.18194908269;13774.348533801556;13884.097533660684 10:26:43 INFO - PID 11772 | __end_tp_report 10:26:43 INFO - PID 11772 | __start_cc_report 10:26:43 INFO - PID 11772 | _x_x_mozilla_cycle_collect,392 10:26:43 INFO - PID 11772 | __end_cc_report 10:26:43 INFO - PID 11772 | __startTimestamp1501608403033__endTimestamp 10:26:43 INFO - PID 11772 | 10:26:43 INFO - PID 11772 | ------- Summary: start ------- 10:26:43 INFO - PID 11772 | Number of tests: 6 10:26:43 INFO - PID 11772 | 10:26:43 INFO - PID 11772 | [#0] dojo.html Cycles:165 Average:6092.84 Median:6275.03 stddev:718.20 (11.4%) stddev-sans-first:681.40 10:26:43 INFO - PID 11772 | Values: 3116.7 3150.2 3151.0 3169.5 3187.9 6104.8 6212.7 6273.5 6275.2 6289.3 5914.8 6030.2 6041.2 6060.0 6069.3 5628.2 5663.9 5677.7 5697.0 5697.5 5591.8 5622.9 5682.3 5692.9 5705.5 5599.2 5642.0 5682.6 5701.7 5705.0 5417.3 5489.8 5597.8 5607.9 5638.8 5600.7 5631.9 5638.1 5658.2 5678.9 6115.1 6139.4 6206.0 6217.8 6220.2 6470.7 6535.6 6564.4 6572.3 6707.6 6603.2 6615.3 6620.4 6668.5 6781.4 6261.1 6263.9 6277.1 6280.5 6308.9 6741.3 6838.9 6919.3 6928.1 6936.2 6574.6 6588.8 6650.3 6681.8 6698.4 6484.9 6565.9 6575.6 6576.2 6585.0 6524.6 6541.4 6575.4 6631.7 6647.2 6628.6 6648.8 6651.3 6652.4 6677.9 5365.9 5366.0 5392.7 5402.3 5434.7 4522.2 4597.2 4636.0 4638.3 4670.9 5753.3 5764.3 5766.6 5768.2 5775.3 6608.8 6609.5 6660.1 6672.4 6674.4 5618.1 5747.9 5754.7 5765.9 5846.4 5757.3 5810.8 5841.9 5844.2 5854.5 6393.1 6412.4 6495.3 6500.9 6506.6 6490.7 6596.9 6605.6 6616.6 6783.6 6148.0 6171.9 6189.1 6197.0 6207.3 6184.3 6241.2 6251.8 6275.0 6279.4 6305.4 6714.1 6788.7 6818.1 6818.8 6444.8 6464.9 6520.4 6553.6 6555.9 6462.2 6465.2 6549.1 6559.8 6578.6 6162.3 6274.8 6299.6 6423.1 6465.8 6577.3 6583.9 6613.2 6641.2 6643.4 6151.8 6264.8 6336.9 6416.4 6447.1 10:26:43 INFO - PID 11772 | 10:26:43 INFO - PID 11772 | [#1] ext.html Cycles:180 Average:36516.10 Median:3500.10 stddev:50941.69 (1455.4%) stddev-sans-first:51013.89 10:26:43 INFO - PID 11772 | Values: 772.5 835.3 864.5 1117.4 1153.7 29809.7 39673.4 40293.4 40460.6 40514.6 40785.4 41005.0 41286.0 41359.6 41369.0 7411.9 7474.1 7608.2 7623.0 7648.1 7356.7 7519.7 7559.2 7559.8 7560.2 7448.3 7500.0 7504.1 7516.8 7529.2 7493.4 7533.0 7533.4 7533.4 7543.6 7451.4 7496.4 7513.1 7528.4 7556.1 36601.1 36760.8 36844.8 36864.0 36914.3 3452.0 3489.1 3497.2 3498.5 3501.7 30580.5 30790.2 30807.5 30813.7 30955.8 4609.4 4788.1 4788.4 4805.3 4813.8 189861.1 189939.0 191142.0 191145.0 191565.0 48181.3 48331.3 48467.5 48507.0 48571.8 50421.5 50481.0 50667.2 50726.2 50868.5 12337.3 14812.0 15006.6 15043.9 15113.9 10000.9 12075.2 12242.8 12245.1 12247.1 14470.0 14501.1 14508.5 14510.5 14704.3 5667.0 5841.5 5900.2 5981.4 6063.2 975.4 987.6 998.9 1016.4 1016.5 22802.5 22888.2 23000.4 23400.6 23482.5 1071.1 1084.0 1091.8 1104.4 1111.6 11811.7 12017.0 12104.6 12188.7 12288.2 211162.0 212111.0 212350.0 212574.0 213380.0 51481.7 51578.2 51833.5 51890.2 51947.5 1434.2 1467.9 1475.4 1478.0 1488.4 22302.2 22705.4 22809.0 22903.2 22936.0 37311.0 37443.4 37461.6 37475.6 37479.3 185958.0 186055.1 186170.0 186686.0 187019.0 33134.2 34736.7 35604.5 35727.8 35751.1 43149.0 44744.1 44944.6 45125.5 45545.3 29757.0 31258.0 31491.2 31639.2 32282.4 31270.5 32131.5 32148.8 32259.7 32386.5 36516.6 36620.3 36716.6 36732.6 36865.6 29560.0 31580.4 31767.0 32311.5 32345.7 22178.0 24188.0 24235.5 24276.7 24481.3 10:26:43 INFO - PID 11772 | 10:26:43 INFO - PID 11772 | [#2] jquery.html Cycles:180 Average:35068.96 Median:23177.15 stddev:83857.81 (361.8%) stddev-sans-first:84053.06 10:26:43 INFO - PID 11772 | Values: 574.2 582.2 582.8 585.7 600.9 21817.3 22595.1 22709.3 22732.0 23551.9 26060.3 26623.7 26650.7 26662.5 26670.7 6464.4 6658.2 6658.5 6659.6 6673.1 5890.8 6201.8 6457.1 6498.0 6517.2 6439.2 6447.1 6452.0 6452.3 6453.4 6442.6 6463.1 6486.6 6488.0 6493.2 6014.2 6022.4 6045.4 6047.9 6049.8 26350.3 29001.6 29253.3 29640.9 30264.7 1870.7 1919.8 1920.0 1922.3 1922.7 17689.3 18762.2 18907.6 18945.4 18972.2 2373.3 2384.9 2420.1 2439.3 2444.1 120838.4 123944.0 125044.0 125296.4 125322.0 14156.4 15054.8 15111.3 15277.8 15422.8 23261.5 23417.9 23457.8 23492.3 23511.0 9715.4 9942.2 10128.8 10132.6 10236.7 7534.0 9000.2 9096.8 9121.6 9285.9 7697.9 9041.8 9075.8 9206.2 9262.2 2721.3 2737.7 2745.6 2782.7 2842.3 906.8 936.1 940.8 973.6 975.9 19081.7 19386.8 20529.6 23092.8 24886.9 1016.6 1028.8 1030.2 1046.6 1059.4 11167.7 11312.2 11686.9 11691.9 11760.8 496993.0 497584.0 497846.0 499945.0 505557.0 120295.4 122261.4 123905.0 124802.0 126292.0 1199.6 1216.7 1248.5 1254.3 1264.2 19763.3 20079.3 21243.0 22014.8 22439.6 61086.4 61294.4 61851.1 62890.4 63284.7 69631.7 70277.6 70743.3 70963.0 72349.3 14550.5 14770.2 14796.9 14859.6 14862.3 22488.1 22488.6 22515.4 22672.7 22937.7 18007.7 18075.0 18342.5 18403.9 18436.1 15396.9 15838.6 15863.9 15959.3 16721.6 18165.0 18187.7 18527.9 19422.0 19530.3 14433.0 14461.9 14603.5 14606.3 14612.0 17064.7 17918.4 17940.4 18019.5 18048.9 10:26:43 INFO - PID 11772 | 10:26:43 INFO - PID 11772 | [#3] mootools.html Cycles:180 Average:8581.85 Median:2619.79 stddev:5918.14 (225.9%) stddev-sans-first:5909.71 10:26:43 INFO - PID 11772 | Values: 1337.5 1398.6 1419.4 1426.2 1426.6 13449.3 14098.1 14099.9 14104.2 14129.2 11675.9 12131.2 12132.8 13645.1 14086.2 2649.2 2711.7 2713.8 2713.9 2715.1 2616.7 2661.0 2690.4 2695.8 2696.5 2501.9 2622.8 2624.4 2629.0 2631.6 2638.9 2662.7 2675.2 2692.5 2693.5 2536.5 2544.3 2549.1 2549.2 2550.9 13633.7 13854.4 13855.7 13856.4 13905.4 7548.5 7857.7 7860.0 7863.3 7863.8 4170.7 5216.1 5236.6 5349.7 5356.8 1698.9 1715.4 1721.2 1784.6 1786.2 22659.3 22874.2 22924.2 22930.2 22938.8 6563.3 6568.9 6608.6 6773.2 6808.0 15138.9 15670.3 15682.7 15854.8 15886.8 7414.9 7575.7 7627.2 7632.5 7638.2 6971.4 6982.6 7004.1 7252.3 7270.4 5056.8 5241.9 5249.8 5275.6 5319.5 1507.8 1523.0 1524.3 1525.8 1537.6 811.4 830.6 832.2 853.7 863.6 6472.3 6649.6 6737.1 6755.6 6776.3 685.1 711.8 712.5 737.5 742.1 4382.0 4750.3 4778.6 5188.0 5208.5 18778.2 19240.1 19261.9 19290.6 19416.4 18731.4 18747.8 19517.4 19579.8 19601.5 10643.9 10775.3 10903.6 10949.3 10962.1 7363.7 7706.4 7773.1 7828.8 7967.0 16813.9 16862.0 17004.4 17088.9 17857.6 16472.5 17286.0 17467.3 17818.0 17950.9 11347.5 11842.8 11870.1 11871.8 11904.3 12919.8 12941.9 13011.4 13085.5 13090.2 10297.9 10649.9 10794.8 10883.0 10956.1 9945.2 10363.7 10587.9 10641.3 10692.6 8724.5 8888.9 8892.7 8899.7 8947.2 6626.9 6723.3 6736.4 6741.2 6864.7 6327.4 6331.2 6466.5 6513.7 6537.1 10:26:43 INFO - PID 11772 | 10:26:43 INFO - PID 11772 | [#4] prototype.html Cycles:180 Average:5496.31 Median:6117.30 stddev:1559.62 (25.5%) stddev-sans-first:1518.05 10:26:43 INFO - PID 11772 | Values: 489.8 495.4 516.7 519.9 531.5 6058.6 6214.7 6251.5 6315.3 6333.2 6029.4 6069.6 6101.3 6117.2 6189.6 4908.6 4914.5 4945.3 4961.5 4962.5 4820.5 4846.7 4851.6 4885.8 4942.4 4878.3 4885.3 4912.5 4923.8 4930.7 4841.8 4849.7 4902.8 4916.7 4954.7 4356.5 4419.9 4434.3 4466.8 4475.6 6058.4 6117.4 6123.6 6129.7 6145.2 5682.4 5696.8 5705.9 5711.5 5730.3 6458.9 6477.0 6481.7 6529.3 6573.1 4789.2 4842.0 4854.8 4882.0 4888.7 6892.6 6917.7 6925.5 6962.9 7021.5 4910.3 4919.0 4932.8 4961.4 4962.9 4960.3 4991.6 5034.8 5048.6 5058.6 5651.4 5666.9 5668.7 5687.9 5710.8 6462.2 6585.6 6609.7 6615.6 6642.5 1643.7 1661.7 1695.8 1696.2 1761.5 1184.1 1196.5 1219.0 1222.5 1224.4 5679.9 5695.0 5708.6 5713.4 5808.5 6427.6 6677.3 6736.8 6737.4 6741.7 5675.9 5741.8 5756.5 5767.6 5783.7 3516.6 3600.6 3609.1 3632.5 3656.3 6534.3 6555.5 6617.3 6672.0 6675.2 6935.9 6958.6 6970.2 6994.6 6997.5 6340.2 6370.9 6468.9 6496.3 6518.3 6758.4 6771.4 6814.1 6840.0 6861.2 6717.6 6760.4 6772.4 6775.5 6781.6 6459.2 6480.7 6525.4 6615.5 6617.0 4887.4 4916.0 4932.6 4946.3 4995.6 6481.7 6681.9 6726.6 6751.3 6776.6 6347.6 6364.3 6367.6 6480.5 6509.9 6401.4 6446.5 6509.2 6510.9 6521.8 6250.5 6436.9 6437.1 6477.7 6512.4 6379.2 6519.9 6528.6 6643.8 6667.8 6306.8 6380.6 6395.7 6449.3 6463.8 10:26:43 INFO - PID 11772 | 10:26:43 INFO - PID 11772 | [#5] yui.html Cycles:180 Average:22443.19 Median:19352.95 stddev:29950.88 (154.8%) stddev-sans-first:29991.26 10:26:43 INFO - PID 11772 | Values: 910.1 915.1 932.7 939.1 949.8 17750.3 18721.8 18743.4 18749.7 18765.7 18359.4 19825.9 19945.6 20007.2 20074.0 1031.6 1049.3 1056.4 1057.8 1059.4 973.5 1040.4 1047.4 1054.9 1062.7 1109.7 1112.3 1113.0 1114.3 1114.9 1103.5 1104.0 1107.9 1109.7 1110.2 811.4 814.1 814.2 815.3 817.4 18413.8 18918.1 19279.7 19482.6 19534.9 19129.9 19326.9 19379.0 19756.0 19910.2 14008.6 15010.5 15157.2 15187.0 15247.9 3488.8 3519.6 3533.6 3564.4 3564.9 117150.4 121107.0 124839.0 127806.0 128844.4 15586.2 16158.9 16505.2 16507.0 16512.9 29007.9 29352.0 29627.3 29628.6 29657.7 8304.8 8414.5 8428.1 8449.6 8504.8 4225.0 4374.7 4374.8 4382.3 4383.1 4783.8 5062.9 5377.9 5935.5 5941.8 1083.0 1118.5 1147.5 1148.1 1149.3 614.8 623.7 655.5 655.6 669.7 10936.5 11316.0 11740.5 11764.6 11887.9 655.9 685.5 686.9 693.2 702.5 5159.4 5504.8 5526.9 5583.6 5742.4 90669.5 94254.5 98586.5 99237.5 100451.0 87009.6 87216.6 89832.0 89872.0 90177.5 79013.2 80874.0 81788.2 83260.8 84132.0 11059.9 11333.4 11861.0 12090.0 12660.0 34370.5 35128.0 35134.6 36896.0 37191.6 62202.4 63044.0 65113.7 67484.7 70001.3 17804.7 18389.2 18487.3 18506.7 18507.0 20008.7 20152.6 20262.6 20360.5 21224.5 17076.7 17624.2 17980.7 18109.7 18388.2 17608.6 17624.6 17644.7 17652.8 17855.4 17266.7 17862.1 18094.9 18423.5 18638.4 12790.7 13176.5 13206.7 13217.9 13385.8 12845.6 13061.5 13634.2 13774.3 13884.1 10:26:43 INFO - PID 11772 | -------- Summary: end -------- 10:26:43 INFO - PID 11772 | 10:26:43 INFO - TEST-INFO | 11772: exit 0 10:26:43 INFO - TEST-OK | dromaeo_css | took 1111958ms 10:26:43 INFO - TEST-START | kraken 10:26:43 INFO - Initialising browser for kraken test... 10:26:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44203/getInfo.html -profile /tmp/tmpHoZw7B/profile 10:26:43 INFO - TEST-INFO | started process 12130 (/builds/slave/test/build/application/firefox/firefox http://localhost:44203/getInfo.html) 10:26:49 INFO - TEST-INFO | 12130: exit 0 10:26:49 INFO - Browser initialized. 10:26:49 INFO - Running cycle 1/1 for kraken test... 10:26:49 INFO - TEST-INFO | started process 12337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoZw7B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:50 INFO - PID 12337 | 10:26:50 INFO - PID 12337 | (/builds/slave/test/build/application/firefox/firefox:12386): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:26:50 INFO - PID 12337 | 10:27:00 INFO - PID 12337 | RSS: Main: 168542208 10:27:00 INFO - PID 12337 | 10:27:03 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44203/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:04 INFO - PID 12337 | RSS: Main: 173223936 10:27:04 INFO - PID 12337 | 10:27:06 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44203/tests/kraken/driver.html?testName=audio-dft) 10:27:07 INFO - PID 12337 | RSS: Main: 174211072 10:27:07 INFO - PID 12337 | 10:27:10 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44203/tests/kraken/driver.html?testName=audio-fft) 10:27:10 INFO - PID 12337 | RSS: Main: 168574976 10:27:10 INFO - PID 12337 | 10:27:13 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44203/tests/kraken/driver.html?testName=audio-oscillator) 10:27:13 INFO - PID 12337 | RSS: Main: 169201664 10:27:13 INFO - PID 12337 | 10:27:15 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44203/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:16 INFO - PID 12337 | RSS: Main: 169644032 10:27:16 INFO - PID 12337 | 10:27:19 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44203/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:20 INFO - PID 12337 | RSS: Main: 172191744 10:27:20 INFO - PID 12337 | 10:27:23 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44203/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:24 INFO - PID 12337 | RSS: Main: 171651072 10:27:24 INFO - PID 12337 | 10:27:27 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44203/tests/kraken/driver.html?testName=json-parse-financial) 10:27:27 INFO - PID 12337 | RSS: Main: 172724224 10:27:27 INFO - PID 12337 | 10:27:29 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44203/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:30 INFO - PID 12337 | RSS: Main: 172277760 10:27:30 INFO - PID 12337 | 10:27:31 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44203/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:32 INFO - PID 12337 | RSS: Main: 172507136 10:27:32 INFO - PID 12337 | 10:27:34 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44203/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:35 INFO - PID 12337 | RSS: Main: 172658688 10:27:35 INFO - PID 12337 | 10:27:38 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:38 INFO - PID 12337 | RSS: Main: 172961792 10:27:38 INFO - PID 12337 | 10:27:41 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:42 INFO - PID 12337 | RSS: Main: 172929024 10:27:42 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | Cycle 1(1): loaded http://localhost:44203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44203/tests/kraken/driver.html?testName=ai-astar) 10:27:44 INFO - PID 12337 | RSS: Main: 174628864 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | __start_tp_report 10:27:44 INFO - PID 12337 | _x_x_mozilla_page_load 10:27:44 INFO - PID 12337 | _x_x_mozilla_page_load_details 10:27:44 INFO - PID 12337 | |i|pagename|runs| 10:27:44 INFO - PID 12337 | |0;ai-astar;99;110;104;110;111;108;111;100;111;110 10:27:44 INFO - PID 12337 | |1;audio-beat-detection;147;119;141;175;120;145;149;123;169;122 10:27:44 INFO - PID 12337 | |2;audio-dft;163;162;164;165;163;162;168;169;163;163 10:27:44 INFO - PID 12337 | |3;audio-fft;75;84;76;188;77;78;76;75;178;75 10:27:44 INFO - PID 12337 | |4;audio-oscillator;79;78;134;81;78;80;122;81;79;124 10:27:44 INFO - PID 12337 | |5;imaging-gaussian-blur;114;115;115;114;114;115;114;114;114;114 10:27:44 INFO - PID 12337 | |6;imaging-darkroom;152;152;152;151;151;159;149;151;151;153 10:27:44 INFO - PID 12337 | |7;imaging-desaturate;95;95;94;98;94;94;94;94;94;94 10:27:44 INFO - PID 12337 | |8;json-parse-financial;57;56;56;55;56;56;56;56;55;57 10:27:44 INFO - PID 12337 | |9;json-stringify-tinderbox;55;54;54;54;55;54;55;54;54;54 10:27:44 INFO - PID 12337 | |10;stanford-crypto-aes;88;92;89;84;81;82;80;82;88;80 10:27:44 INFO - PID 12337 | |11;stanford-crypto-ccm;130;133;128;128;128;128;126;134;146;170 10:27:44 INFO - PID 12337 | |12;stanford-crypto-pbkdf2;180;179;180;182;181;183;183;188;182;190 10:27:44 INFO - PID 12337 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;66;69;68;67;73 10:27:44 INFO - PID 12337 | __end_tp_report 10:27:44 INFO - PID 12337 | __start_cc_report 10:27:44 INFO - PID 12337 | _x_x_mozilla_cycle_collect,954 10:27:44 INFO - PID 12337 | __end_cc_report 10:27:44 INFO - PID 12337 | __startTimestamp1501608464553__endTimestamp 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | ------- Summary: start ------- 10:27:44 INFO - PID 12337 | Number of tests: 14 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#0] ai-astar Cycles:10 Average:107.40 Median:110.50 stddev:4.67 (4.2%) stddev-sans-first:3.84 10:27:44 INFO - PID 12337 | Values: 99.0 110.0 104.0 110.0 111.0 108.0 111.0 100.0 111.0 110.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:146.00 stddev:20.18 (13.8%) stddev-sans-first:21.29 10:27:44 INFO - PID 12337 | Values: 147.0 119.0 141.0 175.0 120.0 145.0 149.0 123.0 169.0 122.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.44 (1.5%) stddev-sans-first:2.55 10:27:44 INFO - PID 12337 | Values: 163.0 162.0 164.0 165.0 163.0 162.0 168.0 169.0 163.0 163.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#3] audio-fft Cycles:10 Average:98.20 Median:76.00 stddev:44.84 (59.0%) stddev-sans-first:46.76 10:27:44 INFO - PID 12337 | Values: 75.0 84.0 76.0 188.0 77.0 78.0 76.0 75.0 178.0 75.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:79.00 stddev:23.04 (29.2%) stddev-sans-first:23.83 10:27:44 INFO - PID 12337 | Values: 79.0 78.0 134.0 81.0 78.0 80.0 122.0 81.0 79.0 124.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:27:44 INFO - PID 12337 | Values: 114.0 115.0 115.0 114.0 114.0 115.0 114.0 114.0 114.0 114.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:152.00 stddev:2.64 (1.7%) stddev-sans-first:2.80 10:27:44 INFO - PID 12337 | Values: 152.0 152.0 152.0 151.0 151.0 159.0 149.0 151.0 151.0 153.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 10:27:44 INFO - PID 12337 | Values: 95.0 95.0 94.0 98.0 94.0 94.0 94.0 94.0 94.0 94.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 10:27:44 INFO - PID 12337 | Values: 57.0 56.0 56.0 55.0 56.0 56.0 56.0 56.0 55.0 57.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 10:27:44 INFO - PID 12337 | Values: 55.0 54.0 54.0 54.0 55.0 54.0 55.0 54.0 54.0 54.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:86.00 stddev:4.30 (5.0%) stddev-sans-first:4.38 10:27:44 INFO - PID 12337 | Values: 88.0 92.0 89.0 84.0 81.0 82.0 80.0 82.0 88.0 80.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:131.50 stddev:13.55 (10.3%) stddev-sans-first:14.25 10:27:44 INFO - PID 12337 | Values: 130.0 133.0 128.0 128.0 128.0 128.0 126.0 134.0 146.0 170.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:182.50 stddev:3.55 (1.9%) stddev-sans-first:3.62 10:27:44 INFO - PID 12337 | Values: 180.0 179.0 180.0 182.0 181.0 183.0 183.0 188.0 182.0 190.0 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:1.97 (2.9%) stddev-sans-first:2.06 10:27:44 INFO - PID 12337 | Values: 67.0 68.0 67.0 67.0 67.0 66.0 69.0 68.0 67.0 73.0 10:27:44 INFO - PID 12337 | -------- Summary: end -------- 10:27:44 INFO - PID 12337 | 10:27:44 INFO - PID 12337 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:27:45 INFO - TEST-INFO | 12337: exit 0 10:27:45 INFO - TEST-OK | kraken | took 61534ms 10:27:45 INFO - SUITE-END | took 1173s 10:27:45 INFO - Completed test suite (00:19:33) 10:27:45 INFO - javascript benchmark 10:27:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8369.14883716302, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.688331166885, 3150.1652062203507, 3151.0074326587123, 3169.4611915974288, 3187.920301992451, 6104.847378815532, 6212.720427580758, 6273.529485288599, 6275.152854364659, 6289.339619339972, 5914.822555323347, 6030.246219222598, 6041.184440100585, 6060.0, 6069.271687397508, 5628.240187574666, 5663.886722265553, 5677.744501497443, 5697.0, 5697.515711164556, 5591.832245032635, 5622.859428514279, 5682.26130603021, 5692.857678558048, 5705.48650621444, 5599.160125981095, 5642.0, 5682.573806964494, 5701.743421546041, 5705.0, 5417.349918009864, 5489.835304940858, 5597.832065038056, 5607.943920560783, 5638.774449022034, 5600.719964001783, 5631.8592035199445, 5638.126090455986, 5658.207850900877, 5678.9432105678825, 6115.052166914135, 6139.38606139387, 6205.968970155121, 6217.844553886144, 6220.1913751212505, 6470.708818103197, 6535.607863528204, 6564.40920317169, 6572.342765723437, 6707.597544147318, 6603.240627327823, 6615.338466153395, 6620.37106474889, 6668.533202675814, 6781.423578995791, 6261.092141639482, 6263.937360626335, 6277.05844123376, 6280.5289603279025, 6308.905366419507, 6741.325867413219, 6838.863222735517, 6919.273476284918, 6928.1339832520935, 6936.237013928464, 6574.6055236685, 6588.8352791180605, 6650.3349665034075, 6681.799546013627, 6698.39714425704, 6484.870302593922, 6565.901511477332, 6575.605463672195, 6576.243731970789, 6585.045168450548, 6524.608523488511, 6541.378569036029, 6575.408213260829, 6631.668416579152, 6647.169103862017, 6628.5691430056895, 6648.83377915556, 6651.334866513407, 6652.368025037614, 6677.898146805723, 5365.946340536622, 5365.973170134124, 5392.676439413648, 5402.324709411324, 5434.728263586805, 4522.208613492626, 4597.218472859622, 4636.026434448736, 4638.327442520816, 4670.906581868344, 5753.33836608787, 5764.308283006066, 5766.596338256281, 5768.163616275617, 5775.335836378787, 6608.834779130464, 6609.4712423007, 6660.067590537328, 6672.432843208285, 6674.432673222734, 5618.101103823368, 5747.85630359236, 5754.683492407874, 5765.913511297334, 5846.386129456431, 5757.309122905278, 5810.82567522975, 5841.853953651193, 5844.211031510777, 5854.4730974212525, 6393.073004414334, 6412.422881940648, 6495.253045899687, 6500.902486462707, 6506.577072490368, 6490.7079181436, 6596.934030659632, 6605.636689982097, 6616.636085015371, 6783.559068660521, 6148.047052706837, 6171.938280617136, 6189.133521306931, 6197.0, 6207.317195108625, 6184.288806787277, 6241.188645476059, 6251.78118765841, 6275.02737075754, 6279.403456671609, 6305.4009869062365, 6714.0600315954825, 6788.694508747019, 6818.079559259437, 6818.795436136924, 6444.806655800334, 6464.870702586016, 6520.413162815369, 6553.574017688835, 6555.868882622225, 6462.224533055875, 6465.1595292611655, 6549.050387693853, 6559.770408035887, 6578.572392794453, 6162.322144564005, 6274.780382686584, 6299.559030867796, 6423.132877061536, 6465.806025819233, 6577.276499584946, 6583.934160658332, 6613.2394774601535, 6641.203055633355, 6643.435307998874, 6151.753929842756, 6264.780732674517, 6336.936630633819, 6416.358364163733, 6447.097406363019], "value": 6039.544594541968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.5248971882294, 835.2566216067698, 864.5417928497894, 1117.3798541809297, 1153.6885041038915, 29809.701902980963, 39673.40489892651, 40293.39559906604, 40460.59539404605, 40514.59485405149, 40785.38821917673, 41005.0, 41286.0, 41359.58640413595, 41369.0, 7411.925880741178, 7474.103107627092, 7608.163102058769, 7623.0, 7648.120466146381, 7356.74251401201, 7519.7368092116785, 7559.206283340252, 7559.773206803778, 7560.2439756024505, 7448.255174482562, 7500.0, 7504.137024242227, 7516.774496765079, 7529.247075292455, 7493.437992150583, 7533.0, 7533.35966442853, 7533.4349923755935, 7543.622818859035, 7451.366633836131, 7496.400287977003, 7513.060867391576, 7528.360089392409, 7556.055493063367, 36601.08497287562, 36760.81619591912, 36844.81577592122, 36864.0, 36914.261714765555, 3451.9827400863087, 3489.110276879405, 3497.2131270464197, 3498.475228715713, 3501.719862411001, 30580.54129188064, 30790.230244244074, 30807.537886931714, 30813.69186308153, 30955.845220773754, 4609.354690343354, 4788.114198873185, 4788.401449818773, 4805.279208118775, 4813.78337974792, 189861.050694747, 189939.0, 191142.0, 191145.0, 191565.0, 48181.27728084011, 48331.27503087457, 48467.5153248463, 48507.0, 48571.75714121407, 50421.49578504241, 50481.0, 50667.23999140016, 50726.239106413435, 50868.491315087114, 12337.259764414164, 14812.0, 15006.624834379229, 15043.924780376028, 15113.924430377778, 10000.899991000142, 12075.154739168349, 12242.81635775464, 12245.08161887862, 12247.142700010914, 14470.0, 14501.12993220389, 14508.492202772852, 14510.492132775302, 14704.30900446441, 5667.0, 5841.474267315962, 5900.20347253124, 5981.431763982415, 6063.151158837766, 975.4439969217619, 987.5753426026733, 998.8601595776597, 1016.364772017489, 1016.4917541229386, 22802.543949120925, 22888.198913038297, 23000.4249893754, 23400.64899026516, 23482.500661246842, 1071.12703146935, 1083.9620613278655, 1091.7652704668535, 1104.376027544435, 1111.572044762772, 11811.704707382212, 12017.0, 12104.576339828063, 12188.695282617828, 12288.2012669178, 211162.0, 212111.0, 212350.0, 212574.0, 213380.0, 51481.742591286806, 51578.22632660513, 51833.481665182866, 51890.22164667533, 51947.480525195024, 1434.1968497641353, 1467.8899082568637, 1475.4172102019643, 1477.9556613301834, 1488.404638144729, 22302.21942232014, 22705.432364191027, 22809.0, 22903.19838805634, 22936.0, 37311.0, 37443.43834842425, 37461.62538374581, 37475.625243747214, 37479.31343089622, 185958.0, 186055.0697246505, 186170.0, 186686.0, 187019.0, 33134.171645708084, 34736.652633474354, 35604.46593301155, 35727.82136089303, 35751.10622234465, 43149.0, 44744.105117898114, 44944.55055449404, 45125.54874451213, 45545.31682024706, 29757.0, 31258.0, 31491.212719681276, 31639.20901977377, 32282.35435291234, 31270.53094203543, 32131.51802723008, 32148.83925580357, 32259.67740322567, 32386.514202287457, 36516.634833651326, 36620.26759464743, 36716.63283367132, 36732.632673672924, 36865.63134368622, 29560.0, 31580.368392632477, 31767.0, 32311.51532726964, 32345.676543234265, 22178.0, 24188.0, 24235.515289693754, 24276.66478343708, 24481.265562033168], "value": 16886.945469402333, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2016560452605, 582.208196852281, 582.8338923406827, 585.7422733997041, 600.9248843894513, 21817.345479635616, 22595.096196152153, 22709.318720438372, 22732.0, 23551.882240588817, 26060.34849128773, 26623.733762662367, 26650.73349266507, 26662.466750664975, 26670.733292667068, 6464.353564643533, 6658.234303055138, 6658.4673226141795, 6659.5671281366795, 6673.065770792093, 5890.793822216223, 6201.751929922798, 6457.128287681174, 6498.0, 6517.217933847921, 6439.22729272488, 6447.129637498924, 6451.967740161293, 6452.3225061368585, 6453.386928241809, 6442.6134431934, 6463.095166676669, 6486.643234622094, 6487.967560162169, 6493.220813502387, 6014.1580178775, 6022.367651396584, 6045.365236650133, 6047.939520604826, 6049.818505444844, 26350.341241468926, 29001.56497652537, 29253.268668283465, 29640.851795740884, 30264.697353026408, 1870.7474490943684, 1919.8368138708227, 1920.039980009995, 1922.2791453205048, 1922.7019811929033, 17689.29242830285, 18762.24951001958, 18907.62184756311, 18945.43163705091, 18972.241110355568, 2373.335466069503, 2384.880755962195, 2420.1408499982604, 2439.2682195341504, 2444.0590372706456, 120838.39580802128, 123944.0, 125044.0, 125296.37351813182, 125322.0, 14156.36296366666, 15054.849451505565, 15111.31999060045, 15277.770833437507, 15422.845771542365, 23261.53476930452, 23417.882910585337, 23457.765422345557, 23492.295231143093, 23511.0, 9715.368501047551, 9942.204623630092, 10128.848067278997, 10132.594696212216, 10236.692899213036, 7533.962330188314, 9000.18998290144, 9096.81806363869, 9121.635134594675, 9285.860712089325, 7697.923020769833, 9041.77395565116, 9075.81848363029, 9206.17144457002, 9262.212711919428, 2721.251655794633, 2737.7262273772462, 2745.6018877263086, 2782.721727827201, 2842.332051967786, 906.7551761024487, 936.1481052242563, 940.7695114696943, 973.6446197137993, 975.858500517421, 19081.713774293396, 19386.80613193878, 20529.589408211752, 23092.7690723094, 24886.875565622056, 1016.5933626549439, 1028.84052971788, 1030.2324768047852, 1046.5813674530098, 1059.4173204737363, 11167.664970050912, 11312.208145429906, 11686.94156529212, 11691.883081169079, 11760.823587646191, 496993.0, 497584.0, 497846.0, 499945.0, 505557.0, 120295.39852300682, 122261.38869305774, 123905.0, 124802.0, 126292.0, 1199.5801469485784, 1216.7444836584416, 1248.5380409248637, 1254.3038613569556, 1264.2288204195434, 19763.308284209983, 20079.29722459707, 21243.0, 22014.779852201915, 22439.5512089754, 61086.38913610807, 61294.38705612887, 61851.07223391563, 62890.371096290284, 63284.683576581825, 69631.6518417425, 70277.64861175661, 70743.29256707572, 70963.0, 72349.27650723635, 14550.4907328243, 14770.187639679922, 14796.926015369854, 14859.628509287355, 14862.33119509603, 22488.100475980777, 22488.550228995657, 22515.43711407228, 22672.659910101032, 22937.65593516132, 18007.729884052012, 18075.0, 18342.532597392445, 18403.90798046001, 18436.07819609041, 15396.923015384851, 15838.60403489922, 15863.920680396986, 15959.281832317341, 16721.581960451087, 18165.0, 18187.727184091986, 18527.907360463112, 19422.0, 19530.31643892457, 14433.0, 14461.927690361481, 14603.488877889224, 14606.342714578082, 14612.0, 17064.744028839825, 17918.372856949944, 17940.372086976895, 18019.459416217534, 18048.90975545114], "value": 11999.713717983186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.5251785616106, 1398.6013986013988, 1419.4393214680194, 1426.2227086237997, 1426.586289975907, 13449.26029068401, 14098.083624564422, 14099.929500352497, 14104.224267665288, 14129.152250864956, 11675.883241167587, 12131.211471254363, 12132.81800772987, 13645.113067650596, 14086.154830710164, 2649.218480548243, 2711.7288271172824, 2713.796465265103, 2713.91858244253, 2715.1311580294314, 2616.738326167387, 2661.0420248710548, 2690.3946612012337, 2695.8247713898536, 2696.5281075811754, 2501.9124330648433, 2622.8426294422397, 2624.370151163726, 2628.986855065722, 2631.5657916443765, 2638.9076382326525, 2662.7071022187642, 2675.2108128102063, 2692.488427198836, 2693.4747724193694, 2536.5307418127704, 2544.274881658718, 2549.056848965876, 2549.1842610364693, 2550.923472295834, 13633.659158521017, 13854.376553055137, 13855.653608659763, 13856.376463059187, 13905.443782248698, 7548.547087174732, 7857.6856925722905, 7859.960700196462, 7863.252990965849, 7863.764087077397, 4170.72890262132, 5216.113260745682, 5236.607254455931, 5349.7057661828585, 5356.758945847408, 1698.898066116037, 1715.408184176457, 1721.2340508473735, 1784.5627821183764, 1786.2319202742815, 22659.32022039325, 22874.199403020983, 22924.19765308206, 22930.19744308941, 22938.770612293996, 6563.343665633494, 6568.86862262752, 6608.603483790988, 6773.187217533928, 6808.0, 15138.924305378623, 15670.294836732146, 15682.68634627301, 15854.762178567331, 15886.841131588537, 7414.925850741532, 7575.734849280359, 7627.161012288644, 7632.542047477169, 7638.159802421729, 6971.442284617218, 6982.61595612236, 7004.089468369079, 7252.274772522811, 7270.382017528464, 5056.82301119459, 5241.899201167721, 5249.842504724865, 5275.630705850554, 5319.46805319465, 1507.7889095526634, 1522.9923850380678, 1524.336913442656, 1525.8169019717704, 1537.6155961009747, 811.363079982223, 830.6345208108413, 832.1512057701111, 853.7481442974338, 863.5725315968635, 6472.255690595548, 6649.567778094409, 6737.124173857367, 6755.594664320157, 6776.322367763184, 685.143570536829, 711.8042538302009, 712.4905692429937, 737.5095561451682, 742.1242933338713, 4382.0, 4750.311204875274, 4778.593819525309, 5187.974060129675, 5208.531232189045, 18778.154983025797, 19240.134193961305, 19261.940593267223, 19290.61418771645, 19416.4175074748, 18731.438056858315, 18747.81252187488, 19517.414477565697, 19579.804201958083, 19601.509962250773, 10643.935606439449, 10775.299605525615, 10903.563857445613, 10949.288296260718, 10962.068224200873, 7363.668634911549, 7706.383489320729, 7773.1060927994, 7828.804279893048, 7967.0, 16813.91593042027, 16862.0, 17004.404845830337, 17088.91455542714, 17857.642847143245, 16472.505824825275, 17286.0, 17467.30130794754, 17818.0, 17950.91024544869, 11347.48936297852, 11842.76314473723, 11870.109741769229, 11871.76256474883, 11904.285742855456, 12919.806202907152, 12941.935290323489, 13011.414486347947, 13085.542006029744, 13090.214587124803, 10297.9485102574, 10649.89350106489, 10794.838077429002, 10883.0, 10956.068734157687, 9945.154661853823, 10363.740906477398, 10587.947060264958, 10641.308314959502, 10692.572297108029, 8724.476531408136, 8888.86666700013, 8892.688755893512, 8899.688510902088, 8947.194752472049, 6626.91252255538, 6723.327667233238, 6736.427403670743, 6741.157355330583, 6864.656767161522, 6327.3988971047675, 6331.195609251341, 6466.51501137426, 6513.7068831903625, 6537.05212744159], "value": 6216.230181670221, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.7526748991759, 495.4475759528125, 516.6796586116608, 519.8908229271852, 531.4711861697612, 6058.575899687024, 6214.689265536722, 6251.499880009594, 6315.336889626592, 6333.240011198651, 6029.427204415584, 6069.57512974092, 6101.267847858252, 6117.204763380754, 6189.566730328879, 4908.631852611068, 4914.5085491450745, 4945.28293397458, 4961.479044700309, 4962.528559786832, 4820.542048505386, 4846.715620360607, 4851.611871050325, 4885.804567817283, 4942.431620363668, 4878.292647566101, 4885.340479035338, 4912.533309335608, 4923.77842997066, 4930.654854160211, 4841.845378806433, 4849.739067842351, 4902.779374928136, 4916.680415772963, 4954.653174277802, 4356.542563030868, 4419.867403977853, 4434.334849772527, 4466.8436604719, 4475.641948644101, 6058.394160583906, 6117.388261173892, 6123.571350005502, 6129.662868542228, 6145.201123853871, 5682.374938756733, 5696.8006119785605, 5705.857353566194, 5711.514521265656, 5730.312362516524, 6458.903116453257, 6477.0, 6481.74073037078, 6529.347065293433, 6573.145491086176, 4789.161896668069, 4842.0, 4854.757262136879, 4881.975590122062, 4888.682235654706, 6892.551984121016, 6917.723291068301, 6925.480588955798, 6962.930370696329, 7021.543599666056, 4910.337104490919, 4918.975405122951, 4932.802687892516, 4961.355023846877, 4962.875928101754, 4960.280759289883, 4991.575716064175, 5034.798608055637, 5048.62135339851, 5058.620603454682, 5651.350094739076, 5666.914996275059, 5668.688222147739, 5687.8862422752145, 5710.8001219957105, 6462.192225971754, 6585.649941761927, 6609.735610575619, 6615.636140012345, 6642.468602511787, 1643.6712657468315, 1661.7341225403877, 1695.7541156532234, 1696.245170898938, 1761.4539492757285, 1184.1474138620179, 1196.5034510678145, 1218.9634310970685, 1222.5293262094158, 1224.400043978462, 5679.858003549944, 5694.971525142348, 5708.571857110734, 5713.400092990176, 5808.535317174616, 6427.55007149495, 6677.29888361715, 6736.7642132525125, 6737.393634572912, 6741.730330786713, 5675.858103547362, 5741.7655204131315, 5756.481916627524, 5767.5674324425, 5783.739731712083, 3516.6460912548855, 3600.595767650618, 3609.1338078860886, 3632.4914511968345, 3656.323580137683, 6534.346565343428, 6555.541112122201, 6617.305182955816, 6671.966640166768, 6675.165604299463, 6935.895961560581, 6958.617276049765, 6970.233274339818, 6994.61529615876, 6997.510174287751, 6340.175777149033, 6370.85324641569, 6468.870622587522, 6496.285408604956, 6518.348165183538, 6758.357955994173, 6771.356721111487, 6814.080099186546, 6840.0, 6861.2109607393795, 6717.56335838169, 6760.391564759196, 6772.356626120511, 6775.49183811226, 6781.6270105144695, 6459.192600924885, 6480.740770369321, 6525.412712855866, 6615.536912416084, 6617.0, 4887.413510378778, 4915.95084049155, 4932.630052745986, 4946.307516947558, 4995.600351971906, 6481.675916204265, 6681.899771503334, 6726.596404215763, 6751.324867513209, 6776.593404395752, 6347.587406818542, 6364.268109167505, 6367.61794292344, 6480.546361754632, 6509.880712130582, 6401.391867772554, 6446.484281257582, 6509.218893732783, 6510.902336464862, 6521.804345869631, 6250.531210159347, 6436.935630643821, 6437.098806167234, 6477.740890364333, 6512.381323774234, 6379.170707807955, 6519.869602607826, 6528.575642583217, 6643.847595252967, 6667.799966001027, 6306.810795676137, 6380.553361264667, 6395.712192951235, 6449.258335291502, 6463.806085817433], "value": 5035.346992564793, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.1490106750189, 915.1031988651122, 932.6735642525122, 939.0656296984502, 949.7578117580016, 17750.289988400466, 18721.812781872177, 18743.43769686908, 18749.71875421868, 18765.7185142223, 18359.357422490215, 19825.900870495665, 19945.601087978233, 20007.1997120115, 20074.0, 1031.6079889641926, 1049.3284298049255, 1056.3820165203326, 1057.7778666480049, 1059.3643813711749, 973.5083782689767, 1040.4225654761603, 1047.3820445936897, 1054.894510548943, 1062.7077553672725, 1109.7003808971613, 1112.3159257056893, 1112.9944350278279, 1114.320264638574, 1114.9331040137577, 1103.4923934989833, 1103.9724006899812, 1107.9002889739922, 1109.7447587054983, 1110.1784679337272, 811.3914564076942, 814.1288820961573, 814.2305521282391, 815.2866242038217, 817.3624572833199, 18413.815861841344, 18918.148683309286, 19279.710804337945, 19482.610347793106, 19534.90232548828, 19129.904350478297, 19326.903365483224, 19379.0, 19756.012199390116, 19910.20359185631, 14008.579742607739, 15010.47463338778, 15157.166355850424, 15187.0, 15247.923760381238, 3488.773229740059, 3519.6304388039143, 3533.6466353364717, 3564.3940530109685, 3564.9108772280642, 117150.41424792906, 121107.0, 124839.0, 127806.0, 128844.3557782205, 15586.220688965506, 16158.949668271525, 16505.17474126289, 16507.0, 16512.917435412986, 29007.85496072506, 29352.0, 29627.259318517208, 29628.555571666442, 29657.703422965493, 8304.792380190544, 8414.453060551044, 8428.115047920002, 8449.57752112392, 8504.829903401896, 4225.0, 4374.671899607479, 4374.759388233678, 4382.298832186835, 4383.1452866691325, 4783.760811959388, 5062.949370506321, 5377.946220537823, 5935.52515798735, 5941.762329506858, 1082.99458502707, 1118.4910865556153, 1147.4836323654388, 1148.093006524836, 1149.2931846914087, 614.7940439952577, 623.6975067092457, 655.5411212151417, 655.5968079631087, 669.7254125808395, 10936.45317734126, 11316.0, 11740.471678774476, 11764.647060588197, 11887.88112118885, 655.8884989551788, 685.5098604497708, 686.9278725733826, 693.1578132568953, 702.4801646781447, 5159.432462429129, 5504.80733174337, 5526.861828454241, 5583.581231407661, 5742.368339482654, 90669.54665226763, 94254.52872735729, 98586.5070674642, 99237.50381248047, 100451.0, 87009.56495217483, 87216.56391718001, 89832.0, 89872.0, 90177.54911225534, 79013.20986790059, 80874.0, 81788.18211817925, 83260.75108873371, 84132.0, 11059.889401105886, 11333.433328333715, 11861.0, 12090.0, 12659.98720102408, 34370.48444273288, 35128.0, 35134.64865351314, 36896.0, 37191.6280837199, 62202.37797622147, 63044.0, 65113.674431627536, 67484.66257668876, 70001.29998700152, 17804.732929006335, 18389.172487238375, 18487.260509579468, 18506.722399164293, 18507.0, 20008.699869501677, 20152.59694806125, 20262.59474810525, 20360.490987724832, 21224.469388265417, 17076.74384884203, 17624.206910688794, 17980.730289045936, 18109.728354074963, 18388.172532235814, 17608.647827043133, 17624.55938601545, 17644.73532897033, 17652.82347176563, 17855.37506187277, 17266.740998885278, 17862.106894655477, 18094.909525452287, 18423.53941151482, 18638.440846774618, 12790.68023299425, 13176.47294108225, 13206.735865282833, 13217.933910330386, 13385.799213011618, 12845.550405735754, 13061.477540898257, 13634.18194908269, 13774.348533801556, 13884.097533660684], "value": 8969.703538125117, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 104.0, 110.0, 111.0, 108.0, 111.0, 100.0, 111.0, 110.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 141.0, 175.0, 120.0, 145.0, 149.0, 123.0, 169.0, 122.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 165.0, 163.0, 162.0, 168.0, 169.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 76.0, 188.0, 77.0, 78.0, 76.0, 75.0, 178.0, 75.0], "value": 98.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 134.0, 81.0, 78.0, 80.0, 122.0, 81.0, 79.0, 124.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 152.0, 151.0, 151.0, 159.0, 149.0, 151.0, 151.0, 153.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 98.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 89.0, 84.0, 81.0, 82.0, 80.0, 82.0, 88.0, 80.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 133.0, 128.0, 128.0, 128.0, 128.0, 126.0, 134.0, 146.0, 170.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 180.0, 182.0, 181.0, 183.0, 183.0, 188.0, 182.0, 190.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 69.0, 68.0, 67.0, 73.0], "value": 67.9, "unit": "score"}]}]} 10:27:45 INFO - Return code: 0 10:27:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:27:45 INFO - # TBPL SUCCESS # 10:27:45 INFO - Running post-action listener: _package_coverage_data 10:27:45 INFO - Running post-action listener: _resource_record_post_action 10:27:45 INFO - [mozharness: 2017-08-01 17:27:45.793292Z] Finished run-tests step (success) 10:27:45 INFO - Running post-run listener: _resource_record_post_run 10:27:45 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 53248; Write bytes: 448724992; Read time: 408; Write time: 278336 10:27:45 INFO - TinderboxPrint: CPU usage
13.1% 10:27:45 INFO - TinderboxPrint: I/O read bytes / time
53,248 / 408 10:27:45 INFO - TinderboxPrint: I/O write bytes / time
448,724,992 / 278,336 10:27:45 INFO - TinderboxPrint: CPU idle
8,256.3 (86.9%) 10:27:45 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 10:27:45 INFO - TinderboxPrint: Swap in / out
0 / 0 10:27:45 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 121106432; Read time: 180; Write time: 88612 10:27:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:27:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 40960; Write bytes: 327618560; Read time: 208; Write time: 189724 10:27:46 INFO - Running post-run listener: _upload_blobber_files 10:27:46 INFO - Blob upload gear active. 10:27:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27:46 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 10:27:46 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:27:46 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:27:46 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:27:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:27:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:47 INFO - (blobuploader) - INFO - Done attempting. 10:27:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:27:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:27:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:53 INFO - (blobuploader) - INFO - Done attempting. 10:27:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:27:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:54 INFO - (blobuploader) - INFO - Done attempting. 10:27:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:55 INFO - (blobuploader) - INFO - Done attempting. 10:27:55 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:55 INFO - Return code: 0 10:27:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/15f53005d927cde2c3602cdc132f52415a286393bd4abc816e285834b2f63b760a0c41fd7dc7f4174b6ef66899cccbb3e0b18d4e74b6d09744789dc3269f0cb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/7c78764509039f0bc1949503955bad510a0e11c02436456bfde295889ab5938e336f659fed44f45bb49e1bf9d9a18858631470556e4eea8813075addc97b5ad3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/526188211c58df5a23f4743b89f01f5d2ad5267c25f06bfb5def0e1efdc9cc602c7b20d567c910cbd81c53a8e0b1cad9d161f8eaeb6673439733366edc2c5a44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8f4cb0fcfcfdabf0404d5a7b0058325746a212edc3521b4bfa74ab33bd689d4cf2f94947a67a19b08816932898d5668444bb0c556cb78422a302680bb2a863f0"} 10:27:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:55 INFO - Contents: 10:27:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/15f53005d927cde2c3602cdc132f52415a286393bd4abc816e285834b2f63b760a0c41fd7dc7f4174b6ef66899cccbb3e0b18d4e74b6d09744789dc3269f0cb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/7c78764509039f0bc1949503955bad510a0e11c02436456bfde295889ab5938e336f659fed44f45bb49e1bf9d9a18858631470556e4eea8813075addc97b5ad3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/526188211c58df5a23f4743b89f01f5d2ad5267c25f06bfb5def0e1efdc9cc602c7b20d567c910cbd81c53a8e0b1cad9d161f8eaeb6673439733366edc2c5a44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8f4cb0fcfcfdabf0404d5a7b0058325746a212edc3521b4bfa74ab33bd689d4cf2f94947a67a19b08816932898d5668444bb0c556cb78422a302680bb2a863f0"} 10:27:55 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:55 INFO - Copying logs to upload dir... 10:27:55 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.252023 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-01 10:27:55.655566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 10:27:55.663349) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/15f53005d927cde2c3602cdc132f52415a286393bd4abc816e285834b2f63b760a0c41fd7dc7f4174b6ef66899cccbb3e0b18d4e74b6d09744789dc3269f0cb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/7c78764509039f0bc1949503955bad510a0e11c02436456bfde295889ab5938e336f659fed44f45bb49e1bf9d9a18858631470556e4eea8813075addc97b5ad3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/526188211c58df5a23f4743b89f01f5d2ad5267c25f06bfb5def0e1efdc9cc602c7b20d567c910cbd81c53a8e0b1cad9d161f8eaeb6673439733366edc2c5a44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8f4cb0fcfcfdabf0404d5a7b0058325746a212edc3521b4bfa74ab33bd689d4cf2f94947a67a19b08816932898d5668444bb0c556cb78422a302680bb2a863f0"} build_url:https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011530 build_url: 'https://queue.taskcluster.net/v1/task/SoyM-Uw2TWqOFF86MmQaog/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/15f53005d927cde2c3602cdc132f52415a286393bd4abc816e285834b2f63b760a0c41fd7dc7f4174b6ef66899cccbb3e0b18d4e74b6d09744789dc3269f0cb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/7c78764509039f0bc1949503955bad510a0e11c02436456bfde295889ab5938e336f659fed44f45bb49e1bf9d9a18858631470556e4eea8813075addc97b5ad3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/526188211c58df5a23f4743b89f01f5d2ad5267c25f06bfb5def0e1efdc9cc602c7b20d567c910cbd81c53a8e0b1cad9d161f8eaeb6673439733366edc2c5a44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8f4cb0fcfcfdabf0404d5a7b0058325746a212edc3521b4bfa74ab33bd689d4cf2f94947a67a19b08816932898d5668444bb0c556cb78422a302680bb2a863f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 10:27:55.690617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 10:27:55.690917) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1501607218.903702-360314536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 10:27:55.771133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 10:27:55.771487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 10:27:55.771871) ========= ========= Total master_lag: 0.32 =========