builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1501768925.38 results: success (0) revision: fa1da3c0b200abbd9cfab3cab19962824314044e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:05.381438) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:05.381923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:05.382218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:05.401454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:05.401830) ========= 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=62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 07:02:05-- 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% 54.5M=0s 2017-08-03 07:02:05 (54.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089093 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:05.504161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:05.504503) ========= 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=62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020034 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:05.560503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:05.560867) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fa1da3c0b200abbd9cfab3cab19962824314044e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev fa1da3c0b200abbd9cfab3cab19962824314044e --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=62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 07:02:05,677 truncating revision to first 12 chars 2017-08-03 07:02:05,677 Setting DEBUG logging. 2017-08-03 07:02:05,677 attempt 1/10 2017-08-03 07:02:05,677 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fa1da3c0b200?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 07:02:06,052 unpacking tar archive at: mozilla-central-fa1da3c0b200/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688227 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:06.266604) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:06.266945) ========= script_repo_revision: fa1da3c0b200abbd9cfab3cab19962824314044e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:06.267340) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:06.267650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 07:02:06.276075) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-03 07:02:06.276350) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:02:06 INFO - MultiFileLogger online at 20170803 07:02:06 in /builds/slave/test 07:02:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:02:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:02:06 INFO - {'append_to_log': False, 07:02:06 INFO - 'base_work_dir': '/builds/slave/test', 07:02:06 INFO - 'blob_upload_branch': 'Firefox', 07:02:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:02:06 INFO - 'branch': 'Firefox', 07:02:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:02:06 INFO - 'code_coverage': False, 07:02:06 INFO - 'config_files': ('talos/linux_config.py',), 07:02:06 INFO - 'default_actions': ('clobber', 07:02:06 INFO - 'read-buildbot-config', 07:02:06 INFO - 'download-and-extract', 07:02:06 INFO - 'populate-webroot', 07:02:06 INFO - 'create-virtualenv', 07:02:06 INFO - 'install', 07:02:06 INFO - 'setup-mitmproxy', 07:02:06 INFO - 'run-tests'), 07:02:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:02:06 INFO - 'disable_ccov_upload': False, 07:02:06 INFO - 'download_minidump_stackwalk': True, 07:02:06 INFO - 'download_symbols': 'ondemand', 07:02:06 INFO - 'enable_stylo': False, 07:02:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:02:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:02:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:02:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:02:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:02:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:02:06 INFO - 'gecko_profile': False, 07:02:06 INFO - 'gecko_profile_interval': 0, 07:02:06 INFO - 'installer_path': 'installer.exe', 07:02:06 INFO - 'log_level': 'info', 07:02:06 INFO - 'log_name': 'talos', 07:02:06 INFO - 'log_to_console': True, 07:02:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:02:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:02:06 INFO - 'opt_config_files': (), 07:02:06 INFO - 'pip_index': False, 07:02:06 INFO - 'suite': 'dromaeojs-e10s', 07:02:06 INFO - 'system_bits': '32', 07:02:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:02:06 INFO - 'title': 'talos-linux64-ix-018', 07:02:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:02:06 INFO - 'use_talos_json': True, 07:02:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:02:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:02:06 INFO - 'work_dir': 'build'} 07:02:06 INFO - [mozharness: 2017-08-03 14:02:06.487287Z] Running clobber step. 07:02:06 INFO - Running pre-action listener: _resource_record_pre_action 07:02:06 INFO - Running main action method: clobber 07:02:06 INFO - rmtree: /builds/slave/test/build 07:02:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:02:07 INFO - Running post-action listener: _resource_record_post_action 07:02:07 INFO - [mozharness: 2017-08-03 14:02:07.524952Z] Finished clobber step (success) 07:02:07 INFO - [mozharness: 2017-08-03 14:02:07.525055Z] Running read-buildbot-config step. 07:02:07 INFO - Running pre-action listener: _resource_record_pre_action 07:02:07 INFO - Running main action method: read_buildbot_config 07:02:07 INFO - Using buildbot properties: 07:02:07 INFO - { 07:02:07 INFO - "project": "", 07:02:07 INFO - "product": "firefox", 07:02:07 INFO - "who": "axel@mozilla.com", 07:02:07 INFO - "installer_path": "public/build/target.tar.bz2", 07:02:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 07:02:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:02:07 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 07:02:07 INFO - "stage_platform": "linux64-stylo", 07:02:07 INFO - "basedir": "/builds/slave/test", 07:02:07 INFO - "buildnumber": 14, 07:02:07 INFO - "platform": "ubuntu64_hw_stylo", 07:02:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:02:07 INFO - "slavebuilddir": "test", 07:02:07 INFO - "taskId": "SMLZuke1SHOGBpBjMXS0JA", 07:02:07 INFO - "branch": "mozilla-central", 07:02:07 INFO - "script_repo_revision": "production", 07:02:07 INFO - "revision": "fa1da3c0b200abbd9cfab3cab19962824314044e", 07:02:07 INFO - "slavename": "talos-linux64-ix-018", 07:02:07 INFO - "repo_path": "mozilla-central" 07:02:07 INFO - } 07:02:07 INFO - Finding installer, test and symbols from parent task. 07:02:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SMLZuke1SHOGBpBjMXS0JA'}, attempt #1 07:02:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SMLZuke1SHOGBpBjMXS0JA'}, attempt #1 07:02:08 INFO - Task dependencies: am3KdoAISBKA1Cb3driNbg 07:02:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg'}, attempt #1 07:02:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 07:02:08 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.test_packages.json 07:02:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.crashreporter-symbols.zip 07:02:08 INFO - Running post-action listener: _resource_record_post_action 07:02:08 INFO - [mozharness: 2017-08-03 14:02:08.883892Z] Finished read-buildbot-config step (success) 07:02:08 INFO - [mozharness: 2017-08-03 14:02:08.884114Z] Running download-and-extract step. 07:02:08 INFO - Running pre-action listener: _resource_record_pre_action 07:02:08 INFO - Running main action method: download_and_extract 07:02:08 INFO - mkdir: /builds/slave/test/build/tests 07:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:08 INFO - trying https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.test_packages.json 07:02:08 INFO - Downloading https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:02:09 INFO - Downloaded 989 bytes. 07:02:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:02:09 INFO - Using the following test package requirements: 07:02:09 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:02:09 INFO - u'common': [u'target.common.tests.zip'], 07:02:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:02:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:02:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:02:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:02:09 INFO - u'mozbase': [u'target.common.tests.zip'], 07:02:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:02:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:02:09 INFO - u'web-platform': [u'target.common.tests.zip', 07:02:09 INFO - u'target.web-platform.tests.tar.gz'], 07:02:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:02:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:02:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip 07:02:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:02:09 INFO - Fetch https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip into memory 07:02:10 INFO - Content-Length response header: 54278210 07:02:10 INFO - Bytes received: 54278210 07:02:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:02:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip 07:02:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:02:21 INFO - Fetch https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.common.tests.zip into memory 07:02:22 INFO - Content-Length response header: 54278210 07:02:22 INFO - Bytes received: 54278210 07:02:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.talos.tests.zip 07:02:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:02:34 INFO - Fetch https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.talos.tests.zip into memory 07:02:35 INFO - Content-Length response header: 14496464 07:02:35 INFO - Bytes received: 14496464 07:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:35 INFO - trying https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 07:02:35 INFO - Downloading https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:02:36 INFO - Downloaded 62111745 bytes. 07:02:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 07:02:36 INFO - mkdir: /builds/slave/test/properties 07:02:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:02:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:02:36 INFO - Contents: 07:02:36 INFO - build_url:https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 07:02:36 INFO - Running post-action listener: _resource_record_post_action 07:02:36 INFO - Running post-action listener: set_extra_try_arguments 07:02:36 INFO - [mozharness: 2017-08-03 14:02:36.458194Z] Finished download-and-extract step (success) 07:02:36 INFO - [mozharness: 2017-08-03 14:02:36.458292Z] Running populate-webroot step. 07:02:36 INFO - Running pre-action listener: _resource_record_pre_action 07:02:36 INFO - Running main action method: populate_webroot 07:02:36 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:02:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:02:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:02:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:02:36 INFO - 'tests': ['damp', 'tps']}, 07:02:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:02:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:02:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:02:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:02:36 INFO - 'other-e10s': {'tests': ['a11yr', 07:02:36 INFO - 'ts_paint', 07:02:36 INFO - 'tpaint', 07:02:36 INFO - 'sessionrestore', 07:02:36 INFO - 'sessionrestore_many_windows', 07:02:36 INFO - 'sessionrestore_no_auto_restore', 07:02:36 INFO - 'tabpaint']}, 07:02:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:02:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:02:36 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:02:36 INFO - 'talos_options': ['--mitmproxy', 07:02:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:02:36 INFO - '--firstNonBlankPaint'], 07:02:36 INFO - 'tests': ['quantum_pageload_google', 07:02:36 INFO - 'quantum_pageload_youtube', 07:02:36 INFO - 'quantum_pageload_amazon', 07:02:36 INFO - 'quantum_pageload_facebook']}, 07:02:36 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:02:36 INFO - 'talos_options': ['--stylo', 07:02:36 INFO - '--mitmproxy', 07:02:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:02:36 INFO - '--firstNonBlankPaint'], 07:02:36 INFO - 'tests': ['quantum_pageload_google', 07:02:36 INFO - 'quantum_pageload_youtube', 07:02:36 INFO - 'quantum_pageload_amazon', 07:02:36 INFO - 'quantum_pageload_facebook']}, 07:02:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:02:36 INFO - 'tsvgr_opacity', 07:02:36 INFO - 'tart', 07:02:36 INFO - 'tscrollx', 07:02:36 INFO - 'cart', 07:02:36 INFO - 'tsvg_static']}, 07:02:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:02:36 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:02:36 INFO - 'talos_options': ['--stylo', 07:02:36 INFO - '--stylo-threads=1', 07:02:36 INFO - '--mitmproxy', 07:02:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:02:36 INFO - '--firstNonBlankPaint'], 07:02:36 INFO - 'tests': ['tp6_google', 07:02:36 INFO - 'tp6_youtube', 07:02:36 INFO - 'tp6_amazon', 07:02:36 INFO - 'tp6_facebook']}, 07:02:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:02:36 INFO - 'talos_options': ['--xperf_path', 07:02:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:36 INFO - 'tests': ['tp5n']}}} 07:02:36 INFO - Running post-action listener: _resource_record_post_action 07:02:36 INFO - [mozharness: 2017-08-03 14:02:36.466888Z] Finished populate-webroot step (success) 07:02:36 INFO - [mozharness: 2017-08-03 14:02:36.466978Z] Running create-virtualenv step. 07:02:36 INFO - Running pre-action listener: _resource_record_pre_action 07:02:36 INFO - Running main action method: create_virtualenv 07:02:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:02:36 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 07:02:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:02:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:02:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:02:36 INFO - Using real prefix '/usr' 07:02:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:02:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:02:39 INFO - Installing pip.................done. 07:02:39 INFO - Return code: 0 07:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:02:39 INFO - Reading from file tmpfile_stdout 07:02:39 INFO - Output received: 07:02:39 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) 07:02:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02: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')]} 07:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02: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', 'pip>=1.5'] in /builds/slave/test/build 07:02: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 pip>=1.5 07:02:39 INFO - Using env: {'DISPLAY': ':0', 07:02:39 INFO - 'HOME': '/home/cltbld', 07:02:39 INFO - 'LANG': 'en_US.UTF-8', 07:02:39 INFO - 'LANGUAGE': 'en_US:en', 07:02:39 INFO - 'LOGNAME': 'cltbld', 07:02:39 INFO - 'MAIL': '/var/mail/cltbld', 07:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:39 INFO - 'MOZ_NO_REMOTE': '1', 07:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:39 INFO - 'NO_EM_RESTART': '1', 07:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:39 INFO - 'PWD': '/builds/slave/test', 07:02:39 INFO - 'SHELL': '/bin/bash', 07:02:39 INFO - 'SHLVL': '1', 07:02:39 INFO - 'TERM': 'linux', 07:02:39 INFO - 'TMOUT': '86400', 07:02:39 INFO - 'USER': 'cltbld', 07:02:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:39 INFO - '_': '/tools/buildbot/bin/python'} 07:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:39 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 07:02:39 INFO - Cleaning up... 07:02:39 INFO - Return code: 0 07:02:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02: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')]} 07:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02: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', '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 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:02: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 psutil>=3.1.1 07:02:39 INFO - Using env: {'DISPLAY': ':0', 07:02:39 INFO - 'HOME': '/home/cltbld', 07:02:39 INFO - 'LANG': 'en_US.UTF-8', 07:02:39 INFO - 'LANGUAGE': 'en_US:en', 07:02:39 INFO - 'LOGNAME': 'cltbld', 07:02:39 INFO - 'MAIL': '/var/mail/cltbld', 07:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:39 INFO - 'MOZ_NO_REMOTE': '1', 07:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:39 INFO - 'NO_EM_RESTART': '1', 07:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:39 INFO - 'PWD': '/builds/slave/test', 07:02:39 INFO - 'SHELL': '/bin/bash', 07:02:39 INFO - 'SHLVL': '1', 07:02:39 INFO - 'TERM': 'linux', 07:02:39 INFO - 'TMOUT': '86400', 07:02:39 INFO - 'USER': 'cltbld', 07:02:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:39 INFO - '_': '/tools/buildbot/bin/python'} 07:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:39 INFO - Downloading/unpacking psutil>=3.1.1 07:02: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 07:02: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 07:02: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 07:02: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 07:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:02:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:40 INFO - Installing collected packages: psutil 07:02:40 INFO - Running setup.py install for psutil 07:02:40 INFO - building 'psutil._psutil_linux' extension 07:02:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:02:41 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 07:02:41 INFO - building 'psutil._psutil_posix' extension 07:02:41 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 07:02:41 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 07:02:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:41 INFO - Successfully installed psutil 07:02:41 INFO - Cleaning up... 07:02:41 INFO - Return code: 0 07:02:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02: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')]} 07:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:02: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 mozsystemmonitor==0.3 07:02:41 INFO - Using env: {'DISPLAY': ':0', 07:02:41 INFO - 'HOME': '/home/cltbld', 07:02:41 INFO - 'LANG': 'en_US.UTF-8', 07:02:41 INFO - 'LANGUAGE': 'en_US:en', 07:02:41 INFO - 'LOGNAME': 'cltbld', 07:02:41 INFO - 'MAIL': '/var/mail/cltbld', 07:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:41 INFO - 'MOZ_NO_REMOTE': '1', 07:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:41 INFO - 'NO_EM_RESTART': '1', 07:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:41 INFO - 'PWD': '/builds/slave/test', 07:02:41 INFO - 'SHELL': '/bin/bash', 07:02:41 INFO - 'SHLVL': '1', 07:02:41 INFO - 'TERM': 'linux', 07:02:41 INFO - 'TMOUT': '86400', 07:02:41 INFO - 'USER': 'cltbld', 07:02:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:41 INFO - '_': '/tools/buildbot/bin/python'} 07:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:02: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 07:02: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 07:02: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 07:02: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 07:02:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:02:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:02:42 INFO - Installing collected packages: mozsystemmonitor 07:02:42 INFO - Running setup.py install for mozsystemmonitor 07:02:42 INFO - Successfully installed mozsystemmonitor 07:02:42 INFO - Cleaning up... 07:02:42 INFO - Return code: 0 07:02:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:02:42 INFO - Using env: {'DISPLAY': ':0', 07:02:42 INFO - 'HOME': '/home/cltbld', 07:02:42 INFO - 'LANG': 'en_US.UTF-8', 07:02:42 INFO - 'LANGUAGE': 'en_US:en', 07:02:42 INFO - 'LOGNAME': 'cltbld', 07:02:42 INFO - 'MAIL': '/var/mail/cltbld', 07:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:42 INFO - 'MOZ_NO_REMOTE': '1', 07:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:42 INFO - 'NO_EM_RESTART': '1', 07:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:42 INFO - 'PWD': '/builds/slave/test', 07:02:42 INFO - 'SHELL': '/bin/bash', 07:02:42 INFO - 'SHLVL': '1', 07:02:42 INFO - 'TERM': 'linux', 07:02:42 INFO - 'TMOUT': '86400', 07:02:42 INFO - 'USER': 'cltbld', 07:02:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:42 INFO - '_': '/tools/buildbot/bin/python'} 07:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:43 INFO - Downloading/unpacking jsonschema==2.5.1 07:02: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 07:02: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 07:02: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 07:02: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 07:02:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:02:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:44 INFO - Downloading functools32-3.2.3-2.tar.gz 07:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:02:44 INFO - warning: no files found matching '*.txt' 07:02:44 INFO - no previously-included directories found matching 'build' 07:02:44 INFO - no previously-included directories found matching 'dist' 07:02:44 INFO - no previously-included directories found matching '.git*' 07:02:44 INFO - Installing collected packages: jsonschema, functools32 07:02:44 INFO - Running setup.py install for functools32 07:02:44 INFO - warning: no files found matching '*.txt' 07:02:44 INFO - no previously-included directories found matching 'build' 07:02:44 INFO - no previously-included directories found matching 'dist' 07:02:44 INFO - no previously-included directories found matching '.git*' 07:02:44 INFO - Successfully installed jsonschema functools32 07:02:44 INFO - Cleaning up... 07:02:44 INFO - Return code: 0 07:02:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02: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')]} 07:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:02:44 INFO - Using env: {'DISPLAY': ':0', 07:02:44 INFO - 'HOME': '/home/cltbld', 07:02:44 INFO - 'LANG': 'en_US.UTF-8', 07:02:44 INFO - 'LANGUAGE': 'en_US:en', 07:02:44 INFO - 'LOGNAME': 'cltbld', 07:02:44 INFO - 'MAIL': '/var/mail/cltbld', 07:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:44 INFO - 'MOZ_NO_REMOTE': '1', 07:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:44 INFO - 'NO_EM_RESTART': '1', 07:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:44 INFO - 'PWD': '/builds/slave/test', 07:02:44 INFO - 'SHELL': '/bin/bash', 07:02:44 INFO - 'SHLVL': '1', 07:02:44 INFO - 'TERM': 'linux', 07:02:44 INFO - 'TMOUT': '86400', 07:02:44 INFO - 'USER': 'cltbld', 07:02:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:44 INFO - '_': '/tools/buildbot/bin/python'} 07:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:02:44 INFO - Cleaning up... 07:02:44 INFO - Return code: 0 07:02:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02: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')]} 07:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:02:44 INFO - Using env: {'DISPLAY': ':0', 07:02:44 INFO - 'HOME': '/home/cltbld', 07:02:44 INFO - 'LANG': 'en_US.UTF-8', 07:02:44 INFO - 'LANGUAGE': 'en_US:en', 07:02:44 INFO - 'LOGNAME': 'cltbld', 07:02:44 INFO - 'MAIL': '/var/mail/cltbld', 07:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:44 INFO - 'MOZ_NO_REMOTE': '1', 07:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:44 INFO - 'NO_EM_RESTART': '1', 07:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:44 INFO - 'PWD': '/builds/slave/test', 07:02:44 INFO - 'SHELL': '/bin/bash', 07:02:44 INFO - 'SHLVL': '1', 07:02:44 INFO - 'TERM': 'linux', 07:02:44 INFO - 'TMOUT': '86400', 07:02:44 INFO - 'USER': 'cltbld', 07:02:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:44 INFO - '_': '/tools/buildbot/bin/python'} 07:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:44 INFO - Downloading/unpacking blobuploader==1.2.4 07:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:46 INFO - Downloading blobuploader-1.2.4.tar.gz 07:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:02:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:02:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:46 INFO - Downloading docopt-0.6.1.tar.gz 07:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:02:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:02:46 INFO - Running setup.py install for blobuploader 07:02:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:02:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:02:46 INFO - Running setup.py install for requests 07:02:47 INFO - Running setup.py install for docopt 07:02:47 INFO - Successfully installed blobuploader requests docopt 07:02:47 INFO - Cleaning up... 07:02:47 INFO - Return code: 0 07:02:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02: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')]} 07:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:47 INFO - Using env: {'DISPLAY': ':0', 07:02:47 INFO - 'HOME': '/home/cltbld', 07:02:47 INFO - 'LANG': 'en_US.UTF-8', 07:02:47 INFO - 'LANGUAGE': 'en_US:en', 07:02:47 INFO - 'LOGNAME': 'cltbld', 07:02:47 INFO - 'MAIL': '/var/mail/cltbld', 07:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:47 INFO - 'MOZ_NO_REMOTE': '1', 07:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:47 INFO - 'NO_EM_RESTART': '1', 07:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:47 INFO - 'PWD': '/builds/slave/test', 07:02:47 INFO - 'SHELL': '/bin/bash', 07:02:47 INFO - 'SHLVL': '1', 07:02:47 INFO - 'TERM': 'linux', 07:02:47 INFO - 'TMOUT': '86400', 07:02:47 INFO - 'USER': 'cltbld', 07:02:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:47 INFO - '_': '/tools/buildbot/bin/python'} 07:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:02:47 INFO - Running setup.py (path:/tmp/pip-x5Bm8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:02:47 INFO - Running setup.py (path:/tmp/pip-OTvr3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:02:47 INFO - Running setup.py (path:/tmp/pip-1ayZu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:02:47 INFO - Running setup.py (path:/tmp/pip-rPpJbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:02:47 INFO - Running setup.py (path:/tmp/pip-bLCBl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:02:47 INFO - Running setup.py (path:/tmp/pip-0DIl2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:02:47 INFO - Running setup.py (path:/tmp/pip-xaQgzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:02:48 INFO - Running setup.py (path:/tmp/pip-ZQsaIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:02:48 INFO - Running setup.py (path:/tmp/pip-mUGeT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:02:48 INFO - Running setup.py (path:/tmp/pip-zWwHrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:02:48 INFO - Running setup.py (path:/tmp/pip-10BxLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:02:48 INFO - Running setup.py (path:/tmp/pip-uZkkdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:02:48 INFO - Running setup.py (path:/tmp/pip-JnnwyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:02:48 INFO - Running setup.py (path:/tmp/pip-zp7xvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:48 INFO - Running setup.py (path:/tmp/pip-rs7SlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:02:48 INFO - Running setup.py (path:/tmp/pip-QTgwyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:02:48 INFO - Running setup.py (path:/tmp/pip-HLbulN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:02:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:02:48 INFO - Running setup.py install for manifestparser 07:02:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:02:48 INFO - Running setup.py install for mozcrash 07:02:48 INFO - Running setup.py install for mozdebug 07:02:49 INFO - Running setup.py install for mozdevice 07:02:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:02:49 INFO - Running setup.py install for mozfile 07:02:49 INFO - Running setup.py install for mozhttpd 07:02:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:02:49 INFO - Running setup.py install for mozinfo 07:02:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:02:49 INFO - Running setup.py install for mozInstall 07:02:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:02:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:02:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:02:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:02:49 INFO - Running setup.py install for mozleak 07:02:49 INFO - Running setup.py install for mozlog 07:02:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:02:49 INFO - Running setup.py install for moznetwork 07:02:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:02:49 INFO - Running setup.py install for mozprocess 07:02:49 INFO - Running setup.py install for mozprofile 07:02:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:02:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:02:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:02:50 INFO - Running setup.py install for mozrunner 07:02:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:02:50 INFO - Running setup.py install for mozscreenshot 07:02:50 INFO - Running setup.py install for moztest 07:02:50 INFO - Running setup.py install for mozversion 07:02:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:02:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:02:50 INFO - Cleaning up... 07:02:50 INFO - Return code: 0 07:02:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02: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')]} 07:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:50 INFO - Using env: {'DISPLAY': ':0', 07:02:50 INFO - 'HOME': '/home/cltbld', 07:02:50 INFO - 'LANG': 'en_US.UTF-8', 07:02:50 INFO - 'LANGUAGE': 'en_US:en', 07:02:50 INFO - 'LOGNAME': 'cltbld', 07:02:50 INFO - 'MAIL': '/var/mail/cltbld', 07:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:50 INFO - 'MOZ_NO_REMOTE': '1', 07:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:50 INFO - 'NO_EM_RESTART': '1', 07:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:50 INFO - 'PWD': '/builds/slave/test', 07:02:50 INFO - 'SHELL': '/bin/bash', 07:02:50 INFO - 'SHLVL': '1', 07:02:50 INFO - 'TERM': 'linux', 07:02:50 INFO - 'TMOUT': '86400', 07:02:50 INFO - 'USER': 'cltbld', 07:02:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:50 INFO - '_': '/tools/buildbot/bin/python'} 07:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:02:50 INFO - Running setup.py (path:/tmp/pip-uzMJ2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:02:50 INFO - Running setup.py (path:/tmp/pip-AGifJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:02:50 INFO - Running setup.py (path:/tmp/pip-TnmgQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:02:50 INFO - Running setup.py (path:/tmp/pip-c73nDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:02:51 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)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:02:51 INFO - Running setup.py (path:/tmp/pip-bD62qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:02:51 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)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:02:51 INFO - Running setup.py (path:/tmp/pip-y4WYuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:02:51 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)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:02:51 INFO - Running setup.py (path:/tmp/pip-2M7aZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:02:51 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)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:02:51 INFO - Running setup.py (path:/tmp/pip-jMUygQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:02:51 INFO - Running setup.py (path:/tmp/pip-IuZ_7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:02:51 INFO - Running setup.py (path:/tmp/pip-1ZrZQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:02:51 INFO - Running setup.py (path:/tmp/pip-Qd9x6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:02:51 INFO - Running setup.py (path:/tmp/pip-Cxga6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:02:51 INFO - Running setup.py (path:/tmp/pip-zWo82w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:02:51 INFO - Running setup.py (path:/tmp/pip-9DDWiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:51 INFO - Running setup.py (path:/tmp/pip-e2OK0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:02:51 INFO - Running setup.py (path:/tmp/pip-WrgFl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:02:51 INFO - Running setup.py (path:/tmp/pip-q4Eum8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:51 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:02:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:53 INFO - Downloading blessings-1.6.tar.gz 07:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:02:53 INFO - Installing collected packages: blessings 07:02:53 INFO - Running setup.py install for blessings 07:02:53 INFO - Successfully installed blessings 07:02:53 INFO - Cleaning up... 07:02:53 INFO - Return code: 0 07:02:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:02:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:02:53 INFO - Reading from file tmpfile_stdout 07:02:53 INFO - Current package versions: 07:02:53 INFO - argparse == 1.2.1 07:02:53 INFO - blessings == 1.6 07:02:53 INFO - blobuploader == 1.2.4 07:02:53 INFO - docopt == 0.6.1 07:02:53 INFO - functools32 == 3.2.3-2 07:02:53 INFO - jsonschema == 2.5.1 07:02:53 INFO - manifestparser == 1.1 07:02:53 INFO - mozInstall == 1.13 07:02:53 INFO - mozcrash == 1.0 07:02:53 INFO - mozdebug == 0.1 07:02:53 INFO - mozdevice == 0.51 07:02:53 INFO - mozfile == 1.2 07:02:53 INFO - mozhttpd == 0.7 07:02:53 INFO - mozinfo == 0.10 07:02:53 INFO - mozleak == 0.1 07:02:53 INFO - mozlog == 3.5 07:02:53 INFO - moznetwork == 0.27 07:02:53 INFO - mozprocess == 0.25 07:02:53 INFO - mozprofile == 0.28 07:02:53 INFO - mozrunner == 6.13 07:02:53 INFO - mozscreenshot == 0.1 07:02:53 INFO - mozsystemmonitor == 0.3 07:02:53 INFO - moztest == 0.8 07:02:53 INFO - mozversion == 1.4 07:02:53 INFO - psutil == 3.1.1 07:02:53 INFO - requests == 1.2.3 07:02:53 INFO - wsgiref == 0.1.2 07:02:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:53 INFO - Using env: {'DISPLAY': ':0', 07:02:53 INFO - 'HOME': '/home/cltbld', 07:02:53 INFO - 'LANG': 'en_US.UTF-8', 07:02:53 INFO - 'LANGUAGE': 'en_US:en', 07:02:53 INFO - 'LOGNAME': 'cltbld', 07:02:53 INFO - 'MAIL': '/var/mail/cltbld', 07:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:53 INFO - 'MOZ_NO_REMOTE': '1', 07:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:53 INFO - 'NO_EM_RESTART': '1', 07:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:53 INFO - 'PWD': '/builds/slave/test', 07:02:53 INFO - 'SHELL': '/bin/bash', 07:02:53 INFO - 'SHLVL': '1', 07:02:53 INFO - 'TERM': 'linux', 07:02:53 INFO - 'TMOUT': '86400', 07:02:53 INFO - 'USER': 'cltbld', 07:02:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:53 INFO - '_': '/tools/buildbot/bin/python'} 07:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:02:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:02:54 INFO - Installing collected packages: simplejson 07:02:54 INFO - Running setup.py install for simplejson 07:02:54 INFO - building 'simplejson._speedups' extension 07:02:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 07:02:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 07:02:55 INFO - Successfully installed simplejson 07:02:55 INFO - Cleaning up... 07:02:55 INFO - Return code: 0 07:02:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f6d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, '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': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', '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 07:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:02:55 INFO - Using env: {'DISPLAY': ':0', 07:02:55 INFO - 'HOME': '/home/cltbld', 07:02:55 INFO - 'LANG': 'en_US.UTF-8', 07:02:55 INFO - 'LANGUAGE': 'en_US:en', 07:02:55 INFO - 'LOGNAME': 'cltbld', 07:02:55 INFO - 'MAIL': '/var/mail/cltbld', 07:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:55 INFO - 'MOZ_NO_REMOTE': '1', 07:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:55 INFO - 'NO_EM_RESTART': '1', 07:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:55 INFO - 'PWD': '/builds/slave/test', 07:02:55 INFO - 'SHELL': '/bin/bash', 07:02:55 INFO - 'SHLVL': '1', 07:02:55 INFO - 'TERM': 'linux', 07:02:55 INFO - 'TMOUT': '86400', 07:02:55 INFO - 'USER': 'cltbld', 07:02:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:55 INFO - '_': '/tools/buildbot/bin/python'} 07:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:02:56 INFO - Cleaning up... 07:02:56 INFO - Return code: 0 07:02:56 INFO - Running post-action listener: _resource_record_post_action 07:02:56 INFO - Running post-action listener: _start_resource_monitoring 07:02:56 INFO - Starting resource monitoring. 07:02:56 INFO - [mozharness: 2017-08-03 14:02:56.239433Z] Finished create-virtualenv step (success) 07:02:56 INFO - [mozharness: 2017-08-03 14:02:56.239936Z] Running install step. 07:02:56 INFO - Running pre-action listener: _resource_record_pre_action 07:02:56 INFO - Running main action method: install 07:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:02:56 INFO - Reading from file tmpfile_stdout 07:02:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:02:56 INFO - Reading from file tmpfile_stdout 07:02:56 INFO - Output received: 07:02:56 INFO - Usage: mozinstall [options] installer 07:02:56 INFO - Options: 07:02:56 INFO - -h, --help show this help message and exit 07:02:56 INFO - -d DEST, --destination=DEST 07:02:56 INFO - Directory to install application into. [default: 07:02:56 INFO - "/builds/slave/test"] 07:02:56 INFO - --app=APP Application being installed. [default: firefox] 07:02:56 INFO - mkdir: /builds/slave/test/build/application 07:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:03:14 INFO - Reading from file tmpfile_stdout 07:03:14 INFO - Output received: 07:03:14 INFO - /builds/slave/test/build/application/firefox/firefox 07:03:14 INFO - Running post-action listener: _resource_record_post_action 07:03:14 INFO - [mozharness: 2017-08-03 14:03:14.596136Z] Finished install step (success) 07:03:14 INFO - [mozharness: 2017-08-03 14:03:14.596283Z] Running setup-mitmproxy step. 07:03:14 INFO - Running pre-action listener: _resource_record_pre_action 07:03:14 INFO - Running main action method: setup_mitmproxy 07:03:14 INFO - Skipping: mitmproxy is not required 07:03:14 INFO - Running post-action listener: _resource_record_post_action 07:03:14 INFO - [mozharness: 2017-08-03 14:03:14.596816Z] Finished setup-mitmproxy step (success) 07:03:14 INFO - [mozharness: 2017-08-03 14:03:14.597032Z] Running run-tests step. 07:03:14 INFO - Running pre-action listener: _resource_record_pre_action 07:03:14 INFO - Running pre-action listener: _set_gcov_prefix 07:03:14 INFO - Running main action method: run_tests 07:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:03:14 INFO - Python 2.7.3 07:03:14 INFO - Return code: 0 07:03:14 INFO - grabbing minidump binary from tooltool 07:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f3eb0>, '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 0x16f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:03:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:03:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:03:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:03:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:03:14 INFO - Return code: 0 07:03:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:03:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:03:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:03:14 INFO - ENV: RUST_BACKTRACE is now 1 07:03:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:03:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 07:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 07:03:14 INFO - Using env: {'DISPLAY': ':0', 07:03:14 INFO - 'HOME': '/home/cltbld', 07:03:14 INFO - 'LANG': 'en_US.UTF-8', 07:03:14 INFO - 'LANGUAGE': 'en_US:en', 07:03:14 INFO - 'LOGNAME': 'cltbld', 07:03:14 INFO - 'MAIL': '/var/mail/cltbld', 07:03:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:03:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:14 INFO - 'MOZ_NO_REMOTE': '1', 07:03:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:14 INFO - 'NO_EM_RESTART': '1', 07:03:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:14 INFO - 'PWD': '/builds/slave/test', 07:03:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:03:14 INFO - 'RUST_BACKTRACE': '1', 07:03:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:03:14 INFO - 'SHELL': '/bin/bash', 07:03:14 INFO - 'SHLVL': '1', 07:03:14 INFO - 'STYLO_FORCE_ENABLED': '1', 07:03:14 INFO - 'TERM': 'linux', 07:03:14 INFO - 'TMOUT': '86400', 07:03:14 INFO - 'USER': 'cltbld', 07:03:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621', 07:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:14 INFO - '_': '/tools/buildbot/bin/python'} 07:03:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 07:03:14 INFO - mozversion application_buildid: 20170803132126 07:03:14 INFO - mozversion application_changeset: fa1da3c0b200abbd9cfab3cab19962824314044e 07:03:14 INFO - mozversion application_display_name: Nightly 07:03:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:03:14 INFO - mozversion application_name: Firefox 07:03:14 INFO - mozversion application_remotingname: firefox 07:03:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:03:14 INFO - mozversion application_vendor: Mozilla 07:03:14 INFO - mozversion application_version: 57.0a1 07:03:14 INFO - mozversion platform_buildid: 20170803132126 07:03:14 INFO - mozversion platform_changeset: fa1da3c0b200abbd9cfab3cab19962824314044e 07:03:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:03:14 INFO - mozversion platform_version: 57.0a1 07:03:14 INFO - using testdate: 1501768994 07:03:14 INFO - actual date: 1501768994 07:03:14 INFO - starting webserver on 'localhost:49389' 07:03:14 INFO - SUITE-START | Running 2 tests 07:03:14 INFO - TEST-START | dromaeo_css 07:03:14 INFO - Initialising browser for dromaeo_css test... 07:03:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49389/getInfo.html -profile /tmp/tmp_3zEVe/profile 07:03:14 INFO - TEST-INFO | started process 5214 (/builds/slave/test/build/application/firefox/firefox http://localhost:49389/getInfo.html) 07:03:20 INFO - TEST-INFO | 5214: exit 0 07:03:21 INFO - Browser initialized. 07:03:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:03:21 INFO - TEST-INFO | started process 5438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_3zEVe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:03:22 INFO - PID 5438 | 07:03:22 INFO - PID 5438 | (/builds/slave/test/build/application/firefox/firefox:5492): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:03:22 INFO - PID 5438 | 07:03:32 INFO - PID 5438 | RSS: Main: 173953024 07:03:32 INFO - PID 5438 | 07:06:32 INFO - PID 5438 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49389/tests/dromaeo/cssquery-ext.html) 07:06:33 INFO - PID 5438 | RSS: Main: 175722496 07:06:33 INFO - PID 5438 | 07:09:35 INFO - PID 5438 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-ext.html (next: http://localhost:49389/tests/dromaeo/cssquery-jquery.html) 07:09:36 INFO - PID 5438 | RSS: Main: 173514752 07:09:36 INFO - PID 5438 | 07:12:38 INFO - PID 5438 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49389/tests/dromaeo/cssquery-mootools.html) 07:12:38 INFO - PID 5438 | RSS: Main: 175464448 07:12:38 INFO - PID 5438 | 07:15:40 INFO - PID 5438 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49389/tests/dromaeo/cssquery-prototype.html) 07:15:41 INFO - PID 5438 | RSS: Main: 174161920 07:15:41 INFO - PID 5438 | 07:18:44 INFO - PID 5438 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49389/tests/dromaeo/cssquery-yui.html) 07:18:45 INFO - PID 5438 | RSS: Main: 177156096 07:18:45 INFO - PID 5438 | 07:21:47 INFO - PID 5438 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-yui.html (next: http://localhost:49389/tests/dromaeo/cssquery-dojo.html) 07:21:47 INFO - PID 5438 | RSS: Main: 177983488 07:21:47 INFO - PID 5438 | 07:21:47 INFO - PID 5438 | __start_tp_report 07:21:47 INFO - PID 5438 | _x_x_mozilla_page_load 07:21:47 INFO - PID 5438 | _x_x_mozilla_page_load_details 07:21:47 INFO - PID 5438 | |i|pagename|runs| 07:21:47 INFO - PID 5438 | |0;dojo.html;3114.128044147638;3151.2594540283044;3167.6990685884834;3185.872565097396;3225.9354812903744;6132.724027418766;6141.9692901535545;6172.166757487737;6214.596051256665;6278.403551662596;6228.968855155718;6261.499080073595;6308.968455157729;6328.746850126001;6379.776707815216;5681.573881958849;5698.373178950312;5731.541476681877;5767.971160144193;5792.768289268424;5539.501444869961;5639.746211420475;5650;5773.134029895528;5780.1907732917425;5679;5736.942630573703;5750.539956803445;5779.826605201851;5782.074868021117;5651.095824668033;5701.600887937846;5732.398098199712;5736.971315143398;5756.30924289088;5501.779928802843;5538.418466061086;5559.138333558305;5590.552755779528;5602.747876345534;6141.877162456726;6147.446729794296;6170.475509581691;6211.782587609412;6251.374862513758;6642.335766423367;6647.468202543785;6738.59568425896;6743.561668491532;6755.3582409671;6429.196350456193;6579.572327798725;6675.86648267032;6772.2211945626395;6772.288909664513;6242.469390101847;6305.810825675191;6321.905171422432;6330.65181415022;6330.8100756977365;6781.966090169616;6866.6566671667215;6893.4829887758615;6980.232174460805;6988.475864310095;6480.351964803482;6559.836004099936;6582.736690532421;6591.110200123018;6594.439472644879;6660.500462465335;6663.433608143362;6676.799696009128;6682.365175308338;6696.397324240842;6590.505712071614;6600.339966003457;6605.801825945229;6628.734850606018;6654.534182607268;6687.465002799764;6690.899636505456;6700.061991321219;6701.262861085277;6720.193576770819;5402.054640437907;5402.540784033401;5465.371482279509;5469.425710300441;5491.093969495068;4572.81708731647;4623.329617205486;4627.3521706961055;4646.674732768742;4658.906821863544;5806.970965145148;5823.912641310384;5825.825225243249;5828.795992140254;5835.124731290341;6662.633555154416;6737.258901520829;6745.426638735762;6748.763793267212;6816.4546836252985;5800.56495762811;5842.707864606838;5856.707164641751;5890.3815099414805;5900.085486749561;5863.398553701661;5872.471477567039;5930.466258036798;5950.9702451487465;5954.821355359346;6417.711202995876;6526.673666316665;6532.052852336385;6550.443212326911;6607.306232845482;6761;6842.657867106725;6845.349691779273;6853.246142924175;6855.006024126574;6498.577592456475;6544.2474115475425;6589;6629.7679581214425;6633.1045308882685;6642.767503137367;6670.966645166744;6762.594244345355;6769.89845152333;6782.96608516974;6792.898106528307;6795.45636349081;6882.208546017272;6889.483288753464;6897;6367.331430199948;6426.807195784134;6428.228612566522;6438.5171112165835;6493.837654058686;6489.675516224075;6503.837404064747;6513.8697226056165;6514.1531600891585;6516.73933042673;6436.066770318372;6439.420452159328;6441.323661015525;6495.707693153725;6504.38208370204;6534.967325163344;6549.869002619826;6565.934340656532;6625;6639.535232533676;6254.405831446005;6317.526185536195;6341.239051313872;6341.524385671185;6399.328070552711 07:21:47 INFO - PID 5438 | |1;ext.html;809.1503920883072;859.0893652728105;874.1040433555606;902.3908861518473;906.8413027720147;41056.58943410565;41778.164436711246;41790;41798;41824.95437614061;37993.240135197346;38284.80857595715;38342.808285958534;38401;38464.80767596165;6904.75833345833;7009.544379615334;7037.225905150455;7055.294470552929;7055.929440705604;6907.13660792401;6951.443884489228;6961.129858767654;6990.860182796341;6999.860002799941;7477.401807855385;7647.770566882975;7693.230676932318;7714.459987800856;7721.343685786686;7614.314711675948;7676.347510461617;7678.270564296383;7678.424118191158;7680.654370553339;7400.851982960311;7559.69761209551;7637.312641862259;7644.082710074771;7681.462297639167;39355.80322098371;39779.40330895039;39819.40270895939;39871.601283987366;39891;3428.160100775301;3480.4953281774256;3481.460373642064;3482.8780992665133;3487.8256087195537;31854.840725796454;31925.84037079823;32013.519797203062;32051.198720031953;32135.51796723051;4936.950630493685;4963.751812409365;4972.477889821553;4984.401871775374;4991.276264941599;222062;224611;225980;226824.99999999834;228556;48687.51312486901;49856.750716246184;50116.49883501191;50148.49851501511;50252.24621630678;51979.74010129925;52038.73980630073;52093.739531302104;52100;52153;16868.409605663743;16977.830221697626;16985.49043528696;16992.235349409308;17064;14043.929780351033;14054.227017513931;14057.929710351587;14065.648358790908;14068.929655351658;13902;13924.164550126823;13951.302434878215;13985.79021314681;14144.434222631186;5546.223528705985;5564;5567.192757050205;5603.915941260884;5656.660600363992;1000.4347543637822;1020.4438580973239;1022.223110436074;1033.1837848099917;1033.3748082410184;23341.883290583777;23987;24242.15152469655;30503.847480762455;31015;1076.4510099849133;1091.7379828841022;1107.994529900882;1111.9332840029624;1116.436199719153;12086.214396064228;12420.875791242153;12552.435140418704;12583.622491325275;12695.111342205957;240303;240319;240921;241531;242059;52981.205281920804;53008;54960;58803;58940.7052964741;1428.4214892968364;1447.2054652231157;1477.30566633682;1506.5555661079788;1511.1439379572616;27309.590356144276;27679.236324561578;28404;28519.572206417335;28847.711522884503;37694.62305376911;37731.43402849014;37898.24203515859;37910.431343529315;38115.80942095272;212721;213282;213412;213576;213677;33872.830635846665;34328.82835585806;34447.13882152966;34490.13774655654;34823;43058.56941430546;44102.33846492241;44121.77939110284;44151.33772993472;44500.777496112314;32094.51858222082;32197.51703724493;32420.513692294164;32488.025359239262;32550.51174232341;31924.36151277008;32248.516272256406;32265;32465;32903.506447402826;34670.30659386748;34997.8250108758;35176.12059698528;35288.47067294044;35371.29257414786;30770.076897693107;31210.687893121685;31283.37433251368;31462.842685786425;31501.52747708832;22952.655710164694;23271;23632.921482662277;23680.40798980039;24074.638880416456 07:21:47 INFO - PID 5438 | |2;jquery.html;570.3611954610834;580.5471732049001;587.6151121015731;596.3738075021228;600.6936462404174;22177.334679959586;22840.771592284073;23354.766452335472;23369;23423.648645270292;25176.24471265865;27329.86335068327;27452.725472745267;27525.86237068812;27736.445271094566;6476.2228532576155;6649.534532582721;6677.465802735794;6679.398854103129;6679.899801502981;3972.423998520213;5415.675059496423;6615.106960560311;6692.163479565054;6705.497087718416;3966.8611598594057;6268.498520118403;6275;6280.434760871521;6299.685015749217;6290.528210384216;6300.180976473029;6300.338464461257;6301.4013668701855;6304;5851.941480585182;5917.497012753921;5925.111233315038;5928.7628494860155;5930.377310382434;29903.401931961456;30701.232469188224;31245.843770781226;31814.840925795455;31844.840775795972;1862.459886632875;1907.3324336482258;1908.3225454963426;1909.0931807391378;1910.4459706685045;18610;19218.13518391676;19223.423297301102;19236;19240.71138932917;2200.7469141048823;2233.062113912161;2279.2364557872966;2317.5249073939804;2321.408040949564;146349;151154;151453;151723;152324;14755.77866332006;15627;15631.921840390725;15711.68576628461;16109.516714498584;24259;24282.271531854072;24337.51324973526;24385.63421548678;24385.63421548678;10179.491025448699;10234.232432567587;10276.588936442458;10283.897161028444;10359.274850760525;8760.56197190138;9391.859122113174;9579.712608621752;9668.081532254424;9704.175145112744;8106.716264930699;9293.90706092944;9352.4856132912;9380.5309734513;9640.662576809778;2644.8942042318477;2693.3805224798407;2738.5344491436504;2764.6682398112357;2776.3753155540244;945.9952700236593;958.7411398922252;960.9387863033753;970.8640790289365;978.706388083572;19501.804981949997;19708.408747737303;19745.703814442506;19753.703694444306;20312.085956131716;1035.6478797208833;1045.9163266938626;1046.670298855858;1047.1099565369375;1052.1057101463696;10922;11154.665360039211;11291.039816929046;11353.659390218307;11378.43107844621;468262;471377;481908;484906;485072;110615;114571.42714286376;115073;115654.42172789082;117240.9999999983;1067.2689207892618;1195.0857593940643;1220.536196245421;1220.798568236249;1221.267239656199;20806;21132.260370886946;21138.577228455037;21171.576568468852;21424.143034278455;54768.45231547634;55282.72358638181;55721.44278557163;56395.71802140963;57396.42603573911;71940;71967.64016179886;72229;72525.6373718128;72732;14428.927855360656;14781.630459238606;14836.62908427298;14937.477188298792;14973.625659358604;23001.194958176384;23312.650310245022;23439.296821095395;23823.404414889766;23840.165594204118;18531.90734046321;19708.31020914261;19747.901260493607;19793.40619781409;19899.403017909484;15342.23288835576;15834.524964251092;16534;17545.1227438625;18316;19081.42755717331;19912.402627921187;20297.391078267676;20476.488087797923;20529.794702053387;14989.550313490177;15237;15279.923600381928;15302.158381289137;15305.617359565655;18717.81282187215;18824.341148059753;19035.524111897314;19057.71413428772;19060.61878762389 07:21:47 INFO - PID 5438 | |3;mootools.html;1361.4282001559345;1406.8522805105463;1422.2106730764435;1425.750493663609;1426.1371870018645;13871.445142194312;14459.566213013626;14466.782998255034;14474;14611.78082328766;14471.204083775388;14751.262436878167;14761.92619036906;14768.187749673763;14789.334479948402;2636.709961904189;2708.1740069278862;2766.14249582629;2768.4463107378506;2802.9159125226274;2800.7899407544414;2828.0526023781954;2831.278024103861;2831.702671219513;2833.3766571354267;2714.8506832124226;2742.2595899107228;2764.751172394484;2788.9163325100176;2800.2019424464033;2619.8559079250635;2661.6007598860133;2688.086050742747;2738.8082834201614;2740.2190375742816;2615.6207349934343;2619.2011436511857;2634.920952371432;2650.9337266568295;2653.1244689252694;14011.229382383965;14287.499937502138;14306.856931430657;14319.49881754144;14339.856601434061;7382.52013619113;7612.352949999256;7629.389648828081;7643.923560764377;7655.540667559964;5230;5288.735563221823;5471.835844924659;5480.068388373986;5569.610127291051;1819.4359748477882;1831.7893442254178;1853.2123847364817;1887.4903775980408;1889.8204670556413;23260.65109023366;23807.64288535656;23809.52380952371;23819.88090059556;23833.285001449985;6891.793246202622;6992.1958974717545;7032.824179395556;7089;7133.429325653935;18311;18392;18501.074946252633;18517.722234166496;18524.81475185258;7895.249951254622;8049.315808156255;8069.596520173968;8070.112287648354;8085.191480851985;7124.536905101152;7271.854562908712;7276.417886569062;7334.046573945353;7338.559686418832;5299.549538289211;5492.917606235909;5498.1752737089755;5551.056320425457;5670.404607516234;1741.2947756158776;1765.576261697209;1786.6516029374407;1786.998561610978;1799.19935628644;883.6686242659002;917;926.4580220571041;926.8748718922994;938.5401153434768;7328.96335518319;7354.816129596696;7370.705171793175;7383.2247614000835;7390.482666213314;719.6042176802738;746.5259560179217;749.2095838890024;750.8836130399797;751.5227830327672;4669;4930.9013819723405;5061.063703214917;5123.97438012815;5197.636165468381;18800;19393.32123375675;19596.70604940927;19612.313569025016;19612.411627651192;19031.904840475985;19186.904065479583;19710.802891970896;19717.30989415392;19718.8028119717;10349.586016559404;10999.23005389631;11016.889831101747;11033.779324413466;11086.16853735973;7832.725854595062;8468;8505.702300419456;8674.913250867663;8837.867431988654;16332.346706131622;16692.165391730607;16953.152342382586;17435.56411089733;17599.29602815873;15862.841371586137;16414.589635259214;17532.211050503014;17897.642047158723;18109.90945045319;9219;10464.686059418229;10474.581016759244;11022.669319920415;11230;12375.75248495007;12465.501379945063;12493.875061249271;12499.125061245626;12503;10547.841782373423;10648.627298044532;10696.83954740664;10788.622398216025;11030.944845275722;10148.746281343025;10405.06354428105;10440.738981525219;10597.25819192649;10847.837282440612;9096.272298215994;9231.907680923105;9409.388389754644;9409.435433873989;9413.576389062646;7304.890426643711;7347.191808901123;7391.556506609621;7405.9629701851145;7433.479656423999;7119.964400177966;7227.747028853965;7322.414206863545;7341.853162936604;7397.741079062207 07:21:47 INFO - PID 5438 | |4;prototype.html;507.17583926120057;508.9160288552389;533.0697932108469;535.4056996733625;537.4330081763737;6114.052321890103;6253.343398943114;6259.248890133184;6274.749010039599;6300.495960323175;6039;6056.4851987581105;6074.179985701929;6083.148359229712;6143.81568552943;4900.460949295574;4907.75461226939;4914.459409464956;4937;4997.725125118117;4927.753612319388;4965.652404331699;4993.475685053071;5006.749662516878;5024.748762561876;4767.666263361566;4949.208126699728;4950.900981980359;4964.578010869081;4978.576820970222;4937.753322238391;4960.627952903546;4962.42932062812;4987.326710894019;5012.1980483122525;4418.823247070113;4465.977670111661;4474.731516109044;4514.8419805306985;4523.47979982303;6026.819195424145;6045.6674882881425;6047.939520604782;6082.482988945945;6112.419320164622;5695.886082278373;5706.201131841545;5712.542996560265;5748.913766293509;5752.942470575283;6406.711697973602;6454.547726761488;6488.8702225955685;6507.5119366047265;6590.835229119262;4780.1873681474235;4821.638377121695;4842.15262329091;4843.75781210938;4903.607711383081;6758.459323254128;6857.382835544775;6865.450763938873;6943.51395402322;6996.7201311947465;5003.799848006039;5009.373828271466;5019.749012549358;5059.215821547666;5071.87320316995;4992.500749924979;5080.390353157644;5087.43879284495;5122.974385128051;5168.664036837594;5670.744816483269;5744.2192920194875;5746.482816546531;5757.193992841006;5774.538036957118;6488.31872653374;6600.108985287021;6604.801855944329;6644.4020038196795;6689.397954184147;1667.483080245128;1744.4069016534438;1751.211954620426;1768.6109056007658;1791.784985801712;1174.9118816088828;1220.536196245421;1237.7215126596625;1247.8065899785547;1267.14467734279;5741.62679425836;5767.163761254595;5785.971070144707;5804.94195058044;5817.3019237690905;6585.275619681831;6630.977551846733;6632.602043877383;6679.298673639295;6705.631190284484;5658.2840236686625;5709.371969083398;5756.56825738063;5779.24869766936;5818.272715910512;3553.7384228598994;3554.306910152495;3571;3608.80151591665;3652.2878038782715;6523.836904077436;6535.705893234815;6562.212534495796;6575.44108750752;6602.438792702578;6890.724371025203;6896.655167241618;6948.478864085214;6964.686589103502;6988.301169882971;6412.583182093149;6413.45485633717;6419.812334718092;6542.593342431495;6547.345265473415;6657.201135863727;6679.198496180489;6714.664266786739;6734;6780.423663988616;6570.934290657032;6580.144581204413;6624.304448032887;6628.801135965929;6656.83357916056;6493.188351456068;6500.6998600279185;6520.445762110274;6537.378948999837;6587.176602924635;4971.602271818174;4995.2507123930245;5019.7490125494305;5041.6470847040355;5065.873353166053;6722.630255336004;6758.978407847323;6768.661566921536;6819.2498825128205;6833.145856767904;6582.807338440948;6583.490309138256;6586.637734924625;6588.6046837188005;6602.3397660233595;6467.805965820845;6494.383033611799;6541.2477565078725;6595.604263744191;6620.602763834186;6212.192414986203;6366.4797993423335;6409.198850143732;6421.935780642134;6517.490766055198;6427.678616069272;6447.4197322241225;6452.161219041494;6470.670558598807;6470.935290647033;6341.55609107358;6343.238811342669;6374.840628984312;6377.521685873671;6382.32985536512 07:21:47 INFO - PID 5438 | |5;yui.html;883.5449743382163;894.8120894612131;910;917.449530281831;927.9164875161237;17735.467935961926;18374.448766536992;18461.07694615269;18582.721259181122;19127.234910603558;19603.803961960377;19679.21283148676;19737.60524789507;19776.11007504662;19816.702749458735;1020.2705065877896;1047.4500887034292;1059.3590877519105;1062.1184416933927;1062.1768129699467;1057.6615483045427;1070.175964507329;1070.3096502755718;1070.7216123807789;1070.7323169207698;1060.522764755859;1100.4662738571826;1111.5164903267105;1126.752114534801;1127.5433449452985;1086.293908959179;1091.4324551233394;1091.5197313182175;1093.7703082352716;1093.797647435223;794.2018271637025;799.6281728996045;800.1678254615193;800.1678254615251;801.4069588504465;18791.060446977597;19173.137208825636;19617.117229724554;19689.704654430196;19832.70250946237;20532.58934821295;20956.056977436052;21197.5760484791;21308.14767409302;21323;15801.841981580152;15882.841171588252;15937;15956.122413267265;16022.35910563576;3610.801405922673;3622.7464077514583;3627.437747149196;3630.6006339302658;3631.983044747475;120317.39841300825;120598.39700801528;122355.38822305831;126091.36954315261;129805.35097324547;16001.439949601709;16425;16846.24191911367;16910.492685219462;16925.661486770197;30225.848870755504;31064.844675776476;31234.53148202779;31284.53073203904;31307.06078817639;7286.125664920243;7544.283293087148;8610.397272190887;8850.822983540293;8851.247643950208;4104.8152833122585;4281.657467402601;4298.41971333866;4301.483821941387;4306.569343065668;5231.633785634969;5340.359156901197;5354.384245811703;5384.19237114436;5662.263905692316;1050.2805578178973;1083.875354334246;1085.1264731890903;1093.2893619147617;1094.7317907112808;553.7840242305504;554.7420449490926;558.4722437296797;560.2101037537053;567.2087438023933;11294.717632059264;11662.241954272946;11823.408829558488;11929.582464613697;12860.164089334163;661.9371159739817;665.0489799586637;673.7776533743951;674.544682339419;677.2178134254943;5694.487496125369;5702.372738998707;5736.598438109292;5751.884962300731;5914.2311499504785;102412.48793756132;104056.47971760093;106152.9384706143;109255;111162;89391;91885;92172;93921.5303923476;94612;80090;81796.18203817886;82756.99999999879;84005;86950.56524717336;11321.660350189508;12317.384130793245;12642.55751048709;12699.873001270238;12709.8093528599;36848.46910224634;37657;37811.337709992484;37937.39594738495;38086.23827523489;68743;68804.6559767218;69596.6520167396;71555.64222178856;72780.63609681917;18809.495240380464;18958.146883390556;19055;19085.141168647166;19222.711659324843;18387.356442524448;19192.13635386439;19199.040047997263;21506.462338441663;21749.238776642742;14470.638234044232;15497.5350739478;18459.63080738351;18568.164432600835;18651.72022419692;18933.90533047326;19009.90495047516;19115.617687645892;19167.90416047911;19309.324173653855;18996.14517346695;19387.61224775525;19390.70913936264;19498.902505487382;19684.212631494578;12059;12130.150889437655;12234;12282.140250182401;12572;14333.64165895861;14526.927365363106;14569.41722331095;14574.927125364306;14580.927095364455 07:21:47 INFO - PID 5438 | __end_tp_report 07:21:47 INFO - PID 5438 | __start_cc_report 07:21:47 INFO - PID 5438 | _x_x_mozilla_cycle_collect,362 07:21:47 INFO - PID 5438 | __end_cc_report 07:21:47 INFO - PID 5438 | __startTimestamp1501770107836__endTimestamp 07:21:47 INFO - PID 5438 | 07:21:47 INFO - PID 5438 | ------- Summary: start ------- 07:21:47 INFO - PID 5438 | Number of tests: 6 07:21:47 INFO - PID 5438 | 07:21:47 INFO - PID 5438 | [#0] dojo.html Cycles:165 Average:6170.55 Median:6426.81 stddev:735.46 (11.4%) stddev-sans-first:697.53 07:21:47 INFO - PID 5438 | Values: 3114.1 3151.3 3167.7 3185.9 3225.9 6132.7 6142.0 6172.2 6214.6 6278.4 6229.0 6261.5 6309.0 6328.7 6379.8 5681.6 5698.4 5731.5 5768.0 5792.8 5539.5 5639.7 5650.0 5773.1 5780.2 5679.0 5736.9 5750.5 5779.8 5782.1 5651.1 5701.6 5732.4 5737.0 5756.3 5501.8 5538.4 5559.1 5590.6 5602.7 6141.9 6147.4 6170.5 6211.8 6251.4 6642.3 6647.5 6738.6 6743.6 6755.4 6429.2 6579.6 6675.9 6772.2 6772.3 6242.5 6305.8 6321.9 6330.7 6330.8 6782.0 6866.7 6893.5 6980.2 6988.5 6480.4 6559.8 6582.7 6591.1 6594.4 6660.5 6663.4 6676.8 6682.4 6696.4 6590.5 6600.3 6605.8 6628.7 6654.5 6687.5 6690.9 6700.1 6701.3 6720.2 5402.1 5402.5 5465.4 5469.4 5491.1 4572.8 4623.3 4627.4 4646.7 4658.9 5807.0 5823.9 5825.8 5828.8 5835.1 6662.6 6737.3 6745.4 6748.8 6816.5 5800.6 5842.7 5856.7 5890.4 5900.1 5863.4 5872.5 5930.5 5951.0 5954.8 6417.7 6526.7 6532.1 6550.4 6607.3 6761.0 6842.7 6845.3 6853.2 6855.0 6498.6 6544.2 6589.0 6629.8 6633.1 6642.8 6671.0 6762.6 6769.9 6783.0 6792.9 6795.5 6882.2 6889.5 6897.0 6367.3 6426.8 6428.2 6438.5 6493.8 6489.7 6503.8 6513.9 6514.2 6516.7 6436.1 6439.4 6441.3 6495.7 6504.4 6535.0 6549.9 6565.9 6625.0 6639.5 6254.4 6317.5 6341.2 6341.5 6399.3 07:21:47 INFO - PID 5438 | 07:21:47 INFO - PID 5438 | [#1] ext.html Cycles:180 Average:39659.30 Median:19075.40 stddev:58877.12 (308.7%) stddev-sans-first:58970.02 07:21:47 INFO - PID 5438 | Values: 809.2 859.1 874.1 902.4 906.8 41056.6 41778.2 41790.0 41798.0 41825.0 37993.2 38284.8 38342.8 38401.0 38464.8 6904.8 7009.5 7037.2 7055.3 7055.9 6907.1 6951.4 6961.1 6990.9 6999.9 7477.4 7647.8 7693.2 7714.5 7721.3 7614.3 7676.3 7678.3 7678.4 7680.7 7400.9 7559.7 7637.3 7644.1 7681.5 39355.8 39779.4 39819.4 39871.6 39891.0 3428.2 3480.5 3481.5 3482.9 3487.8 31854.8 31925.8 32013.5 32051.2 32135.5 4937.0 4963.8 4972.5 4984.4 4991.3 222062.0 224611.0 225980.0 226825.0 228556.0 48687.5 49856.8 50116.5 50148.5 50252.2 51979.7 52038.7 52093.7 52100.0 52153.0 16868.4 16977.8 16985.5 16992.2 17064.0 14043.9 14054.2 14057.9 14065.6 14068.9 13902.0 13924.2 13951.3 13985.8 14144.4 5546.2 5564.0 5567.2 5603.9 5656.7 1000.4 1020.4 1022.2 1033.2 1033.4 23341.9 23987.0 24242.2 30503.8 31015.0 1076.5 1091.7 1108.0 1111.9 1116.4 12086.2 12420.9 12552.4 12583.6 12695.1 240303.0 240319.0 240921.0 241531.0 242059.0 52981.2 53008.0 54960.0 58803.0 58940.7 1428.4 1447.2 1477.3 1506.6 1511.1 27309.6 27679.2 28404.0 28519.6 28847.7 37694.6 37731.4 37898.2 37910.4 38115.8 212721.0 213282.0 213412.0 213576.0 213677.0 33872.8 34328.8 34447.1 34490.1 34823.0 43058.6 44102.3 44121.8 44151.3 44500.8 32094.5 32197.5 32420.5 32488.0 32550.5 31924.4 32248.5 32265.0 32465.0 32903.5 34670.3 34997.8 35176.1 35288.5 35371.3 30770.1 31210.7 31283.4 31462.8 31501.5 22952.7 23271.0 23632.9 23680.4 24074.6 07:21:47 INFO - PID 5438 | 07:21:47 INFO - PID 5438 | [#2] jquery.html Cycles:180 Average:35079.83 Median:12659.36 stddev:81194.82 (641.4%) stddev-sans-first:81381.25 07:21:47 INFO - PID 5438 | Values: 570.4 580.5 587.6 596.4 600.7 22177.3 22840.8 23354.8 23369.0 23423.6 25176.2 27329.9 27452.7 27525.9 27736.4 6476.2 6649.5 6677.5 6679.4 6679.9 3972.4 5415.7 6615.1 6692.2 6705.5 3966.9 6268.5 6275.0 6280.4 6299.7 6290.5 6300.2 6300.3 6301.4 6304.0 5851.9 5917.5 5925.1 5928.8 5930.4 29903.4 30701.2 31245.8 31814.8 31844.8 1862.5 1907.3 1908.3 1909.1 1910.4 18610.0 19218.1 19223.4 19236.0 19240.7 2200.7 2233.1 2279.2 2317.5 2321.4 146349.0 151154.0 151453.0 151723.0 152324.0 14755.8 15627.0 15631.9 15711.7 16109.5 24259.0 24282.3 24337.5 24385.6 24385.6 10179.5 10234.2 10276.6 10283.9 10359.3 8760.6 9391.9 9579.7 9668.1 9704.2 8106.7 9293.9 9352.5 9380.5 9640.7 2644.9 2693.4 2738.5 2764.7 2776.4 946.0 958.7 960.9 970.9 978.7 19501.8 19708.4 19745.7 19753.7 20312.1 1035.6 1045.9 1046.7 1047.1 1052.1 10922.0 11154.7 11291.0 11353.7 11378.4 468262.0 471377.0 481908.0 484906.0 485072.0 110615.0 114571.4 115073.0 115654.4 117241.0 1067.3 1195.1 1220.5 1220.8 1221.3 20806.0 21132.3 21138.6 21171.6 21424.1 54768.5 55282.7 55721.4 56395.7 57396.4 71940.0 71967.6 72229.0 72525.6 72732.0 14428.9 14781.6 14836.6 14937.5 14973.6 23001.2 23312.7 23439.3 23823.4 23840.2 18531.9 19708.3 19747.9 19793.4 19899.4 15342.2 15834.5 16534.0 17545.1 18316.0 19081.4 19912.4 20297.4 20476.5 20529.8 14989.6 15237.0 15279.9 15302.2 15305.6 18717.8 18824.3 19035.5 19057.7 19060.6 07:21:47 INFO - PID 5438 | 07:21:47 INFO - PID 5438 | [#3] mootools.html Cycles:180 Average:8877.41 Median:2657.36 stddev:6068.87 (228.4%) stddev-sans-first:6059.61 07:21:47 INFO - PID 5438 | Values: 1361.4 1406.9 1422.2 1425.8 1426.1 13871.4 14459.6 14466.8 14474.0 14611.8 14471.2 14751.3 14761.9 14768.2 14789.3 2636.7 2708.2 2766.1 2768.4 2802.9 2800.8 2828.1 2831.3 2831.7 2833.4 2714.9 2742.3 2764.8 2788.9 2800.2 2619.9 2661.6 2688.1 2738.8 2740.2 2615.6 2619.2 2634.9 2650.9 2653.1 14011.2 14287.5 14306.9 14319.5 14339.9 7382.5 7612.4 7629.4 7643.9 7655.5 5230.0 5288.7 5471.8 5480.1 5569.6 1819.4 1831.8 1853.2 1887.5 1889.8 23260.7 23807.6 23809.5 23819.9 23833.3 6891.8 6992.2 7032.8 7089.0 7133.4 18311.0 18392.0 18501.1 18517.7 18524.8 7895.2 8049.3 8069.6 8070.1 8085.2 7124.5 7271.9 7276.4 7334.0 7338.6 5299.5 5492.9 5498.2 5551.1 5670.4 1741.3 1765.6 1786.7 1787.0 1799.2 883.7 917.0 926.5 926.9 938.5 7329.0 7354.8 7370.7 7383.2 7390.5 719.6 746.5 749.2 750.9 751.5 4669.0 4930.9 5061.1 5124.0 5197.6 18800.0 19393.3 19596.7 19612.3 19612.4 19031.9 19186.9 19710.8 19717.3 19718.8 10349.6 10999.2 11016.9 11033.8 11086.2 7832.7 8468.0 8505.7 8674.9 8837.9 16332.3 16692.2 16953.2 17435.6 17599.3 15862.8 16414.6 17532.2 17897.6 18109.9 9219.0 10464.7 10474.6 11022.7 11230.0 12375.8 12465.5 12493.9 12499.1 12503.0 10547.8 10648.6 10696.8 10788.6 11030.9 10148.7 10405.1 10440.7 10597.3 10847.8 9096.3 9231.9 9409.4 9409.4 9413.6 7304.9 7347.2 7391.6 7406.0 7433.5 7120.0 7227.7 7322.4 7341.9 7397.7 07:21:47 INFO - PID 5438 | 07:21:47 INFO - PID 5438 | [#4] prototype.html Cycles:180 Average:5508.03 Median:6078.33 stddev:1543.14 (25.4%) stddev-sans-first:1501.13 07:21:47 INFO - PID 5438 | Values: 507.2 508.9 533.1 535.4 537.4 6114.1 6253.3 6259.2 6274.7 6300.5 6039.0 6056.5 6074.2 6083.1 6143.8 4900.5 4907.8 4914.5 4937.0 4997.7 4927.8 4965.7 4993.5 5006.7 5024.7 4767.7 4949.2 4950.9 4964.6 4978.6 4937.8 4960.6 4962.4 4987.3 5012.2 4418.8 4466.0 4474.7 4514.8 4523.5 6026.8 6045.7 6047.9 6082.5 6112.4 5695.9 5706.2 5712.5 5748.9 5752.9 6406.7 6454.5 6488.9 6507.5 6590.8 4780.2 4821.6 4842.2 4843.8 4903.6 6758.5 6857.4 6865.5 6943.5 6996.7 5003.8 5009.4 5019.7 5059.2 5071.9 4992.5 5080.4 5087.4 5123.0 5168.7 5670.7 5744.2 5746.5 5757.2 5774.5 6488.3 6600.1 6604.8 6644.4 6689.4 1667.5 1744.4 1751.2 1768.6 1791.8 1174.9 1220.5 1237.7 1247.8 1267.1 5741.6 5767.2 5786.0 5804.9 5817.3 6585.3 6631.0 6632.6 6679.3 6705.6 5658.3 5709.4 5756.6 5779.2 5818.3 3553.7 3554.3 3571.0 3608.8 3652.3 6523.8 6535.7 6562.2 6575.4 6602.4 6890.7 6896.7 6948.5 6964.7 6988.3 6412.6 6413.5 6419.8 6542.6 6547.3 6657.2 6679.2 6714.7 6734.0 6780.4 6570.9 6580.1 6624.3 6628.8 6656.8 6493.2 6500.7 6520.4 6537.4 6587.2 4971.6 4995.3 5019.7 5041.6 5065.9 6722.6 6759.0 6768.7 6819.2 6833.1 6582.8 6583.5 6586.6 6588.6 6602.3 6467.8 6494.4 6541.2 6595.6 6620.6 6212.2 6366.5 6409.2 6421.9 6517.5 6427.7 6447.4 6452.2 6470.7 6470.9 6341.6 6343.2 6374.8 6377.5 6382.3 07:21:47 INFO - PID 5438 | 07:21:47 INFO - PID 5438 | [#5] yui.html Cycles:180 Average:23262.06 Median:19348.47 stddev:31147.37 (161.0%) stddev-sans-first:31189.42 07:21:47 INFO - PID 5438 | Values: 883.5 894.8 910.0 917.4 927.9 17735.5 18374.4 18461.1 18582.7 19127.2 19603.8 19679.2 19737.6 19776.1 19816.7 1020.3 1047.5 1059.4 1062.1 1062.2 1057.7 1070.2 1070.3 1070.7 1070.7 1060.5 1100.5 1111.5 1126.8 1127.5 1086.3 1091.4 1091.5 1093.8 1093.8 794.2 799.6 800.2 800.2 801.4 18791.1 19173.1 19617.1 19689.7 19832.7 20532.6 20956.1 21197.6 21308.1 21323.0 15801.8 15882.8 15937.0 15956.1 16022.4 3610.8 3622.7 3627.4 3630.6 3632.0 120317.4 120598.4 122355.4 126091.4 129805.4 16001.4 16425.0 16846.2 16910.5 16925.7 30225.8 31064.8 31234.5 31284.5 31307.1 7286.1 7544.3 8610.4 8850.8 8851.2 4104.8 4281.7 4298.4 4301.5 4306.6 5231.6 5340.4 5354.4 5384.2 5662.3 1050.3 1083.9 1085.1 1093.3 1094.7 553.8 554.7 558.5 560.2 567.2 11294.7 11662.2 11823.4 11929.6 12860.2 661.9 665.0 673.8 674.5 677.2 5694.5 5702.4 5736.6 5751.9 5914.2 102412.5 104056.5 106152.9 109255.0 111162.0 89391.0 91885.0 92172.0 93921.5 94612.0 80090.0 81796.2 82757.0 84005.0 86950.6 11321.7 12317.4 12642.6 12699.9 12709.8 36848.5 37657.0 37811.3 37937.4 38086.2 68743.0 68804.7 69596.7 71555.6 72780.6 18809.5 18958.1 19055.0 19085.1 19222.7 18387.4 19192.1 19199.0 21506.5 21749.2 14470.6 15497.5 18459.6 18568.2 18651.7 18933.9 19009.9 19115.6 19167.9 19309.3 18996.1 19387.6 19390.7 19498.9 19684.2 12059.0 12130.2 12234.0 12282.1 12572.0 14333.6 14526.9 14569.4 14574.9 14580.9 07:21:47 INFO - PID 5438 | -------- Summary: end -------- 07:21:47 INFO - PID 5438 | 07:21:48 INFO - TEST-INFO | 5438: exit 0 07:21:48 INFO - TEST-OK | dromaeo_css | took 1113577ms 07:21:48 INFO - TEST-START | kraken 07:21:48 INFO - Initialising browser for kraken test... 07:21:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49389/getInfo.html -profile /tmp/tmpZH1k5w/profile 07:21:48 INFO - TEST-INFO | started process 5821 (/builds/slave/test/build/application/firefox/firefox http://localhost:49389/getInfo.html) 07:21:54 INFO - TEST-INFO | 5821: exit 0 07:21:54 INFO - Browser initialized. 07:21:54 INFO - Running cycle 1/1 for kraken test... 07:21:54 INFO - TEST-INFO | started process 6046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZH1k5w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:21:55 INFO - PID 6046 | 07:21:55 INFO - PID 6046 | (/builds/slave/test/build/application/firefox/firefox:6100): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:21:55 INFO - PID 6046 | 07:22:05 INFO - PID 6046 | RSS: Main: 174243840 07:22:05 INFO - PID 6046 | 07:22:08 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-beat-detection) 07:22:09 INFO - PID 6046 | RSS: Main: 178769920 07:22:09 INFO - PID 6046 | 07:22:11 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-dft) 07:22:12 INFO - PID 6046 | RSS: Main: 179355648 07:22:12 INFO - PID 6046 | 07:22:15 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-fft) 07:22:16 INFO - PID 6046 | RSS: Main: 174653440 07:22:16 INFO - PID 6046 | 07:22:18 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-oscillator) 07:22:19 INFO - PID 6046 | RSS: Main: 174694400 07:22:19 INFO - PID 6046 | 07:22:21 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:22:22 INFO - PID 6046 | RSS: Main: 174804992 07:22:22 INFO - PID 6046 | 07:22:25 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-darkroom) 07:22:25 INFO - PID 6046 | RSS: Main: 177963008 07:22:25 INFO - PID 6046 | 07:22:29 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-desaturate) 07:22:29 INFO - PID 6046 | RSS: Main: 178003968 07:22:29 INFO - PID 6046 | 07:22:32 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49389/tests/kraken/driver.html?testName=json-parse-financial) 07:22:33 INFO - PID 6046 | RSS: Main: 178323456 07:22:33 INFO - PID 6046 | 07:22:35 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:22:35 INFO - PID 6046 | RSS: Main: 178429952 07:22:35 INFO - PID 6046 | 07:22:37 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:22:38 INFO - PID 6046 | RSS: Main: 175800320 07:22:38 INFO - PID 6046 | 07:22:40 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:22:41 INFO - PID 6046 | RSS: Main: 175636480 07:22:41 INFO - PID 6046 | 07:22:43 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:22:44 INFO - PID 6046 | RSS: Main: 175828992 07:22:44 INFO - PID 6046 | 07:22:47 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:22:48 INFO - PID 6046 | RSS: Main: 176181248 07:22:48 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49389/tests/kraken/driver.html?testName=ai-astar) 07:22:50 INFO - PID 6046 | RSS: Main: 177594368 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | __start_tp_report 07:22:50 INFO - PID 6046 | _x_x_mozilla_page_load 07:22:50 INFO - PID 6046 | _x_x_mozilla_page_load_details 07:22:50 INFO - PID 6046 | |i|pagename|runs| 07:22:50 INFO - PID 6046 | |0;ai-astar;98;108;100;107;112;121;107;101;115;108 07:22:50 INFO - PID 6046 | |1;audio-beat-detection;143;117;149;178;124;143;146;126;171;119 07:22:50 INFO - PID 6046 | |2;audio-dft;163;174;163;162;165;167;165;173;161;163 07:22:50 INFO - PID 6046 | |3;audio-fft;74;83;74;177;75;74;76;79;161;77 07:22:50 INFO - PID 6046 | |4;audio-oscillator;78;78;136;86;82;81;132;84;78;135 07:22:50 INFO - PID 6046 | |5;imaging-gaussian-blur;121;114;114;114;115;113;119;117;114;115 07:22:50 INFO - PID 6046 | |6;imaging-darkroom;152;152;152;150;150;151;151;152;151;150 07:22:50 INFO - PID 6046 | |7;imaging-desaturate;94;94;93;93;93;93;94;99;94;94 07:22:50 INFO - PID 6046 | |8;json-parse-financial;55;56;56;56;56;55;56;56;55;57 07:22:50 INFO - PID 6046 | |9;json-stringify-tinderbox;53;53;54;53;61;54;58;54;55;56 07:22:50 INFO - PID 6046 | |10;stanford-crypto-aes;78;86;78;77;82;78;78;80;79;77 07:22:50 INFO - PID 6046 | |11;stanford-crypto-ccm;126;123;127;130;134;135;127;124;126;165 07:22:50 INFO - PID 6046 | |12;stanford-crypto-pbkdf2;183;174;181;184;180;184;174;172;179;177 07:22:50 INFO - PID 6046 | |13;stanford-crypto-sha256-iterative;67;66;67;77;69;69;70;68;65;64 07:22:50 INFO - PID 6046 | __end_tp_report 07:22:50 INFO - PID 6046 | __start_cc_report 07:22:50 INFO - PID 6046 | _x_x_mozilla_cycle_collect,987 07:22:50 INFO - PID 6046 | __end_cc_report 07:22:50 INFO - PID 6046 | __startTimestamp1501770170536__endTimestamp 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | ------- Summary: start ------- 07:22:50 INFO - PID 6046 | Number of tests: 14 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#0] ai-astar Cycles:10 Average:107.70 Median:110.00 stddev:7.06 (6.4%) stddev-sans-first:6.55 07:22:50 INFO - PID 6046 | Values: 98.0 108.0 100.0 107.0 112.0 121.0 107.0 101.0 115.0 108.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:144.50 stddev:20.91 (14.5%) stddev-sans-first:22.18 07:22:50 INFO - PID 6046 | Values: 143.0 117.0 149.0 178.0 124.0 143.0 146.0 126.0 171.0 119.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:4.50 (2.7%) stddev-sans-first:4.68 07:22:50 INFO - PID 6046 | Values: 163.0 174.0 163.0 162.0 165.0 167.0 165.0 173.0 161.0 163.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:39.28 (52.0%) stddev-sans-first:40.92 07:22:50 INFO - PID 6046 | Values: 74.0 83.0 74.0 177.0 75.0 74.0 76.0 79.0 161.0 77.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:79.50 stddev:25.91 (32.6%) stddev-sans-first:26.56 07:22:50 INFO - PID 6046 | Values: 78.0 78.0 136.0 86.0 82.0 81.0 132.0 84.0 78.0 135.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.00 stddev:2.59 (2.3%) stddev-sans-first:1.87 07:22:50 INFO - PID 6046 | Values: 121.0 114.0 114.0 114.0 115.0 113.0 119.0 117.0 114.0 115.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 07:22:50 INFO - PID 6046 | Values: 152.0 152.0 152.0 150.0 150.0 151.0 151.0 152.0 151.0 150.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:1.79 (1.9%) stddev-sans-first:1.90 07:22:50 INFO - PID 6046 | Values: 94.0 94.0 93.0 93.0 93.0 93.0 94.0 99.0 94.0 94.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 07:22:50 INFO - PID 6046 | Values: 55.0 56.0 56.0 56.0 56.0 55.0 56.0 56.0 55.0 57.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:54.50 stddev:2.60 (4.8%) stddev-sans-first:2.65 07:22:50 INFO - PID 6046 | Values: 53.0 53.0 54.0 53.0 61.0 54.0 58.0 54.0 55.0 56.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:2.79 (3.6%) stddev-sans-first:2.92 07:22:50 INFO - PID 6046 | Values: 78.0 86.0 78.0 77.0 82.0 78.0 78.0 80.0 79.0 77.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:128.50 stddev:12.35 (9.6%) stddev-sans-first:12.92 07:22:50 INFO - PID 6046 | Values: 126.0 123.0 127.0 130.0 134.0 135.0 127.0 124.0 126.0 165.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:180.50 stddev:4.39 (2.4%) stddev-sans-first:4.39 07:22:50 INFO - PID 6046 | Values: 183.0 174.0 181.0 184.0 180.0 184.0 174.0 172.0 179.0 177.0 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:3.61 (5.3%) stddev-sans-first:3.81 07:22:50 INFO - PID 6046 | Values: 67.0 66.0 67.0 77.0 69.0 69.0 70.0 68.0 65.0 64.0 07:22:50 INFO - PID 6046 | -------- Summary: end -------- 07:22:50 INFO - PID 6046 | 07:22:50 INFO - PID 6046 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:22:51 INFO - TEST-INFO | 6046: exit 0 07:22:51 INFO - TEST-OK | kraken | took 62729ms 07:22:51 INFO - SUITE-END | took 1176s 07:22:51 INFO - Completed test suite (00:19:36) 07:22:51 INFO - javascript benchmark 07:22:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8524.333926402465, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.128044147638, 3151.2594540283044, 3167.6990685884834, 3185.872565097396, 3225.9354812903744, 6132.724027418766, 6141.9692901535545, 6172.166757487737, 6214.596051256665, 6278.403551662596, 6228.968855155718, 6261.499080073595, 6308.968455157729, 6328.746850126001, 6379.776707815216, 5681.573881958849, 5698.373178950312, 5731.541476681877, 5767.971160144193, 5792.768289268424, 5539.501444869961, 5639.746211420475, 5650.0, 5773.134029895528, 5780.1907732917425, 5679.0, 5736.942630573703, 5750.539956803445, 5779.826605201851, 5782.074868021117, 5651.095824668033, 5701.600887937846, 5732.398098199712, 5736.971315143398, 5756.30924289088, 5501.779928802843, 5538.418466061086, 5559.138333558305, 5590.552755779528, 5602.747876345534, 6141.877162456726, 6147.446729794296, 6170.475509581691, 6211.782587609412, 6251.374862513758, 6642.335766423367, 6647.468202543785, 6738.59568425896, 6743.561668491532, 6755.3582409671, 6429.196350456193, 6579.572327798725, 6675.86648267032, 6772.2211945626395, 6772.288909664513, 6242.469390101847, 6305.810825675191, 6321.905171422432, 6330.65181415022, 6330.8100756977365, 6781.966090169616, 6866.6566671667215, 6893.4829887758615, 6980.232174460805, 6988.475864310095, 6480.351964803482, 6559.836004099936, 6582.736690532421, 6591.110200123018, 6594.439472644879, 6660.500462465335, 6663.433608143362, 6676.799696009128, 6682.365175308338, 6696.397324240842, 6590.505712071614, 6600.339966003457, 6605.801825945229, 6628.734850606018, 6654.534182607268, 6687.465002799764, 6690.899636505456, 6700.061991321219, 6701.262861085277, 6720.193576770819, 5402.054640437907, 5402.540784033401, 5465.371482279509, 5469.425710300441, 5491.093969495068, 4572.81708731647, 4623.329617205486, 4627.3521706961055, 4646.674732768742, 4658.906821863544, 5806.970965145148, 5823.912641310384, 5825.825225243249, 5828.795992140254, 5835.124731290341, 6662.633555154416, 6737.258901520829, 6745.426638735762, 6748.763793267212, 6816.4546836252985, 5800.56495762811, 5842.707864606838, 5856.707164641751, 5890.3815099414805, 5900.085486749561, 5863.398553701661, 5872.471477567039, 5930.466258036798, 5950.9702451487465, 5954.821355359346, 6417.711202995876, 6526.673666316665, 6532.052852336385, 6550.443212326911, 6607.306232845482, 6761.0, 6842.657867106725, 6845.349691779273, 6853.246142924175, 6855.006024126574, 6498.577592456475, 6544.2474115475425, 6589.0, 6629.7679581214425, 6633.1045308882685, 6642.767503137367, 6670.966645166744, 6762.594244345355, 6769.89845152333, 6782.96608516974, 6792.898106528307, 6795.45636349081, 6882.208546017272, 6889.483288753464, 6897.0, 6367.331430199948, 6426.807195784134, 6428.228612566522, 6438.5171112165835, 6493.837654058686, 6489.675516224075, 6503.837404064747, 6513.8697226056165, 6514.1531600891585, 6516.73933042673, 6436.066770318372, 6439.420452159328, 6441.323661015525, 6495.707693153725, 6504.38208370204, 6534.967325163344, 6549.869002619826, 6565.934340656532, 6625.0, 6639.535232533676, 6254.405831446005, 6317.526185536195, 6341.239051313872, 6341.524385671185, 6399.328070552711], "value": 6114.983724279575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.1503920883072, 859.0893652728105, 874.1040433555606, 902.3908861518473, 906.8413027720147, 41056.58943410565, 41778.164436711246, 41790.0, 41798.0, 41824.95437614061, 37993.240135197346, 38284.80857595715, 38342.808285958534, 38401.0, 38464.80767596165, 6904.75833345833, 7009.544379615334, 7037.225905150455, 7055.294470552929, 7055.929440705604, 6907.13660792401, 6951.443884489228, 6961.129858767654, 6990.860182796341, 6999.860002799941, 7477.401807855385, 7647.770566882975, 7693.230676932318, 7714.459987800856, 7721.343685786686, 7614.314711675948, 7676.347510461617, 7678.270564296383, 7678.424118191158, 7680.654370553339, 7400.851982960311, 7559.69761209551, 7637.312641862259, 7644.082710074771, 7681.462297639167, 39355.80322098371, 39779.40330895039, 39819.40270895939, 39871.601283987366, 39891.0, 3428.160100775301, 3480.4953281774256, 3481.460373642064, 3482.8780992665133, 3487.8256087195537, 31854.840725796454, 31925.84037079823, 32013.519797203062, 32051.198720031953, 32135.51796723051, 4936.950630493685, 4963.751812409365, 4972.477889821553, 4984.401871775374, 4991.276264941599, 222062.0, 224611.0, 225980.0, 226824.99999999834, 228556.0, 48687.51312486901, 49856.750716246184, 50116.49883501191, 50148.49851501511, 50252.24621630678, 51979.74010129925, 52038.73980630073, 52093.739531302104, 52100.0, 52153.0, 16868.409605663743, 16977.830221697626, 16985.49043528696, 16992.235349409308, 17064.0, 14043.929780351033, 14054.227017513931, 14057.929710351587, 14065.648358790908, 14068.929655351658, 13902.0, 13924.164550126823, 13951.302434878215, 13985.79021314681, 14144.434222631186, 5546.223528705985, 5564.0, 5567.192757050205, 5603.915941260884, 5656.660600363992, 1000.4347543637822, 1020.4438580973239, 1022.223110436074, 1033.1837848099917, 1033.3748082410184, 23341.883290583777, 23987.0, 24242.15152469655, 30503.847480762455, 31015.0, 1076.4510099849133, 1091.7379828841022, 1107.994529900882, 1111.9332840029624, 1116.436199719153, 12086.214396064228, 12420.875791242153, 12552.435140418704, 12583.622491325275, 12695.111342205957, 240303.0, 240319.0, 240921.0, 241531.0, 242059.0, 52981.205281920804, 53008.0, 54960.0, 58803.0, 58940.7052964741, 1428.4214892968364, 1447.2054652231157, 1477.30566633682, 1506.5555661079788, 1511.1439379572616, 27309.590356144276, 27679.236324561578, 28404.0, 28519.572206417335, 28847.711522884503, 37694.62305376911, 37731.43402849014, 37898.24203515859, 37910.431343529315, 38115.80942095272, 212721.0, 213282.0, 213412.0, 213576.0, 213677.0, 33872.830635846665, 34328.82835585806, 34447.13882152966, 34490.13774655654, 34823.0, 43058.56941430546, 44102.33846492241, 44121.77939110284, 44151.33772993472, 44500.777496112314, 32094.51858222082, 32197.51703724493, 32420.513692294164, 32488.025359239262, 32550.51174232341, 31924.36151277008, 32248.516272256406, 32265.0, 32465.0, 32903.506447402826, 34670.30659386748, 34997.8250108758, 35176.12059698528, 35288.47067294044, 35371.29257414786, 30770.076897693107, 31210.687893121685, 31283.37433251368, 31462.842685786425, 31501.52747708832, 22952.655710164694, 23271.0, 23632.921482662277, 23680.40798980039, 24074.638880416456], "value": 17441.612308502783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.3611954610834, 580.5471732049001, 587.6151121015731, 596.3738075021228, 600.6936462404174, 22177.334679959586, 22840.771592284073, 23354.766452335472, 23369.0, 23423.648645270292, 25176.24471265865, 27329.86335068327, 27452.725472745267, 27525.86237068812, 27736.445271094566, 6476.2228532576155, 6649.534532582721, 6677.465802735794, 6679.398854103129, 6679.899801502981, 3972.423998520213, 5415.675059496423, 6615.106960560311, 6692.163479565054, 6705.497087718416, 3966.8611598594057, 6268.498520118403, 6275.0, 6280.434760871521, 6299.685015749217, 6290.528210384216, 6300.180976473029, 6300.338464461257, 6301.4013668701855, 6304.0, 5851.941480585182, 5917.497012753921, 5925.111233315038, 5928.7628494860155, 5930.377310382434, 29903.401931961456, 30701.232469188224, 31245.843770781226, 31814.840925795455, 31844.840775795972, 1862.459886632875, 1907.3324336482258, 1908.3225454963426, 1909.0931807391378, 1910.4459706685045, 18610.0, 19218.13518391676, 19223.423297301102, 19236.0, 19240.71138932917, 2200.7469141048823, 2233.062113912161, 2279.2364557872966, 2317.5249073939804, 2321.408040949564, 146349.0, 151154.0, 151453.0, 151723.0, 152324.0, 14755.77866332006, 15627.0, 15631.921840390725, 15711.68576628461, 16109.516714498584, 24259.0, 24282.271531854072, 24337.51324973526, 24385.63421548678, 24385.63421548678, 10179.491025448699, 10234.232432567587, 10276.588936442458, 10283.897161028444, 10359.274850760525, 8760.56197190138, 9391.859122113174, 9579.712608621752, 9668.081532254424, 9704.175145112744, 8106.716264930699, 9293.90706092944, 9352.4856132912, 9380.5309734513, 9640.662576809778, 2644.8942042318477, 2693.3805224798407, 2738.5344491436504, 2764.6682398112357, 2776.3753155540244, 945.9952700236593, 958.7411398922252, 960.9387863033753, 970.8640790289365, 978.706388083572, 19501.804981949997, 19708.408747737303, 19745.703814442506, 19753.703694444306, 20312.085956131716, 1035.6478797208833, 1045.9163266938626, 1046.670298855858, 1047.1099565369375, 1052.1057101463696, 10922.0, 11154.665360039211, 11291.039816929046, 11353.659390218307, 11378.43107844621, 468262.0, 471377.0, 481908.0, 484906.0, 485072.0, 110615.0, 114571.42714286376, 115073.0, 115654.42172789082, 117240.9999999983, 1067.2689207892618, 1195.0857593940643, 1220.536196245421, 1220.798568236249, 1221.267239656199, 20806.0, 21132.260370886946, 21138.577228455037, 21171.576568468852, 21424.143034278455, 54768.45231547634, 55282.72358638181, 55721.44278557163, 56395.71802140963, 57396.42603573911, 71940.0, 71967.64016179886, 72229.0, 72525.6373718128, 72732.0, 14428.927855360656, 14781.630459238606, 14836.62908427298, 14937.477188298792, 14973.625659358604, 23001.194958176384, 23312.650310245022, 23439.296821095395, 23823.404414889766, 23840.165594204118, 18531.90734046321, 19708.31020914261, 19747.901260493607, 19793.40619781409, 19899.403017909484, 15342.23288835576, 15834.524964251092, 16534.0, 17545.1227438625, 18316.0, 19081.42755717331, 19912.402627921187, 20297.391078267676, 20476.488087797923, 20529.794702053387, 14989.550313490177, 15237.0, 15279.923600381928, 15302.158381289137, 15305.617359565655, 18717.81282187215, 18824.341148059753, 19035.524111897314, 19057.71413428772, 19060.61878762389], "value": 12076.673904362307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.4282001559345, 1406.8522805105463, 1422.2106730764435, 1425.750493663609, 1426.1371870018645, 13871.445142194312, 14459.566213013626, 14466.782998255034, 14474.0, 14611.78082328766, 14471.204083775388, 14751.262436878167, 14761.92619036906, 14768.187749673763, 14789.334479948402, 2636.709961904189, 2708.1740069278862, 2766.14249582629, 2768.4463107378506, 2802.9159125226274, 2800.7899407544414, 2828.0526023781954, 2831.278024103861, 2831.702671219513, 2833.3766571354267, 2714.8506832124226, 2742.2595899107228, 2764.751172394484, 2788.9163325100176, 2800.2019424464033, 2619.8559079250635, 2661.6007598860133, 2688.086050742747, 2738.8082834201614, 2740.2190375742816, 2615.6207349934343, 2619.2011436511857, 2634.920952371432, 2650.9337266568295, 2653.1244689252694, 14011.229382383965, 14287.499937502138, 14306.856931430657, 14319.49881754144, 14339.856601434061, 7382.52013619113, 7612.352949999256, 7629.389648828081, 7643.923560764377, 7655.540667559964, 5230.0, 5288.735563221823, 5471.835844924659, 5480.068388373986, 5569.610127291051, 1819.4359748477882, 1831.7893442254178, 1853.2123847364817, 1887.4903775980408, 1889.8204670556413, 23260.65109023366, 23807.64288535656, 23809.52380952371, 23819.88090059556, 23833.285001449985, 6891.793246202622, 6992.1958974717545, 7032.824179395556, 7089.0, 7133.429325653935, 18311.0, 18392.0, 18501.074946252633, 18517.722234166496, 18524.81475185258, 7895.249951254622, 8049.315808156255, 8069.596520173968, 8070.112287648354, 8085.191480851985, 7124.536905101152, 7271.854562908712, 7276.417886569062, 7334.046573945353, 7338.559686418832, 5299.549538289211, 5492.917606235909, 5498.1752737089755, 5551.056320425457, 5670.404607516234, 1741.2947756158776, 1765.576261697209, 1786.6516029374407, 1786.998561610978, 1799.19935628644, 883.6686242659002, 917.0, 926.4580220571041, 926.8748718922994, 938.5401153434768, 7328.96335518319, 7354.816129596696, 7370.705171793175, 7383.2247614000835, 7390.482666213314, 719.6042176802738, 746.5259560179217, 749.2095838890024, 750.8836130399797, 751.5227830327672, 4669.0, 4930.9013819723405, 5061.063703214917, 5123.97438012815, 5197.636165468381, 18800.0, 19393.32123375675, 19596.70604940927, 19612.313569025016, 19612.411627651192, 19031.904840475985, 19186.904065479583, 19710.802891970896, 19717.30989415392, 19718.8028119717, 10349.586016559404, 10999.23005389631, 11016.889831101747, 11033.779324413466, 11086.16853735973, 7832.725854595062, 8468.0, 8505.702300419456, 8674.913250867663, 8837.867431988654, 16332.346706131622, 16692.165391730607, 16953.152342382586, 17435.56411089733, 17599.29602815873, 15862.841371586137, 16414.589635259214, 17532.211050503014, 17897.642047158723, 18109.90945045319, 9219.0, 10464.686059418229, 10474.581016759244, 11022.669319920415, 11230.0, 12375.75248495007, 12465.501379945063, 12493.875061249271, 12499.125061245626, 12503.0, 10547.841782373423, 10648.627298044532, 10696.83954740664, 10788.622398216025, 11030.944845275722, 10148.746281343025, 10405.06354428105, 10440.738981525219, 10597.25819192649, 10847.837282440612, 9096.272298215994, 9231.907680923105, 9409.388389754644, 9409.435433873989, 9413.576389062646, 7304.890426643711, 7347.191808901123, 7391.556506609621, 7405.9629701851145, 7433.479656423999, 7119.964400177966, 7227.747028853965, 7322.414206863545, 7341.853162936604, 7397.741079062207], "value": 6477.078523973916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.17583926120057, 508.9160288552389, 533.0697932108469, 535.4056996733625, 537.4330081763737, 6114.052321890103, 6253.343398943114, 6259.248890133184, 6274.749010039599, 6300.495960323175, 6039.0, 6056.4851987581105, 6074.179985701929, 6083.148359229712, 6143.81568552943, 4900.460949295574, 4907.75461226939, 4914.459409464956, 4937.0, 4997.725125118117, 4927.753612319388, 4965.652404331699, 4993.475685053071, 5006.749662516878, 5024.748762561876, 4767.666263361566, 4949.208126699728, 4950.900981980359, 4964.578010869081, 4978.576820970222, 4937.753322238391, 4960.627952903546, 4962.42932062812, 4987.326710894019, 5012.1980483122525, 4418.823247070113, 4465.977670111661, 4474.731516109044, 4514.8419805306985, 4523.47979982303, 6026.819195424145, 6045.6674882881425, 6047.939520604782, 6082.482988945945, 6112.419320164622, 5695.886082278373, 5706.201131841545, 5712.542996560265, 5748.913766293509, 5752.942470575283, 6406.711697973602, 6454.547726761488, 6488.8702225955685, 6507.5119366047265, 6590.835229119262, 4780.1873681474235, 4821.638377121695, 4842.15262329091, 4843.75781210938, 4903.607711383081, 6758.459323254128, 6857.382835544775, 6865.450763938873, 6943.51395402322, 6996.7201311947465, 5003.799848006039, 5009.373828271466, 5019.749012549358, 5059.215821547666, 5071.87320316995, 4992.500749924979, 5080.390353157644, 5087.43879284495, 5122.974385128051, 5168.664036837594, 5670.744816483269, 5744.2192920194875, 5746.482816546531, 5757.193992841006, 5774.538036957118, 6488.31872653374, 6600.108985287021, 6604.801855944329, 6644.4020038196795, 6689.397954184147, 1667.483080245128, 1744.4069016534438, 1751.211954620426, 1768.6109056007658, 1791.784985801712, 1174.9118816088828, 1220.536196245421, 1237.7215126596625, 1247.8065899785547, 1267.14467734279, 5741.62679425836, 5767.163761254595, 5785.971070144707, 5804.94195058044, 5817.3019237690905, 6585.275619681831, 6630.977551846733, 6632.602043877383, 6679.298673639295, 6705.631190284484, 5658.2840236686625, 5709.371969083398, 5756.56825738063, 5779.24869766936, 5818.272715910512, 3553.7384228598994, 3554.306910152495, 3571.0, 3608.80151591665, 3652.2878038782715, 6523.836904077436, 6535.705893234815, 6562.212534495796, 6575.44108750752, 6602.438792702578, 6890.724371025203, 6896.655167241618, 6948.478864085214, 6964.686589103502, 6988.301169882971, 6412.583182093149, 6413.45485633717, 6419.812334718092, 6542.593342431495, 6547.345265473415, 6657.201135863727, 6679.198496180489, 6714.664266786739, 6734.0, 6780.423663988616, 6570.934290657032, 6580.144581204413, 6624.304448032887, 6628.801135965929, 6656.83357916056, 6493.188351456068, 6500.6998600279185, 6520.445762110274, 6537.378948999837, 6587.176602924635, 4971.602271818174, 4995.2507123930245, 5019.7490125494305, 5041.6470847040355, 5065.873353166053, 6722.630255336004, 6758.978407847323, 6768.661566921536, 6819.2498825128205, 6833.145856767904, 6582.807338440948, 6583.490309138256, 6586.637734924625, 6588.6046837188005, 6602.3397660233595, 6467.805965820845, 6494.383033611799, 6541.2477565078725, 6595.604263744191, 6620.602763834186, 6212.192414986203, 6366.4797993423335, 6409.198850143732, 6421.935780642134, 6517.490766055198, 6427.678616069272, 6447.4197322241225, 6452.161219041494, 6470.670558598807, 6470.935290647033, 6341.55609107358, 6343.238811342669, 6374.840628984312, 6377.521685873671, 6382.32985536512], "value": 5056.59060922029, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.5449743382163, 894.8120894612131, 910.0, 917.449530281831, 927.9164875161237, 17735.467935961926, 18374.448766536992, 18461.07694615269, 18582.721259181122, 19127.234910603558, 19603.803961960377, 19679.21283148676, 19737.60524789507, 19776.11007504662, 19816.702749458735, 1020.2705065877896, 1047.4500887034292, 1059.3590877519105, 1062.1184416933927, 1062.1768129699467, 1057.6615483045427, 1070.175964507329, 1070.3096502755718, 1070.7216123807789, 1070.7323169207698, 1060.522764755859, 1100.4662738571826, 1111.5164903267105, 1126.752114534801, 1127.5433449452985, 1086.293908959179, 1091.4324551233394, 1091.5197313182175, 1093.7703082352716, 1093.797647435223, 794.2018271637025, 799.6281728996045, 800.1678254615193, 800.1678254615251, 801.4069588504465, 18791.060446977597, 19173.137208825636, 19617.117229724554, 19689.704654430196, 19832.70250946237, 20532.58934821295, 20956.056977436052, 21197.5760484791, 21308.14767409302, 21323.0, 15801.841981580152, 15882.841171588252, 15937.0, 15956.122413267265, 16022.35910563576, 3610.801405922673, 3622.7464077514583, 3627.437747149196, 3630.6006339302658, 3631.983044747475, 120317.39841300825, 120598.39700801528, 122355.38822305831, 126091.36954315261, 129805.35097324547, 16001.439949601709, 16425.0, 16846.24191911367, 16910.492685219462, 16925.661486770197, 30225.848870755504, 31064.844675776476, 31234.53148202779, 31284.53073203904, 31307.06078817639, 7286.125664920243, 7544.283293087148, 8610.397272190887, 8850.822983540293, 8851.247643950208, 4104.8152833122585, 4281.657467402601, 4298.41971333866, 4301.483821941387, 4306.569343065668, 5231.633785634969, 5340.359156901197, 5354.384245811703, 5384.19237114436, 5662.263905692316, 1050.2805578178973, 1083.875354334246, 1085.1264731890903, 1093.2893619147617, 1094.7317907112808, 553.7840242305504, 554.7420449490926, 558.4722437296797, 560.2101037537053, 567.2087438023933, 11294.717632059264, 11662.241954272946, 11823.408829558488, 11929.582464613697, 12860.164089334163, 661.9371159739817, 665.0489799586637, 673.7776533743951, 674.544682339419, 677.2178134254943, 5694.487496125369, 5702.372738998707, 5736.598438109292, 5751.884962300731, 5914.2311499504785, 102412.48793756132, 104056.47971760093, 106152.9384706143, 109255.0, 111162.0, 89391.0, 91885.0, 92172.0, 93921.5303923476, 94612.0, 80090.0, 81796.18203817886, 82756.99999999879, 84005.0, 86950.56524717336, 11321.660350189508, 12317.384130793245, 12642.55751048709, 12699.873001270238, 12709.8093528599, 36848.46910224634, 37657.0, 37811.337709992484, 37937.39594738495, 38086.23827523489, 68743.0, 68804.6559767218, 69596.6520167396, 71555.64222178856, 72780.63609681917, 18809.495240380464, 18958.146883390556, 19055.0, 19085.141168647166, 19222.711659324843, 18387.356442524448, 19192.13635386439, 19199.040047997263, 21506.462338441663, 21749.238776642742, 14470.638234044232, 15497.5350739478, 18459.63080738351, 18568.164432600835, 18651.72022419692, 18933.90533047326, 19009.90495047516, 19115.617687645892, 19167.90416047911, 19309.324173653855, 18996.14517346695, 19387.61224775525, 19390.70913936264, 19498.902505487382, 19684.212631494578, 12059.0, 12130.150889437655, 12234.0, 12282.140250182401, 12572.0, 14333.64165895861, 14526.927365363106, 14569.41722331095, 14574.927125364306, 14580.927095364455], "value": 9094.30702570606, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 100.0, 107.0, 112.0, 121.0, 107.0, 101.0, 115.0, 108.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 149.0, 178.0, 124.0, 143.0, 146.0, 126.0, 171.0, 119.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 174.0, 163.0, 162.0, 165.0, 167.0, 165.0, 173.0, 161.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 83.0, 74.0, 177.0, 75.0, 74.0, 76.0, 79.0, 161.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 136.0, 86.0, 82.0, 81.0, 132.0, 84.0, 78.0, 135.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 114.0, 114.0, 114.0, 115.0, 113.0, 119.0, 117.0, 114.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 152.0, 150.0, 150.0, 151.0, 151.0, 152.0, 151.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 93.0, 93.0, 94.0, 99.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 61.0, 54.0, 58.0, 54.0, 55.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 86.0, 78.0, 77.0, 82.0, 78.0, 78.0, 80.0, 79.0, 77.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 127.0, 130.0, 134.0, 135.0, 127.0, 124.0, 126.0, 165.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 174.0, 181.0, 184.0, 180.0, 184.0, 174.0, 172.0, 179.0, 177.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 77.0, 69.0, 69.0, 70.0, 68.0, 65.0, 64.0], "value": 68.2, "unit": "score"}]}]} 07:22:51 INFO - Return code: 0 07:22:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:22:51 INFO - # TBPL SUCCESS # 07:22:51 INFO - Running post-action listener: _package_coverage_data 07:22:51 INFO - Running post-action listener: _resource_record_post_action 07:22:51 INFO - [mozharness: 2017-08-03 14:22:51.827978Z] Finished run-tests step (success) 07:22:51 INFO - Running post-run listener: _resource_record_post_run 07:22:51 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433086464; Read time: 8; Write time: 357252 07:22:51 INFO - TinderboxPrint: CPU usage
13.2% 07:22:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:22:51 INFO - TinderboxPrint: I/O write bytes / time
433,086,464 / 357,252 07:22:51 INFO - TinderboxPrint: CPU idle
8,271.6 (86.8%) 07:22:51 INFO - TinderboxPrint: CPU user
1,205.9 (12.7%) 07:22:51 INFO - TinderboxPrint: Swap in / out
0 / 0 07:22:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106528768; Read time: 0; Write time: 60164 07:22:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:22:51 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 326557696; Read time: 0; Write time: 297088 07:22:52 INFO - Running post-run listener: _upload_blobber_files 07:22:52 INFO - Blob upload gear active. 07:22:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:22:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:22:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:22:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:22:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:22:53 INFO - (blobuploader) - INFO - Done attempting. 07:22:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:22:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:22:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:22:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:22:54 INFO - (blobuploader) - INFO - Done attempting. 07:22:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:22:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:23:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:00 INFO - (blobuploader) - INFO - Done attempting. 07:23:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:23:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:23:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:01 INFO - (blobuploader) - INFO - Done attempting. 07:23:01 INFO - (blobuploader) - INFO - Iteration through files over. 07:23:01 INFO - Return code: 0 07:23:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:23:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:23:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46c7f3b568052fa1d5495f5a33cda0b7fb8247e3fd6000f7750e5b899146e4a5fbfb0d2aa0f3bb3449115266deb0121a9c34d152704c2225ed21ceb8ab27f40c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddfd65afa1788c39544aff2d83e29d0ea52e96abd558121b4b88938a25eada5aee4a9eafca33c40013c4e84076816fd134b105daf02188efa90062cfd309b8e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/556b738688b017132b3e61c652c6c938115d5233736000cf41cde59d5a609c08739e21e3c19240f15bc3f362680e428df24983e1cb8a34965ecfe5515f1170dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cae27385c8e96f066a091bcaa8566c26d7681d7ff5407bece2d101947c6e74a345835935437e0cdf8858994b32ce95cf765758e5735324b4008eb1ed513086f"} 07:23:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:23:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:23:01 INFO - Contents: 07:23:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46c7f3b568052fa1d5495f5a33cda0b7fb8247e3fd6000f7750e5b899146e4a5fbfb0d2aa0f3bb3449115266deb0121a9c34d152704c2225ed21ceb8ab27f40c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddfd65afa1788c39544aff2d83e29d0ea52e96abd558121b4b88938a25eada5aee4a9eafca33c40013c4e84076816fd134b105daf02188efa90062cfd309b8e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/556b738688b017132b3e61c652c6c938115d5233736000cf41cde59d5a609c08739e21e3c19240f15bc3f362680e428df24983e1cb8a34965ecfe5515f1170dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cae27385c8e96f066a091bcaa8566c26d7681d7ff5407bece2d101947c6e74a345835935437e0cdf8858994b32ce95cf765758e5735324b4008eb1ed513086f"} 07:23:01 INFO - Running post-run listener: copy_logs_to_upload_dir 07:23:01 INFO - Copying logs to upload dir... 07:23:01 INFO - mkdir: /builds/slave/test/build/upload/logs 07:23:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.370556 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-03 07:23:01.690147) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 07:23:01.693931) ========= 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=62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46c7f3b568052fa1d5495f5a33cda0b7fb8247e3fd6000f7750e5b899146e4a5fbfb0d2aa0f3bb3449115266deb0121a9c34d152704c2225ed21ceb8ab27f40c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddfd65afa1788c39544aff2d83e29d0ea52e96abd558121b4b88938a25eada5aee4a9eafca33c40013c4e84076816fd134b105daf02188efa90062cfd309b8e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/556b738688b017132b3e61c652c6c938115d5233736000cf41cde59d5a609c08739e21e3c19240f15bc3f362680e428df24983e1cb8a34965ecfe5515f1170dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cae27385c8e96f066a091bcaa8566c26d7681d7ff5407bece2d101947c6e74a345835935437e0cdf8858994b32ce95cf765758e5735324b4008eb1ed513086f"} build_url:https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/am3KdoAISBKA1Cb3driNbg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46c7f3b568052fa1d5495f5a33cda0b7fb8247e3fd6000f7750e5b899146e4a5fbfb0d2aa0f3bb3449115266deb0121a9c34d152704c2225ed21ceb8ab27f40c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddfd65afa1788c39544aff2d83e29d0ea52e96abd558121b4b88938a25eada5aee4a9eafca33c40013c4e84076816fd134b105daf02188efa90062cfd309b8e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/556b738688b017132b3e61c652c6c938115d5233736000cf41cde59d5a609c08739e21e3c19240f15bc3f362680e428df24983e1cb8a34965ecfe5515f1170dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cae27385c8e96f066a091bcaa8566c26d7681d7ff5407bece2d101947c6e74a345835935437e0cdf8858994b32ce95cf765758e5735324b4008eb1ed513086f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 07:23:01.719595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:23:01.719924) ========= 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=62c568580acbfdaac3eec7be000001dc-1501767502.467714-290487621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 07:23:01.802332) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 07:23:01.805648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 07:23:01.805941) ========= ========= Total master_lag: 0.20 =========